builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0311 starttime: 1487525220.28 results: success (0) buildid: 20170219085119 builduid: 7c062e890ff24841ab79a589c67ed2fc revision: 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:00.281925) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:00.282398) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:00.282697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:00.309654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:00.309987) ========= 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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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-02-19 09:27:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.3M=0.001s 2017-02-19 09:27:00 (18.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.518171 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:00.862834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:00.863148) ========= 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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.025973 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:00.918326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-19 09:27:00.918712) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c --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 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XPZ3RC5yOk/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.kQmakhwY4X/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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-02-19 09:27:01,069 truncating revision to first 12 chars 2017-02-19 09:27:01,069 Setting DEBUG logging. 2017-02-19 09:27:01,069 attempt 1/10 2017-02-19 09:27:01,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2ddf71e1526a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-19 09:27:01,952 unpacking tar archive at: mozilla-aurora-2ddf71e1526a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.157722 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-19 09:27:02.143667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:02.144107) ========= script_repo_revision: 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:02.144654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:02.145019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-19 09:27:02.168906) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-19 09:27:02.169492) ========= /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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:27:02 INFO - MultiFileLogger online at 20170219 09:27:02 in /builds/slave/test 09:27:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:27:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:27:02 INFO - {'append_to_log': False, 09:27:02 INFO - 'base_work_dir': '/builds/slave/test', 09:27:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:27:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:27:02 INFO - 'branch': 'Mozilla-Aurora', 09:27:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:27:02 INFO - 'config_files': ('talos/mac_config.py',), 09:27:02 INFO - 'default_actions': ('clobber', 09:27:02 INFO - 'read-buildbot-config', 09:27:02 INFO - 'download-and-extract', 09:27:02 INFO - 'populate-webroot', 09:27:02 INFO - 'create-virtualenv', 09:27:02 INFO - 'install', 09:27:02 INFO - 'run-tests'), 09:27:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:27:02 INFO - 'download_minidump_stackwalk': True, 09:27:02 INFO - 'download_symbols': 'ondemand', 09:27:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:27:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:27:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:27:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:27:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:27:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:27:02 INFO - 'installer_path': 'installer.exe', 09:27:02 INFO - 'log_level': 'info', 09:27:02 INFO - 'log_name': 'talos', 09:27:02 INFO - 'log_to_console': True, 09:27:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:27:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:27:02 INFO - 'opt_config_files': (), 09:27:02 INFO - 'pip_index': False, 09:27:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:27:02 INFO - 'cmd': ('bash', 09:27:02 INFO - '-c', 09:27:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:27:02 INFO - 'enabled': True, 09:27:02 INFO - 'halt_on_failure': False, 09:27:02 INFO - 'name': 'check_screen_resolution'},), 09:27:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:27:02 INFO - 'cmd': ('bash', 09:27:02 INFO - '-c', 09:27:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:27:02 INFO - 'enabled': True, 09:27:02 INFO - 'halt_on_failure': False, 09:27:02 INFO - 'name': 'check_screen_resolution'},), 09:27:02 INFO - 'run_cmd_checks_enabled': True, 09:27:02 INFO - 'sps_profile': False, 09:27:02 INFO - 'sps_profile_interval': 0, 09:27:02 INFO - 'suite': 'dromaeojs', 09:27:02 INFO - 'system_bits': '32', 09:27:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:27:02 INFO - 'title': 't-yosemite-r7-0311', 09:27:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:27:02 INFO - 'use_talos_json': True, 09:27:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:27:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:27:02 INFO - 'work_dir': 'build'} 09:27:02 INFO - [mozharness: 2017-02-19 17:27:02.389042Z] Running clobber step. 09:27:02 INFO - Running pre-action listener: _resource_record_pre_action 09:27:02 INFO - Running main action method: clobber 09:27:02 INFO - rmtree: /builds/slave/test/build 09:27:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:27:04 INFO - Running post-action listener: _resource_record_post_action 09:27:04 INFO - [mozharness: 2017-02-19 17:27:04.771195Z] Finished clobber step (success) 09:27:04 INFO - [mozharness: 2017-02-19 17:27:04.771387Z] Running read-buildbot-config step. 09:27:04 INFO - Running pre-action listener: _resource_record_pre_action 09:27:04 INFO - Running main action method: read_buildbot_config 09:27:04 INFO - Using buildbot properties: 09:27:04 INFO - { 09:27:04 INFO - "project": "", 09:27:04 INFO - "product": "firefox", 09:27:04 INFO - "script_repo_revision": "production", 09:27:04 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:27:04 INFO - "repository": "", 09:27:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:27:04 INFO - "buildid": "20170219085119", 09:27:04 INFO - "pgo_build": "False", 09:27:04 INFO - "basedir": "/builds/slave/test", 09:27:04 INFO - "buildnumber": 7, 09:27:04 INFO - "slavename": "t-yosemite-r7-0311", 09:27:04 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:27:04 INFO - "platform": "yosemite_r7", 09:27:04 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:27:04 INFO - "branch": "mozilla-aurora", 09:27:04 INFO - "repo_path": "releases/mozilla-aurora", 09:27:04 INFO - "revision": "2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c", 09:27:04 INFO - "stage_platform": "macosx64", 09:27:04 INFO - "builduid": "7c062e890ff24841ab79a589c67ed2fc", 09:27:04 INFO - "slavebuilddir": "test" 09:27:04 INFO - } 09:27:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:27:04 INFO - Running post-action listener: _resource_record_post_action 09:27:04 INFO - [mozharness: 2017-02-19 17:27:04.774724Z] Finished read-buildbot-config step (success) 09:27:04 INFO - [mozharness: 2017-02-19 17:27:04.774862Z] Running download-and-extract step. 09:27:04 INFO - Running pre-action listener: _resource_record_pre_action 09:27:04 INFO - Running main action method: download_and_extract 09:27:04 INFO - mkdir: /builds/slave/test/build/tests 09:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:04 INFO - trying https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:27:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:27:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:27:05 INFO - Downloaded 1199 bytes. 09:27:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:27:05 INFO - Using the following test package requirements: 09:27:05 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:27:05 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:27:05 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:27:05 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:27:05 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:27:05 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:27:05 INFO - u'jsshell-mac.zip'], 09:27:05 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:27:05 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:27:05 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:27:05 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:27:05 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:27:05 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:27:05 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:27:05 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:27:05 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:27:05 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:27:05 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:27:05 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:27:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:27:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:27:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:27:06 INFO - Expected file size: 16358984 09:27:06 INFO - Obtained file size: 16358984 09:27:13 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:27:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:27:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:27:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:27:15 INFO - Expected file size: 16358984 09:27:15 INFO - Obtained file size: 16358984 09:27:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:27:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:27:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:27:23 INFO - Expected file size: 14403485 09:27:23 INFO - Obtained file size: 14403485 09:27: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')]} 09:27:24 INFO - trying https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:27:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:27:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:27:26 INFO - Downloaded 73959717 bytes. 09:27:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:27:26 INFO - mkdir: /builds/slave/test/properties 09:27:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:27:26 INFO - Writing to file /builds/slave/test/properties/build_url 09:27:26 INFO - Contents: 09:27:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:27:27 INFO - Running post-action listener: _resource_record_post_action 09:27:27 INFO - Running post-action listener: set_extra_try_arguments 09:27:27 INFO - [mozharness: 2017-02-19 17:27:27.441271Z] Finished download-and-extract step (success) 09:27:27 INFO - [mozharness: 2017-02-19 17:27:27.441383Z] Running populate-webroot step. 09:27:27 INFO - Running pre-action listener: _resource_record_pre_action 09:27:27 INFO - Running main action method: populate_webroot 09:27:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:27:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:27:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:27:27 INFO - '--tppagecycles', 09:27:27 INFO - '7'], 09:27:27 INFO - 'tests': ['tsvgm']}}, 09:27:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:27:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:27:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:27:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:27:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:27:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:27:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:27:27 INFO - 'talos_options': ['--disable-e10s'], 09:27:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:27:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:27:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:27:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:27:27 INFO - 'talos_options': ['--disable-e10s'], 09:27:27 INFO - 'tests': ['damp', 'tps']}, 09:27:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:27:27 INFO - 'tests': ['damp', 'tps']}, 09:27:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:27:27 INFO - 'tests': ['dromaeo_dom']}, 09:27:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:27:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:27:27 INFO - 'tests': ['basic_compositor_video']}, 09:27:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:27:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:27:27 INFO - 'tests': ['a11yr', 09:27:27 INFO - 'ts_paint', 09:27:27 INFO - 'tpaint', 09:27:27 INFO - 'sessionrestore', 09:27:27 INFO - 'sessionrestore_no_auto_restore', 09:27:27 INFO - 'tabpaint']}, 09:27:27 INFO - 'other-e10s': {'tests': ['a11yr', 09:27:27 INFO - 'ts_paint', 09:27:27 INFO - 'tpaint', 09:27:27 INFO - 'sessionrestore', 09:27:27 INFO - 'sessionrestore_no_auto_restore', 09:27:27 INFO - 'tabpaint']}, 09:27:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:27:27 INFO - 'ts_paint', 09:27:27 INFO - 'tpaint', 09:27:27 INFO - 'sessionrestore', 09:27:27 INFO - 'sessionrestore_no_auto_restore', 09:27:27 INFO - 'tabpaint']}, 09:27:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:27:27 INFO - 'ts_paint', 09:27:27 INFO - 'tpaint', 09:27:27 INFO - 'sessionrestore', 09:27:27 INFO - 'sessionrestore_no_auto_restore', 09:27:27 INFO - 'tabpaint']}, 09:27:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:27:27 INFO - 'tests': ['a11yr', 09:27:27 INFO - 'ts_paint', 09:27:27 INFO - 'tpaint', 09:27:27 INFO - 'sessionrestore', 09:27:27 INFO - 'sessionrestore_no_auto_restore', 09:27:27 INFO - 'tabpaint']}, 09:27:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:27:27 INFO - 'tests': ['a11yr', 09:27:27 INFO - 'ts_paint', 09:27:27 INFO - 'tpaint', 09:27:27 INFO - 'sessionrestore', 09:27:27 INFO - 'sessionrestore_no_auto_restore', 09:27:27 INFO - 'tabpaint']}, 09:27:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:27:27 INFO - 'tests': ['tsvgx', 09:27:27 INFO - 'tsvgr_opacity', 09:27:27 INFO - 'tart', 09:27:27 INFO - 'tscrollx', 09:27:27 INFO - 'cart', 09:27:27 INFO - 'tsvg_static']}, 09:27:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:27:27 INFO - 'tsvgr_opacity', 09:27:27 INFO - 'tart', 09:27:27 INFO - 'tscrollx', 09:27:27 INFO - 'cart', 09:27:27 INFO - 'tsvg_static']}, 09:27:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:27:27 INFO - 'talos_options': ['--disable-e10s'], 09:27:27 INFO - 'tests': ['tp5o']}, 09:27:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:27:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:27:27 INFO - 'talos_options': ['--disable-e10s', 09:27:27 INFO - '--xperf_path', 09:27:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:27:27 INFO - 'tests': ['tp5n']}, 09:27:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:27:27 INFO - 'talos_options': ['--xperf_path', 09:27:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:27:27 INFO - 'tests': ['tp5n']}}, 09:27:27 INFO - 'talos.zip': {'path': '', 09:27:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:27:27 INFO - Running post-action listener: _resource_record_post_action 09:27:27 INFO - [mozharness: 2017-02-19 17:27:27.459760Z] Finished populate-webroot step (success) 09:27:27 INFO - [mozharness: 2017-02-19 17:27:27.459891Z] Running create-virtualenv step. 09:27:27 INFO - Running pre-action listener: _resource_record_pre_action 09:27:27 INFO - Running main action method: create_virtualenv 09:27:27 INFO - Creating virtualenv /builds/slave/test/build/venv 09:27:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:27:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:27:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:27:27 INFO - Using real prefix '/tools/python27' 09:27:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:27:28 INFO - Installing distribute.............................................................................................................................................................................................done. 09:27:31 INFO - Installing pip.................done. 09:27:31 INFO - Return code: 0 09:27:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:27:31 INFO - Reading from file tmpfile_stdout 09:27:31 INFO - Output received: 09:27:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:27:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:31 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 0x10c250b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c253768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a85880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02ed30>, '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 0x10bf55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023be8>, '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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:27:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:27:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XPZ3RC5yOk/Render', 09:27:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:31 INFO - 'HOME': '/Users/cltbld', 09:27:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:31 INFO - 'LOGNAME': 'cltbld', 09:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:31 INFO - 'MOZ_NO_REMOTE': '1', 09:27:31 INFO - 'NO_EM_RESTART': '1', 09:27:31 INFO - 'PAGER': '/bin/cat', 09:27:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:31 INFO - 'PWD': '/builds/slave/test', 09:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:31 INFO - 'SHELL': '/bin/bash', 09:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kQmakhwY4X/Listeners', 09:27:31 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 09:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:31 INFO - 'USER': 'cltbld', 09:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:31 INFO - 'XPC_FLAGS': '0x0', 09:27:31 INFO - 'XPC_SERVICE_NAME': '0', 09:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:27:31 INFO - Cleaning up... 09:27:31 INFO - Return code: 0 09:27:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:31 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 0x10c250b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c253768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a85880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02ed30>, '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 0x10bf55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023be8>, '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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:27:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:27:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XPZ3RC5yOk/Render', 09:27:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:31 INFO - 'HOME': '/Users/cltbld', 09:27:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:31 INFO - 'LOGNAME': 'cltbld', 09:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:31 INFO - 'MOZ_NO_REMOTE': '1', 09:27:31 INFO - 'NO_EM_RESTART': '1', 09:27:31 INFO - 'PAGER': '/bin/cat', 09:27:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:31 INFO - 'PWD': '/builds/slave/test', 09:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:31 INFO - 'SHELL': '/bin/bash', 09:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kQmakhwY4X/Listeners', 09:27:31 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 09:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:31 INFO - 'USER': 'cltbld', 09:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:31 INFO - 'XPC_FLAGS': '0x0', 09:27:31 INFO - 'XPC_SERVICE_NAME': '0', 09:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:31 INFO - Downloading/unpacking psutil>=3.1.1 09:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:27:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:27:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:27:36 INFO - Installing collected packages: psutil 09:27:36 INFO - Running setup.py install for psutil 09:27:36 INFO - building 'psutil._psutil_osx' extension 09:27:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:27:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:27:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:27:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:27:37 INFO - building 'psutil._psutil_posix' extension 09:27:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:27:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:27:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:27:37 INFO - ^ 09:27:37 INFO - 1 warning generated. 09:27:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:27:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:27:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:27:37 INFO - Successfully installed psutil 09:27:37 INFO - Cleaning up... 09:27:37 INFO - Return code: 0 09:27:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c250b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c253768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a85880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02ed30>, '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 0x10bf55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023be8>, '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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:27:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:27:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:27:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XPZ3RC5yOk/Render', 09:27:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:37 INFO - 'HOME': '/Users/cltbld', 09:27:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:37 INFO - 'LOGNAME': 'cltbld', 09:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:37 INFO - 'MOZ_NO_REMOTE': '1', 09:27:37 INFO - 'NO_EM_RESTART': '1', 09:27:37 INFO - 'PAGER': '/bin/cat', 09:27:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:37 INFO - 'PWD': '/builds/slave/test', 09:27:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:37 INFO - 'SHELL': '/bin/bash', 09:27:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kQmakhwY4X/Listeners', 09:27:37 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 09:27:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:37 INFO - 'USER': 'cltbld', 09:27:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:37 INFO - 'XPC_FLAGS': '0x0', 09:27:37 INFO - 'XPC_SERVICE_NAME': '0', 09:27:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:27:41 INFO - Installing collected packages: mozsystemmonitor 09:27:41 INFO - Running setup.py install for mozsystemmonitor 09:27:41 INFO - Successfully installed mozsystemmonitor 09:27:41 INFO - Cleaning up... 09:27:41 INFO - Return code: 0 09:27:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c250b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c253768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a85880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02ed30>, '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 0x10bf55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023be8>, '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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XPZ3RC5yOk/Render', 09:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:41 INFO - 'HOME': '/Users/cltbld', 09:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:41 INFO - 'LOGNAME': 'cltbld', 09:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:41 INFO - 'MOZ_NO_REMOTE': '1', 09:27:41 INFO - 'NO_EM_RESTART': '1', 09:27:41 INFO - 'PAGER': '/bin/cat', 09:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:41 INFO - 'PWD': '/builds/slave/test', 09:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:41 INFO - 'SHELL': '/bin/bash', 09:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kQmakhwY4X/Listeners', 09:27:41 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 09:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:41 INFO - 'USER': 'cltbld', 09:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:41 INFO - 'XPC_FLAGS': '0x0', 09:27:41 INFO - 'XPC_SERVICE_NAME': '0', 09:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:41 INFO - Downloading/unpacking jsonschema==2.5.1 09:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:27:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:27:45 INFO - warning: no files found matching '*.txt' 09:27:45 INFO - no previously-included directories found matching 'build' 09:27:45 INFO - no previously-included directories found matching 'dist' 09:27:45 INFO - no previously-included directories found matching '.git*' 09:27:45 INFO - Installing collected packages: jsonschema, functools32 09:27:45 INFO - Running setup.py install for functools32 09:27:45 INFO - warning: no files found matching '*.txt' 09:27:45 INFO - no previously-included directories found matching 'build' 09:27:45 INFO - no previously-included directories found matching 'dist' 09:27:45 INFO - no previously-included directories found matching '.git*' 09:27:45 INFO - Successfully installed jsonschema functools32 09:27:45 INFO - Cleaning up... 09:27:45 INFO - Return code: 0 09:27:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c250b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c253768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a85880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02ed30>, '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 0x10bf55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023be8>, '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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:27:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XPZ3RC5yOk/Render', 09:27:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:45 INFO - 'HOME': '/Users/cltbld', 09:27:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:45 INFO - 'LOGNAME': 'cltbld', 09:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:45 INFO - 'MOZ_NO_REMOTE': '1', 09:27:45 INFO - 'NO_EM_RESTART': '1', 09:27:45 INFO - 'PAGER': '/bin/cat', 09:27:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:45 INFO - 'PWD': '/builds/slave/test', 09:27:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:45 INFO - 'SHELL': '/bin/bash', 09:27:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kQmakhwY4X/Listeners', 09:27:45 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 09:27:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:45 INFO - 'USER': 'cltbld', 09:27:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:45 INFO - 'XPC_FLAGS': '0x0', 09:27:45 INFO - 'XPC_SERVICE_NAME': '0', 09:27:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:27:46 INFO - Cleaning up... 09:27:46 INFO - Return code: 0 09:27:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:46 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 0x10c250b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c253768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a85880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02ed30>, '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 0x10bf55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023be8>, '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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:27:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:27:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XPZ3RC5yOk/Render', 09:27:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:46 INFO - 'HOME': '/Users/cltbld', 09:27:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:46 INFO - 'LOGNAME': 'cltbld', 09:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:46 INFO - 'MOZ_NO_REMOTE': '1', 09:27:46 INFO - 'NO_EM_RESTART': '1', 09:27:46 INFO - 'PAGER': '/bin/cat', 09:27:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:46 INFO - 'PWD': '/builds/slave/test', 09:27:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:46 INFO - 'SHELL': '/bin/bash', 09:27:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kQmakhwY4X/Listeners', 09:27:46 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 09:27:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:46 INFO - 'USER': 'cltbld', 09:27:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:46 INFO - 'XPC_FLAGS': '0x0', 09:27:46 INFO - 'XPC_SERVICE_NAME': '0', 09:27:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:46 INFO - Downloading/unpacking blobuploader==1.2.4 09:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:49 INFO - Downloading blobuploader-1.2.4.tar.gz 09:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:27:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:27:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:50 INFO - Downloading docopt-0.6.1.tar.gz 09:27:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:27:50 INFO - Installing collected packages: blobuploader, requests, docopt 09:27:50 INFO - Running setup.py install for blobuploader 09:27:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:27:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:27:50 INFO - Running setup.py install for requests 09:27:50 INFO - Running setup.py install for docopt 09:27:51 INFO - Successfully installed blobuploader requests docopt 09:27:51 INFO - Cleaning up... 09:27:51 INFO - Return code: 0 09:27:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:51 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 0x10c250b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c253768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a85880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02ed30>, '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 0x10bf55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023be8>, '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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:27:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XPZ3RC5yOk/Render', 09:27:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:51 INFO - 'HOME': '/Users/cltbld', 09:27:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:51 INFO - 'LOGNAME': 'cltbld', 09:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:51 INFO - 'MOZ_NO_REMOTE': '1', 09:27:51 INFO - 'NO_EM_RESTART': '1', 09:27:51 INFO - 'PAGER': '/bin/cat', 09:27:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:51 INFO - 'PWD': '/builds/slave/test', 09:27:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:51 INFO - 'SHELL': '/bin/bash', 09:27:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kQmakhwY4X/Listeners', 09:27:51 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 09:27:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:51 INFO - 'USER': 'cltbld', 09:27:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:51 INFO - 'XPC_FLAGS': '0x0', 09:27:51 INFO - 'XPC_SERVICE_NAME': '0', 09:27:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:27:51 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Y5ErBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:27:51 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-iejM6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:27:51 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-rUFKXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:27:51 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-EpBye_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:27:51 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Ju6WJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:27:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-zpFdRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:27:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-gpTUc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:27:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-ydDtZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:27:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-fgRi_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:27:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-UXF7Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:27:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-OeAr0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:27:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-62wKd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:27:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-P57qIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:27:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-hjyBIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-HNNdJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:27:53 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Id6EwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:27:53 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-JaDNe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:27:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:27:53 INFO - Running setup.py install for manifestparser 09:27:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:27:53 INFO - Running setup.py install for mozcrash 09:27:53 INFO - Running setup.py install for mozdebug 09:27:53 INFO - Running setup.py install for mozdevice 09:27:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:27:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:27:53 INFO - Running setup.py install for mozfile 09:27:54 INFO - Running setup.py install for mozhttpd 09:27:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:27:54 INFO - Running setup.py install for mozinfo 09:27:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:27:54 INFO - Running setup.py install for mozInstall 09:27:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:27:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:27:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:27:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:27:54 INFO - Running setup.py install for mozleak 09:27:54 INFO - Running setup.py install for mozlog 09:27:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:27:54 INFO - Running setup.py install for moznetwork 09:27:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:27:54 INFO - Running setup.py install for mozprocess 09:27:55 INFO - Running setup.py install for mozprofile 09:27:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:27:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:27:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:27:55 INFO - Running setup.py install for mozrunner 09:27:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:27:55 INFO - Running setup.py install for mozscreenshot 09:27:55 INFO - Running setup.py install for moztest 09:27:55 INFO - Running setup.py install for mozversion 09:27:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:27:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:27:55 INFO - Cleaning up... 09:27:55 INFO - Return code: 0 09:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:55 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 0x10c250b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c253768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a85880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02ed30>, '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 0x10bf55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023be8>, '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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:27:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:27:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XPZ3RC5yOk/Render', 09:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:55 INFO - 'HOME': '/Users/cltbld', 09:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:55 INFO - 'LOGNAME': 'cltbld', 09:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:55 INFO - 'MOZ_NO_REMOTE': '1', 09:27:55 INFO - 'NO_EM_RESTART': '1', 09:27:55 INFO - 'PAGER': '/bin/cat', 09:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:55 INFO - 'PWD': '/builds/slave/test', 09:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:55 INFO - 'SHELL': '/bin/bash', 09:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kQmakhwY4X/Listeners', 09:27:55 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 09:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:55 INFO - 'USER': 'cltbld', 09:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:55 INFO - 'XPC_FLAGS': '0x0', 09:27:55 INFO - 'XPC_SERVICE_NAME': '0', 09:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:27:56 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-XjROZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:27:56 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-GlJ2im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:27:56 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-7hjRGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:27:56 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-9hwmj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:27:56 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-MSpKj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:27:56 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-VfFFSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:27:56 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-3_ZLHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:27:56 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-zhy9DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:27:56 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-_j5n1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:27:57 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-fZNzbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:27:57 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-f5aLtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:27:57 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Sry8j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:27:57 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-7QNpLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:27:57 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-xEAfH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:57 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-qXqleK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:27:57 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-jF3Z9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:27:57 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-PbLfGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:27:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:00 INFO - Downloading blessings-1.6.tar.gz 09:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:28:00 INFO - Installing collected packages: blessings 09:28:00 INFO - Running setup.py install for blessings 09:28:00 INFO - Successfully installed blessings 09:28:00 INFO - Cleaning up... 09:28:00 INFO - Return code: 0 09:28:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:28:01 INFO - Reading from file tmpfile_stdout 09:28:01 INFO - Current package versions: 09:28:01 INFO - blessings == 1.6 09:28:01 INFO - blobuploader == 1.2.4 09:28:01 INFO - docopt == 0.6.1 09:28:01 INFO - functools32 == 3.2.3-2 09:28:01 INFO - jsonschema == 2.5.1 09:28:01 INFO - manifestparser == 1.1 09:28:01 INFO - mozInstall == 1.12 09:28:01 INFO - mozcrash == 1.0 09:28:01 INFO - mozdebug == 0.1 09:28:01 INFO - mozdevice == 0.49 09:28:01 INFO - mozfile == 1.2 09:28:01 INFO - mozhttpd == 0.7 09:28:01 INFO - mozinfo == 0.9 09:28:01 INFO - mozleak == 0.1 09:28:01 INFO - mozlog == 3.4 09:28:01 INFO - moznetwork == 0.27 09:28:01 INFO - mozprocess == 0.24 09:28:01 INFO - mozprofile == 0.28 09:28:01 INFO - mozrunner == 6.13 09:28:01 INFO - mozscreenshot == 0.1 09:28:01 INFO - mozsystemmonitor == 0.3 09:28:01 INFO - moztest == 0.8 09:28:01 INFO - mozversion == 1.4 09:28:01 INFO - psutil == 3.1.1 09:28:01 INFO - requests == 1.2.3 09:28:01 INFO - wsgiref == 0.1.2 09:28:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:01 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 0x10c250b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c253768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a85880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02ed30>, '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 0x10bf55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023be8>, '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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:28:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XPZ3RC5yOk/Render', 09:28:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:28:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:28:01 INFO - 'HOME': '/Users/cltbld', 09:28:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:28:01 INFO - 'LOGNAME': 'cltbld', 09:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:01 INFO - 'MOZ_NO_REMOTE': '1', 09:28:01 INFO - 'NO_EM_RESTART': '1', 09:28:01 INFO - 'PAGER': '/bin/cat', 09:28:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:01 INFO - 'PWD': '/builds/slave/test', 09:28:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:28:01 INFO - 'SHELL': '/bin/bash', 09:28:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kQmakhwY4X/Listeners', 09:28:01 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 09:28:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:28:01 INFO - 'USER': 'cltbld', 09:28:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:28:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:01 INFO - 'XPC_FLAGS': '0x0', 09:28:01 INFO - 'XPC_SERVICE_NAME': '0', 09:28:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:28:01 INFO - Cleaning up... 09:28:01 INFO - Return code: 0 09:28:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:01 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 0x10c250b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c253768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a85880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02ed30>, '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 0x10bf55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023be8>, '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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:28:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XPZ3RC5yOk/Render', 09:28:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:28:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:28:01 INFO - 'HOME': '/Users/cltbld', 09:28:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:28:01 INFO - 'LOGNAME': 'cltbld', 09:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:01 INFO - 'MOZ_NO_REMOTE': '1', 09:28:01 INFO - 'NO_EM_RESTART': '1', 09:28:01 INFO - 'PAGER': '/bin/cat', 09:28:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:01 INFO - 'PWD': '/builds/slave/test', 09:28:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:28:01 INFO - 'SHELL': '/bin/bash', 09:28:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kQmakhwY4X/Listeners', 09:28:01 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 09:28:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:28:01 INFO - 'USER': 'cltbld', 09:28:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:28:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:01 INFO - 'XPC_FLAGS': '0x0', 09:28:01 INFO - 'XPC_SERVICE_NAME': '0', 09:28:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:28:01 INFO - Cleaning up... 09:28:01 INFO - Return code: 0 09:28:01 INFO - Running post-action listener: _resource_record_post_action 09:28:01 INFO - Running post-action listener: _start_resource_monitoring 09:28:01 INFO - Starting resource monitoring. 09:28:01 INFO - [mozharness: 2017-02-19 17:28:01.776079Z] Finished create-virtualenv step (success) 09:28:01 INFO - [mozharness: 2017-02-19 17:28:01.777043Z] Running install step. 09:28:01 INFO - Running pre-action listener: _resource_record_pre_action 09:28:01 INFO - Running main action method: install 09:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:28:02 INFO - Reading from file tmpfile_stdout 09:28:02 INFO - Detecting whether we're running mozinstall >=1.0... 09:28:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:28:02 INFO - Reading from file tmpfile_stdout 09:28:02 INFO - Output received: 09:28:02 INFO - Usage: mozinstall [options] installer 09:28:02 INFO - Options: 09:28:02 INFO - -h, --help show this help message and exit 09:28:02 INFO - -d DEST, --destination=DEST 09:28:02 INFO - Directory to install application into. [default: 09:28:02 INFO - "/builds/slave/test"] 09:28:02 INFO - --app=APP Application being installed. [default: firefox] 09:28:02 INFO - mkdir: /builds/slave/test/build/application 09:28:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:28:22 INFO - Reading from file tmpfile_stdout 09:28:22 INFO - Output received: 09:28:22 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:28:22 INFO - Running post-action listener: _resource_record_post_action 09:28:22 INFO - [mozharness: 2017-02-19 17:28:22.043068Z] Finished install step (success) 09:28:22 INFO - [mozharness: 2017-02-19 17:28:22.043221Z] Running run-tests step. 09:28:22 INFO - Running pre-action listener: _resource_record_pre_action 09:28:22 INFO - Running main action method: run_tests 09:28:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:28:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:28:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:28:22 INFO - 2017-02-19 09:28:22.057 screenresolution[1640:12243] starting screenresolution argv=screenresolution get 09:28:22 INFO - 2017-02-19 09:28:22.060 screenresolution[1640:12243] Display 0: 1600x1200x32@60 09:28:22 INFO - 2017-02-19 09:28:22.066 screenresolution[1641:12245] starting screenresolution argv=screenresolution list 09:28:22 INFO - Available Modes on Display 0 09:28:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:28:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:28:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:28:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:28:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:28:22 INFO - Intel Iris: 09:28:22 INFO - Chipset Model: Intel Iris 09:28:22 INFO - Type: GPU 09:28:22 INFO - Bus: Built-In 09:28:22 INFO - VRAM (Dynamic, Max): 1536 MB 09:28:22 INFO - Vendor: Intel (0x8086) 09:28:22 INFO - Device ID: 0x0a2e 09:28:22 INFO - Revision ID: 0x0009 09:28:22 INFO - Displays: 09:28:22 INFO - Display: 09:28:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:28:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:28:22 INFO - Display Serial Number: 1600x1200 60 09:28:22 INFO - Main Display: Yes 09:28:22 INFO - Mirror: Off 09:28:22 INFO - Online: Yes 09:28:22 INFO - Rotation: Supported 09:28:22 INFO - Return code: 0 09:28:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:28:22 INFO - Python 2.7.3 09:28:22 INFO - Return code: 0 09:28:22 INFO - grabbing minidump binary from tooltool 09:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:22 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 0x10c02ed30>, '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 0x10bf55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:28:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:28:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:28:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:28:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:28:22 INFO - Return code: 0 09:28:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:28:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:28:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:28:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:28:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:28:22 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/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:28:22 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/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0311 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XPZ3RC5yOk/Render', 09:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:28:22 INFO - 'HOME': '/Users/cltbld', 09:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:28:22 INFO - 'LOGNAME': 'cltbld', 09:28:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:28:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:22 INFO - 'MOZ_NO_REMOTE': '1', 09:28:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:28:22 INFO - 'NO_EM_RESTART': '1', 09:28:22 INFO - 'PAGER': '/bin/cat', 09:28:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:22 INFO - 'PWD': '/builds/slave/test', 09:28:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:28:22 INFO - 'SHELL': '/bin/bash', 09:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kQmakhwY4X/Listeners', 09:28:22 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 09:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:28:22 INFO - 'USER': 'cltbld', 09:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:22 INFO - 'XPC_FLAGS': '0x0', 09:28:22 INFO - 'XPC_SERVICE_NAME': '0', 09:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:28:22 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/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:28:22 INFO - mozversion application_buildid: 20170219085119 09:28:22 INFO - mozversion application_changeset: 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c 09:28:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:28:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:28:22 INFO - mozversion application_name: Firefox 09:28:22 INFO - mozversion application_remotingname: firefox-dev 09:28:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:28:22 INFO - mozversion application_vendor: Mozilla 09:28:22 INFO - mozversion application_version: 53.0a2 09:28:22 INFO - mozversion platform_buildid: 20170219085119 09:28:22 INFO - mozversion platform_changeset: 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c 09:28:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:28:22 INFO - mozversion platform_version: 53.0a2 09:28:22 INFO - using testdate: 1487525302 09:28:22 INFO - actual date: 1487525302 09:28:22 INFO - starting webserver on 'localhost:49242' 09:28:22 INFO - SUITE-START | Running 2 tests 09:28:22 INFO - TEST-START | dromaeo_css 09:28:22 INFO - operating with platform_type : mac_ 09:28:22 INFO - Initialising browser for dromaeo_css test... 09:28:22 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmp9MV18x/profile http://localhost:49242/getInfo.html) 09:28:25 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 09:28:25 INFO - PROCESS | 1651 | colorDepth:24 09:28:25 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 09:28:25 INFO - PROCESS | 1651 | __metrics 09:28:25 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:28:25 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:28:25 INFO - TEST-INFO | 1651: exit 0 09:28:25 INFO - Browser initialized. 09:28:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:28:25 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmp9MV18x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:28:38 INFO - PROCESS | 1654 | RSS: Main: 213377024 09:28:38 INFO - PROCESS | 1654 | 09:31:42 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 09:31:43 INFO - PROCESS | 1654 | RSS: Main: 355254272 09:31:43 INFO - PROCESS | 1654 | 09:33:27 INFO - PROCESS | 1654 | ************************* 09:33:27 INFO - PROCESS | 1654 | A coding exception was thrown and uncaught in a Task. 09:33:27 INFO - PROCESS | 1654 | 09:33:27 ERROR - PROCESS | 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:33:27 INFO - PROCESS | 1654 | Full stack: 09:33:27 INFO - PROCESS | 1654 | ************************* 09:34:46 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 09:34:47 INFO - PROCESS | 1654 | RSS: Main: 355389440 09:34:47 INFO - PROCESS | 1654 | 09:37:49 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 09:37:50 INFO - PROCESS | 1654 | RSS: Main: 320598016 09:37:50 INFO - PROCESS | 1654 | 09:40:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 09:40:53 INFO - PROCESS | 1654 | RSS: Main: 324677632 09:40:53 INFO - PROCESS | 1654 | 09:43:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 09:43:57 INFO - PROCESS | 1654 | RSS: Main: 308203520 09:43:57 INFO - PROCESS | 1654 | 09:47:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 09:47:01 INFO - PROCESS | 1654 | RSS: Main: 425545728 09:47:01 INFO - PROCESS | 1654 | 09:47:01 INFO - PROCESS | 1654 | __start_tp_report 09:47:01 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 09:47:01 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 09:47:01 INFO - PROCESS | 1654 | |i|pagename|runs| 09:47:01 INFO - PROCESS | 1654 | |0;dojo.html;3339.9499007514887;3356.5468661730665;3360.0423879194436;3371.2751758371946;3407.505911642812;5660.122680984449;5687.971560142204;5701.6008879378405;5702.572307076975;5714.57140714447;4550.476695180056;5615;5856.5021973132225;5869.06095024795;5908.704564771766;5287.154055351135;5300.363956325227;5331.893362132755;5346.759395827177;5379.9731001345135;5228.058949389108;5235.842924712246;5237.47625237477;5398.055340315449;5403.189521571757;4343.717658352213;4833.758312084382;4962.230854217584;5356.11624082026;5415.404305526408;5402.35171779389;5405.486478784509;5405.486478784529;5407.540359069484;5412.810551630674;5135.435102138762;5218.817341393071;5324.840254792362;5364.7317634118135;5371.677699338053;5711.228984087136;5775;5791.971040144772;5822.243108395924;5891.175235467038;6353.205849268841;6366.076918846741;6370.108184854124;6373.330800265951;6388.64862432566;6308.842278943017;6377.234731832164;6390.712417941158;6401.2318521777215;6403.423691867754;4967.602591792648;5729.885402291972;5748;5793.565482588739;5860.062390017662;6442.903356449657;6448.903266451007;6453.064305675651;6453.064305675651;6460.353964603502;6263.029230469285;6287.465565426898;6295.433410992941;6327.177466929362;6328.17733694626;5271.262023316739;6206.317305096436;6244.65654389013;6354.52341074412;6380.521460890452;6238.157848690459;6291.339409362043;6293.905591416133;6334.9366506334345;6385.297617262097;6371.23545174582;6377.617342959437;6381.744730210739;6384.138141350951;6391.424771770563;5041.269015992734;5091.592672586185;5103.2855400244;5104.642675012714;5107.97446012775;4032.6169013943627;4044.716869819143;4409.985703288197;4417.917610185461;4493.977530112328;5970.9701451492465;5982.2223110996165;5982.73077711504;5995.190649262381;6027.819165425044;6238;6294.307626161119;6295.024271237966;6303.180586523814;6356.841078973062;5929.644221346733;5959.940400595939;5960.821175364746;5973.581849270509;5986.640801551921;5441.5374693151525;5588.077967135378;5593.161025846074;5595.776168953196;5601.5238704709745;6336.461400780985;6352.682365881595;6389;6407.647579383179;6495.805125846232;6361.745530178741;6369.0764839099;6380.585261957958;6387.68061596909;6396.840078997876;5385.4076051635075;6483.254425740912;6485.837854053686;6491.05879647439;6499.675016249074;5723.456271654186;6126.365000174519;6145.402195429131;6180;6247.406496382836;6296.748130074746;6336.493080553637;6347.587406818542;6355.5551111421755;6397.552171348148;6102.633841969496;6171.876562468815;6176.536759742948;6194.38056194395;6194.81415557516;6088.056351265561;6114.633122012693;6120.081455037999;6141.36327073057;6145.893739127;5993.280806303272;6144.201253836973;6147.231596050494;6158.076288556752;6163.722632481638;6230.089200382223;6262.123302737529;6269.49844012487;6281.654509002049;6309.211348581427;5833.970830145822;5886.293644762484;6036.336003039574;6088.786892458743;6114.296855861455 09:47:01 INFO - PROCESS | 1654 | |1;ext.html;503.1597232621522;510.33911085144734;517.8291163915908;519.5947161214253;536.495694047595;24065;40157.59842401575;41744.58255417445;41813;43926.560734392646;43111.56888431115;43302.56697433025;43352;43564.69305920819;43670;8390.412671113025;9095.45427274364;9289.489078100702;9306.441613503177;9309.813803723922;8433.19884610961;11057.834132488018;11299.209055366127;11325.943370283178;11535.077193824474;11342.773144537105;11431.485583148778;11433.428328583579;11457.770844583103;11462.656120316404;8382.580870956428;11323.943380283128;11416.086713063018;11428.542858285658;11428.714282142972;8469.830603387898;8611.6985905493;8618.569071546397;8626.396152269344;10998;38677.03307417337;41311.58688413138;41345;41376;41400.585994140274;3916.118873253495;3967.821448034845;3998.4002399639994;4019.879403617896;4049.230646177217;29020;30354.392912141855;30755.538666920012;30945.381092378026;31542;3186.3149422874194;3275.1812046988252;3290.161008942728;3291.9506207406907;3308.520264561625;493194;493805;494678;495105;495822;62646.68676656679;62885.685571572765;62977;63083;63088;63173;65635.67182164059;65788.67105664441;66012;66017;16278.67442651164;16514.174291285388;16528.173591320625;16552.42066527666;16578.17109144538;11547.018503427134;11783.646490605295;12683.682907927376;12797.680057998625;12845.293508857103;14697.85302146965;16272.918635406748;16535.503934881974;16691.49925502237;16703.16484175786;5403.648762830482;6313.800377928179;6438.774642887476;6490;6490.837729056717;872.31959071924;879.9560021998874;883.9381243313035;904.755715956688;917.3349321741684;29666.961656341926;29741.256468588457;30078.398432031237;30240.450645912573;30735.385292294028;857.9957100214459;1075.8493810866485;1100.1254003067581;1115.4478533126155;1202.9218100823418;15374.231288435758;15390.3074361654;15473.858821648395;15513.767293490606;15824.525264242091;609080;613800;614583;616323;616826;52167.73916130471;59892.70053649704;60969.695151523956;61261;61436.69281653563;1415.419677932043;1442.2644451329688;1442.8268607767136;1444.949426770079;1446.5804916574286;24962.62556061624;26599.601005985314;28955;29859;29951.78235742813;43347.34978975381;51065;51146;51264.718382040744;51428.22857657213;531654;533661;533682;534253;536622;24198.274051778473;24456.633150503112;25139.120130796065;25140.74296285142;40214.396784047676;36312.818435907655;36610.718624848;40586.391204131374;41041.384379234936;43570.34644480272;28896.7110328894;34593.65406345904;35501.82249088738;36483.45274820827;37107.628923710414;29422.705772942852;32368;34853.12867178341;35909.28181436409;36287;34664.653353467154;35277.94166175019;35498;35816.64183358133;35962.64037359593;29414.264643384086;30247.69752302449;31539.896103636263;31907.521387178745;31940.84029579837;20648.690269645667;23686.407839803454;23706.525869482168;24278.75721242765;24330.27009189727 09:47:01 INFO - PROCESS | 1654 | |2;jquery.html;333.7130068141398;383.00227906304093;404.28441658264853;406.29913399386055;415.003990422985;20378;21397.893010534925;22062.669059964093;22288.442788930286;22362.776372236272;21880.890595547;21983.560328793454;22023;22097.447563810914;22296.219632312874;4939.506049395068;5208.036513245042;5271.736413179345;5272.683638981654;5337.653052551591;3876.127871228965;5316.149416093426;5351.0903146465;5366.597505187107;5370.462953704638;4160.604742549453;4194.182134483777;6678.966605166992;6735.696893639773;6741.865162696743;6068.3021452533085;6227.844303892439;6609.1408116944485;6620.668966551677;6702.262751097375;6004.489618382443;6025;6032.306284777263;6036.698165091728;6038.728257228435;13761.449542018407;13869.583912482642;14013.579592612135;14160.15039097647;14180.361883715257;2537.961930571043;2634.078072674568;2638.604209368591;2644.074573899139;2718.320419895026;9636.662716804878;9894.257930655158;10218.080372766412;10365.481725913749;10496.317739346918;1764.7794025746782;1772.3619496981075;1790.5255107396551;1798.5144011116925;1825.0144921742244;127588.0861787074;129940.35029824884;134086.32956835153;136869;137630;10380.896191038144;11852.11109166816;11966.64100076999;12144.271343719405;12160.939195303967;16349;16391.262393192334;16396;16398.934069285697;16407.671846563;8752.69365572202;8918.286537077018;8974.41666291689;9028.826252587121;9067;7389.408847292204;8508.872366914502;8736.912630873738;8746.169113934166;8849.469031858109;4846.466888642247;4861.343718597944;4868.41579010521;4870.732109733928;4904.509549045067;1998.9700154497693;2050.1286953044896;2051.210284040655;2052.4458396232935;2055.016908683128;928.1414691410419;962.7929995051097;976.2043934193609;993.2848349188573;997.6458357283205;21209;21402.57194856094;21518.892405538187;21611.135554577955;21737.681599116524;905.6875377994581;972.6984634763246;977.4770497783652;979.8432250839832;1008.7578981044496;9264.166225039779;9981.151602113756;11026;11032.669019929415;11067.889321106846;692225;715478;718158.4092079506;724736;730244;159476;161143;161652.1917390429;168013;168895;993.478423827482;999.1357475783395;1019.1591936652292;1026.1534234256917;1027.6095083868083;18126.365577204735;18437.26250949947;18822.6235475287;18978.52553686169;19141.808581914003;59583;59764.402355975886;61860.381396187266;62308;62654.12037638878;88067;88489.11510885066;90331.54834225787;92121.53939230261;92308;8320.04478947459;8399.41204115706;8518.74443766688;8684.522351270742;8689.304855611663;12417.875821242033;13497.460101595827;13549.25479098659;13689.383977721225;13760.31198440094;4900.730459824601;5396.892062158657;9279.608058790966;11536.826947595624;11963.102767292314;11553.768924621629;11578.90000449956;11848.99283560907;11956.940215299215;12137.878621213675;11295.830562541403;11591.76816463683;11791.233569817934;11792.941035294769;11980;7414.555126692416;7616.961915190389;7771.455998080306;8048.114707382067;8873.955630221808;5168.8449346519665;7065.964670176616;8898.06570310134;11515;11742.295462272292 09:47:01 INFO - PROCESS | 1654 | |3;mootools.html;1195.151442475842;1412.682146517033;1444.6099553120657;1449.630344262213;1460.9269536523175;8098.919010809897;8523.70167044152;8525.317974562036;8544;8550.615222314995;7461.626918654073;7721.691132354699;7735.30382265596;7800.492967957093;7817.648205830737;2124.6388114020615;2157.9028943697494;2287.1880482428746;2365.503244318695;2367.32531228599;2383.4518060846017;2385.9642105368434;2387.259949415678;2394.0663141374876;2396.772306630867;2291.633338665814;2320.791128798408;2326.8603883767028;2336.042222688698;2337.836351455399;2040.1941233212872;2123.787621237879;2125.6173888700027;2126.968095478569;2279.8290128240365;2133.114757375687;2273.556656451976;2349.7180338359335;2350.74141844397;2359.1742889988536;8340.332773378115;8408.579571021486;8422.747317580483;8425.988881334279;8427.915720842835;5001.524855138756;5162.19985902182;5165.483451654842;5167.870803229912;5168.508991645787;3460.3944309745693;3464.133966508373;3508.3509550733197;3521.1901262709466;3592.119930616989;1207.7886369885323;1211.8545774507027;1248.431963456625;1259.5843371687322;1265.0891358222066;11036.11711063113;11091.83362249567;11095.667129986032;11112.999830015257;11113.944430277877;4396.890077748082;4599.72401655895;4662.417197850269;4700.811967521329;4718.740469274154;9623.230141588796;9630.855537166948;9631.903680963242;9638.75903102414;9643.710688679352;5172.120739474299;5178.430372659004;5253.579713622901;5255.474452554714;5282;4669.41632295963;4700.7179569225955;4708.764561771966;4731.621470282369;4835.081334546425;3115.704008119225;3292.506124081407;3631.582368027711;3746.1383881706815;3930.8231129599235;1293.3662505372488;1312.7440149171011;1314.907956443059;1328.9401976911063;1331.1946272504995;765.2003656179306;810.4934415990007;893.2585953658448;897.4929165021741;911.1526280559011;5133.6919784813035;5646.774129034792;5678.346990096109;5771.480566749013;5985.581009329305;791.4657606115849;963.5519483440233;999.7950420163849;1004.4073996342047;1024.9692509224735;3607.296577167427;3607.494950706903;3693.5041308270193;3722.274156539449;3867.323218436762;8478.872816907751;10013.349132306377;10061.949690251648;10086.193104551618;10159.644412445528;9582.185514231369;9975.052370024836;9994.500274986221;9996.400215987063;9997.450140242356;7630.847383052308;7760.495567788075;7761.72833950809;7778.222177782177;7794.22057794216;5062.443131255485;5308.548773354308;5455.399906010415;5468.890622187454;5620.213170156263;8804.955975220082;9078.81842363136;9178.449293042439;9295.30285228624;9394.812103758024;9198.54007299619;9310.72067837966;9371.203447706748;9396.436213827192;9490.478023708487;7098.538594991515;7238.384737297389;7242.203357630762;7248.311410416002;7249.565026098451;7565.659545320364;7751.186125456971;7811.2188781123705;7821.061472623094;7833.725819596515;7027.7188912442925;7045.436365090883;7090.220075791762;7092.858142837217;7111.324424179695;5816.36020037804;6906.723731050702;6934.930650693428;6943.895841562279;7054.717811287491;6205.944989351911;6226.875462490815;6320.873582528416;6341.0805433212845;6342.207224096988;4800.615950724004;4874.171390863491;4929.186684197068;4992.301077849177;5117.360329958755;4261.829526819017;4744.596709279612;4948.164222114985;5009.098362294676;5104.285400044071 09:47:01 INFO - PROCESS | 1654 | |4;prototype.html;321.57391456320374;341.4144594435042;352.1706381471634;369.2651623269694;371.44654464847383;4882.951170488294;5063.341765570471;5192.5067118623765;5340.1722732976405;5376.381716102649;5151.278820965068;5226.5557427618605;5258;5304.151335786275;5321.760520776565;4046.9680231541065;4081.244969680604;4150.43969064177;4195.370694395834;4198.8320467181275;3930.4497370368026;4068.5524592294823;4194.601512856289;4226.957730422687;4230.957690423103;3875.4380614810834;4099.118689481761;4117.835286588533;4162;4176.540580536139;3857.614238576148;3916.686665066788;4087.0804069084516;4141.337386018237;4159.480064991876;3671.6695497405362;3678.1356381250384;3701.6668499835146;3704.4258139988074;3710.443433484999;4740.762961851894;5052.823151189691;5099.6685215460875;5190.273361729361;5248.422673505911;4344.695871288979;4549.749763762991;4556.134334476439;4607.285870690049;4640.466346370177;4922.793915490692;5292.814751483679;5473.698946557938;5507.394186639466;5535.197396377543;3208.7753857230005;3562.946555801665;3766.246750649881;3790.275424681791;3848.4612154298143;4958.652894297401;5650.180723795068;5653.802116925888;5929.8814023719715;5940.435658612425;3917.0207448137967;3930.7838068906485;3933.1347103637154;3934.8622798201927;3948.7235893487755;3283.983580082132;3772.7170462215445;3867.1924691515337;3970.7220494565104;3977.7016723745833;4525.660575456854;4564.543545645409;4568.908621827545;4624.44506659203;4629.282461218517;4555.8086560364545;4699.154152252559;5365.141577347684;5501.587380946445;5667.574931880043;1182.3092977042738;1188.3523479703583;1205.9517619295304;1218.4638758946035;1228.9815652765217;730.4886579394445;739.4692985519922;792.3502727763179;841.6717480182733;844.4004756622867;4617.376654151713;4677.6257899367965;4800.591949684246;4872.97667489824;5051.747412629354;4547.499775024745;5005.27423523587;5364.970601876066;5479.780808767684;5485.61600687948;4408.581184787504;4561.5823613484245;4580.992181720017;4849.515048495122;4880.901797095625;2620.0436840553443;2726.05950946923;2780.582912563091;2820.13985734353;2822.4214036122544;4774;4949.3869475283245;5217.035053359398;5286.880740363127;5573.916391254134;5136.917849290396;5541.750621221974;5823.505002074787;5959.880802384015;5980.55145864062;4935.16102262609;5367.865803354869;5952.672603006789;5957.778655375724;6002.4897883679505;5368.2752828367675;5679.716014199191;5755.165501002415;5759.65442073477;5824.213731146241;5379.08555545566;5657;5669.31968163823;5680.261565996394;5680.488756011979;5013.24801279811;5368.61815004369;5768.94231057684;5922.585419020627;6069.787557435468;3685.7788532688123;3867.7485963412287;3877.526539914927;3882.9805850970565;3911.4915061041884;4849.927251091166;5716.714164291852;5755.740991655469;5761.798337058183;5766.279215098113;5383.273258110105;5553.528679737478;5575.598884680423;5616.410276920865;5669.6314739541795;4705.5059218781535;4771.423431347033;4783.736894470699;4973.229149481836;5139.203423469368;4437.356583295339;4894.681845680162;5318.946810531846;5361.410244873139;5452.863678408072;5016.949830501649;5494.5054945055135;5529.253550770594;5608.8878222434505;5642.153676948491;4349.978250108729;4873.853784386474;5022.372203474566;5190.97404512975;5296.285001524899 09:47:01 INFO - PROCESS | 1654 | |5;yui.html;698.601796975724;710.4742490556989;738.5347231244315;815.9592020398981;825.6573521988373;14628.4880029199;14902.254887255634;15627.609309767247;15710;15745.527634170992;13853.792193117111;14106.435742570311;14297.71404571908;14545.563633090998;14602.853971460283;849.1847826086948;860.2129051917487;862.3316929379719;863.9870401943975;868.9087645797196;672.4519516593961;695.4366962760155;836.9539675317855;863.818598094401;865.1953683074738;815.3640160674684;905.1401168889548;911.5032307392487;913.3195769151991;914.1544071733653;905.6694306578117;908.309684639672;909.122696597783;909.3907082254905;913.2785099771173;518.1269560790043;535.2800483349888;667.4993754683987;671;671.9529632925697;14483.275836208148;15029.699406011929;15058.472953446686;15366.462173823862;15369.385224591115;12501;14342.42630294787;14414.13515189092;14547.709045819025;14554.272286385743;11295.943520282428;11424.828627570592;11812.940935295355;11829.408529573488;12045.63863084109;3535.5934067582302;3731.5149030626117;3769.5866288613583;3853.133045064866;3855.9614403855885;99046.51430228552;104294.43558346554;107080.46459767652;110494;110715;8820.955895220482;10486.423246721504;10506.264561480775;10594.841077383846;10895.509702063426;22879.771202287764;22931.050860676696;23501.177458789203;23506.412339691302;23985;7475.215102414277;7574.962125189339;7720.227977202235;7790.5325680459355;7833.138354780969;4201.34879093741;4257.638100761408;4260.723053001545;4441.400410944481;4465.977670111629;3504.56192975878;3552.0942159749097;3566.732495062881;3643.981780091083;3655.738770124303;649.7303618998158;654.2084078265257;656.5601047298226;657.5299057276422;672.4049216443483;669.9497537684693;677.2719326723792;682.1916029505053;688.2738710660201;729.7774178875388;9020.323475739346;9952.253580981456;10106.747331316776;10129.493525323851;10164.542595583216;665.2017578905333;687.3744892148121;698.6820996446604;701.1656129206228;703.1772825793834;4464.732116073046;4976.925346119811;4997.3253610762085;5009.44896061433;5013.649044566918;109321;109570.45214773875;110368.79262414867;110455;114983.700325993;94090;95885;97431.51284243533;98645;100678.98642027265;67691;68640.97038544426;69779.30220697829;73904;76310.23689763031;10175.440350780482;10687.366070759645;10777.299475534066;10797.62208322705;10992.505337259683;49200.50799491959;49766.004679906924;49776.25335619896;51105.722356941376;52060.95878082493;70695;71862.64068679832;72042.63978680073;72120;73476.26523734909;12438.81341779856;12692.873071269169;13008.349582521025;13121.803172952605;13175.14361566495;13502.189868607915;14239.216843073731;14348.49780257686;14833.629159271104;14997.925010374878;12778.872211277769;13061.673458163243;13523.459061637817;13570.117942333716;13592.592222233348;13017;13206.867931320949;13463.596092117252;13671.86328136706;13695;12212.938935305267;13176;13310.534131305358;13398.129121607064;13539.86460135386;10519.737006574896;11127.443627818415;11133.888661113286;11176;11343.489542970421;9826.312158148861;10196.788011776267;10873.891261087289;11001.1749118818;11055.502502387251 09:47:01 INFO - PROCESS | 1654 | __end_tp_report 09:47:01 INFO - PROCESS | 1654 | __start_cc_report 09:47:01 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1515 09:47:01 INFO - PROCESS | 1654 | __end_cc_report 09:47:01 INFO - PROCESS | 1654 | __startTimestamp1487526421114__endTimestamp 09:47:01 INFO - PROCESS | 1654 | 09:47:01 INFO - PROCESS | 1654 | ------- Summary: start ------- 09:47:01 INFO - PROCESS | 1654 | Number of tests: 6 09:47:01 INFO - PROCESS | 1654 | 09:47:01 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5816.82 Median:6088.06 stddev:691.45 (11.4%) stddev-sans-first:665.71 09:47:01 INFO - PROCESS | 1654 | Values: 3339.9 3356.5 3360.0 3371.3 3407.5 5660.1 5688.0 5701.6 5702.6 5714.6 4550.5 5615.0 5856.5 5869.1 5908.7 5287.2 5300.4 5331.9 5346.8 5380.0 5228.1 5235.8 5237.5 5398.1 5403.2 4343.7 4833.8 4962.2 5356.1 5415.4 5402.4 5405.5 5405.5 5407.5 5412.8 5135.4 5218.8 5324.8 5364.7 5371.7 5711.2 5775.0 5792.0 5822.2 5891.2 6353.2 6366.1 6370.1 6373.3 6388.6 6308.8 6377.2 6390.7 6401.2 6403.4 4967.6 5729.9 5748.0 5793.6 5860.1 6442.9 6448.9 6453.1 6453.1 6460.4 6263.0 6287.5 6295.4 6327.2 6328.2 5271.3 6206.3 6244.7 6354.5 6380.5 6238.2 6291.3 6293.9 6334.9 6385.3 6371.2 6377.6 6381.7 6384.1 6391.4 5041.3 5091.6 5103.3 5104.6 5108.0 4032.6 4044.7 4410.0 4417.9 4494.0 5971.0 5982.2 5982.7 5995.2 6027.8 6238.0 6294.3 6295.0 6303.2 6356.8 5929.6 5959.9 5960.8 5973.6 5986.6 5441.5 5588.1 5593.2 5595.8 5601.5 6336.5 6352.7 6389.0 6407.6 6495.8 6361.7 6369.1 6380.6 6387.7 6396.8 5385.4 6483.3 6485.8 6491.1 6499.7 5723.5 6126.4 6145.4 6180.0 6247.4 6296.7 6336.5 6347.6 6355.6 6397.6 6102.6 6171.9 6176.5 6194.4 6194.8 6088.1 6114.6 6120.1 6141.4 6145.9 5993.3 6144.2 6147.2 6158.1 6163.7 6230.1 6262.1 6269.5 6281.7 6309.2 5834.0 5886.3 6036.3 6088.8 6114.3 09:47:01 INFO - PROCESS | 1654 | 09:47:01 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:67929.48 Median:36299.91 stddev:146816.06 (404.5%) stddev-sans-first:147140.64 09:47:01 INFO - PROCESS | 1654 | Values: 503.2 510.3 517.8 519.6 536.5 24065.0 40157.6 41744.6 41813.0 43926.6 43111.6 43302.6 43352.0 43564.7 43670.0 8390.4 9095.5 9289.5 9306.4 9309.8 8433.2 11057.8 11299.2 11325.9 11535.1 11342.8 11431.5 11433.4 11457.8 11462.7 8382.6 11323.9 11416.1 11428.5 11428.7 8469.8 8611.7 8618.6 8626.4 10998.0 38677.0 41311.6 41345.0 41376.0 41400.6 3916.1 3967.8 3998.4 4019.9 4049.2 29020.0 30354.4 30755.5 30945.4 31542.0 3186.3 3275.2 3290.2 3292.0 3308.5 493194.0 493805.0 494678.0 495105.0 495822.0 62646.7 62885.7 62977.0 63083.0 63088.0 63173.0 65635.7 65788.7 66012.0 66017.0 16278.7 16514.2 16528.2 16552.4 16578.2 11547.0 11783.6 12683.7 12797.7 12845.3 14697.9 16272.9 16535.5 16691.5 16703.2 5403.6 6313.8 6438.8 6490.0 6490.8 872.3 880.0 883.9 904.8 917.3 29667.0 29741.3 30078.4 30240.5 30735.4 858.0 1075.8 1100.1 1115.4 1202.9 15374.2 15390.3 15473.9 15513.8 15824.5 609080.0 613800.0 614583.0 616323.0 616826.0 52167.7 59892.7 60969.7 61261.0 61436.7 1415.4 1442.3 1442.8 1444.9 1446.6 24962.6 26599.6 28955.0 29859.0 29951.8 43347.3 51065.0 51146.0 51264.7 51428.2 531654.0 533661.0 533682.0 534253.0 536622.0 24198.3 24456.6 25139.1 25140.7 40214.4 36312.8 36610.7 40586.4 41041.4 43570.3 28896.7 34593.7 35501.8 36483.5 37107.6 29422.7 32368.0 34853.1 35909.3 36287.0 34664.7 35277.9 35498.0 35816.6 35962.6 29414.3 30247.7 31539.9 31907.5 31940.8 20648.7 23686.4 23706.5 24278.8 24330.3 09:47:01 INFO - PROCESS | 1654 | 09:47:01 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:40075.52 Median:2129.57 stddev:119994.65 (5634.7%) stddev-sans-first:120294.16 09:47:01 INFO - PROCESS | 1654 | Values: 333.7 383.0 404.3 406.3 415.0 20378.0 21397.9 22062.7 22288.4 22362.8 21880.9 21983.6 22023.0 22097.4 22296.2 4939.5 5208.0 5271.7 5272.7 5337.7 3876.1 5316.1 5351.1 5366.6 5370.5 4160.6 4194.2 6679.0 6735.7 6741.9 6068.3 6227.8 6609.1 6620.7 6702.3 6004.5 6025.0 6032.3 6036.7 6038.7 13761.4 13869.6 14013.6 14160.2 14180.4 2538.0 2634.1 2638.6 2644.1 2718.3 9636.7 9894.3 10218.1 10365.5 10496.3 1764.8 1772.4 1790.5 1798.5 1825.0 127588.1 129940.4 134086.3 136869.0 137630.0 10380.9 11852.1 11966.6 12144.3 12160.9 16349.0 16391.3 16396.0 16398.9 16407.7 8752.7 8918.3 8974.4 9028.8 9067.0 7389.4 8508.9 8736.9 8746.2 8849.5 4846.5 4861.3 4868.4 4870.7 4904.5 1999.0 2050.1 2051.2 2052.4 2055.0 928.1 962.8 976.2 993.3 997.6 21209.0 21402.6 21518.9 21611.1 21737.7 905.7 972.7 977.5 979.8 1008.8 9264.2 9981.2 11026.0 11032.7 11067.9 692225.0 715478.0 718158.4 724736.0 730244.0 159476.0 161143.0 161652.2 168013.0 168895.0 993.5 999.1 1019.2 1026.2 1027.6 18126.4 18437.3 18822.6 18978.5 19141.8 59583.0 59764.4 61860.4 62308.0 62654.1 88067.0 88489.1 90331.5 92121.5 92308.0 8320.0 8399.4 8518.7 8684.5 8689.3 12417.9 13497.5 13549.3 13689.4 13760.3 4900.7 5396.9 9279.6 11536.8 11963.1 11553.8 11578.9 11849.0 11956.9 12137.9 11295.8 11591.8 11791.2 11792.9 11980.0 7414.6 7617.0 7771.5 8048.1 8874.0 5168.8 7066.0 8898.1 11515.0 11742.3 09:47:01 INFO - PROCESS | 1654 | 09:47:01 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5407.59 Median:5166.68 stddev:2964.71 (57.4%) stddev-sans-first:2956.12 09:47:01 INFO - PROCESS | 1654 | Values: 1195.2 1412.7 1444.6 1449.6 1460.9 8098.9 8523.7 8525.3 8544.0 8550.6 7461.6 7721.7 7735.3 7800.5 7817.6 2124.6 2157.9 2287.2 2365.5 2367.3 2383.5 2386.0 2387.3 2394.1 2396.8 2291.6 2320.8 2326.9 2336.0 2337.8 2040.2 2123.8 2125.6 2127.0 2279.8 2133.1 2273.6 2349.7 2350.7 2359.2 8340.3 8408.6 8422.7 8426.0 8427.9 5001.5 5162.2 5165.5 5167.9 5168.5 3460.4 3464.1 3508.4 3521.2 3592.1 1207.8 1211.9 1248.4 1259.6 1265.1 11036.1 11091.8 11095.7 11113.0 11113.9 4396.9 4599.7 4662.4 4700.8 4718.7 9623.2 9630.9 9631.9 9638.8 9643.7 5172.1 5178.4 5253.6 5255.5 5282.0 4669.4 4700.7 4708.8 4731.6 4835.1 3115.7 3292.5 3631.6 3746.1 3930.8 1293.4 1312.7 1314.9 1328.9 1331.2 765.2 810.5 893.3 897.5 911.2 5133.7 5646.8 5678.3 5771.5 5985.6 791.5 963.6 999.8 1004.4 1025.0 3607.3 3607.5 3693.5 3722.3 3867.3 8478.9 10013.3 10061.9 10086.2 10159.6 9582.2 9975.1 9994.5 9996.4 9997.5 7630.8 7760.5 7761.7 7778.2 7794.2 5062.4 5308.5 5455.4 5468.9 5620.2 8805.0 9078.8 9178.4 9295.3 9394.8 9198.5 9310.7 9371.2 9396.4 9490.5 7098.5 7238.4 7242.2 7248.3 7249.6 7565.7 7751.2 7811.2 7821.1 7833.7 7027.7 7045.4 7090.2 7092.9 7111.3 5816.4 6906.7 6934.9 6943.9 7054.7 6205.9 6226.9 6320.9 6341.1 6342.2 4800.6 4874.2 4929.2 4992.3 5117.4 4261.8 4744.6 4948.2 5009.1 5104.3 09:47:01 INFO - PROCESS | 1654 | 09:47:01 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4462.71 Median:4881.93 stddev:1350.41 (27.7%) stddev-sans-first:1317.94 09:47:01 INFO - PROCESS | 1654 | Values: 321.6 341.4 352.2 369.3 371.4 4883.0 5063.3 5192.5 5340.2 5376.4 5151.3 5226.6 5258.0 5304.2 5321.8 4047.0 4081.2 4150.4 4195.4 4198.8 3930.4 4068.6 4194.6 4227.0 4231.0 3875.4 4099.1 4117.8 4162.0 4176.5 3857.6 3916.7 4087.1 4141.3 4159.5 3671.7 3678.1 3701.7 3704.4 3710.4 4740.8 5052.8 5099.7 5190.3 5248.4 4344.7 4549.7 4556.1 4607.3 4640.5 4922.8 5292.8 5473.7 5507.4 5535.2 3208.8 3562.9 3766.2 3790.3 3848.5 4958.7 5650.2 5653.8 5929.9 5940.4 3917.0 3930.8 3933.1 3934.9 3948.7 3284.0 3772.7 3867.2 3970.7 3977.7 4525.7 4564.5 4568.9 4624.4 4629.3 4555.8 4699.2 5365.1 5501.6 5667.6 1182.3 1188.4 1206.0 1218.5 1229.0 730.5 739.5 792.4 841.7 844.4 4617.4 4677.6 4800.6 4873.0 5051.7 4547.5 5005.3 5365.0 5479.8 5485.6 4408.6 4561.6 4581.0 4849.5 4880.9 2620.0 2726.1 2780.6 2820.1 2822.4 4774.0 4949.4 5217.0 5286.9 5573.9 5136.9 5541.8 5823.5 5959.9 5980.6 4935.2 5367.9 5952.7 5957.8 6002.5 5368.3 5679.7 5755.2 5759.7 5824.2 5379.1 5657.0 5669.3 5680.3 5680.5 5013.2 5368.6 5768.9 5922.6 6069.8 3685.8 3867.7 3877.5 3883.0 3911.5 4849.9 5716.7 5755.7 5761.8 5766.3 5383.3 5553.5 5575.6 5616.4 5669.6 4705.5 4771.4 4783.7 4973.2 5139.2 4437.4 4894.7 5318.9 5361.4 5452.9 5016.9 5494.5 5529.3 5608.9 5642.2 4350.0 4873.9 5022.4 5191.0 5296.3 09:47:01 INFO - PROCESS | 1654 | 09:47:01 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:20909.84 Median:3649.86 stddev:30513.95 (836.0%) stddev-sans-first:30561.81 09:47:01 INFO - PROCESS | 1654 | Values: 698.6 710.5 738.5 816.0 825.7 14628.5 14902.3 15627.6 15710.0 15745.5 13853.8 14106.4 14297.7 14545.6 14602.9 849.2 860.2 862.3 864.0 868.9 672.5 695.4 837.0 863.8 865.2 815.4 905.1 911.5 913.3 914.2 905.7 908.3 909.1 909.4 913.3 518.1 535.3 667.5 671.0 672.0 14483.3 15029.7 15058.5 15366.5 15369.4 12501.0 14342.4 14414.1 14547.7 14554.3 11295.9 11424.8 11812.9 11829.4 12045.6 3535.6 3731.5 3769.6 3853.1 3856.0 99046.5 104294.4 107080.5 110494.0 110715.0 8821.0 10486.4 10506.3 10594.8 10895.5 22879.8 22931.1 23501.2 23506.4 23985.0 7475.2 7575.0 7720.2 7790.5 7833.1 4201.3 4257.6 4260.7 4441.4 4466.0 3504.6 3552.1 3566.7 3644.0 3655.7 649.7 654.2 656.6 657.5 672.4 669.9 677.3 682.2 688.3 729.8 9020.3 9952.3 10106.7 10129.5 10164.5 665.2 687.4 698.7 701.2 703.2 4464.7 4976.9 4997.3 5009.4 5013.6 109321.0 109570.5 110368.8 110455.0 114983.7 94090.0 95885.0 97431.5 98645.0 100679.0 67691.0 68641.0 69779.3 73904.0 76310.2 10175.4 10687.4 10777.3 10797.6 10992.5 49200.5 49766.0 49776.3 51105.7 52061.0 70695.0 71862.6 72042.6 72120.0 73476.3 12438.8 12692.9 13008.3 13121.8 13175.1 13502.2 14239.2 14348.5 14833.6 14997.9 12778.9 13061.7 13523.5 13570.1 13592.6 13017.0 13206.9 13463.6 13671.9 13695.0 12212.9 13176.0 13310.5 13398.1 13539.9 10519.7 11127.4 11133.9 11176.0 11343.5 9826.3 10196.8 10873.9 11001.2 11055.5 09:47:01 INFO - PROCESS | 1654 | -------- Summary: end -------- 09:47:01 INFO - PROCESS | 1654 | 09:47:01 INFO - TEST-INFO | 1654: exit 0 09:47:01 INFO - TEST-OK | dromaeo_css | took 1119097ms 09:47:01 INFO - TEST-START | kraken 09:47:01 INFO - operating with platform_type : mac_ 09:47:01 INFO - Initialising browser for kraken test... 09:47:01 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpFBtzTj/profile http://localhost:49242/getInfo.html) 09:47:04 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 09:47:04 INFO - PROCESS | 1661 | colorDepth:24 09:47:04 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 09:47:04 INFO - PROCESS | 1661 | __metrics 09:47:04 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:47:04 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:47:04 INFO - TEST-INFO | 1661: exit 0 09:47:04 INFO - Browser initialized. 09:47:04 INFO - Running cycle 1/1 for kraken test... 09:47:04 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpFBtzTj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:47:16 INFO - PROCESS | 1662 | RSS: Main: 213434368 09:47:16 INFO - PROCESS | 1662 | 09:47:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 09:47:20 INFO - PROCESS | 1662 | RSS: Main: 266670080 09:47:20 INFO - PROCESS | 1662 | 09:47:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 09:47:23 INFO - PROCESS | 1662 | RSS: Main: 275656704 09:47:23 INFO - PROCESS | 1662 | 09:47:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 09:47:27 INFO - PROCESS | 1662 | RSS: Main: 373096448 09:47:27 INFO - PROCESS | 1662 | 09:47:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 09:47:30 INFO - PROCESS | 1662 | RSS: Main: 276467712 09:47:30 INFO - PROCESS | 1662 | 09:47:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:47:32 INFO - PROCESS | 1662 | RSS: Main: 277860352 09:47:32 INFO - PROCESS | 1662 | 09:47:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 09:47:36 INFO - PROCESS | 1662 | RSS: Main: 317857792 09:47:36 INFO - PROCESS | 1662 | 09:47:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 09:47:39 INFO - PROCESS | 1662 | RSS: Main: 319684608 09:47:39 INFO - PROCESS | 1662 | 09:47:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 09:47:43 INFO - PROCESS | 1662 | RSS: Main: 317526016 09:47:43 INFO - PROCESS | 1662 | 09:47:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:47:45 INFO - PROCESS | 1662 | RSS: Main: 295456768 09:47:45 INFO - PROCESS | 1662 | 09:47:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:47:47 INFO - PROCESS | 1662 | RSS: Main: 297824256 09:47:47 INFO - PROCESS | 1662 | 09:47:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:47:50 INFO - PROCESS | 1662 | RSS: Main: 300023808 09:47:50 INFO - PROCESS | 1662 | 09:47:53 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:47:54 INFO - PROCESS | 1662 | RSS: Main: 316862464 09:47:54 INFO - PROCESS | 1662 | 09:47:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:47:58 INFO - PROCESS | 1662 | RSS: Main: 310591488 09:47:58 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 09:47:59 INFO - PROCESS | 1662 | RSS: Main: 354930688 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | __start_tp_report 09:47:59 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 09:47:59 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 09:47:59 INFO - PROCESS | 1662 | |i|pagename|runs| 09:47:59 INFO - PROCESS | 1662 | |0;ai-astar;115;113;112;111;111;113;111;112;113;113 09:47:59 INFO - PROCESS | 1662 | |1;audio-beat-detection;140;109;119;133;124;142;139;136;127;108 09:47:59 INFO - PROCESS | 1662 | |2;audio-dft;181;186;183;184;185;180;183;182;184;181 09:47:59 INFO - PROCESS | 1662 | |3;audio-fft;81;59;59;90;59;61;60;59;74;59 09:47:59 INFO - PROCESS | 1662 | |4;audio-oscillator;89;70;85;70;68;69;81;68;69;82 09:47:59 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;88;85;87;85;87;84;88;86;87;84 09:47:59 INFO - PROCESS | 1662 | |6;imaging-darkroom;96;110;165;162;96;98;99;99;97;98 09:47:59 INFO - PROCESS | 1662 | |7;imaging-desaturate;85;87;87;85;87;86;88;87;87;86 09:47:59 INFO - PROCESS | 1662 | |8;json-parse-financial;57;53;53;55;57;56;57;56;56;57 09:47:59 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;65;75;76;72;72;67;68;68;68;68 09:47:59 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;84;83;73;80;97;101;97;83;84;84 09:47:59 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;138;136;137;136;136;140;142;141;185;151 09:47:59 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;169;196;229;183;168;168;166;167;226;178 09:47:59 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;64;66;66;66;65;66;65;66;63;65 09:47:59 INFO - PROCESS | 1662 | __end_tp_report 09:47:59 INFO - PROCESS | 1662 | __start_cc_report 09:47:59 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2038 09:47:59 INFO - PROCESS | 1662 | __end_cc_report 09:47:59 INFO - PROCESS | 1662 | __startTimestamp1487526479978__endTimestamp 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | ------- Summary: start ------- 09:47:59 INFO - PROCESS | 1662 | Number of tests: 14 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.26 (1.1%) stddev-sans-first:0.93 09:47:59 INFO - PROCESS | 1662 | Values: 115.0 113.0 112.0 111.0 111.0 113.0 111.0 112.0 113.0 113.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:134.50 stddev:12.51 (9.3%) stddev-sans-first:12.45 09:47:59 INFO - PROCESS | 1662 | Values: 140.0 109.0 119.0 133.0 124.0 142.0 139.0 136.0 127.0 108.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.50 stddev:1.91 (1.0%) stddev-sans-first:1.90 09:47:59 INFO - PROCESS | 1662 | Values: 181.0 186.0 183.0 184.0 185.0 180.0 183.0 182.0 184.0 181.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.50 stddev:11.41 (18.9%) stddev-sans-first:10.75 09:47:59 INFO - PROCESS | 1662 | Values: 81.0 59.0 59.0 90.0 59.0 61.0 60.0 59.0 74.0 59.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:75.50 stddev:8.17 (10.8%) stddev-sans-first:6.95 09:47:59 INFO - PROCESS | 1662 | Values: 89.0 70.0 85.0 70.0 68.0 69.0 81.0 68.0 69.0 82.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:87.00 stddev:1.52 (1.8%) stddev-sans-first:1.45 09:47:59 INFO - PROCESS | 1662 | Values: 88.0 85.0 87.0 85.0 87.0 84.0 88.0 86.0 87.0 84.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:112.00 Median:97.50 stddev:27.45 (28.2%) stddev-sans-first:28.49 09:47:59 INFO - PROCESS | 1662 | Values: 96.0 110.0 165.0 162.0 96.0 98.0 99.0 99.0 97.0 98.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:0.97 (1.1%) stddev-sans-first:0.87 09:47:59 INFO - PROCESS | 1662 | Values: 85.0 87.0 87.0 85.0 87.0 86.0 88.0 87.0 87.0 86.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.50 stddev:1.57 (2.8%) stddev-sans-first:1.59 09:47:59 INFO - PROCESS | 1662 | Values: 57.0 53.0 53.0 55.0 57.0 56.0 57.0 56.0 56.0 57.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:3.63 (5.2%) stddev-sans-first:3.40 09:47:59 INFO - PROCESS | 1662 | Values: 65.0 75.0 76.0 72.0 72.0 67.0 68.0 68.0 68.0 68.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:84.00 stddev:8.81 (10.5%) stddev-sans-first:9.29 09:47:59 INFO - PROCESS | 1662 | Values: 84.0 83.0 73.0 80.0 97.0 101.0 97.0 83.0 84.0 84.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:140.50 stddev:15.04 (10.7%) stddev-sans-first:15.78 09:47:59 INFO - PROCESS | 1662 | Values: 138.0 136.0 137.0 136.0 136.0 140.0 142.0 141.0 185.0 151.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:180.50 stddev:24.29 (13.5%) stddev-sans-first:25.06 09:47:59 INFO - PROCESS | 1662 | Values: 169.0 196.0 229.0 183.0 168.0 168.0 166.0 167.0 226.0 178.0 09:47:59 INFO - PROCESS | 1662 | 09:47:59 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.00 09:47:59 INFO - PROCESS | 1662 | Values: 64.0 66.0 66.0 66.0 65.0 66.0 65.0 66.0 63.0 65.0 09:47:59 INFO - PROCESS | 1662 | -------- Summary: end -------- 09:47:59 INFO - PROCESS | 1662 | 09:48:00 INFO - TEST-INFO | 1662: exit 0 09:48:00 INFO - TEST-OK | kraken | took 59118ms 09:48:00 INFO - SUITE-END | took 1178s 09:48:01 INFO - Completed test suite (00:19:38) 09:48:01 INFO - javascript benchmark 09:48:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.9499007514887, 3356.5468661730665, 3360.0423879194436, 3371.2751758371946, 3407.505911642812, 5660.122680984449, 5687.971560142204, 5701.6008879378405, 5702.572307076975, 5714.57140714447, 4550.476695180056, 5615.0, 5856.5021973132225, 5869.06095024795, 5908.704564771766, 5287.154055351135, 5300.363956325227, 5331.893362132755, 5346.759395827177, 5379.9731001345135, 5228.058949389108, 5235.842924712246, 5237.47625237477, 5398.055340315449, 5403.189521571757, 4343.717658352213, 4833.758312084382, 4962.230854217584, 5356.11624082026, 5415.404305526408, 5402.35171779389, 5405.486478784509, 5405.486478784529, 5407.540359069484, 5412.810551630674, 5135.435102138762, 5218.817341393071, 5324.840254792362, 5364.7317634118135, 5371.677699338053, 5711.228984087136, 5775.0, 5791.971040144772, 5822.243108395924, 5891.175235467038, 6353.205849268841, 6366.076918846741, 6370.108184854124, 6373.330800265951, 6388.64862432566, 6308.842278943017, 6377.234731832164, 6390.712417941158, 6401.2318521777215, 6403.423691867754, 4967.602591792648, 5729.885402291972, 5748.0, 5793.565482588739, 5860.062390017662, 6442.903356449657, 6448.903266451007, 6453.064305675651, 6453.064305675651, 6460.353964603502, 6263.029230469285, 6287.465565426898, 6295.433410992941, 6327.177466929362, 6328.17733694626, 5271.262023316739, 6206.317305096436, 6244.65654389013, 6354.52341074412, 6380.521460890452, 6238.157848690459, 6291.339409362043, 6293.905591416133, 6334.9366506334345, 6385.297617262097, 6371.23545174582, 6377.617342959437, 6381.744730210739, 6384.138141350951, 6391.424771770563, 5041.269015992734, 5091.592672586185, 5103.2855400244, 5104.642675012714, 5107.97446012775, 4032.6169013943627, 4044.716869819143, 4409.985703288197, 4417.917610185461, 4493.977530112328, 5970.9701451492465, 5982.2223110996165, 5982.73077711504, 5995.190649262381, 6027.819165425044, 6238.0, 6294.307626161119, 6295.024271237966, 6303.180586523814, 6356.841078973062, 5929.644221346733, 5959.940400595939, 5960.821175364746, 5973.581849270509, 5986.640801551921, 5441.5374693151525, 5588.077967135378, 5593.161025846074, 5595.776168953196, 5601.5238704709745, 6336.461400780985, 6352.682365881595, 6389.0, 6407.647579383179, 6495.805125846232, 6361.745530178741, 6369.0764839099, 6380.585261957958, 6387.68061596909, 6396.840078997876, 5385.4076051635075, 6483.254425740912, 6485.837854053686, 6491.05879647439, 6499.675016249074, 5723.456271654186, 6126.365000174519, 6145.402195429131, 6180.0, 6247.406496382836, 6296.748130074746, 6336.493080553637, 6347.587406818542, 6355.5551111421755, 6397.552171348148, 6102.633841969496, 6171.876562468815, 6176.536759742948, 6194.38056194395, 6194.81415557516, 6088.056351265561, 6114.633122012693, 6120.081455037999, 6141.36327073057, 6145.893739127, 5993.280806303272, 6144.201253836973, 6147.231596050494, 6158.076288556752, 6163.722632481638, 6230.089200382223, 6262.123302737529, 6269.49844012487, 6281.654509002049, 6309.211348581427, 5833.970830145822, 5886.293644762484, 6036.336003039574, 6088.786892458743, 6114.296855861455], "value": 5771.032433842884, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.1597232621522, 510.33911085144734, 517.8291163915908, 519.5947161214253, 536.495694047595, 24065.0, 40157.59842401575, 41744.58255417445, 41813.0, 43926.560734392646, 43111.56888431115, 43302.56697433025, 43352.0, 43564.69305920819, 43670.0, 8390.412671113025, 9095.45427274364, 9289.489078100702, 9306.441613503177, 9309.813803723922, 8433.19884610961, 11057.834132488018, 11299.209055366127, 11325.943370283178, 11535.077193824474, 11342.773144537105, 11431.485583148778, 11433.428328583579, 11457.770844583103, 11462.656120316404, 8382.580870956428, 11323.943380283128, 11416.086713063018, 11428.542858285658, 11428.714282142972, 8469.830603387898, 8611.6985905493, 8618.569071546397, 8626.396152269344, 10998.0, 38677.03307417337, 41311.58688413138, 41345.0, 41376.0, 41400.585994140274, 3916.118873253495, 3967.821448034845, 3998.4002399639994, 4019.879403617896, 4049.230646177217, 29020.0, 30354.392912141855, 30755.538666920012, 30945.381092378026, 31542.0, 3186.3149422874194, 3275.1812046988252, 3290.161008942728, 3291.9506207406907, 3308.520264561625, 493194.0, 493805.0, 494678.0, 495105.0, 495822.0, 62646.68676656679, 62885.685571572765, 62977.0, 63083.0, 63088.0, 63173.0, 65635.67182164059, 65788.67105664441, 66012.0, 66017.0, 16278.67442651164, 16514.174291285388, 16528.173591320625, 16552.42066527666, 16578.17109144538, 11547.018503427134, 11783.646490605295, 12683.682907927376, 12797.680057998625, 12845.293508857103, 14697.85302146965, 16272.918635406748, 16535.503934881974, 16691.49925502237, 16703.16484175786, 5403.648762830482, 6313.800377928179, 6438.774642887476, 6490.0, 6490.837729056717, 872.31959071924, 879.9560021998874, 883.9381243313035, 904.755715956688, 917.3349321741684, 29666.961656341926, 29741.256468588457, 30078.398432031237, 30240.450645912573, 30735.385292294028, 857.9957100214459, 1075.8493810866485, 1100.1254003067581, 1115.4478533126155, 1202.9218100823418, 15374.231288435758, 15390.3074361654, 15473.858821648395, 15513.767293490606, 15824.525264242091, 609080.0, 613800.0, 614583.0, 616323.0, 616826.0, 52167.73916130471, 59892.70053649704, 60969.695151523956, 61261.0, 61436.69281653563, 1415.419677932043, 1442.2644451329688, 1442.8268607767136, 1444.949426770079, 1446.5804916574286, 24962.62556061624, 26599.601005985314, 28955.0, 29859.0, 29951.78235742813, 43347.34978975381, 51065.0, 51146.0, 51264.718382040744, 51428.22857657213, 531654.0, 533661.0, 533682.0, 534253.0, 536622.0, 24198.274051778473, 24456.633150503112, 25139.120130796065, 25140.74296285142, 40214.396784047676, 36312.818435907655, 36610.718624848, 40586.391204131374, 41041.384379234936, 43570.34644480272, 28896.7110328894, 34593.65406345904, 35501.82249088738, 36483.45274820827, 37107.628923710414, 29422.705772942852, 32368.0, 34853.12867178341, 35909.28181436409, 36287.0, 34664.653353467154, 35277.94166175019, 35498.0, 35816.64183358133, 35962.64037359593, 29414.264643384086, 30247.69752302449, 31539.896103636263, 31907.521387178745, 31940.84029579837, 20648.690269645667, 23686.407839803454, 23706.525869482168, 24278.75721242765, 24330.27009189727], "value": 19650.858056798163, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.7130068141398, 383.00227906304093, 404.28441658264853, 406.29913399386055, 415.003990422985, 20378.0, 21397.893010534925, 22062.669059964093, 22288.442788930286, 22362.776372236272, 21880.890595547, 21983.560328793454, 22023.0, 22097.447563810914, 22296.219632312874, 4939.506049395068, 5208.036513245042, 5271.736413179345, 5272.683638981654, 5337.653052551591, 3876.127871228965, 5316.149416093426, 5351.0903146465, 5366.597505187107, 5370.462953704638, 4160.604742549453, 4194.182134483777, 6678.966605166992, 6735.696893639773, 6741.865162696743, 6068.3021452533085, 6227.844303892439, 6609.1408116944485, 6620.668966551677, 6702.262751097375, 6004.489618382443, 6025.0, 6032.306284777263, 6036.698165091728, 6038.728257228435, 13761.449542018407, 13869.583912482642, 14013.579592612135, 14160.15039097647, 14180.361883715257, 2537.961930571043, 2634.078072674568, 2638.604209368591, 2644.074573899139, 2718.320419895026, 9636.662716804878, 9894.257930655158, 10218.080372766412, 10365.481725913749, 10496.317739346918, 1764.7794025746782, 1772.3619496981075, 1790.5255107396551, 1798.5144011116925, 1825.0144921742244, 127588.0861787074, 129940.35029824884, 134086.32956835153, 136869.0, 137630.0, 10380.896191038144, 11852.11109166816, 11966.64100076999, 12144.271343719405, 12160.939195303967, 16349.0, 16391.262393192334, 16396.0, 16398.934069285697, 16407.671846563, 8752.69365572202, 8918.286537077018, 8974.41666291689, 9028.826252587121, 9067.0, 7389.408847292204, 8508.872366914502, 8736.912630873738, 8746.169113934166, 8849.469031858109, 4846.466888642247, 4861.343718597944, 4868.41579010521, 4870.732109733928, 4904.509549045067, 1998.9700154497693, 2050.1286953044896, 2051.210284040655, 2052.4458396232935, 2055.016908683128, 928.1414691410419, 962.7929995051097, 976.2043934193609, 993.2848349188573, 997.6458357283205, 21209.0, 21402.57194856094, 21518.892405538187, 21611.135554577955, 21737.681599116524, 905.6875377994581, 972.6984634763246, 977.4770497783652, 979.8432250839832, 1008.7578981044496, 9264.166225039779, 9981.151602113756, 11026.0, 11032.669019929415, 11067.889321106846, 692225.0, 715478.0, 718158.4092079506, 724736.0, 730244.0, 159476.0, 161143.0, 161652.1917390429, 168013.0, 168895.0, 993.478423827482, 999.1357475783395, 1019.1591936652292, 1026.1534234256917, 1027.6095083868083, 18126.365577204735, 18437.26250949947, 18822.6235475287, 18978.52553686169, 19141.808581914003, 59583.0, 59764.402355975886, 61860.381396187266, 62308.0, 62654.12037638878, 88067.0, 88489.11510885066, 90331.54834225787, 92121.53939230261, 92308.0, 8320.04478947459, 8399.41204115706, 8518.74443766688, 8684.522351270742, 8689.304855611663, 12417.875821242033, 13497.460101595827, 13549.25479098659, 13689.383977721225, 13760.31198440094, 4900.730459824601, 5396.892062158657, 9279.608058790966, 11536.826947595624, 11963.102767292314, 11553.768924621629, 11578.90000449956, 11848.99283560907, 11956.940215299215, 12137.878621213675, 11295.830562541403, 11591.76816463683, 11791.233569817934, 11792.941035294769, 11980.0, 7414.555126692416, 7616.961915190389, 7771.455998080306, 8048.114707382067, 8873.955630221808, 5168.8449346519665, 7065.964670176616, 8898.06570310134, 11515.0, 11742.295462272292], "value": 9711.708302174475, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1195.151442475842, 1412.682146517033, 1444.6099553120657, 1449.630344262213, 1460.9269536523175, 8098.919010809897, 8523.70167044152, 8525.317974562036, 8544.0, 8550.615222314995, 7461.626918654073, 7721.691132354699, 7735.30382265596, 7800.492967957093, 7817.648205830737, 2124.6388114020615, 2157.9028943697494, 2287.1880482428746, 2365.503244318695, 2367.32531228599, 2383.4518060846017, 2385.9642105368434, 2387.259949415678, 2394.0663141374876, 2396.772306630867, 2291.633338665814, 2320.791128798408, 2326.8603883767028, 2336.042222688698, 2337.836351455399, 2040.1941233212872, 2123.787621237879, 2125.6173888700027, 2126.968095478569, 2279.8290128240365, 2133.114757375687, 2273.556656451976, 2349.7180338359335, 2350.74141844397, 2359.1742889988536, 8340.332773378115, 8408.579571021486, 8422.747317580483, 8425.988881334279, 8427.915720842835, 5001.524855138756, 5162.19985902182, 5165.483451654842, 5167.870803229912, 5168.508991645787, 3460.3944309745693, 3464.133966508373, 3508.3509550733197, 3521.1901262709466, 3592.119930616989, 1207.7886369885323, 1211.8545774507027, 1248.431963456625, 1259.5843371687322, 1265.0891358222066, 11036.11711063113, 11091.83362249567, 11095.667129986032, 11112.999830015257, 11113.944430277877, 4396.890077748082, 4599.72401655895, 4662.417197850269, 4700.811967521329, 4718.740469274154, 9623.230141588796, 9630.855537166948, 9631.903680963242, 9638.75903102414, 9643.710688679352, 5172.120739474299, 5178.430372659004, 5253.579713622901, 5255.474452554714, 5282.0, 4669.41632295963, 4700.7179569225955, 4708.764561771966, 4731.621470282369, 4835.081334546425, 3115.704008119225, 3292.506124081407, 3631.582368027711, 3746.1383881706815, 3930.8231129599235, 1293.3662505372488, 1312.7440149171011, 1314.907956443059, 1328.9401976911063, 1331.1946272504995, 765.2003656179306, 810.4934415990007, 893.2585953658448, 897.4929165021741, 911.1526280559011, 5133.6919784813035, 5646.774129034792, 5678.346990096109, 5771.480566749013, 5985.581009329305, 791.4657606115849, 963.5519483440233, 999.7950420163849, 1004.4073996342047, 1024.9692509224735, 3607.296577167427, 3607.494950706903, 3693.5041308270193, 3722.274156539449, 3867.323218436762, 8478.872816907751, 10013.349132306377, 10061.949690251648, 10086.193104551618, 10159.644412445528, 9582.185514231369, 9975.052370024836, 9994.500274986221, 9996.400215987063, 9997.450140242356, 7630.847383052308, 7760.495567788075, 7761.72833950809, 7778.222177782177, 7794.22057794216, 5062.443131255485, 5308.548773354308, 5455.399906010415, 5468.890622187454, 5620.213170156263, 8804.955975220082, 9078.81842363136, 9178.449293042439, 9295.30285228624, 9394.812103758024, 9198.54007299619, 9310.72067837966, 9371.203447706748, 9396.436213827192, 9490.478023708487, 7098.538594991515, 7238.384737297389, 7242.203357630762, 7248.311410416002, 7249.565026098451, 7565.659545320364, 7751.186125456971, 7811.2188781123705, 7821.061472623094, 7833.725819596515, 7027.7188912442925, 7045.436365090883, 7090.220075791762, 7092.858142837217, 7111.324424179695, 5816.36020037804, 6906.723731050702, 6934.930650693428, 6943.895841562279, 7054.717811287491, 6205.944989351911, 6226.875462490815, 6320.873582528416, 6341.0805433212845, 6342.207224096988, 4800.615950724004, 4874.171390863491, 4929.186684197068, 4992.301077849177, 5117.360329958755, 4261.829526819017, 4744.596709279612, 4948.164222114985, 5009.098362294676, 5104.285400044071], "value": 4395.165464614583, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.57391456320374, 341.4144594435042, 352.1706381471634, 369.2651623269694, 371.44654464847383, 4882.951170488294, 5063.341765570471, 5192.5067118623765, 5340.1722732976405, 5376.381716102649, 5151.278820965068, 5226.5557427618605, 5258.0, 5304.151335786275, 5321.760520776565, 4046.9680231541065, 4081.244969680604, 4150.43969064177, 4195.370694395834, 4198.8320467181275, 3930.4497370368026, 4068.5524592294823, 4194.601512856289, 4226.957730422687, 4230.957690423103, 3875.4380614810834, 4099.118689481761, 4117.835286588533, 4162.0, 4176.540580536139, 3857.614238576148, 3916.686665066788, 4087.0804069084516, 4141.337386018237, 4159.480064991876, 3671.6695497405362, 3678.1356381250384, 3701.6668499835146, 3704.4258139988074, 3710.443433484999, 4740.762961851894, 5052.823151189691, 5099.6685215460875, 5190.273361729361, 5248.422673505911, 4344.695871288979, 4549.749763762991, 4556.134334476439, 4607.285870690049, 4640.466346370177, 4922.793915490692, 5292.814751483679, 5473.698946557938, 5507.394186639466, 5535.197396377543, 3208.7753857230005, 3562.946555801665, 3766.246750649881, 3790.275424681791, 3848.4612154298143, 4958.652894297401, 5650.180723795068, 5653.802116925888, 5929.8814023719715, 5940.435658612425, 3917.0207448137967, 3930.7838068906485, 3933.1347103637154, 3934.8622798201927, 3948.7235893487755, 3283.983580082132, 3772.7170462215445, 3867.1924691515337, 3970.7220494565104, 3977.7016723745833, 4525.660575456854, 4564.543545645409, 4568.908621827545, 4624.44506659203, 4629.282461218517, 4555.8086560364545, 4699.154152252559, 5365.141577347684, 5501.587380946445, 5667.574931880043, 1182.3092977042738, 1188.3523479703583, 1205.9517619295304, 1218.4638758946035, 1228.9815652765217, 730.4886579394445, 739.4692985519922, 792.3502727763179, 841.6717480182733, 844.4004756622867, 4617.376654151713, 4677.6257899367965, 4800.591949684246, 4872.97667489824, 5051.747412629354, 4547.499775024745, 5005.27423523587, 5364.970601876066, 5479.780808767684, 5485.61600687948, 4408.581184787504, 4561.5823613484245, 4580.992181720017, 4849.515048495122, 4880.901797095625, 2620.0436840553443, 2726.05950946923, 2780.582912563091, 2820.13985734353, 2822.4214036122544, 4774.0, 4949.3869475283245, 5217.035053359398, 5286.880740363127, 5573.916391254134, 5136.917849290396, 5541.750621221974, 5823.505002074787, 5959.880802384015, 5980.55145864062, 4935.16102262609, 5367.865803354869, 5952.672603006789, 5957.778655375724, 6002.4897883679505, 5368.2752828367675, 5679.716014199191, 5755.165501002415, 5759.65442073477, 5824.213731146241, 5379.08555545566, 5657.0, 5669.31968163823, 5680.261565996394, 5680.488756011979, 5013.24801279811, 5368.61815004369, 5768.94231057684, 5922.585419020627, 6069.787557435468, 3685.7788532688123, 3867.7485963412287, 3877.526539914927, 3882.9805850970565, 3911.4915061041884, 4849.927251091166, 5716.714164291852, 5755.740991655469, 5761.798337058183, 5766.279215098113, 5383.273258110105, 5553.528679737478, 5575.598884680423, 5616.410276920865, 5669.6314739541795, 4705.5059218781535, 4771.423431347033, 4783.736894470699, 4973.229149481836, 5139.203423469368, 4437.356583295339, 4894.681845680162, 5318.946810531846, 5361.410244873139, 5452.863678408072, 5016.949830501649, 5494.5054945055135, 5529.253550770594, 5608.8878222434505, 5642.153676948491, 4349.978250108729, 4873.853784386474, 5022.372203474566, 5190.97404512975, 5296.285001524899], "value": 4032.405997130278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.601796975724, 710.4742490556989, 738.5347231244315, 815.9592020398981, 825.6573521988373, 14628.4880029199, 14902.254887255634, 15627.609309767247, 15710.0, 15745.527634170992, 13853.792193117111, 14106.435742570311, 14297.71404571908, 14545.563633090998, 14602.853971460283, 849.1847826086948, 860.2129051917487, 862.3316929379719, 863.9870401943975, 868.9087645797196, 672.4519516593961, 695.4366962760155, 836.9539675317855, 863.818598094401, 865.1953683074738, 815.3640160674684, 905.1401168889548, 911.5032307392487, 913.3195769151991, 914.1544071733653, 905.6694306578117, 908.309684639672, 909.122696597783, 909.3907082254905, 913.2785099771173, 518.1269560790043, 535.2800483349888, 667.4993754683987, 671.0, 671.9529632925697, 14483.275836208148, 15029.699406011929, 15058.472953446686, 15366.462173823862, 15369.385224591115, 12501.0, 14342.42630294787, 14414.13515189092, 14547.709045819025, 14554.272286385743, 11295.943520282428, 11424.828627570592, 11812.940935295355, 11829.408529573488, 12045.63863084109, 3535.5934067582302, 3731.5149030626117, 3769.5866288613583, 3853.133045064866, 3855.9614403855885, 99046.51430228552, 104294.43558346554, 107080.46459767652, 110494.0, 110715.0, 8820.955895220482, 10486.423246721504, 10506.264561480775, 10594.841077383846, 10895.509702063426, 22879.771202287764, 22931.050860676696, 23501.177458789203, 23506.412339691302, 23985.0, 7475.215102414277, 7574.962125189339, 7720.227977202235, 7790.5325680459355, 7833.138354780969, 4201.34879093741, 4257.638100761408, 4260.723053001545, 4441.400410944481, 4465.977670111629, 3504.56192975878, 3552.0942159749097, 3566.732495062881, 3643.981780091083, 3655.738770124303, 649.7303618998158, 654.2084078265257, 656.5601047298226, 657.5299057276422, 672.4049216443483, 669.9497537684693, 677.2719326723792, 682.1916029505053, 688.2738710660201, 729.7774178875388, 9020.323475739346, 9952.253580981456, 10106.747331316776, 10129.493525323851, 10164.542595583216, 665.2017578905333, 687.3744892148121, 698.6820996446604, 701.1656129206228, 703.1772825793834, 4464.732116073046, 4976.925346119811, 4997.3253610762085, 5009.44896061433, 5013.649044566918, 109321.0, 109570.45214773875, 110368.79262414867, 110455.0, 114983.700325993, 94090.0, 95885.0, 97431.51284243533, 98645.0, 100678.98642027265, 67691.0, 68640.97038544426, 69779.30220697829, 73904.0, 76310.23689763031, 10175.440350780482, 10687.366070759645, 10777.299475534066, 10797.62208322705, 10992.505337259683, 49200.50799491959, 49766.004679906924, 49776.25335619896, 51105.722356941376, 52060.95878082493, 70695.0, 71862.64068679832, 72042.63978680073, 72120.0, 73476.26523734909, 12438.81341779856, 12692.873071269169, 13008.349582521025, 13121.803172952605, 13175.14361566495, 13502.189868607915, 14239.216843073731, 14348.49780257686, 14833.629159271104, 14997.925010374878, 12778.872211277769, 13061.673458163243, 13523.459061637817, 13570.117942333716, 13592.592222233348, 13017.0, 13206.867931320949, 13463.596092117252, 13671.86328136706, 13695.0, 12212.938935305267, 13176.0, 13310.534131305358, 13398.129121607064, 13539.86460135386, 10519.737006574896, 11127.443627818415, 11133.888661113286, 11176.0, 11343.489542970421, 9826.312158148861, 10196.788011776267, 10873.891261087289, 11001.1749118818, 11055.502502387251], "value": 7528.952590259308, "unit": "score"}], "name": "dromaeo_css", "value": 7264.549899656451, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 112.0, 111.0, 111.0, 113.0, 111.0, 112.0, 113.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 119.0, 133.0, 124.0, 142.0, 139.0, 136.0, 127.0, 108.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 186.0, 183.0, 184.0, 185.0, 180.0, 183.0, 182.0, 184.0, 181.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 90.0, 59.0, 61.0, 60.0, 59.0, 74.0, 59.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 85.0, 70.0, 68.0, 69.0, 81.0, 68.0, 69.0, 82.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 85.0, 87.0, 84.0, 88.0, 86.0, 87.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 110.0, 165.0, 162.0, 96.0, 98.0, 99.0, 99.0, 97.0, 98.0], "value": 112.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 87.0, 85.0, 87.0, 86.0, 88.0, 87.0, 87.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 55.0, 57.0, 56.0, 57.0, 56.0, 56.0, 57.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 76.0, 72.0, 72.0, 67.0, 68.0, 68.0, 68.0, 68.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 73.0, 80.0, 97.0, 101.0, 97.0, 83.0, 84.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 137.0, 136.0, 136.0, 140.0, 142.0, 141.0, 185.0, 151.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 196.0, 229.0, 183.0, 168.0, 168.0, 166.0, 167.0, 226.0, 178.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 63.0, 65.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1455.4, "alertThreshold": 2.0}]} 09:48:01 INFO - Return code: 0 09:48:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:48:01 ERROR - # TBPL SUCCESS # 09:48:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:48:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:48:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:48:01 INFO - 2017-02-19 09:48:01.316 screenresolution[1666:14477] starting screenresolution argv=screenresolution get 09:48:01 INFO - 2017-02-19 09:48:01.319 screenresolution[1666:14477] Display 0: 1600x1200x32@60 09:48:01 INFO - 2017-02-19 09:48:01.325 screenresolution[1667:14480] starting screenresolution argv=screenresolution list 09:48:01 INFO - Available Modes on Display 0 09:48:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:48:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:48:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:48:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:48:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:48:01 INFO - Intel Iris: 09:48:01 INFO - Chipset Model: Intel Iris 09:48:01 INFO - Type: GPU 09:48:01 INFO - Bus: Built-In 09:48:01 INFO - VRAM (Dynamic, Max): 1536 MB 09:48:01 INFO - Vendor: Intel (0x8086) 09:48:01 INFO - Device ID: 0x0a2e 09:48:01 INFO - Revision ID: 0x0009 09:48:01 INFO - Displays: 09:48:01 INFO - Display: 09:48:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:48:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:48:01 INFO - Display Serial Number: 1600x1200 60 09:48:01 INFO - Main Display: Yes 09:48:01 INFO - Mirror: Off 09:48:01 INFO - Online: Yes 09:48:01 INFO - Rotation: Supported 09:48:01 INFO - Return code: 0 09:48:01 INFO - Running post-action listener: _resource_record_post_action 09:48:01 INFO - [mozharness: 2017-02-19 17:48:01.559839Z] Finished run-tests step (success) 09:48:01 INFO - Running post-run listener: _resource_record_post_run 09:48:01 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 33217536; Write bytes: 512227328; Read time: 200; Write time: 1682 09:48:01 INFO - TinderboxPrint: CPU usage
53.4% 09:48:01 INFO - TinderboxPrint: I/O read bytes / time
33,217,536 / 200 09:48:01 INFO - TinderboxPrint: I/O write bytes / time
512,227,328 / 1,682 09:48:01 INFO - TinderboxPrint: CPU idle
2,233.7 (46.6%) 09:48:01 INFO - TinderboxPrint: CPU system
952.3 (19.8%) 09:48:01 INFO - TinderboxPrint: CPU user
1,611.8 (33.6%) 09:48:01 INFO - TinderboxPrint: Swap in / out
236,638,208 / 0 09:48:01 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206391808; Write bytes: 200837120; Read time: 15759; Write time: 459 09:48:01 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 28953600; Write bytes: 300294144; Read time: 169; Write time: 1186 09:48:02 INFO - Running post-run listener: _upload_blobber_files 09:48:02 INFO - Blob upload gear active. 09:48:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:48:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:48:02 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'] 09:48:02 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 09:48:02 INFO - (blobuploader) - INFO - Open directory for files ... 09:48:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:48:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:48:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:03 INFO - (blobuploader) - INFO - Done attempting. 09:48:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:48:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:48:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:04 INFO - (blobuploader) - INFO - Done attempting. 09:48:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:48:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:48:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:05 INFO - (blobuploader) - INFO - Done attempting. 09:48:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:48:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:48:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:08 INFO - (blobuploader) - INFO - Done attempting. 09:48:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:48:08 INFO - Return code: 0 09:48:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:48:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:48:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c38b13da7f1342632c5ac849ad29ebbe6cae4ba69708cf9f5458709e06af9e975e6132f94fcc20b0f64f94769450037e46e8279dcf4cf8194222c0ae91c9540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bd8e5c5ae9ba9f898cccbe19b54e62abb8f87e2a0bd84dc7332f87773711189dd26047613f7ee6d46d55a2ed5a75546831e611a71fcdfd356223a5694032bb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f52acf666acf47a7dc1e4d61ef46e2dc79c44b32644b100f904ffa50ebbbc96163ebbed45ec5e7ab283ff9d8ca09cd375b7e9441bc9eefefc70477a1b8b99e95", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5688bda83db71149dda0b5a1dc0992c42f189f50f0379d98e0d38362fe04c868d94f4d720b868f3dab47d81956db4e3abdc7725ef4da502e27d7cec56093491a"} 09:48:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:48:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:48:08 INFO - Contents: 09:48:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c38b13da7f1342632c5ac849ad29ebbe6cae4ba69708cf9f5458709e06af9e975e6132f94fcc20b0f64f94769450037e46e8279dcf4cf8194222c0ae91c9540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bd8e5c5ae9ba9f898cccbe19b54e62abb8f87e2a0bd84dc7332f87773711189dd26047613f7ee6d46d55a2ed5a75546831e611a71fcdfd356223a5694032bb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f52acf666acf47a7dc1e4d61ef46e2dc79c44b32644b100f904ffa50ebbbc96163ebbed45ec5e7ab283ff9d8ca09cd375b7e9441bc9eefefc70477a1b8b99e95", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5688bda83db71149dda0b5a1dc0992c42f189f50f0379d98e0d38362fe04c868d94f4d720b868f3dab47d81956db4e3abdc7725ef4da502e27d7cec56093491a"} 09:48:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:48:08 INFO - Copying logs to upload dir... 09:48:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:48:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.074482 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-19 09:48:08.284747) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-19 09:48:08.288022) ========= 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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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/9c38b13da7f1342632c5ac849ad29ebbe6cae4ba69708cf9f5458709e06af9e975e6132f94fcc20b0f64f94769450037e46e8279dcf4cf8194222c0ae91c9540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bd8e5c5ae9ba9f898cccbe19b54e62abb8f87e2a0bd84dc7332f87773711189dd26047613f7ee6d46d55a2ed5a75546831e611a71fcdfd356223a5694032bb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f52acf666acf47a7dc1e4d61ef46e2dc79c44b32644b100f904ffa50ebbbc96163ebbed45ec5e7ab283ff9d8ca09cd375b7e9441bc9eefefc70477a1b8b99e95", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5688bda83db71149dda0b5a1dc0992c42f189f50f0379d98e0d38362fe04c868d94f4d720b868f3dab47d81956db4e3abdc7725ef4da502e27d7cec56093491a"} build_url:https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011073 build_url: 'https://queue.taskcluster.net/v1/task/Zjw2Lr60R_ybtJ_P0-SnEw/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/9c38b13da7f1342632c5ac849ad29ebbe6cae4ba69708cf9f5458709e06af9e975e6132f94fcc20b0f64f94769450037e46e8279dcf4cf8194222c0ae91c9540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bd8e5c5ae9ba9f898cccbe19b54e62abb8f87e2a0bd84dc7332f87773711189dd26047613f7ee6d46d55a2ed5a75546831e611a71fcdfd356223a5694032bb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f52acf666acf47a7dc1e4d61ef46e2dc79c44b32644b100f904ffa50ebbbc96163ebbed45ec5e7ab283ff9d8ca09cd375b7e9441bc9eefefc70477a1b8b99e95", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5688bda83db71149dda0b5a1dc0992c42f189f50f0379d98e0d38362fe04c868d94f4d720b868f3dab47d81956db4e3abdc7725ef4da502e27d7cec56093491a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-19 09:48:08.323498) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 09:48:08.323835) ========= 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.XPZ3RC5yOk/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.kQmakhwY4X/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.005153 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 09:48:08.372411) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-19 09:48:08.372748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-19 09:48:08.373068) ========= ========= Total master_lag: 0.24 =========