builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0100 starttime: 1486399903.56 results: success (0) buildid: 20170206072151 builduid: 38aa74bb32b54f2e8659bfdfde07dade revision: 9a1b79873db7526a0c9f33511e224a617af7ca6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:43.559451) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:43.559894) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:43.560167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:43.586661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:43.587038) ========= 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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-06 08:51:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.8M=0.001s 2017-02-06 08:51:43 (20.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126543 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:43.737721) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:43.738062) ========= 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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.026626 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:43.787282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 08:51:43.787657) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9a1b79873db7526a0c9f33511e224a617af7ca6b --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-beta --rev 9a1b79873db7526a0c9f33511e224a617af7ca6b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v4I59Uyboq/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.NxOKX2GGIZ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-06 08:51:43,885 truncating revision to first 12 chars 2017-02-06 08:51:43,885 Setting DEBUG logging. 2017-02-06 08:51:43,885 attempt 1/10 2017-02-06 08:51:43,886 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9a1b79873db7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 08:51:45,001 unpacking tar archive at: mozilla-beta-9a1b79873db7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.390984 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 08:51:45.202380) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:45.202697) ========= script_repo_revision: 9a1b79873db7526a0c9f33511e224a617af7ca6b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:45.203192) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:45.203474) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 08:51:45.223121) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-06 08:51:45.223524) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v4I59Uyboq/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.NxOKX2GGIZ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:51:45 INFO - MultiFileLogger online at 20170206 08:51:45 in /builds/slave/test 08:51:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:51:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:51:45 INFO - {'append_to_log': False, 08:51:45 INFO - 'base_work_dir': '/builds/slave/test', 08:51:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:51:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:51:45 INFO - 'branch': 'Mozilla-Beta', 08:51:45 INFO - 'buildbot_json_path': 'buildprops.json', 08:51:45 INFO - 'config_files': ('talos/mac_config.py',), 08:51:45 INFO - 'default_actions': ('clobber', 08:51:45 INFO - 'read-buildbot-config', 08:51:45 INFO - 'download-and-extract', 08:51:45 INFO - 'populate-webroot', 08:51:45 INFO - 'create-virtualenv', 08:51:45 INFO - 'install', 08:51:45 INFO - 'run-tests'), 08:51:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:51:45 INFO - 'download_minidump_stackwalk': True, 08:51:45 INFO - 'download_symbols': 'ondemand', 08:51:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:51:45 INFO - 'tooltool.py': '/tools/tooltool.py', 08:51:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:51:45 INFO - '/tools/misc-python/virtualenv.py')}, 08:51:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:51:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:51:45 INFO - 'installer_path': 'installer.exe', 08:51:45 INFO - 'log_level': 'info', 08:51:45 INFO - 'log_name': 'talos', 08:51:45 INFO - 'log_to_console': True, 08:51:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:51:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:51:45 INFO - 'opt_config_files': (), 08:51:45 INFO - 'pip_index': False, 08:51:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:51:45 INFO - 'cmd': ('bash', 08:51:45 INFO - '-c', 08:51:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:51:45 INFO - 'enabled': True, 08:51:45 INFO - 'halt_on_failure': False, 08:51:45 INFO - 'name': 'check_screen_resolution'},), 08:51:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:51:45 INFO - 'cmd': ('bash', 08:51:45 INFO - '-c', 08:51:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:51:45 INFO - 'enabled': True, 08:51:45 INFO - 'halt_on_failure': False, 08:51:45 INFO - 'name': 'check_screen_resolution'},), 08:51:45 INFO - 'run_cmd_checks_enabled': True, 08:51:45 INFO - 'sps_profile': False, 08:51:45 INFO - 'sps_profile_interval': 0, 08:51:45 INFO - 'suite': 'dromaeojs', 08:51:45 INFO - 'system_bits': '32', 08:51:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:51:45 INFO - 'title': 't-yosemite-r7-0100', 08:51:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:51:45 INFO - 'use_talos_json': True, 08:51:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:51:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:51:45 INFO - 'work_dir': 'build'} 08:51:45 INFO - [mozharness: 2017-02-06 16:51:45.441339Z] Running clobber step. 08:51:45 INFO - Running pre-action listener: _resource_record_pre_action 08:51:45 INFO - Running main action method: clobber 08:51:45 INFO - rmtree: /builds/slave/test/build 08:51:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:51:47 INFO - Running post-action listener: _resource_record_post_action 08:51:47 INFO - [mozharness: 2017-02-06 16:51:47.921562Z] Finished clobber step (success) 08:51:47 INFO - [mozharness: 2017-02-06 16:51:47.921701Z] Running read-buildbot-config step. 08:51:47 INFO - Running pre-action listener: _resource_record_pre_action 08:51:47 INFO - Running main action method: read_buildbot_config 08:51:47 INFO - Using buildbot properties: 08:51:47 INFO - { 08:51:47 INFO - "project": "", 08:51:47 INFO - "product": "firefox", 08:51:47 INFO - "script_repo_revision": "production", 08:51:47 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:51:47 INFO - "repository": "", 08:51:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:51:47 INFO - "buildid": "20170206072151", 08:51:47 INFO - "pgo_build": "False", 08:51:47 INFO - "basedir": "/builds/slave/test", 08:51:47 INFO - "buildnumber": 16, 08:51:47 INFO - "slavename": "t-yosemite-r7-0100", 08:51:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:51:47 INFO - "platform": "yosemite_r7", 08:51:47 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:51:47 INFO - "branch": "mozilla-beta", 08:51:47 INFO - "repo_path": "releases/mozilla-beta", 08:51:47 INFO - "revision": "9a1b79873db7526a0c9f33511e224a617af7ca6b", 08:51:47 INFO - "stage_platform": "macosx64", 08:51:47 INFO - "builduid": "38aa74bb32b54f2e8659bfdfde07dade", 08:51:47 INFO - "slavebuilddir": "test" 08:51:47 INFO - } 08:51:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 08:51:47 INFO - Running post-action listener: _resource_record_post_action 08:51:47 INFO - [mozharness: 2017-02-06 16:51:47.925033Z] Finished read-buildbot-config step (success) 08:51:47 INFO - [mozharness: 2017-02-06 16:51:47.925135Z] Running download-and-extract step. 08:51:47 INFO - Running pre-action listener: _resource_record_pre_action 08:51:47 INFO - Running main action method: download_and_extract 08:51:47 INFO - mkdir: /builds/slave/test/build/tests 08:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:47 INFO - trying https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 08:51:47 INFO - Downloading https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 08:51:50 INFO - Downloaded 1165 bytes. 08:51:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:51:50 INFO - Using the following test package requirements: 08:51:50 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:51:50 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:50 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 08:51:50 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:50 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 08:51:50 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:51:50 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:50 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 08:51:50 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:51:50 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:50 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 08:51:50 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:50 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 08:51:50 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:50 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 08:51:50 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:50 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 08:51:50 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 08:51:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:51:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:51:50 INFO - Fetch https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:51:51 INFO - Http code: 200 08:51:51 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 08:51:51 INFO - x-amz-cf-id: y8f3UHDkkRHUQw0J3QjFHV4MYxJn3XYqpHqOO5o0BA-q0aljzy-sPw== 08:51:51 INFO - x-amz-version-id: gbqqhiZiVpwt3olv9szNrzUtfTGtqalg 08:51:51 INFO - Expected file size: 16091751 08:51:51 INFO - Obtained file size: 16091751 08:51:58 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:51:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:51:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:51:58 INFO - Fetch https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:51:58 INFO - Http code: 200 08:51:58 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 08:51:58 INFO - x-amz-cf-id: yZZl5FiuhXCWJRDOzlPm0_OYUUgXBMm4a0aV8hCt8Nnedh0qhhacIQ== 08:51:58 INFO - x-amz-version-id: gbqqhiZiVpwt3olv9szNrzUtfTGtqalg 08:51:59 INFO - Expected file size: 16091751 08:51:59 INFO - Obtained file size: 16091751 08:52:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 08:52:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 08:52:05 INFO - Fetch https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 08:52:06 INFO - Http code: 200 08:52:06 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 08:52:06 INFO - x-amz-cf-id: naAMNKNNEVYNLa26cxWE-_Ws44nnek_c2nNCLNSuy380SCQivLSRrA== 08:52:06 INFO - x-amz-version-id: M5GIScAYX433l3AjxnNhzt_rlrtwneap 08:52:06 INFO - Expected file size: 14403005 08:52:06 INFO - Obtained file size: 14403005 08:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:07 INFO - trying https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:52:07 INFO - Downloading https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 08:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 08:52:09 INFO - Downloaded 82136117 bytes. 08:52:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:52:09 INFO - mkdir: /builds/slave/test/properties 08:52:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:52:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:52:09 INFO - Contents: 08:52:09 INFO - build_url:https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:52:10 INFO - Running post-action listener: _resource_record_post_action 08:52:10 INFO - Running post-action listener: set_extra_try_arguments 08:52:10 INFO - [mozharness: 2017-02-06 16:52:10.216571Z] Finished download-and-extract step (success) 08:52:10 INFO - [mozharness: 2017-02-06 16:52:10.216727Z] Running populate-webroot step. 08:52:10 INFO - Running pre-action listener: _resource_record_pre_action 08:52:10 INFO - Running main action method: populate_webroot 08:52:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:52:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:52:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:52:10 INFO - '--tppagecycles', 08:52:10 INFO - '7'], 08:52:10 INFO - 'tests': ['tsvgm']}}, 08:52:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:52:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:52:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:52:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:52:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:52:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:52:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:10 INFO - 'talos_options': ['--disable-e10s'], 08:52:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:10 INFO - 'talos_options': ['--disable-e10s'], 08:52:10 INFO - 'tests': ['damp', 'tps']}, 08:52:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:10 INFO - 'tests': ['damp', 'tps']}, 08:52:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:52:10 INFO - 'tests': ['dromaeo_dom']}, 08:52:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:52:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:52:10 INFO - 'tests': ['basic_compositor_video']}, 08:52:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:52:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:52:10 INFO - 'tests': ['a11yr', 08:52:10 INFO - 'ts_paint', 08:52:10 INFO - 'tpaint', 08:52:10 INFO - 'sessionrestore', 08:52:10 INFO - 'sessionrestore_no_auto_restore', 08:52:10 INFO - 'tabpaint']}, 08:52:10 INFO - 'other-e10s': {'tests': ['a11yr', 08:52:10 INFO - 'ts_paint', 08:52:10 INFO - 'tpaint', 08:52:10 INFO - 'sessionrestore', 08:52:10 INFO - 'sessionrestore_no_auto_restore', 08:52:10 INFO - 'tabpaint']}, 08:52:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:52:10 INFO - 'ts_paint', 08:52:10 INFO - 'tpaint', 08:52:10 INFO - 'sessionrestore', 08:52:10 INFO - 'sessionrestore_no_auto_restore', 08:52:10 INFO - 'tabpaint']}, 08:52:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:52:10 INFO - 'ts_paint', 08:52:10 INFO - 'tpaint', 08:52:10 INFO - 'sessionrestore', 08:52:10 INFO - 'sessionrestore_no_auto_restore', 08:52:10 INFO - 'tabpaint']}, 08:52:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:52:10 INFO - 'tests': ['a11yr', 08:52:10 INFO - 'ts_paint', 08:52:10 INFO - 'tpaint', 08:52:10 INFO - 'sessionrestore', 08:52:10 INFO - 'sessionrestore_no_auto_restore', 08:52:10 INFO - 'tabpaint']}, 08:52:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:52:10 INFO - 'tests': ['a11yr', 08:52:10 INFO - 'ts_paint', 08:52:10 INFO - 'tpaint', 08:52:10 INFO - 'sessionrestore', 08:52:10 INFO - 'sessionrestore_no_auto_restore', 08:52:10 INFO - 'tabpaint']}, 08:52:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:52:10 INFO - 'tests': ['tsvgx', 08:52:10 INFO - 'tsvgr_opacity', 08:52:10 INFO - 'tart', 08:52:10 INFO - 'tscrollx', 08:52:10 INFO - 'cart']}, 08:52:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:52:10 INFO - 'tsvgr_opacity', 08:52:10 INFO - 'tart', 08:52:10 INFO - 'tscrollx', 08:52:10 INFO - 'cart']}, 08:52:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:10 INFO - 'talos_options': ['--disable-e10s'], 08:52:10 INFO - 'tests': ['tp5o']}, 08:52:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:10 INFO - 'tests': ['tp5o']}, 08:52:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:10 INFO - 'talos_options': ['--disable-e10s', 08:52:10 INFO - '--xperf_path', 08:52:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:10 INFO - 'tests': ['tp5n']}, 08:52:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:10 INFO - 'talos_options': ['--xperf_path', 08:52:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:10 INFO - 'tests': ['tp5n']}}, 08:52:10 INFO - 'talos.zip': {'path': '', 08:52:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:52:10 INFO - Running post-action listener: _resource_record_post_action 08:52:10 INFO - [mozharness: 2017-02-06 16:52:10.235547Z] Finished populate-webroot step (success) 08:52:10 INFO - [mozharness: 2017-02-06 16:52:10.235678Z] Running create-virtualenv step. 08:52:10 INFO - Running pre-action listener: _resource_record_pre_action 08:52:10 INFO - Running main action method: create_virtualenv 08:52:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:52:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:52:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:52:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:52:10 INFO - Using real prefix '/tools/python27' 08:52:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:52:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:52:13 INFO - Installing pip.................done. 08:52:13 INFO - Return code: 0 08:52:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:52:14 INFO - Reading from file tmpfile_stdout 08:52:14 INFO - Output received: 08:52:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:52:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:14 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 0x10e90d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e883570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc42b4deb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e721d30>, '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 0x10e587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e719b20>, '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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:52:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I59Uyboq/Render', 08:52:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:14 INFO - 'HOME': '/Users/cltbld', 08:52:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:14 INFO - 'LOGNAME': 'cltbld', 08:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:14 INFO - 'MOZ_NO_REMOTE': '1', 08:52:14 INFO - 'NO_EM_RESTART': '1', 08:52:14 INFO - 'PAGER': '/bin/cat', 08:52:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:14 INFO - 'PWD': '/builds/slave/test', 08:52:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:14 INFO - 'SHELL': '/bin/bash', 08:52:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NxOKX2GGIZ/Listeners', 08:52:14 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:52:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:14 INFO - 'USER': 'cltbld', 08:52:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:14 INFO - 'XPC_FLAGS': '0x0', 08:52:14 INFO - 'XPC_SERVICE_NAME': '0', 08:52:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:52:14 INFO - Cleaning up... 08:52:14 INFO - Return code: 0 08:52:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:14 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 0x10e90d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e883570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc42b4deb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e721d30>, '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 0x10e587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e719b20>, '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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:52:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I59Uyboq/Render', 08:52:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:14 INFO - 'HOME': '/Users/cltbld', 08:52:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:14 INFO - 'LOGNAME': 'cltbld', 08:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:14 INFO - 'MOZ_NO_REMOTE': '1', 08:52:14 INFO - 'NO_EM_RESTART': '1', 08:52:14 INFO - 'PAGER': '/bin/cat', 08:52:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:14 INFO - 'PWD': '/builds/slave/test', 08:52:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:14 INFO - 'SHELL': '/bin/bash', 08:52:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NxOKX2GGIZ/Listeners', 08:52:14 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:52:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:14 INFO - 'USER': 'cltbld', 08:52:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:14 INFO - 'XPC_FLAGS': '0x0', 08:52:14 INFO - 'XPC_SERVICE_NAME': '0', 08:52:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:14 INFO - Downloading/unpacking psutil>=3.1.1 08:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:52:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:18 INFO - Installing collected packages: psutil 08:52:18 INFO - Running setup.py install for psutil 08:52:18 INFO - building 'psutil._psutil_osx' extension 08:52:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:52:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:52:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:52:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:52:19 INFO - building 'psutil._psutil_posix' extension 08:52:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:52:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:52:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:52:19 INFO - ^ 08:52:19 INFO - 1 warning generated. 08:52:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:52:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:19 INFO - Successfully installed psutil 08:52:19 INFO - Cleaning up... 08:52:19 INFO - Return code: 0 08:52:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:19 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 0x10e90d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e883570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc42b4deb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e721d30>, '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 0x10e587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e719b20>, '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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:52:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I59Uyboq/Render', 08:52:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:19 INFO - 'HOME': '/Users/cltbld', 08:52:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:19 INFO - 'LOGNAME': 'cltbld', 08:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:19 INFO - 'MOZ_NO_REMOTE': '1', 08:52:19 INFO - 'NO_EM_RESTART': '1', 08:52:19 INFO - 'PAGER': '/bin/cat', 08:52:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:19 INFO - 'PWD': '/builds/slave/test', 08:52:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:19 INFO - 'SHELL': '/bin/bash', 08:52:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NxOKX2GGIZ/Listeners', 08:52:19 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:52:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:19 INFO - 'USER': 'cltbld', 08:52:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:19 INFO - 'XPC_FLAGS': '0x0', 08:52:19 INFO - 'XPC_SERVICE_NAME': '0', 08:52:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:52:22 INFO - Installing collected packages: mozsystemmonitor 08:52:22 INFO - Running setup.py install for mozsystemmonitor 08:52:22 INFO - Successfully installed mozsystemmonitor 08:52:22 INFO - Cleaning up... 08:52:22 INFO - Return code: 0 08:52:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:22 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 0x10e90d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e883570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc42b4deb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e721d30>, '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 0x10e587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e719b20>, '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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:52:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I59Uyboq/Render', 08:52:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:22 INFO - 'HOME': '/Users/cltbld', 08:52:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:22 INFO - 'LOGNAME': 'cltbld', 08:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:22 INFO - 'MOZ_NO_REMOTE': '1', 08:52:22 INFO - 'NO_EM_RESTART': '1', 08:52:22 INFO - 'PAGER': '/bin/cat', 08:52:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:22 INFO - 'PWD': '/builds/slave/test', 08:52:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:22 INFO - 'SHELL': '/bin/bash', 08:52:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NxOKX2GGIZ/Listeners', 08:52:22 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:52:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:22 INFO - 'USER': 'cltbld', 08:52:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:22 INFO - 'XPC_FLAGS': '0x0', 08:52:22 INFO - 'XPC_SERVICE_NAME': '0', 08:52:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:25 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:26 INFO - warning: no files found matching '*.txt' 08:52:26 INFO - no previously-included directories found matching 'build' 08:52:26 INFO - no previously-included directories found matching 'dist' 08:52:26 INFO - no previously-included directories found matching '.git*' 08:52:26 INFO - Installing collected packages: jsonschema, functools32 08:52:26 INFO - Running setup.py install for functools32 08:52:26 INFO - warning: no files found matching '*.txt' 08:52:26 INFO - no previously-included directories found matching 'build' 08:52:26 INFO - no previously-included directories found matching 'dist' 08:52:26 INFO - no previously-included directories found matching '.git*' 08:52:26 INFO - Successfully installed jsonschema functools32 08:52:26 INFO - Cleaning up... 08:52:26 INFO - Return code: 0 08:52:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:26 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 0x10e90d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e883570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc42b4deb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e721d30>, '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 0x10e587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e719b20>, '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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:52:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I59Uyboq/Render', 08:52:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:26 INFO - 'HOME': '/Users/cltbld', 08:52:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:26 INFO - 'LOGNAME': 'cltbld', 08:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:26 INFO - 'MOZ_NO_REMOTE': '1', 08:52:26 INFO - 'NO_EM_RESTART': '1', 08:52:26 INFO - 'PAGER': '/bin/cat', 08:52:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:26 INFO - 'PWD': '/builds/slave/test', 08:52:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:26 INFO - 'SHELL': '/bin/bash', 08:52:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NxOKX2GGIZ/Listeners', 08:52:26 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:52:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:26 INFO - 'USER': 'cltbld', 08:52:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:26 INFO - 'XPC_FLAGS': '0x0', 08:52:26 INFO - 'XPC_SERVICE_NAME': '0', 08:52:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:52:26 INFO - Cleaning up... 08:52:26 INFO - Return code: 0 08:52:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:26 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 0x10e90d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e883570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc42b4deb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e721d30>, '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 0x10e587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e719b20>, '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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:52:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I59Uyboq/Render', 08:52:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:26 INFO - 'HOME': '/Users/cltbld', 08:52:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:26 INFO - 'LOGNAME': 'cltbld', 08:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:26 INFO - 'MOZ_NO_REMOTE': '1', 08:52:26 INFO - 'NO_EM_RESTART': '1', 08:52:26 INFO - 'PAGER': '/bin/cat', 08:52:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:26 INFO - 'PWD': '/builds/slave/test', 08:52:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:26 INFO - 'SHELL': '/bin/bash', 08:52:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NxOKX2GGIZ/Listeners', 08:52:26 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:52:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:26 INFO - 'USER': 'cltbld', 08:52:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:26 INFO - 'XPC_FLAGS': '0x0', 08:52:26 INFO - 'XPC_SERVICE_NAME': '0', 08:52:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:29 INFO - Downloading blobuploader-1.2.4.tar.gz 08:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:52:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:52:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:30 INFO - Downloading docopt-0.6.1.tar.gz 08:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:52:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:52:30 INFO - Running setup.py install for blobuploader 08:52:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:52:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:52:30 INFO - Running setup.py install for requests 08:52:31 INFO - Running setup.py install for docopt 08:52:31 INFO - Successfully installed blobuploader requests docopt 08:52:31 INFO - Cleaning up... 08:52:31 INFO - Return code: 0 08:52:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:31 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 0x10e90d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e883570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc42b4deb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e721d30>, '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 0x10e587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e719b20>, '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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I59Uyboq/Render', 08:52:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:31 INFO - 'HOME': '/Users/cltbld', 08:52:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:31 INFO - 'LOGNAME': 'cltbld', 08:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:31 INFO - 'MOZ_NO_REMOTE': '1', 08:52:31 INFO - 'NO_EM_RESTART': '1', 08:52:31 INFO - 'PAGER': '/bin/cat', 08:52:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:31 INFO - 'PWD': '/builds/slave/test', 08:52:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:31 INFO - 'SHELL': '/bin/bash', 08:52:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NxOKX2GGIZ/Listeners', 08:52:31 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:52:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:31 INFO - 'USER': 'cltbld', 08:52:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:31 INFO - 'XPC_FLAGS': '0x0', 08:52:31 INFO - 'XPC_SERVICE_NAME': '0', 08:52:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-dlHNmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-syxhUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Rtsoue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-crJVp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-7jjbgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Gt1hig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-b33xKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-02l9QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-mTQJlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-xQKwGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-kbATt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-SQep0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-PfcSw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-oYlBlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-MSNHqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Jnrj3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-TjFC4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:52:33 INFO - Running setup.py install for manifestparser 08:52:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:52:33 INFO - Running setup.py install for mozcrash 08:52:34 INFO - Running setup.py install for mozdebug 08:52:34 INFO - Running setup.py install for mozdevice 08:52:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:52:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:52:34 INFO - Running setup.py install for mozfile 08:52:34 INFO - Running setup.py install for mozhttpd 08:52:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:52:34 INFO - Running setup.py install for mozinfo 08:52:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:52:34 INFO - Running setup.py install for mozInstall 08:52:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:52:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:52:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:52:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:52:34 INFO - Running setup.py install for mozleak 08:52:35 INFO - Running setup.py install for mozlog 08:52:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:52:35 INFO - Running setup.py install for moznetwork 08:52:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:52:35 INFO - Running setup.py install for mozprocess 08:52:35 INFO - Running setup.py install for mozprofile 08:52:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:52:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:52:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:52:35 INFO - Running setup.py install for mozrunner 08:52:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:52:35 INFO - Running setup.py install for mozscreenshot 08:52:36 INFO - Running setup.py install for moztest 08:52:36 INFO - Running setup.py install for mozversion 08:52:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:52:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:52:36 INFO - Cleaning up... 08:52:36 INFO - Return code: 0 08:52:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:36 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 0x10e90d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e883570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc42b4deb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e721d30>, '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 0x10e587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e719b20>, '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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I59Uyboq/Render', 08:52:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:36 INFO - 'HOME': '/Users/cltbld', 08:52:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:36 INFO - 'LOGNAME': 'cltbld', 08:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:36 INFO - 'MOZ_NO_REMOTE': '1', 08:52:36 INFO - 'NO_EM_RESTART': '1', 08:52:36 INFO - 'PAGER': '/bin/cat', 08:52:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:36 INFO - 'PWD': '/builds/slave/test', 08:52:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:36 INFO - 'SHELL': '/bin/bash', 08:52:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NxOKX2GGIZ/Listeners', 08:52:36 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:52:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:36 INFO - 'USER': 'cltbld', 08:52:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:36 INFO - 'XPC_FLAGS': '0x0', 08:52:36 INFO - 'XPC_SERVICE_NAME': '0', 08:52:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-DWVP3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-xbDxe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-5y2qWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-xM51b8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-nzQLDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-WrJy5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-kRZIMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-uIQtbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-7tR5WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-b03vvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-9dJ_Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-MYenHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-qyiIte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:38 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-VaxSsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:38 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-DVXZa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:38 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-DsDsp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:38 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-2cdAO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:52:38 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:38 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:41 INFO - Downloading blessings-1.6.tar.gz 08:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:52:41 INFO - Installing collected packages: blessings 08:52:41 INFO - Running setup.py install for blessings 08:52:41 INFO - Successfully installed blessings 08:52:41 INFO - Cleaning up... 08:52:41 INFO - Return code: 0 08:52:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:41 INFO - Reading from file tmpfile_stdout 08:52:41 INFO - Current package versions: 08:52:41 INFO - blessings == 1.6 08:52:41 INFO - blobuploader == 1.2.4 08:52:41 INFO - docopt == 0.6.1 08:52:41 INFO - functools32 == 3.2.3-2 08:52:41 INFO - jsonschema == 2.5.1 08:52:41 INFO - manifestparser == 1.1 08:52:41 INFO - mozInstall == 1.12 08:52:41 INFO - mozcrash == 1.0 08:52:41 INFO - mozdebug == 0.1 08:52:41 INFO - mozdevice == 0.48 08:52:41 INFO - mozfile == 1.2 08:52:41 INFO - mozhttpd == 0.7 08:52:41 INFO - mozinfo == 0.9 08:52:41 INFO - mozleak == 0.1 08:52:41 INFO - mozlog == 3.4 08:52:41 INFO - moznetwork == 0.27 08:52:41 INFO - mozprocess == 0.23 08:52:41 INFO - mozprofile == 0.28 08:52:41 INFO - mozrunner == 6.13 08:52:41 INFO - mozscreenshot == 0.1 08:52:41 INFO - mozsystemmonitor == 0.3 08:52:41 INFO - moztest == 0.8 08:52:41 INFO - mozversion == 1.4 08:52:41 INFO - psutil == 3.1.1 08:52:41 INFO - requests == 1.2.3 08:52:41 INFO - wsgiref == 0.1.2 08:52:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:42 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 0x10e90d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e883570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc42b4deb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e721d30>, '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 0x10e587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e719b20>, '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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I59Uyboq/Render', 08:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:42 INFO - 'HOME': '/Users/cltbld', 08:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:42 INFO - 'LOGNAME': 'cltbld', 08:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:42 INFO - 'MOZ_NO_REMOTE': '1', 08:52:42 INFO - 'NO_EM_RESTART': '1', 08:52:42 INFO - 'PAGER': '/bin/cat', 08:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:42 INFO - 'PWD': '/builds/slave/test', 08:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:42 INFO - 'SHELL': '/bin/bash', 08:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NxOKX2GGIZ/Listeners', 08:52:42 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:42 INFO - 'USER': 'cltbld', 08:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:42 INFO - 'XPC_FLAGS': '0x0', 08:52:42 INFO - 'XPC_SERVICE_NAME': '0', 08:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:52:42 INFO - Cleaning up... 08:52:42 INFO - Return code: 0 08:52:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e90d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e883570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc42b4deb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e721d30>, '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 0x10e587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e719b20>, '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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:52:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I59Uyboq/Render', 08:52:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:43 INFO - 'HOME': '/Users/cltbld', 08:52:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:43 INFO - 'LOGNAME': 'cltbld', 08:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:43 INFO - 'MOZ_NO_REMOTE': '1', 08:52:43 INFO - 'NO_EM_RESTART': '1', 08:52:43 INFO - 'PAGER': '/bin/cat', 08:52:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:43 INFO - 'PWD': '/builds/slave/test', 08:52:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:43 INFO - 'SHELL': '/bin/bash', 08:52:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NxOKX2GGIZ/Listeners', 08:52:43 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:52:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:43 INFO - 'USER': 'cltbld', 08:52:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:43 INFO - 'XPC_FLAGS': '0x0', 08:52:43 INFO - 'XPC_SERVICE_NAME': '0', 08:52:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:52:43 INFO - Cleaning up... 08:52:43 INFO - Return code: 0 08:52:43 INFO - Running post-action listener: _resource_record_post_action 08:52:43 INFO - Running post-action listener: _start_resource_monitoring 08:52:43 INFO - Starting resource monitoring. 08:52:43 INFO - [mozharness: 2017-02-06 16:52:43.554911Z] Finished create-virtualenv step (success) 08:52:43 INFO - [mozharness: 2017-02-06 16:52:43.555958Z] Running install step. 08:52:43 INFO - Running pre-action listener: _resource_record_pre_action 08:52:43 INFO - Running main action method: install 08:52:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:43 INFO - Reading from file tmpfile_stdout 08:52:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:52:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:52:43 INFO - Reading from file tmpfile_stdout 08:52:43 INFO - Output received: 08:52:43 INFO - Usage: mozinstall [options] installer 08:52:43 INFO - Options: 08:52:43 INFO - -h, --help show this help message and exit 08:52:43 INFO - -d DEST, --destination=DEST 08:52:43 INFO - Directory to install application into. [default: 08:52:43 INFO - "/builds/slave/test"] 08:52:43 INFO - --app=APP Application being installed. [default: firefox] 08:52:43 INFO - mkdir: /builds/slave/test/build/application 08:52:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:53:05 INFO - Reading from file tmpfile_stdout 08:53:05 INFO - Output received: 08:53:05 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:53:05 INFO - Running post-action listener: _resource_record_post_action 08:53:05 INFO - [mozharness: 2017-02-06 16:53:05.248966Z] Finished install step (success) 08:53:05 INFO - [mozharness: 2017-02-06 16:53:05.249109Z] Running run-tests step. 08:53:05 INFO - Running pre-action listener: _resource_record_pre_action 08:53:05 INFO - Running main action method: run_tests 08:53:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:53:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:53:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:53:05 INFO - 2017-02-06 08:53:05.263 screenresolution[1623:7269] starting screenresolution argv=screenresolution get 08:53:05 INFO - 2017-02-06 08:53:05.266 screenresolution[1623:7269] Display 0: 1600x1200x32@60 08:53:05 INFO - 2017-02-06 08:53:05.271 screenresolution[1624:7272] starting screenresolution argv=screenresolution list 08:53:05 INFO - Available Modes on Display 0 08:53:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:53:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:53:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:53:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:53:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:53:05 INFO - Intel Iris: 08:53:05 INFO - Chipset Model: Intel Iris 08:53:05 INFO - Type: GPU 08:53:05 INFO - Bus: Built-In 08:53:05 INFO - VRAM (Dynamic, Max): 1536 MB 08:53:05 INFO - Vendor: Intel (0x8086) 08:53:05 INFO - Device ID: 0x0a2e 08:53:05 INFO - Revision ID: 0x0009 08:53:05 INFO - Displays: 08:53:05 INFO - Display: 08:53:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:53:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:53:05 INFO - Display Serial Number: 1600x1200 60 08:53:05 INFO - Main Display: Yes 08:53:05 INFO - Mirror: Off 08:53:05 INFO - Online: Yes 08:53:05 INFO - Rotation: Supported 08:53:05 INFO - Return code: 0 08:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:53:05 INFO - Python 2.7.3 08:53:05 INFO - Return code: 0 08:53:05 INFO - grabbing minidump binary from tooltool 08:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:05 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 0x10e721d30>, '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 0x10e587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e719b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:53:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:53:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:53:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:53:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:53:05 INFO - Return code: 0 08:53:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:53:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:53:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:53:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:53:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:53:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I59Uyboq/Render', 08:53:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:05 INFO - 'HOME': '/Users/cltbld', 08:53:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:05 INFO - 'LOGNAME': 'cltbld', 08:53:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:53:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:05 INFO - 'MOZ_NO_REMOTE': '1', 08:53:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:53:05 INFO - 'NO_EM_RESTART': '1', 08:53:05 INFO - 'PAGER': '/bin/cat', 08:53:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:05 INFO - 'PWD': '/builds/slave/test', 08:53:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:53:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:05 INFO - 'SHELL': '/bin/bash', 08:53:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NxOKX2GGIZ/Listeners', 08:53:05 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:53:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:05 INFO - 'USER': 'cltbld', 08:53:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:05 INFO - 'XPC_FLAGS': '0x0', 08:53:05 INFO - 'XPC_SERVICE_NAME': '0', 08:53:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:53:05 INFO - mozversion application_buildid: 20170206072151 08:53:05 INFO - mozversion application_changeset: 9a1b79873db7526a0c9f33511e224a617af7ca6b 08:53:05 INFO - mozversion application_display_name: Firefox 08:53:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:53:05 INFO - mozversion application_name: Firefox 08:53:05 INFO - mozversion application_remotingname: firefox 08:53:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:53:05 INFO - mozversion application_vendor: Mozilla 08:53:05 INFO - mozversion application_version: 52.0 08:53:05 INFO - mozversion platform_buildid: 20170206072151 08:53:05 INFO - mozversion platform_changeset: 9a1b79873db7526a0c9f33511e224a617af7ca6b 08:53:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:53:05 INFO - mozversion platform_version: 52.0 08:53:05 INFO - using testdate: 1486399985 08:53:05 INFO - actual date: 1486399985 08:53:05 INFO - starting webserver on 'localhost:49246' 08:53:05 INFO - SUITE-START | Running 2 tests 08:53:05 INFO - TEST-START | dromaeo_css 08:53:05 INFO - operating with platform_type : mac_ 08:53:05 INFO - Initialising browser for dromaeo_css test... 08:53:05 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpOLeJU1/profile http://localhost:49246/getInfo.html) 08:53:08 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 08:53:08 INFO - PROCESS | 1634 | colorDepth:24 08:53:08 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 08:53:08 INFO - PROCESS | 1634 | __metrics 08:53:08 INFO - PROCESS | 1634 | 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" 08:53:08 INFO - PROCESS | 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:53:09 INFO - TEST-INFO | 1634: exit 0 08:53:09 INFO - Browser initialized. 08:53:09 INFO - Running cycle 1/1 for dromaeo_css test... 08:53:09 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpOLeJU1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:21 INFO - PROCESS | 1637 | RSS: Main: 168062976 08:53:21 INFO - PROCESS | 1637 | 08:56:25 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 08:56:26 INFO - PROCESS | 1637 | RSS: Main: 275001344 08:56:26 INFO - PROCESS | 1637 | 08:59:29 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 08:59:29 INFO - PROCESS | 1637 | RSS: Main: 298094592 08:59:29 INFO - PROCESS | 1637 | 09:02:32 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 09:02:32 INFO - PROCESS | 1637 | RSS: Main: 267034624 09:02:32 INFO - PROCESS | 1637 | 09:05:35 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 09:05:35 INFO - PROCESS | 1637 | RSS: Main: 264851456 09:05:35 INFO - PROCESS | 1637 | 09:08:38 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 09:08:39 INFO - PROCESS | 1637 | RSS: Main: 256487424 09:08:39 INFO - PROCESS | 1637 | 09:11:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 09:11:43 INFO - PROCESS | 1637 | RSS: Main: 375549952 09:11:43 INFO - PROCESS | 1637 | 09:11:43 INFO - PROCESS | 1637 | __start_tp_report 09:11:43 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 09:11:43 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 09:11:43 INFO - PROCESS | 1637 | |i|pagename|runs| 09:11:43 INFO - PROCESS | 1637 | |0;dojo.html;3502.894913152605;3518.8064656443903;3533.858645654173;3550.7159427245824;3587.1390866192105;5762.481376676098;5827.941720582793;5831.650100993933;5834.620749651281;5842.883142337156;4805.20714082176;5715.514181294595;5762.423757624236;5852.092925596528;5855.765769369231;4123.958760412387;5166.147585648373;5261.552768014723;5282.7358632068435;5318.095923692981;5239.921401178985;5266.5786737061135;5267.947320526784;5279.287296215;5365.892682146355;5300.337457817773;5347.7058761768085;5348.759305831247;5369.62412631116;5400.891982160354;5334.333208348957;5337.759800808973;5345.1982202669715;5355.169948657965;5394.1908713692865;5157.638965272395;5179.9381126869275;5218.13900706383;5275.446078161776;5293.4971177738435;5732.512736417368;5740.052891272935;5753.165790960287;5835.416458354173;5845.678487683176;6289.308176100625;6312.873742525124;6319.6524191169465;6328.430441260309;6375.71309291083;6225.284092329395;6319.5576309658345;6327.303996560375;6328.71520781566;6343.016832390987;5756.625819321731;5868.853278668067;5924.851878703067;5937.881242375129;5965.731542080617;6337.9366206337345;6366.045093236052;6388.39310265524;6390.392912673288;6390.680465976682;6112.877742445126;6247.031710084944;6275.623462592168;6300.842478938063;6308.526860485482;6280.654563999024;6290.402411770874;6328.398802113792;6333.493320534346;6338.239411270677;6311.589746666452;6323.7786677466065;6326.240851097898;6332.018537126753;6337.493000559944;6309.621422714652;6326.145970294044;6357.904631430532;6367.076773867763;6385.457236134887;4932.630052746058;4999.47505511916;5002.024605201951;5005.374328208974;5043.218301163325;4539.477960034572;4543.454785425704;4557.020240648277;4599.701019433793;4632.189366860786;5405.594545418219;5911.231539899872;5931.673757943355;5938.8218353449465;5942.494887934574;5887.911681324784;6217.564770466114;6232.184697121222;6291.653959032297;6302.086197501337;5845.123231515222;5871.442212989759;5873.060310350324;5873.2658417697785;5970.462658360769;5445.482679145475;5501.669899806025;5505.834824955257;5506.8072617459;5530.446955304518;6241.126242326169;6484.157059582319;6501.414872661483;6504.869902602016;6505.41451269388;4745.833895813768;6224.782132625336;6287.402696743802;6313.40022697843;6322.810315690536;6405.743770249138;6430.935690643221;6443.065755465525;6447.548671592944;6452.193475815523;6334.303226645157;6335.556511044183;6337.7781777637565;6345.302016778243;6365.172527571572;6172.783952561639;6270.9339412299105;6274.811755647338;6283.937160628335;6318.589291696025;6052.939470605237;6249.687515624291;6261.592996455216;6265;6268.216472940882;6037.879242415039;6236.407541283571;6243.96878015607;6244.718987645476;6255.812325630239;4731.243001119942;5753.626014309057;6036.909446358396;6075.574709770273;6076.605020673642;6204.503639708722;6242.094896240111;6255.311915689362;6258.249010118815;6264.154339164154;5916.763329466773;6104.633721976696;6114.602550834182;6124.510039196764;6140.258857967636 09:11:43 INFO - PROCESS | 1637 | |1;ext.html;476.8068932082507;488.6042305732357;489.23434824499634;503.5543543963592;590.044128511811;28668.856655716718;41185;42308;42374.57625423745;42401.575984240146;43098.78450607743;43647.90880227988;43682.563174368246;43684;43709.34435983455;8830.161134692195;9441.150296473315;9648.95175524123;9862.506874656274;9907.603695852158;9756.268279879003;9855.950720246388;9886.912439631635;9889.75275618108;9892.901070989306;9828.852567211461;9883.50582470877;9896.257780666443;9899.752506187331;9900.356476828983;9793.167580755644;9858.359206651616;9865.457399843006;9870.161036311922;9904.108630223242;9715.514224288829;9788.021197880225;9792.804143917154;9817.656382026666;9825.852612210823;40939.59060409388;41261;41306.38040429396;41308.38037429441;41371;3347.681970212826;3372.7470439716876;3414.4195486767308;3490.1449144959647;3891.630295121959;29360.706392936012;29884;30879.536806947915;32397.190070248198;32527.861524846518;3155.8106513609027;3338.4992251162275;3360.798352098882;3419.863205471803;3454.222799870034;473381;477148;479090;479748;480675;56453.43546564482;56707;59875.80248395008;59983.70008150019;60034.09948850771;62969;63090;63105.684471578264;63118.73762524724;63120.68439657772;14705.485308014167;16952.57618559521;16957.576060598585;16960.660786784196;16969.321227150776;13119.868801312055;13169.078164528582;13190;13195.20828750278;13225.206487610581;15942.043477391393;16499.927504712155;16576.419825306057;16615.83384166167;16618.58453538647;6974.58152510851;6999.895001574981;7050.964745176241;7139.500234983501;7144.392726618192;697.5605368617738;732.684830728843;741.3439106390883;821.9219174178444;1063.8510608514814;24431;24506.264812055666;28893.71106288952;30327.375773695418;30815.69184308173;1002.734275417015;1089.5206109311878;1094.162965331522;1102.873169585492;1114.4984756859446;15236.542903712907;15639.296231669603;15672.764908526382;15799.520287827212;15863.12752798584;606246;610770.1922355841;612366;613907;614308;58451.70774146102;58466.83066338649;58790.11814822781;58895.822083558945;58959.99999999914;1411.788231765223;1419.1626940105386;1440.9927950360182;1441.8125643666467;1448.3192899337294;24216.63675044911;25950.87024564865;29817.403651926405;30167.849160754056;32325.51511727279;56528.717356412955;57226.42773572211;57290.713546432;57324.14013789713;57435;586074;592470;592763.0361848163;592835;593438;25665.615015774405;26745.86627066852;26752.732472675023;26760.464790704467;26768.33079173036;47364;47734.76132619315;47984.520154798;48045;48854;38814.61185388223;38953;39083.2183356337;39468.013299667735;40986.79506602448;36753.63246367502;39109.804450977565;39145.825625231286;40139;40424.79787601043;37407.251854963295;37787.62212377841;38987.41518877276;39336;39418.40872386974;32361.866133846335;34389.14027149241;34817.651823482454;34864.47703284503;34894.30211395809;25713.742862571136;25818;26080.478390432465;26185.73814261833;26482.470350592495 09:11:43 INFO - PROCESS | 1637 | |2;jquery.html;361.95837478689924;367.71134659292454;382.16687620986255;385.79360042377317;412.23530351198525;15478.303476343563;15958.122303273316;18245.543861403454;20444.8977755111;20547.589048219026;17885;18209.27162913485;18336.808107473003;18374.908125459388;20982;5860.267466566679;5896.88206235875;6145.139680444719;6158.230221222348;6166.784162554289;6053.848653783647;6203.689815509229;6221.0979407985815;6232.158658581102;6233.470155036827;4438.733675979435;5820.505257053155;6186.257649082094;6190.3190649028575;6194.721237544321;6014.488768454665;6064.151018857319;6074.96962515189;6076.908846367308;6080.817575472743;5130.794768209267;5245.475452454724;5308.8141915033175;5348.064088784486;5359.196120581905;26079.217623471326;26126;26132.954681812895;26222.34444138912;26375.47249055008;2129.903099903551;2961.6742158362563;3044.756419486436;3094.300600564766;3171.904842854718;6930.826729331757;6936.34104760047;6941.930580694229;6947.3747362737095;7310.342069213796;1794.8474379677743;1831.9725204121949;1866.7479890214784;1910.0831600831539;1938.6413513500047;107953.46023269833;115004;115424;116316.41841790822;116556.41721791337;10863.945680271549;10957.83563246552;11017.173711971634;11303.361012653118;11334.546618135182;14187.14877107377;14206.573802785933;14223.715525689428;14225.14649121056;14248;8637.827243455222;8750.47497150173;8763.386562940534;8785.428947118544;8881.644734210558;8797.560121993874;8839.513826739463;8840.381173317935;8981.640734370552;8993.775155621162;5605.66366018032;5736.741846616912;6774.45804335652;6803.761868334684;6812.182538095361;1868.579569596857;1906;1906.6262503183625;1914.4830895658372;1916.5208697825544;849;894.7807787092204;978.83849164887;997.6109317366233;1027.41950797799;21320.680189797167;22345.776542234693;22481.775182248297;22485.32544023682;23743;852.5694524265207;953.2040745977048;998.2114129837347;1002.4686915934566;1025.5333823110616;10866.511007004703;11317.547298108148;11904.345261010554;11941.701457463632;12057.397130143458;506687;620086;632778;634798;637813;106480.99999999846;122607.77392225963;123675.3816230913;125169;125251.37374313253;1012.4178597306578;1015.8933312002133;1041.3335465302212;1042.3693665332364;1042.718466014172;19206.327778527684;19928.302509412682;20216;20237.19051237934;20247.898760506105;53974;54581;55033.34233126323;56705.432945671666;57568;79842.6007869957;83352.58208216446;83704.16295836963;83706;86684.56657716671;7136.4290856730295;7233.891491627524;7250.274972502708;7591.089069311718;7974.920250797418;10617.734556636145;12967.768062034093;13065.673358166121;13215.669608259486;13664.521741738992;11379.260348077349;11518.136139789716;11555.306681599131;11607.6517704469;11858.051355891335;11120.221584489009;11286.717832054264;11369.31784092957;11609.535618575163;11669.35818529989;10468.319559228627;10850.023497885228;10860.185486088732;11526.654200373667;11535.884641153816;7116.857662846817;7400.555966642019;7520.247975202436;7777.222277772177;7887.501374738781;10205.795884082425;10325;10437.634682786065;11683.766324673628;11863.703407414883 09:11:43 INFO - PROCESS | 1637 | |3;mootools.html;1359.6125104345263;1494.708531836292;1527.404312318196;1676.2959556986066;1833.9358122465717;7723.343515801156;8143.674253029879;8415.747527574174;8631.48211107334;8647.0488246293;8512.319014478842;8596.914030859689;8601.870971935426;8606.311495080394;8617;2222.1777942161343;2365.763423657629;2395.2694428199393;2395.73646898841;2397.4485868250313;2233.140241007208;2374.81001519878;2437.8293519453646;2440.5240978009206;2449.9265022049276;2375.9168429104984;2383.2969274064108;2402.9158979435724;2408.6868707068143;2409.662647229389;2359.6106642403984;2369.7511761265077;2395.4490467192645;2397.3646983549374;2403.615421532555;1962.3229985654925;2356.32844639277;2397.4725560376687;2401.807855371566;2403.579373609611;8400.243978042006;8512.233898949062;8589.141085891424;8631.870521942175;8643.654253829902;5187;5366.785328586851;5369.865753356158;5369.892602147975;5389.622726409153;3489;3615.5842078161086;3654.305681920453;3695.0392897846755;3708.9814550927344;1079.2499213046935;1102.2229328323592;1109.0295991007868;1130.2032067392468;1132.8867113288688;11218.046466050395;11255.493502792395;11336.603218887381;11345.602903898407;11361.488733007034;4330.870073897788;4538.183127037165;4610.654200934943;4613.792379342871;4618.1918164321105;8955.865662015074;8962.73111806647;8966.282697384193;8971.282297416192;8973.50645714479;5163.7676304566385;5240.895182096413;5254.6847189168775;5257.737113144328;5260.000599886086;4402.559744025636;4430.556944305544;4853.490383509751;4858.02839432115;4934.7285899275885;3704;3738.980950286869;3784.829682664287;3848.037990502374;3852.7303088783515;1169.4037638623388;1175.3183153770792;1175.4710380328886;1183.5384200161943;1188.3107797477442;816.3591580609193;868.70898249086;889.1242126505387;893.2318206342541;903.1600611431431;5566.248556444909;5640.294963129609;5740.827775166752;5825.3883342248455;5952.821415357546;933.7852293972288;948.4214629076258;948.5494390164616;953.1278879825021;997.3118548201862;3567.7324200685052;3595.442706380515;3680;3689.94465083024;3753.793541355252;10024.348417352849;10397.428141452292;10512.3692578444;10513.632022879163;10518.474076296154;10464.529096190538;10465.895341046493;10471.267011309288;10486.895131048745;10487.895121048845;7999.480033797785;8133.471324364015;8150.4294699370475;8153.429259951865;8183.181681831888;4808.447028591757;5213.947860521346;5381;5528.19841123043;5577;9496.905030949601;9521.428714277166;9601.807963840545;9661.178799801814;9669.371490853073;9703.805923881624;9713.368631039242;9777.120059194422;9800.411975281506;9840.261980351646;6445.484361251182;6639.03733958583;6771;6912.135983002125;7050.400715939202;8101;8275;8279.37904657141;8288.088310285984;8288.254057134887;6254.21822272216;7151.53515021522;7265.9273407267365;7281.890771638324;7357.742479013209;7014;7163.462740294603;7163.892541611775;7225.963870180615;7287.1984081752025;6640.83397915056;6641.203055633355;6723.899141512783;6725.260221375547;6727.966360168168;4730.385049943486;4736.100140973204;4772.832950846704;4788.928166077581;4807.591354734747;4727.149113159527;4739.265413860857;4744.644151688706;4924.089043526959;4990.401151861654 09:11:43 INFO - PROCESS | 1637 | |4;prototype.html;269.5565794268428;311.58870291215607;315.7963113791605;321.2659074015874;323.8170433704955;5077.5684066854365;5253.003858533762;5253.947460525398;5283.709395983225;5333.986542556911;4726.574608285254;5082.872928176797;5173.793048278074;5194.194899790529;5305.840824775263;3369.9326013479717;4118.711690181688;4122.50529936408;4133.111381053073;4142.606452387018;3624.8187590620496;4113.992071942378;4117.649999750025;4169.958300417003;4180.205760905418;4009.095679552204;4043.2722110020186;4091.6112969267874;4092.3043082676018;4096.5903409659095;3550.751447398683;4055.1889622075705;4056.707960002589;4074.694397920168;4077.734947228421;3577.2308953575107;3607.567091948983;3625.492431059654;3630.981845090758;3636.818159092035;4854.378635536806;4872.490667306304;5170.043541944752;5181.792728290864;5236.738163091868;4063.728698397789;4494.393256910308;4611.861644150681;4618.284165954249;4648.954934517897;5518.862028449281;5521.199426083195;5524.58565607581;5536.584756143306;5544.251526043973;3121.406932682783;3763.8708387483643;3918.45141680165;3946.934327731525;3958.524977002778;5761.84763047388;5771.961047011536;5775.971120144372;5780.485488812338;5781.913271300934;3974.682025437958;3995.300822356076;3999.34010888206;4011.8997025074023;4025.2150830587752;3910.2179564087296;4036.616521430459;4044.656204222615;4062.679629120548;4070.715049946475;4604.102200070954;4612.930806037912;4623.815047398134;4632.652551058617;4636.003259299267;4598.793054312564;5464.426235245322;5547;5574.324324324347;5622.690752008597;1064.622059168984;1067.900062935178;1160.6750109969053;1204.3978010994504;1281.5450515067203;801.4910531812341;852.5481494807761;887.9788243520004;922.9030951750104;936.2650319499161;4341.283688191413;4474.731516109044;4890.657653964188;4890.877728056827;4893.556400861683;4447.799094244536;5049.924251136236;5081.695098294041;5298.682079075268;5367.63823917475;4673.4744707347445;4841.668541151141;4857.2071059141135;4859.489753575895;4868.902621947612;2731.5629499280417;2750.944981100367;2754.4628797384717;2790.693023767384;2790.916272511828;5055.747212639353;5203.531682148625;5361.946380536145;5368.221607866915;5390.51485366319;4658.732377491125;4783.784729687172;5027.731974216788;5166.044281807803;5482.643628164236;4525.479569849444;4716.575508204278;5267.947320526822;5439.129739241703;5522.834314970477;4698.765061746967;4919.868430260988;4970.826021089245;4988.077205716954;5128.8461346159675;4800.687955282895;4825.9034819304115;5180.559652429586;5291.23277124807;5529.4470552944385;5569.8024924641395;5847.94152058474;5883.235179426818;5893.9685555026845;5954.98765209924;3470;3489.581250249986;3931.7981930119226;3953.2686453006286;4041.009952561641;5410.48600382963;5480.6437581557075;5616.550675945833;5709.429057094258;5710.400407957105;5395.489263006364;5432.320959880015;5446.039425806785;5451;5466.644668096561;4884.9511504884495;5342.572594192377;5362.624616276979;5547.472990065938;5592.636478628876;4679.157751604744;5282.415275417283;5453.736699269917;5465.289512363367;5469.835904922858;4837.612990960785;5475.917861232005;5533.750981205936;5535.595608700701;5539.446055394428;4605.907881842411;5430.6198566101575;5440.204732438365;5446.564274857923;5459.945400546103 09:11:43 INFO - PROCESS | 1637 | |5;yui.html;710.0698085507985;730.3536370312272;771.7106085218044;794.3327604811958;829.2205326992627;14610.56168314951;15670.373185072584;15674.843251567481;15717.13555754433;15740.370385184578;11957.581484648039;14117.929410352934;14251.643708907282;14275.4289828407;14295.356708948097;684.1243208692881;689.6965335252473;846.496334680867;861.8922634670666;876.2332958661171;874.3791907745508;874.4534665833854;876.128252388874;876.2726936642572;878.7803049237691;911.3256190419075;911.6945823149252;911.8541033434652;913.1507697841005;919.3748251189189;907.7775944893543;910.2172131966504;911.4713466189594;911.8221946720392;914.0585197246813;683.4293365040197;683.6240067962601;685.0409426802466;685.5201359048685;686.807693845724;12029.819552706716;13933.721325573533;13970.580882573538;14152.646183845383;14415.135091894519;13077.542286019943;13887.611238876032;14261.001729878913;14588.489402870848;14730.631734206623;11680.299182049104;11733.882661173364;11817.763644727058;11826.763464730657;11918.81644487402;3851.8651847185492;3914.15845593196;3954.307996100671;3962.1679447316096;4048.291548978946;88666.11333886643;90091;94024;95512.52243738806;96214;10411.479426028669;10839;10917.017468427879;10946.288491248044;11061.502232399562;19575.510612234524;20172.495687607632;20812;20929;20938.267160649306;8001.839963200703;8084.595770211466;8175.509469431734;8345.582720863933;8436.957815211008;4305.397244385788;4471.463424389094;4529.909401811945;4594.931076033862;4601.263797792337;3509.7192224621967;3634.4548317752547;3635.818209089535;3641.417373220272;3641.4901913732097;665.434380776346;668.3750693101965;669.7086767256259;679.1849780263703;687.3641881259815;598.8981873081586;670.8356452669127;675.5748355835865;687.1582311668167;693.4937495628119;8637.827243455096;8766.38635295536;9342.95328523353;9347.439153650803;9684.95157524208;612.4182027074297;622.4677900395187;634.6065439427584;648.5265755998054;702.6030292884606;4505.864824055284;4670.1827180244;4673.112108699336;4708.8116475341285;4814.229723244334;93302.60046099314;95245.61885952907;106652.66736663136;118303;125759;58953.70523147357;60926.39073609207;69239;79982;102102;59226.70386648039;76168.97102758325;78424.2157578417;80902.59548702337;81519;7995.560244186393;8953.28373730087;9209.907900921173;9363.4381937084;9460.621575137193;51986.66060027232;53600.73199633977;53665.7316713414;54557.454425456825;56872.146917795435;54568.727156363966;78537.60731196307;78944;80044.19955800367;80239;12055.21641093326;12261.38693065361;12525.248485090924;12584.937075314565;12953.417096230503;13450.730985380433;13641.522546710818;14429.855701443272;14558.12651240929;15343.46297879569;13099.541516046893;13662.521811736542;13968.790468142783;14068.366923488264;14294.785578216128;13197;13487.39306731219;13664.111832731238;14026.368813403216;14776.926115369355;12197.817032744693;12832.165909215872;13000.739985200433;13148.868511314764;13532.86467135316;11180.496877640688;11259.943700281447;11424.200305978502;11564.47959841826;11760.411979401168;11319.703526836856;11432.314061156358;11524.193306468467;11567.537298507965;11592.536298547964 09:11:43 INFO - PROCESS | 1637 | __end_tp_report 09:11:43 INFO - PROCESS | 1637 | __start_cc_report 09:11:43 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1247 09:11:43 INFO - PROCESS | 1637 | __end_cc_report 09:11:43 INFO - PROCESS | 1637 | __startTimestamp1486401103085__endTimestamp 09:11:43 INFO - PROCESS | 1637 | 09:11:43 INFO - PROCESS | 1637 | ------- Summary: start ------- 09:11:43 INFO - PROCESS | 1637 | Number of tests: 6 09:11:43 INFO - PROCESS | 1637 | 09:11:43 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5819.50 Median:6052.94 stddev:657.49 (10.9%) stddev-sans-first:633.89 09:11:43 INFO - PROCESS | 1637 | Values: 3502.9 3518.8 3533.9 3550.7 3587.1 5762.5 5827.9 5831.7 5834.6 5842.9 4805.2 5715.5 5762.4 5852.1 5855.8 4124.0 5166.1 5261.6 5282.7 5318.1 5239.9 5266.6 5267.9 5279.3 5365.9 5300.3 5347.7 5348.8 5369.6 5400.9 5334.3 5337.8 5345.2 5355.2 5394.2 5157.6 5179.9 5218.1 5275.4 5293.5 5732.5 5740.1 5753.2 5835.4 5845.7 6289.3 6312.9 6319.7 6328.4 6375.7 6225.3 6319.6 6327.3 6328.7 6343.0 5756.6 5868.9 5924.9 5937.9 5965.7 6337.9 6366.0 6388.4 6390.4 6390.7 6112.9 6247.0 6275.6 6300.8 6308.5 6280.7 6290.4 6328.4 6333.5 6338.2 6311.6 6323.8 6326.2 6332.0 6337.5 6309.6 6326.1 6357.9 6367.1 6385.5 4932.6 4999.5 5002.0 5005.4 5043.2 4539.5 4543.5 4557.0 4599.7 4632.2 5405.6 5911.2 5931.7 5938.8 5942.5 5887.9 6217.6 6232.2 6291.7 6302.1 5845.1 5871.4 5873.1 5873.3 5970.5 5445.5 5501.7 5505.8 5506.8 5530.4 6241.1 6484.2 6501.4 6504.9 6505.4 4745.8 6224.8 6287.4 6313.4 6322.8 6405.7 6430.9 6443.1 6447.5 6452.2 6334.3 6335.6 6337.8 6345.3 6365.2 6172.8 6270.9 6274.8 6283.9 6318.6 6052.9 6249.7 6261.6 6265.0 6268.2 6037.9 6236.4 6244.0 6244.7 6255.8 4731.2 5753.6 6036.9 6075.6 6076.6 6204.5 6242.1 6255.3 6258.2 6264.2 5916.8 6104.6 6114.6 6124.5 6140.3 09:11:43 INFO - PROCESS | 1637 | 09:11:43 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:69738.01 Median:41307.38 stddev:150429.13 (364.2%) stddev-sans-first:150761.24 09:11:43 INFO - PROCESS | 1637 | Values: 476.8 488.6 489.2 503.6 590.0 28668.9 41185.0 42308.0 42374.6 42401.6 43098.8 43647.9 43682.6 43684.0 43709.3 8830.2 9441.2 9649.0 9862.5 9907.6 9756.3 9856.0 9886.9 9889.8 9892.9 9828.9 9883.5 9896.3 9899.8 9900.4 9793.2 9858.4 9865.5 9870.2 9904.1 9715.5 9788.0 9792.8 9817.7 9825.9 40939.6 41261.0 41306.4 41308.4 41371.0 3347.7 3372.7 3414.4 3490.1 3891.6 29360.7 29884.0 30879.5 32397.2 32527.9 3155.8 3338.5 3360.8 3419.9 3454.2 473381.0 477148.0 479090.0 479748.0 480675.0 56453.4 56707.0 59875.8 59983.7 60034.1 62969.0 63090.0 63105.7 63118.7 63120.7 14705.5 16952.6 16957.6 16960.7 16969.3 13119.9 13169.1 13190.0 13195.2 13225.2 15942.0 16499.9 16576.4 16615.8 16618.6 6974.6 6999.9 7051.0 7139.5 7144.4 697.6 732.7 741.3 821.9 1063.9 24431.0 24506.3 28893.7 30327.4 30815.7 1002.7 1089.5 1094.2 1102.9 1114.5 15236.5 15639.3 15672.8 15799.5 15863.1 606246.0 610770.2 612366.0 613907.0 614308.0 58451.7 58466.8 58790.1 58895.8 58960.0 1411.8 1419.2 1441.0 1441.8 1448.3 24216.6 25950.9 29817.4 30167.8 32325.5 56528.7 57226.4 57290.7 57324.1 57435.0 586074.0 592470.0 592763.0 592835.0 593438.0 25665.6 26745.9 26752.7 26760.5 26768.3 47364.0 47734.8 47984.5 48045.0 48854.0 38814.6 38953.0 39083.2 39468.0 40986.8 36753.6 39109.8 39145.8 40139.0 40424.8 37407.3 37787.6 38987.4 39336.0 39418.4 32361.9 34389.1 34817.7 34864.5 34894.3 25713.7 25818.0 26080.5 26185.7 26482.5 09:11:43 INFO - PROCESS | 1637 | 09:11:43 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:35160.26 Median:26129.48 stddev:101313.04 (387.7%) stddev-sans-first:101563.55 09:11:43 INFO - PROCESS | 1637 | Values: 362.0 367.7 382.2 385.8 412.2 15478.3 15958.1 18245.5 20444.9 20547.6 17885.0 18209.3 18336.8 18374.9 20982.0 5860.3 5896.9 6145.1 6158.2 6166.8 6053.8 6203.7 6221.1 6232.2 6233.5 4438.7 5820.5 6186.3 6190.3 6194.7 6014.5 6064.2 6075.0 6076.9 6080.8 5130.8 5245.5 5308.8 5348.1 5359.2 26079.2 26126.0 26133.0 26222.3 26375.5 2129.9 2961.7 3044.8 3094.3 3171.9 6930.8 6936.3 6941.9 6947.4 7310.3 1794.8 1832.0 1866.7 1910.1 1938.6 107953.5 115004.0 115424.0 116316.4 116556.4 10863.9 10957.8 11017.2 11303.4 11334.5 14187.1 14206.6 14223.7 14225.1 14248.0 8637.8 8750.5 8763.4 8785.4 8881.6 8797.6 8839.5 8840.4 8981.6 8993.8 5605.7 5736.7 6774.5 6803.8 6812.2 1868.6 1906.0 1906.6 1914.5 1916.5 849.0 894.8 978.8 997.6 1027.4 21320.7 22345.8 22481.8 22485.3 23743.0 852.6 953.2 998.2 1002.5 1025.5 10866.5 11317.5 11904.3 11941.7 12057.4 506687.0 620086.0 632778.0 634798.0 637813.0 106481.0 122607.8 123675.4 125169.0 125251.4 1012.4 1015.9 1041.3 1042.4 1042.7 19206.3 19928.3 20216.0 20237.2 20247.9 53974.0 54581.0 55033.3 56705.4 57568.0 79842.6 83352.6 83704.2 83706.0 86684.6 7136.4 7233.9 7250.3 7591.1 7974.9 10617.7 12967.8 13065.7 13215.7 13664.5 11379.3 11518.1 11555.3 11607.7 11858.1 11120.2 11286.7 11369.3 11609.5 11669.4 10468.3 10850.0 10860.2 11526.7 11535.9 7116.9 7400.6 7520.2 7777.2 7887.5 10205.8 10325.0 10437.6 11683.8 11863.7 09:11:43 INFO - PROCESS | 1637 | 09:11:43 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5529.43 Median:5077.08 stddev:3065.78 (60.4%) stddev-sans-first:3058.36 09:11:43 INFO - PROCESS | 1637 | Values: 1359.6 1494.7 1527.4 1676.3 1833.9 7723.3 8143.7 8415.7 8631.5 8647.0 8512.3 8596.9 8601.9 8606.3 8617.0 2222.2 2365.8 2395.3 2395.7 2397.4 2233.1 2374.8 2437.8 2440.5 2449.9 2375.9 2383.3 2402.9 2408.7 2409.7 2359.6 2369.8 2395.4 2397.4 2403.6 1962.3 2356.3 2397.5 2401.8 2403.6 8400.2 8512.2 8589.1 8631.9 8643.7 5187.0 5366.8 5369.9 5369.9 5389.6 3489.0 3615.6 3654.3 3695.0 3709.0 1079.2 1102.2 1109.0 1130.2 1132.9 11218.0 11255.5 11336.6 11345.6 11361.5 4330.9 4538.2 4610.7 4613.8 4618.2 8955.9 8962.7 8966.3 8971.3 8973.5 5163.8 5240.9 5254.7 5257.7 5260.0 4402.6 4430.6 4853.5 4858.0 4934.7 3704.0 3739.0 3784.8 3848.0 3852.7 1169.4 1175.3 1175.5 1183.5 1188.3 816.4 868.7 889.1 893.2 903.2 5566.2 5640.3 5740.8 5825.4 5952.8 933.8 948.4 948.5 953.1 997.3 3567.7 3595.4 3680.0 3689.9 3753.8 10024.3 10397.4 10512.4 10513.6 10518.5 10464.5 10465.9 10471.3 10486.9 10487.9 7999.5 8133.5 8150.4 8153.4 8183.2 4808.4 5213.9 5381.0 5528.2 5577.0 9496.9 9521.4 9601.8 9661.2 9669.4 9703.8 9713.4 9777.1 9800.4 9840.3 6445.5 6639.0 6771.0 6912.1 7050.4 8101.0 8275.0 8279.4 8288.1 8288.3 6254.2 7151.5 7265.9 7281.9 7357.7 7014.0 7163.5 7163.9 7226.0 7287.2 6640.8 6641.2 6723.9 6725.3 6728.0 4730.4 4736.1 4772.8 4788.9 4807.6 4727.1 4739.3 4744.6 4924.1 4990.4 09:11:43 INFO - PROCESS | 1637 | 09:11:43 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4434.76 Median:4870.70 stddev:1326.59 (27.2%) stddev-sans-first:1292.95 09:11:43 INFO - PROCESS | 1637 | Values: 269.6 311.6 315.8 321.3 323.8 5077.6 5253.0 5253.9 5283.7 5334.0 4726.6 5082.9 5173.8 5194.2 5305.8 3369.9 4118.7 4122.5 4133.1 4142.6 3624.8 4114.0 4117.6 4170.0 4180.2 4009.1 4043.3 4091.6 4092.3 4096.6 3550.8 4055.2 4056.7 4074.7 4077.7 3577.2 3607.6 3625.5 3631.0 3636.8 4854.4 4872.5 5170.0 5181.8 5236.7 4063.7 4494.4 4611.9 4618.3 4649.0 5518.9 5521.2 5524.6 5536.6 5544.3 3121.4 3763.9 3918.5 3946.9 3958.5 5761.8 5772.0 5776.0 5780.5 5781.9 3974.7 3995.3 3999.3 4011.9 4025.2 3910.2 4036.6 4044.7 4062.7 4070.7 4604.1 4612.9 4623.8 4632.7 4636.0 4598.8 5464.4 5547.0 5574.3 5622.7 1064.6 1067.9 1160.7 1204.4 1281.5 801.5 852.5 888.0 922.9 936.3 4341.3 4474.7 4890.7 4890.9 4893.6 4447.8 5049.9 5081.7 5298.7 5367.6 4673.5 4841.7 4857.2 4859.5 4868.9 2731.6 2750.9 2754.5 2790.7 2790.9 5055.7 5203.5 5361.9 5368.2 5390.5 4658.7 4783.8 5027.7 5166.0 5482.6 4525.5 4716.6 5267.9 5439.1 5522.8 4698.8 4919.9 4970.8 4988.1 5128.8 4800.7 4825.9 5180.6 5291.2 5529.4 5569.8 5847.9 5883.2 5894.0 5955.0 3470.0 3489.6 3931.8 3953.3 4041.0 5410.5 5480.6 5616.6 5709.4 5710.4 5395.5 5432.3 5446.0 5451.0 5466.6 4885.0 5342.6 5362.6 5547.5 5592.6 4679.2 5282.4 5453.7 5465.3 5469.8 4837.6 5475.9 5533.8 5535.6 5539.4 4605.9 5430.6 5440.2 5446.6 5459.9 09:11:43 INFO - PROCESS | 1637 | 09:11:43 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19981.51 Median:4671.65 stddev:28512.94 (610.3%) stddev-sans-first:28556.21 09:11:43 INFO - PROCESS | 1637 | Values: 710.1 730.4 771.7 794.3 829.2 14610.6 15670.4 15674.8 15717.1 15740.4 11957.6 14117.9 14251.6 14275.4 14295.4 684.1 689.7 846.5 861.9 876.2 874.4 874.5 876.1 876.3 878.8 911.3 911.7 911.9 913.2 919.4 907.8 910.2 911.5 911.8 914.1 683.4 683.6 685.0 685.5 686.8 12029.8 13933.7 13970.6 14152.6 14415.1 13077.5 13887.6 14261.0 14588.5 14730.6 11680.3 11733.9 11817.8 11826.8 11918.8 3851.9 3914.2 3954.3 3962.2 4048.3 88666.1 90091.0 94024.0 95512.5 96214.0 10411.5 10839.0 10917.0 10946.3 11061.5 19575.5 20172.5 20812.0 20929.0 20938.3 8001.8 8084.6 8175.5 8345.6 8437.0 4305.4 4471.5 4529.9 4594.9 4601.3 3509.7 3634.5 3635.8 3641.4 3641.5 665.4 668.4 669.7 679.2 687.4 598.9 670.8 675.6 687.2 693.5 8637.8 8766.4 9343.0 9347.4 9685.0 612.4 622.5 634.6 648.5 702.6 4505.9 4670.2 4673.1 4708.8 4814.2 93302.6 95245.6 106652.7 118303.0 125759.0 58953.7 60926.4 69239.0 79982.0 102102.0 59226.7 76169.0 78424.2 80902.6 81519.0 7995.6 8953.3 9209.9 9363.4 9460.6 51986.7 53600.7 53665.7 54557.5 56872.1 54568.7 78537.6 78944.0 80044.2 80239.0 12055.2 12261.4 12525.2 12584.9 12953.4 13450.7 13641.5 14429.9 14558.1 15343.5 13099.5 13662.5 13968.8 14068.4 14294.8 13197.0 13487.4 13664.1 14026.4 14776.9 12197.8 12832.2 13000.7 13148.9 13532.9 11180.5 11259.9 11424.2 11564.5 11760.4 11319.7 11432.3 11524.2 11567.5 11592.5 09:11:43 INFO - PROCESS | 1637 | -------- Summary: end -------- 09:11:43 INFO - PROCESS | 1637 | 09:11:43 INFO - TEST-INFO | 1637: exit 0 09:11:43 INFO - TEST-OK | dromaeo_css | took 1117843ms 09:11:43 INFO - TEST-START | kraken 09:11:43 INFO - operating with platform_type : mac_ 09:11:43 INFO - Initialising browser for kraken test... 09:11:43 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpI547ct/profile http://localhost:49246/getInfo.html) 09:11:46 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 09:11:46 INFO - PROCESS | 1646 | colorDepth:24 09:11:46 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 09:11:46 INFO - PROCESS | 1646 | __metrics 09:11:46 INFO - PROCESS | 1646 | 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:11:46 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:11:46 INFO - TEST-INFO | 1646: exit 0 09:11:46 INFO - Browser initialized. 09:11:46 INFO - Running cycle 1/1 for kraken test... 09:11:46 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpI547ct/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:58 INFO - PROCESS | 1648 | RSS: Main: 167743488 09:11:58 INFO - PROCESS | 1648 | 09:12:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 09:12:02 INFO - PROCESS | 1648 | RSS: Main: 217661440 09:12:02 INFO - PROCESS | 1648 | 09:12:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 09:12:05 INFO - PROCESS | 1648 | RSS: Main: 231088128 09:12:05 INFO - PROCESS | 1648 | 09:12:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 09:12:09 INFO - PROCESS | 1648 | RSS: Main: 328945664 09:12:09 INFO - PROCESS | 1648 | 09:12:11 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 09:12:12 INFO - PROCESS | 1648 | RSS: Main: 231473152 09:12:12 INFO - PROCESS | 1648 | 09:12:14 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:12:14 INFO - PROCESS | 1648 | RSS: Main: 233664512 09:12:14 INFO - PROCESS | 1648 | 09:12:17 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 09:12:18 INFO - PROCESS | 1648 | RSS: Main: 275431424 09:12:18 INFO - PROCESS | 1648 | 09:12:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 09:12:21 INFO - PROCESS | 1648 | RSS: Main: 272953344 09:12:21 INFO - PROCESS | 1648 | 09:12:24 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 09:12:25 INFO - PROCESS | 1648 | RSS: Main: 271974400 09:12:25 INFO - PROCESS | 1648 | 09:12:27 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:12:27 INFO - PROCESS | 1648 | RSS: Main: 246636544 09:12:27 INFO - PROCESS | 1648 | 09:12:29 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:12:30 INFO - PROCESS | 1648 | RSS: Main: 246636544 09:12:30 INFO - PROCESS | 1648 | 09:12:32 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:12:32 INFO - PROCESS | 1648 | RSS: Main: 254570496 09:12:32 INFO - PROCESS | 1648 | 09:12:35 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:12:36 INFO - PROCESS | 1648 | RSS: Main: 265261056 09:12:36 INFO - PROCESS | 1648 | 09:12:39 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:40 INFO - PROCESS | 1648 | RSS: Main: 263184384 09:12:40 INFO - PROCESS | 1648 | 09:12:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 09:12:41 INFO - PROCESS | 1648 | RSS: Main: 307466240 09:12:41 INFO - PROCESS | 1648 | 09:12:41 INFO - PROCESS | 1648 | __start_tp_report 09:12:42 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 09:12:42 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 09:12:42 INFO - PROCESS | 1648 | |i|pagename|runs| 09:12:42 INFO - PROCESS | 1648 | |0;ai-astar;104;112;113;112;114;112;113;112;114;114 09:12:42 INFO - PROCESS | 1648 | |1;audio-beat-detection;141;108;111;143;112;131;139;119;135;101 09:12:42 INFO - PROCESS | 1648 | |2;audio-dft;183;182;183;182;183;181;183;182;182;184 09:12:42 INFO - PROCESS | 1648 | |3;audio-fft;84;75;81;112;62;57;57;59;81;57 09:12:42 INFO - PROCESS | 1648 | |4;audio-oscillator;86;71;94;71;72;69;89;68;70;91 09:12:42 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;88;92;133;72;117;130;135;85;88;86 09:12:42 INFO - PROCESS | 1648 | |6;imaging-darkroom;109;128;141;110;92;93;93;94;92;93 09:12:42 INFO - PROCESS | 1648 | |7;imaging-desaturate;81;81;81;80;86;127;136;113;81;95 09:12:42 INFO - PROCESS | 1648 | |8;json-parse-financial;40;41;87;83;86;88;86;59;55;55 09:12:42 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;62;70;71;74;69;69;69;68;68;68 09:12:42 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;81;82;81;83;79;81;81;86;83;90 09:12:42 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;133;136;112;142;148;150;151;131;246;174 09:12:42 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;165;221;212;162;162;162;161;160;162;159 09:12:42 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;66;68;66;65;65;67;64;68;65;75 09:12:42 INFO - PROCESS | 1648 | __end_tp_report 09:12:42 INFO - PROCESS | 1648 | __start_cc_report 09:12:42 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1869 09:12:42 INFO - PROCESS | 1648 | __end_cc_report 09:12:42 INFO - PROCESS | 1648 | __startTimestamp1486401161994__endTimestamp 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | ------- Summary: start ------- 09:12:42 INFO - PROCESS | 1648 | Number of tests: 14 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 09:12:42 INFO - PROCESS | 1648 | Values: 104.0 112.0 113.0 112.0 114.0 112.0 113.0 112.0 114.0 114.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:133.00 stddev:15.52 (11.7%) stddev-sans-first:15.19 09:12:42 INFO - PROCESS | 1648 | Values: 141.0 108.0 111.0 143.0 112.0 131.0 139.0 119.0 135.0 101.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 09:12:42 INFO - PROCESS | 1648 | Values: 183.0 182.0 183.0 182.0 183.0 181.0 183.0 182.0 182.0 184.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:72.50 Median:68.50 stddev:17.82 (26.0%) stddev-sans-first:18.40 09:12:42 INFO - PROCESS | 1648 | Values: 84.0 75.0 81.0 112.0 62.0 57.0 57.0 59.0 81.0 57.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:79.00 stddev:10.48 (13.3%) stddev-sans-first:10.72 09:12:42 INFO - PROCESS | 1648 | Values: 86.0 71.0 94.0 71.0 72.0 69.0 89.0 68.0 70.0 91.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:85.50 stddev:23.55 (27.5%) stddev-sans-first:24.38 09:12:42 INFO - PROCESS | 1648 | Values: 88.0 92.0 133.0 72.0 117.0 130.0 135.0 85.0 88.0 86.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:104.50 Median:92.50 stddev:17.49 (18.9%) stddev-sans-first:18.48 09:12:42 INFO - PROCESS | 1648 | Values: 109.0 128.0 141.0 110.0 92.0 93.0 93.0 94.0 92.0 93.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:81.00 stddev:21.36 (26.4%) stddev-sans-first:21.95 09:12:42 INFO - PROCESS | 1648 | Values: 81.0 81.0 81.0 80.0 86.0 127.0 136.0 113.0 81.0 95.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:84.50 stddev:19.91 (23.6%) stddev-sans-first:18.35 09:12:42 INFO - PROCESS | 1648 | Values: 40.0 41.0 87.0 83.0 86.0 88.0 86.0 59.0 55.0 55.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:3.01 (4.4%) stddev-sans-first:1.94 09:12:42 INFO - PROCESS | 1648 | Values: 62.0 70.0 71.0 74.0 69.0 69.0 69.0 68.0 68.0 68.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:3.16 (3.8%) stddev-sans-first:3.30 09:12:42 INFO - PROCESS | 1648 | Values: 81.0 82.0 81.0 83.0 79.0 81.0 81.0 86.0 83.0 90.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:152.30 Median:149.00 stddev:36.66 (24.6%) stddev-sans-first:38.22 09:12:42 INFO - PROCESS | 1648 | Values: 133.0 136.0 112.0 142.0 148.0 150.0 151.0 131.0 246.0 174.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:162.00 stddev:23.29 (14.4%) stddev-sans-first:24.54 09:12:42 INFO - PROCESS | 1648 | Values: 165.0 221.0 212.0 162.0 162.0 162.0 161.0 160.0 162.0 159.0 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.50 stddev:3.14 (4.7%) stddev-sans-first:3.32 09:12:42 INFO - PROCESS | 1648 | Values: 66.0 68.0 66.0 65.0 65.0 67.0 64.0 68.0 65.0 75.0 09:12:42 INFO - PROCESS | 1648 | -------- Summary: end -------- 09:12:42 INFO - PROCESS | 1648 | 09:12:42 INFO - TEST-INFO | 1648: exit 0 09:12:43 INFO - TEST-OK | kraken | took 59312ms 09:12:43 INFO - SUITE-END | took 1177s 09:12:43 INFO - Completed test suite (00:19:37) 09:12:43 INFO - javascript benchmark 09:12:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3502.894913152605, 3518.8064656443903, 3533.858645654173, 3550.7159427245824, 3587.1390866192105, 5762.481376676098, 5827.941720582793, 5831.650100993933, 5834.620749651281, 5842.883142337156, 4805.20714082176, 5715.514181294595, 5762.423757624236, 5852.092925596528, 5855.765769369231, 4123.958760412387, 5166.147585648373, 5261.552768014723, 5282.7358632068435, 5318.095923692981, 5239.921401178985, 5266.5786737061135, 5267.947320526784, 5279.287296215, 5365.892682146355, 5300.337457817773, 5347.7058761768085, 5348.759305831247, 5369.62412631116, 5400.891982160354, 5334.333208348957, 5337.759800808973, 5345.1982202669715, 5355.169948657965, 5394.1908713692865, 5157.638965272395, 5179.9381126869275, 5218.13900706383, 5275.446078161776, 5293.4971177738435, 5732.512736417368, 5740.052891272935, 5753.165790960287, 5835.416458354173, 5845.678487683176, 6289.308176100625, 6312.873742525124, 6319.6524191169465, 6328.430441260309, 6375.71309291083, 6225.284092329395, 6319.5576309658345, 6327.303996560375, 6328.71520781566, 6343.016832390987, 5756.625819321731, 5868.853278668067, 5924.851878703067, 5937.881242375129, 5965.731542080617, 6337.9366206337345, 6366.045093236052, 6388.39310265524, 6390.392912673288, 6390.680465976682, 6112.877742445126, 6247.031710084944, 6275.623462592168, 6300.842478938063, 6308.526860485482, 6280.654563999024, 6290.402411770874, 6328.398802113792, 6333.493320534346, 6338.239411270677, 6311.589746666452, 6323.7786677466065, 6326.240851097898, 6332.018537126753, 6337.493000559944, 6309.621422714652, 6326.145970294044, 6357.904631430532, 6367.076773867763, 6385.457236134887, 4932.630052746058, 4999.47505511916, 5002.024605201951, 5005.374328208974, 5043.218301163325, 4539.477960034572, 4543.454785425704, 4557.020240648277, 4599.701019433793, 4632.189366860786, 5405.594545418219, 5911.231539899872, 5931.673757943355, 5938.8218353449465, 5942.494887934574, 5887.911681324784, 6217.564770466114, 6232.184697121222, 6291.653959032297, 6302.086197501337, 5845.123231515222, 5871.442212989759, 5873.060310350324, 5873.2658417697785, 5970.462658360769, 5445.482679145475, 5501.669899806025, 5505.834824955257, 5506.8072617459, 5530.446955304518, 6241.126242326169, 6484.157059582319, 6501.414872661483, 6504.869902602016, 6505.41451269388, 4745.833895813768, 6224.782132625336, 6287.402696743802, 6313.40022697843, 6322.810315690536, 6405.743770249138, 6430.935690643221, 6443.065755465525, 6447.548671592944, 6452.193475815523, 6334.303226645157, 6335.556511044183, 6337.7781777637565, 6345.302016778243, 6365.172527571572, 6172.783952561639, 6270.9339412299105, 6274.811755647338, 6283.937160628335, 6318.589291696025, 6052.939470605237, 6249.687515624291, 6261.592996455216, 6265.0, 6268.216472940882, 6037.879242415039, 6236.407541283571, 6243.96878015607, 6244.718987645476, 6255.812325630239, 4731.243001119942, 5753.626014309057, 6036.909446358396, 6075.574709770273, 6076.605020673642, 6204.503639708722, 6242.094896240111, 6255.311915689362, 6258.249010118815, 6264.154339164154, 5916.763329466773, 6104.633721976696, 6114.602550834182, 6124.510039196764, 6140.258857967636], "value": 5779.939366784516, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.8068932082507, 488.6042305732357, 489.23434824499634, 503.5543543963592, 590.044128511811, 28668.856655716718, 41185.0, 42308.0, 42374.57625423745, 42401.575984240146, 43098.78450607743, 43647.90880227988, 43682.563174368246, 43684.0, 43709.34435983455, 8830.161134692195, 9441.150296473315, 9648.95175524123, 9862.506874656274, 9907.603695852158, 9756.268279879003, 9855.950720246388, 9886.912439631635, 9889.75275618108, 9892.901070989306, 9828.852567211461, 9883.50582470877, 9896.257780666443, 9899.752506187331, 9900.356476828983, 9793.167580755644, 9858.359206651616, 9865.457399843006, 9870.161036311922, 9904.108630223242, 9715.514224288829, 9788.021197880225, 9792.804143917154, 9817.656382026666, 9825.852612210823, 40939.59060409388, 41261.0, 41306.38040429396, 41308.38037429441, 41371.0, 3347.681970212826, 3372.7470439716876, 3414.4195486767308, 3490.1449144959647, 3891.630295121959, 29360.706392936012, 29884.0, 30879.536806947915, 32397.190070248198, 32527.861524846518, 3155.8106513609027, 3338.4992251162275, 3360.798352098882, 3419.863205471803, 3454.222799870034, 473381.0, 477148.0, 479090.0, 479748.0, 480675.0, 56453.43546564482, 56707.0, 59875.80248395008, 59983.70008150019, 60034.09948850771, 62969.0, 63090.0, 63105.684471578264, 63118.73762524724, 63120.68439657772, 14705.485308014167, 16952.57618559521, 16957.576060598585, 16960.660786784196, 16969.321227150776, 13119.868801312055, 13169.078164528582, 13190.0, 13195.20828750278, 13225.206487610581, 15942.043477391393, 16499.927504712155, 16576.419825306057, 16615.83384166167, 16618.58453538647, 6974.58152510851, 6999.895001574981, 7050.964745176241, 7139.500234983501, 7144.392726618192, 697.5605368617738, 732.684830728843, 741.3439106390883, 821.9219174178444, 1063.8510608514814, 24431.0, 24506.264812055666, 28893.71106288952, 30327.375773695418, 30815.69184308173, 1002.734275417015, 1089.5206109311878, 1094.162965331522, 1102.873169585492, 1114.4984756859446, 15236.542903712907, 15639.296231669603, 15672.764908526382, 15799.520287827212, 15863.12752798584, 606246.0, 610770.1922355841, 612366.0, 613907.0, 614308.0, 58451.70774146102, 58466.83066338649, 58790.11814822781, 58895.822083558945, 58959.99999999914, 1411.788231765223, 1419.1626940105386, 1440.9927950360182, 1441.8125643666467, 1448.3192899337294, 24216.63675044911, 25950.87024564865, 29817.403651926405, 30167.849160754056, 32325.51511727279, 56528.717356412955, 57226.42773572211, 57290.713546432, 57324.14013789713, 57435.0, 586074.0, 592470.0, 592763.0361848163, 592835.0, 593438.0, 25665.615015774405, 26745.86627066852, 26752.732472675023, 26760.464790704467, 26768.33079173036, 47364.0, 47734.76132619315, 47984.520154798, 48045.0, 48854.0, 38814.61185388223, 38953.0, 39083.2183356337, 39468.013299667735, 40986.79506602448, 36753.63246367502, 39109.804450977565, 39145.825625231286, 40139.0, 40424.79787601043, 37407.251854963295, 37787.62212377841, 38987.41518877276, 39336.0, 39418.40872386974, 32361.866133846335, 34389.14027149241, 34817.651823482454, 34864.47703284503, 34894.30211395809, 25713.742862571136, 25818.0, 26080.478390432465, 26185.73814261833, 26482.470350592495], "value": 19990.143606599093, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.95837478689924, 367.71134659292454, 382.16687620986255, 385.79360042377317, 412.23530351198525, 15478.303476343563, 15958.122303273316, 18245.543861403454, 20444.8977755111, 20547.589048219026, 17885.0, 18209.27162913485, 18336.808107473003, 18374.908125459388, 20982.0, 5860.267466566679, 5896.88206235875, 6145.139680444719, 6158.230221222348, 6166.784162554289, 6053.848653783647, 6203.689815509229, 6221.0979407985815, 6232.158658581102, 6233.470155036827, 4438.733675979435, 5820.505257053155, 6186.257649082094, 6190.3190649028575, 6194.721237544321, 6014.488768454665, 6064.151018857319, 6074.96962515189, 6076.908846367308, 6080.817575472743, 5130.794768209267, 5245.475452454724, 5308.8141915033175, 5348.064088784486, 5359.196120581905, 26079.217623471326, 26126.0, 26132.954681812895, 26222.34444138912, 26375.47249055008, 2129.903099903551, 2961.6742158362563, 3044.756419486436, 3094.300600564766, 3171.904842854718, 6930.826729331757, 6936.34104760047, 6941.930580694229, 6947.3747362737095, 7310.342069213796, 1794.8474379677743, 1831.9725204121949, 1866.7479890214784, 1910.0831600831539, 1938.6413513500047, 107953.46023269833, 115004.0, 115424.0, 116316.41841790822, 116556.41721791337, 10863.945680271549, 10957.83563246552, 11017.173711971634, 11303.361012653118, 11334.546618135182, 14187.14877107377, 14206.573802785933, 14223.715525689428, 14225.14649121056, 14248.0, 8637.827243455222, 8750.47497150173, 8763.386562940534, 8785.428947118544, 8881.644734210558, 8797.560121993874, 8839.513826739463, 8840.381173317935, 8981.640734370552, 8993.775155621162, 5605.66366018032, 5736.741846616912, 6774.45804335652, 6803.761868334684, 6812.182538095361, 1868.579569596857, 1906.0, 1906.6262503183625, 1914.4830895658372, 1916.5208697825544, 849.0, 894.7807787092204, 978.83849164887, 997.6109317366233, 1027.41950797799, 21320.680189797167, 22345.776542234693, 22481.775182248297, 22485.32544023682, 23743.0, 852.5694524265207, 953.2040745977048, 998.2114129837347, 1002.4686915934566, 1025.5333823110616, 10866.511007004703, 11317.547298108148, 11904.345261010554, 11941.701457463632, 12057.397130143458, 506687.0, 620086.0, 632778.0, 634798.0, 637813.0, 106480.99999999846, 122607.77392225963, 123675.3816230913, 125169.0, 125251.37374313253, 1012.4178597306578, 1015.8933312002133, 1041.3335465302212, 1042.3693665332364, 1042.718466014172, 19206.327778527684, 19928.302509412682, 20216.0, 20237.19051237934, 20247.898760506105, 53974.0, 54581.0, 55033.34233126323, 56705.432945671666, 57568.0, 79842.6007869957, 83352.58208216446, 83704.16295836963, 83706.0, 86684.56657716671, 7136.4290856730295, 7233.891491627524, 7250.274972502708, 7591.089069311718, 7974.920250797418, 10617.734556636145, 12967.768062034093, 13065.673358166121, 13215.669608259486, 13664.521741738992, 11379.260348077349, 11518.136139789716, 11555.306681599131, 11607.6517704469, 11858.051355891335, 11120.221584489009, 11286.717832054264, 11369.31784092957, 11609.535618575163, 11669.35818529989, 10468.319559228627, 10850.023497885228, 10860.185486088732, 11526.654200373667, 11535.884641153816, 7116.857662846817, 7400.555966642019, 7520.247975202436, 7777.222277772177, 7887.501374738781, 10205.795884082425, 10325.0, 10437.634682786065, 11683.766324673628, 11863.703407414883], "value": 9659.359137700761, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.6125104345263, 1494.708531836292, 1527.404312318196, 1676.2959556986066, 1833.9358122465717, 7723.343515801156, 8143.674253029879, 8415.747527574174, 8631.48211107334, 8647.0488246293, 8512.319014478842, 8596.914030859689, 8601.870971935426, 8606.311495080394, 8617.0, 2222.1777942161343, 2365.763423657629, 2395.2694428199393, 2395.73646898841, 2397.4485868250313, 2233.140241007208, 2374.81001519878, 2437.8293519453646, 2440.5240978009206, 2449.9265022049276, 2375.9168429104984, 2383.2969274064108, 2402.9158979435724, 2408.6868707068143, 2409.662647229389, 2359.6106642403984, 2369.7511761265077, 2395.4490467192645, 2397.3646983549374, 2403.615421532555, 1962.3229985654925, 2356.32844639277, 2397.4725560376687, 2401.807855371566, 2403.579373609611, 8400.243978042006, 8512.233898949062, 8589.141085891424, 8631.870521942175, 8643.654253829902, 5187.0, 5366.785328586851, 5369.865753356158, 5369.892602147975, 5389.622726409153, 3489.0, 3615.5842078161086, 3654.305681920453, 3695.0392897846755, 3708.9814550927344, 1079.2499213046935, 1102.2229328323592, 1109.0295991007868, 1130.2032067392468, 1132.8867113288688, 11218.046466050395, 11255.493502792395, 11336.603218887381, 11345.602903898407, 11361.488733007034, 4330.870073897788, 4538.183127037165, 4610.654200934943, 4613.792379342871, 4618.1918164321105, 8955.865662015074, 8962.73111806647, 8966.282697384193, 8971.282297416192, 8973.50645714479, 5163.7676304566385, 5240.895182096413, 5254.6847189168775, 5257.737113144328, 5260.000599886086, 4402.559744025636, 4430.556944305544, 4853.490383509751, 4858.02839432115, 4934.7285899275885, 3704.0, 3738.980950286869, 3784.829682664287, 3848.037990502374, 3852.7303088783515, 1169.4037638623388, 1175.3183153770792, 1175.4710380328886, 1183.5384200161943, 1188.3107797477442, 816.3591580609193, 868.70898249086, 889.1242126505387, 893.2318206342541, 903.1600611431431, 5566.248556444909, 5640.294963129609, 5740.827775166752, 5825.3883342248455, 5952.821415357546, 933.7852293972288, 948.4214629076258, 948.5494390164616, 953.1278879825021, 997.3118548201862, 3567.7324200685052, 3595.442706380515, 3680.0, 3689.94465083024, 3753.793541355252, 10024.348417352849, 10397.428141452292, 10512.3692578444, 10513.632022879163, 10518.474076296154, 10464.529096190538, 10465.895341046493, 10471.267011309288, 10486.895131048745, 10487.895121048845, 7999.480033797785, 8133.471324364015, 8150.4294699370475, 8153.429259951865, 8183.181681831888, 4808.447028591757, 5213.947860521346, 5381.0, 5528.19841123043, 5577.0, 9496.905030949601, 9521.428714277166, 9601.807963840545, 9661.178799801814, 9669.371490853073, 9703.805923881624, 9713.368631039242, 9777.120059194422, 9800.411975281506, 9840.261980351646, 6445.484361251182, 6639.03733958583, 6771.0, 6912.135983002125, 7050.400715939202, 8101.0, 8275.0, 8279.37904657141, 8288.088310285984, 8288.254057134887, 6254.21822272216, 7151.53515021522, 7265.9273407267365, 7281.890771638324, 7357.742479013209, 7014.0, 7163.462740294603, 7163.892541611775, 7225.963870180615, 7287.1984081752025, 6640.83397915056, 6641.203055633355, 6723.899141512783, 6725.260221375547, 6727.966360168168, 4730.385049943486, 4736.100140973204, 4772.832950846704, 4788.928166077581, 4807.591354734747, 4727.149113159527, 4739.265413860857, 4744.644151688706, 4924.089043526959, 4990.401151861654], "value": 4471.576156201026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [269.5565794268428, 311.58870291215607, 315.7963113791605, 321.2659074015874, 323.8170433704955, 5077.5684066854365, 5253.003858533762, 5253.947460525398, 5283.709395983225, 5333.986542556911, 4726.574608285254, 5082.872928176797, 5173.793048278074, 5194.194899790529, 5305.840824775263, 3369.9326013479717, 4118.711690181688, 4122.50529936408, 4133.111381053073, 4142.606452387018, 3624.8187590620496, 4113.992071942378, 4117.649999750025, 4169.958300417003, 4180.205760905418, 4009.095679552204, 4043.2722110020186, 4091.6112969267874, 4092.3043082676018, 4096.5903409659095, 3550.751447398683, 4055.1889622075705, 4056.707960002589, 4074.694397920168, 4077.734947228421, 3577.2308953575107, 3607.567091948983, 3625.492431059654, 3630.981845090758, 3636.818159092035, 4854.378635536806, 4872.490667306304, 5170.043541944752, 5181.792728290864, 5236.738163091868, 4063.728698397789, 4494.393256910308, 4611.861644150681, 4618.284165954249, 4648.954934517897, 5518.862028449281, 5521.199426083195, 5524.58565607581, 5536.584756143306, 5544.251526043973, 3121.406932682783, 3763.8708387483643, 3918.45141680165, 3946.934327731525, 3958.524977002778, 5761.84763047388, 5771.961047011536, 5775.971120144372, 5780.485488812338, 5781.913271300934, 3974.682025437958, 3995.300822356076, 3999.34010888206, 4011.8997025074023, 4025.2150830587752, 3910.2179564087296, 4036.616521430459, 4044.656204222615, 4062.679629120548, 4070.715049946475, 4604.102200070954, 4612.930806037912, 4623.815047398134, 4632.652551058617, 4636.003259299267, 4598.793054312564, 5464.426235245322, 5547.0, 5574.324324324347, 5622.690752008597, 1064.622059168984, 1067.900062935178, 1160.6750109969053, 1204.3978010994504, 1281.5450515067203, 801.4910531812341, 852.5481494807761, 887.9788243520004, 922.9030951750104, 936.2650319499161, 4341.283688191413, 4474.731516109044, 4890.657653964188, 4890.877728056827, 4893.556400861683, 4447.799094244536, 5049.924251136236, 5081.695098294041, 5298.682079075268, 5367.63823917475, 4673.4744707347445, 4841.668541151141, 4857.2071059141135, 4859.489753575895, 4868.902621947612, 2731.5629499280417, 2750.944981100367, 2754.4628797384717, 2790.693023767384, 2790.916272511828, 5055.747212639353, 5203.531682148625, 5361.946380536145, 5368.221607866915, 5390.51485366319, 4658.732377491125, 4783.784729687172, 5027.731974216788, 5166.044281807803, 5482.643628164236, 4525.479569849444, 4716.575508204278, 5267.947320526822, 5439.129739241703, 5522.834314970477, 4698.765061746967, 4919.868430260988, 4970.826021089245, 4988.077205716954, 5128.8461346159675, 4800.687955282895, 4825.9034819304115, 5180.559652429586, 5291.23277124807, 5529.4470552944385, 5569.8024924641395, 5847.94152058474, 5883.235179426818, 5893.9685555026845, 5954.98765209924, 3470.0, 3489.581250249986, 3931.7981930119226, 3953.2686453006286, 4041.009952561641, 5410.48600382963, 5480.6437581557075, 5616.550675945833, 5709.429057094258, 5710.400407957105, 5395.489263006364, 5432.320959880015, 5446.039425806785, 5451.0, 5466.644668096561, 4884.9511504884495, 5342.572594192377, 5362.624616276979, 5547.472990065938, 5592.636478628876, 4679.157751604744, 5282.415275417283, 5453.736699269917, 5465.289512363367, 5469.835904922858, 4837.612990960785, 5475.917861232005, 5533.750981205936, 5535.595608700701, 5539.446055394428, 4605.907881842411, 5430.6198566101575, 5440.204732438365, 5446.564274857923, 5459.945400546103], "value": 4004.9349243638703, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.0698085507985, 730.3536370312272, 771.7106085218044, 794.3327604811958, 829.2205326992627, 14610.56168314951, 15670.373185072584, 15674.843251567481, 15717.13555754433, 15740.370385184578, 11957.581484648039, 14117.929410352934, 14251.643708907282, 14275.4289828407, 14295.356708948097, 684.1243208692881, 689.6965335252473, 846.496334680867, 861.8922634670666, 876.2332958661171, 874.3791907745508, 874.4534665833854, 876.128252388874, 876.2726936642572, 878.7803049237691, 911.3256190419075, 911.6945823149252, 911.8541033434652, 913.1507697841005, 919.3748251189189, 907.7775944893543, 910.2172131966504, 911.4713466189594, 911.8221946720392, 914.0585197246813, 683.4293365040197, 683.6240067962601, 685.0409426802466, 685.5201359048685, 686.807693845724, 12029.819552706716, 13933.721325573533, 13970.580882573538, 14152.646183845383, 14415.135091894519, 13077.542286019943, 13887.611238876032, 14261.001729878913, 14588.489402870848, 14730.631734206623, 11680.299182049104, 11733.882661173364, 11817.763644727058, 11826.763464730657, 11918.81644487402, 3851.8651847185492, 3914.15845593196, 3954.307996100671, 3962.1679447316096, 4048.291548978946, 88666.11333886643, 90091.0, 94024.0, 95512.52243738806, 96214.0, 10411.479426028669, 10839.0, 10917.017468427879, 10946.288491248044, 11061.502232399562, 19575.510612234524, 20172.495687607632, 20812.0, 20929.0, 20938.267160649306, 8001.839963200703, 8084.595770211466, 8175.509469431734, 8345.582720863933, 8436.957815211008, 4305.397244385788, 4471.463424389094, 4529.909401811945, 4594.931076033862, 4601.263797792337, 3509.7192224621967, 3634.4548317752547, 3635.818209089535, 3641.417373220272, 3641.4901913732097, 665.434380776346, 668.3750693101965, 669.7086767256259, 679.1849780263703, 687.3641881259815, 598.8981873081586, 670.8356452669127, 675.5748355835865, 687.1582311668167, 693.4937495628119, 8637.827243455096, 8766.38635295536, 9342.95328523353, 9347.439153650803, 9684.95157524208, 612.4182027074297, 622.4677900395187, 634.6065439427584, 648.5265755998054, 702.6030292884606, 4505.864824055284, 4670.1827180244, 4673.112108699336, 4708.8116475341285, 4814.229723244334, 93302.60046099314, 95245.61885952907, 106652.66736663136, 118303.0, 125759.0, 58953.70523147357, 60926.39073609207, 69239.0, 79982.0, 102102.0, 59226.70386648039, 76168.97102758325, 78424.2157578417, 80902.59548702337, 81519.0, 7995.560244186393, 8953.28373730087, 9209.907900921173, 9363.4381937084, 9460.621575137193, 51986.66060027232, 53600.73199633977, 53665.7316713414, 54557.454425456825, 56872.146917795435, 54568.727156363966, 78537.60731196307, 78944.0, 80044.19955800367, 80239.0, 12055.21641093326, 12261.38693065361, 12525.248485090924, 12584.937075314565, 12953.417096230503, 13450.730985380433, 13641.522546710818, 14429.855701443272, 14558.12651240929, 15343.46297879569, 13099.541516046893, 13662.521811736542, 13968.790468142783, 14068.366923488264, 14294.785578216128, 13197.0, 13487.39306731219, 13664.111832731238, 14026.368813403216, 14776.926115369355, 12197.817032744693, 12832.165909215872, 13000.739985200433, 13148.868511314764, 13532.86467135316, 11180.496877640688, 11259.943700281447, 11424.200305978502, 11564.47959841826, 11760.411979401168, 11319.703526836856, 11432.314061156358, 11524.193306468467, 11567.537298507965, 11592.536298547964], "value": 7452.633332899577, "unit": "score"}], "name": "dromaeo_css", "value": 7280.8740686149, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 114.0, 112.0, 113.0, 112.0, 114.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 111.0, 143.0, 112.0, 131.0, 139.0, 119.0, 135.0, 101.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 183.0, 182.0, 183.0, 181.0, 183.0, 182.0, 182.0, 184.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 81.0, 112.0, 62.0, 57.0, 57.0, 59.0, 81.0, 57.0], "value": 72.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 94.0, 71.0, 72.0, 69.0, 89.0, 68.0, 70.0, 91.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 133.0, 72.0, 117.0, 130.0, 135.0, 85.0, 88.0, 86.0], "value": 102.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 128.0, 141.0, 110.0, 92.0, 93.0, 93.0, 94.0, 92.0, 93.0], "value": 104.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 81.0, 80.0, 86.0, 127.0, 136.0, 113.0, 81.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 41.0, 87.0, 83.0, 86.0, 88.0, 86.0, 59.0, 55.0, 55.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 70.0, 71.0, 74.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 81.0, 83.0, 79.0, 81.0, 81.0, 86.0, 83.0, 90.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 136.0, 112.0, 142.0, 148.0, 150.0, 151.0, 131.0, 246.0, 174.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 221.0, 212.0, 162.0, 162.0, 162.0, 161.0, 160.0, 162.0, 159.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 65.0, 65.0, 67.0, 64.0, 68.0, 65.0, 75.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1483.6, "alertThreshold": 2.0}]} 09:12:43 INFO - Return code: 0 09:12:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:12:43 INFO - # TBPL SUCCESS # 09:12:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:12:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:12:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:12:43 INFO - 2017-02-06 09:12:43.294 screenresolution[1652:10061] starting screenresolution argv=screenresolution get 09:12:43 INFO - 2017-02-06 09:12:43.297 screenresolution[1652:10061] Display 0: 1600x1200x32@60 09:12:43 INFO - 2017-02-06 09:12:43.303 screenresolution[1653:10064] starting screenresolution argv=screenresolution list 09:12:43 INFO - Available Modes on Display 0 09:12:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:12:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:12:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:12:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:12:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:12:43 INFO - Intel Iris: 09:12:43 INFO - Chipset Model: Intel Iris 09:12:43 INFO - Type: GPU 09:12:43 INFO - Bus: Built-In 09:12:43 INFO - VRAM (Dynamic, Max): 1536 MB 09:12:43 INFO - Vendor: Intel (0x8086) 09:12:43 INFO - Device ID: 0x0a2e 09:12:43 INFO - Revision ID: 0x0009 09:12:43 INFO - Displays: 09:12:43 INFO - Display: 09:12:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:12:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:12:43 INFO - Display Serial Number: 1600x1200 60 09:12:43 INFO - Main Display: Yes 09:12:43 INFO - Mirror: Off 09:12:43 INFO - Online: Yes 09:12:43 INFO - Rotation: Supported 09:12:43 INFO - Return code: 0 09:12:43 INFO - Running post-action listener: _resource_record_post_action 09:12:43 INFO - [mozharness: 2017-02-06 17:12:43.557500Z] Finished run-tests step (success) 09:12:43 INFO - Running post-run listener: _resource_record_post_run 09:12:43 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 39068672; Write bytes: 498848256; Read time: 378; Write time: 1537 09:12:43 INFO - TinderboxPrint: CPU usage
53.4% 09:12:43 INFO - TinderboxPrint: I/O read bytes / time
39,068,672 / 378 09:12:43 INFO - TinderboxPrint: I/O write bytes / time
498,848,256 / 1,537 09:12:43 INFO - TinderboxPrint: CPU idle
2,233.8 (46.6%) 09:12:43 INFO - TinderboxPrint: CPU system
960.8 (20.0%) 09:12:43 INFO - TinderboxPrint: CPU user
1,603.2 (33.4%) 09:12:43 INFO - TinderboxPrint: Swap in / out
230,486,016 / 0 09:12:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183247360; Write bytes: 175558656; Read time: 16550; Write time: 334 09:12:43 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 38126592; Write bytes: 306606592; Read time: 364; Write time: 1147 09:12:44 INFO - Running post-run listener: _upload_blobber_files 09:12:44 INFO - Blob upload gear active. 09:12:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:12:44 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:12:44 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:12:44 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:12:44 INFO - (blobuploader) - INFO - Open directory for files ... 09:12:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:12:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:12:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:45 INFO - (blobuploader) - INFO - Done attempting. 09:12:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:12:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:12:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:46 INFO - (blobuploader) - INFO - Done attempting. 09:12:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:12:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:12:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:48 INFO - (blobuploader) - INFO - Done attempting. 09:12:48 INFO - (blobuploader) - INFO - Iteration through files over. 09:12:48 INFO - Return code: 0 09:12:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:12:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:12:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/413357de938845b2c6188264cd71f397484ce2efd3d36b518daa81ed0600fb7bf99b689fa1570e90c88ba5978ecaa1d29fc4573e6d230fa152ace03ef0697e85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ab96a6772e422c0241396689b7a1170b35f354ef6d129bef89b027430f000f52867bd51773cc63eaff12a3ab95660a9293b380872b4ad2f2599cc473c695a73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83e4dedd1f7327ba77b801e3ee3c01e410863f94e19741d1553ae06fcaec64ccd1a87b4482fbbff4b0032d6c5e47670efdbffad7c9554c53b81356ef5e088207"} 09:12:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:12:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:12:48 INFO - Contents: 09:12:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/413357de938845b2c6188264cd71f397484ce2efd3d36b518daa81ed0600fb7bf99b689fa1570e90c88ba5978ecaa1d29fc4573e6d230fa152ace03ef0697e85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ab96a6772e422c0241396689b7a1170b35f354ef6d129bef89b027430f000f52867bd51773cc63eaff12a3ab95660a9293b380872b4ad2f2599cc473c695a73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83e4dedd1f7327ba77b801e3ee3c01e410863f94e19741d1553ae06fcaec64ccd1a87b4482fbbff4b0032d6c5e47670efdbffad7c9554c53b81356ef5e088207"} 09:12:48 INFO - Running post-run listener: copy_logs_to_upload_dir 09:12:48 INFO - Copying logs to upload dir... 09:12:48 INFO - mkdir: /builds/slave/test/build/upload/logs 09:12:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.553525 ========= master_lag: 2.69 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-06 09:12:51.463069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 09:12:51.467769) ========= 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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-Beta/sha512/413357de938845b2c6188264cd71f397484ce2efd3d36b518daa81ed0600fb7bf99b689fa1570e90c88ba5978ecaa1d29fc4573e6d230fa152ace03ef0697e85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ab96a6772e422c0241396689b7a1170b35f354ef6d129bef89b027430f000f52867bd51773cc63eaff12a3ab95660a9293b380872b4ad2f2599cc473c695a73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83e4dedd1f7327ba77b801e3ee3c01e410863f94e19741d1553ae06fcaec64ccd1a87b4482fbbff4b0032d6c5e47670efdbffad7c9554c53b81356ef5e088207"} build_url:https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/VQ8s9PTzQDODWZPScKIJTA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/413357de938845b2c6188264cd71f397484ce2efd3d36b518daa81ed0600fb7bf99b689fa1570e90c88ba5978ecaa1d29fc4573e6d230fa152ace03ef0697e85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ab96a6772e422c0241396689b7a1170b35f354ef6d129bef89b027430f000f52867bd51773cc63eaff12a3ab95660a9293b380872b4ad2f2599cc473c695a73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83e4dedd1f7327ba77b801e3ee3c01e410863f94e19741d1553ae06fcaec64ccd1a87b4482fbbff4b0032d6c5e47670efdbffad7c9554c53b81356ef5e088207"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 09:12:51.506130) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:12:51.506477) ========= 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.v4I59Uyboq/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.NxOKX2GGIZ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005176 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:12:51.660179) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 09:12:51.660500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 09:12:51.660937) ========= ========= Total master_lag: 2.93 =========