builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0235 starttime: 1480074063.17 results: success (0) buildid: 20161125021618 builduid: bb3d2e8a301943f5b8ce26405d2f01dd revision: 75453f12b616711e72c5a090b2041ae32450345e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:03.173842) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:03.174295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:03.174572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:03.204829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:03.205237) ========= 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.vOCEChi2qC/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.EJrHizkeae/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 --2016-11-25 03:41:03-- 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% 171M=0s 2016-11-25 03:41:03 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079827 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:03.308789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:03.309120) ========= 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.vOCEChi2qC/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.EJrHizkeae/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.024651 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:03.359950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 03:41:03.363422) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 75453f12b616711e72c5a090b2041ae32450345e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 75453f12b616711e72c5a090b2041ae32450345e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vOCEChi2qC/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.EJrHizkeae/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 2016-11-25 03:41:03,460 truncating revision to first 12 chars 2016-11-25 03:41:03,461 Setting DEBUG logging. 2016-11-25 03:41:03,461 attempt 1/10 2016-11-25 03:41:03,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/75453f12b616?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 03:41:04,355 unpacking tar archive at: graphics-75453f12b616/testing/mozharness/ program finished with exit code 0 elapsedTime=1.168025 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 03:41:04.630835) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:04.631163) ========= script_repo_revision: 75453f12b616711e72c5a090b2041ae32450345e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:04.631599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:04.631865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 03:41:04.655607) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-25 03:41:04.656003) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vOCEChi2qC/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.EJrHizkeae/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 03:41:04 INFO - MultiFileLogger online at 20161125 03:41:04 in /builds/slave/test 03:41:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 03:41:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:41:04 INFO - {'append_to_log': False, 03:41:04 INFO - 'base_work_dir': '/builds/slave/test', 03:41:04 INFO - 'blob_upload_branch': 'Graphics', 03:41:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:41:04 INFO - 'branch': 'Graphics', 03:41:04 INFO - 'buildbot_json_path': 'buildprops.json', 03:41:04 INFO - 'config_files': ('talos/mac_config.py',), 03:41:04 INFO - 'default_actions': ('clobber', 03:41:04 INFO - 'read-buildbot-config', 03:41:04 INFO - 'download-and-extract', 03:41:04 INFO - 'populate-webroot', 03:41:04 INFO - 'create-virtualenv', 03:41:04 INFO - 'install', 03:41:04 INFO - 'run-tests'), 03:41:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:41:04 INFO - 'download_minidump_stackwalk': True, 03:41:04 INFO - 'download_symbols': 'ondemand', 03:41:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:41:04 INFO - 'tooltool.py': '/tools/tooltool.py', 03:41:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:41:04 INFO - '/tools/misc-python/virtualenv.py')}, 03:41:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:41:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:41:04 INFO - 'installer_path': 'installer.exe', 03:41:04 INFO - 'log_level': 'info', 03:41:04 INFO - 'log_name': 'talos', 03:41:04 INFO - 'log_to_console': True, 03:41:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:41:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:41:04 INFO - 'opt_config_files': (), 03:41:04 INFO - 'pip_index': False, 03:41:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:41:04 INFO - 'cmd': ('bash', 03:41:04 INFO - '-c', 03:41:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:41:04 INFO - 'enabled': True, 03:41:04 INFO - 'halt_on_failure': False, 03:41:04 INFO - 'name': 'check_screen_resolution'},), 03:41:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:41:04 INFO - 'cmd': ('bash', 03:41:04 INFO - '-c', 03:41:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:41:04 INFO - 'enabled': True, 03:41:04 INFO - 'halt_on_failure': False, 03:41:04 INFO - 'name': 'check_screen_resolution'},), 03:41:04 INFO - 'run_cmd_checks_enabled': True, 03:41:04 INFO - 'sps_profile': False, 03:41:04 INFO - 'sps_profile_interval': 0, 03:41:04 INFO - 'suite': 'dromaeojs', 03:41:04 INFO - 'system_bits': '32', 03:41:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:41:04 INFO - 'title': 't-yosemite-r7-0235', 03:41:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:41:04 INFO - 'use_talos_json': True, 03:41:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:41:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:41:04 INFO - 'work_dir': 'build'} 03:41:04 INFO - [mozharness: 2016-11-25 11:41:04.861959Z] Running clobber step. 03:41:04 INFO - Running pre-action listener: _resource_record_pre_action 03:41:04 INFO - Running main action method: clobber 03:41:04 INFO - rmtree: /builds/slave/test/build 03:41:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:41:07 INFO - Running post-action listener: _resource_record_post_action 03:41:07 INFO - [mozharness: 2016-11-25 11:41:07.237643Z] Finished clobber step (success) 03:41:07 INFO - [mozharness: 2016-11-25 11:41:07.237781Z] Running read-buildbot-config step. 03:41:07 INFO - Running pre-action listener: _resource_record_pre_action 03:41:07 INFO - Running main action method: read_buildbot_config 03:41:07 INFO - Using buildbot properties: 03:41:07 INFO - { 03:41:07 INFO - "project": "", 03:41:07 INFO - "product": "firefox", 03:41:07 INFO - "script_repo_revision": "default", 03:41:07 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 03:41:07 INFO - "repository": "", 03:41:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 03:41:07 INFO - "buildid": "20161125021618", 03:41:07 INFO - "pgo_build": "False", 03:41:07 INFO - "basedir": "/builds/slave/test", 03:41:07 INFO - "buildnumber": 2, 03:41:07 INFO - "slavename": "t-yosemite-r7-0235", 03:41:07 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 03:41:07 INFO - "platform": "yosemite_r7", 03:41:07 INFO - "scheduler": "tests-graphics-macosx64-talos", 03:41:07 INFO - "branch": "graphics", 03:41:07 INFO - "repo_path": "projects/graphics", 03:41:07 INFO - "revision": "75453f12b616711e72c5a090b2041ae32450345e", 03:41:07 INFO - "stage_platform": "macosx64", 03:41:07 INFO - "builduid": "bb3d2e8a301943f5b8ce26405d2f01dd", 03:41:07 INFO - "slavebuilddir": "test" 03:41:07 INFO - } 03:41:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 03:41:07 INFO - Running post-action listener: _resource_record_post_action 03:41:07 INFO - [mozharness: 2016-11-25 11:41:07.240946Z] Finished read-buildbot-config step (success) 03:41:07 INFO - [mozharness: 2016-11-25 11:41:07.241054Z] Running download-and-extract step. 03:41:07 INFO - Running pre-action listener: _resource_record_pre_action 03:41:07 INFO - Running main action method: download_and_extract 03:41:07 INFO - mkdir: /builds/slave/test/build/tests 03:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:07 INFO - trying https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 03:41:07 INFO - Downloading https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 03:41:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 03:41:08 INFO - Downloaded 1199 bytes. 03:41:08 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 03:41:08 INFO - Using the following test package requirements: 03:41:08 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 03:41:08 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:41:08 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 03:41:08 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:41:08 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 03:41:08 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:41:08 INFO - u'jsshell-mac.zip'], 03:41:08 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:41:08 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 03:41:08 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 03:41:08 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:41:08 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 03:41:08 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:41:08 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 03:41:08 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:41:08 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 03:41:08 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:41:08 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 03:41:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:41:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 03:41:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:41:08 INFO - Fetch https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 03:41:08 INFO - Http code: 200 03:41:08 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 03:41:08 INFO - x-amz-cf-id: HRCtBCryrnTHKsIglFDpfymkDA66BvDSvaylQTlHMMML6h4aBldalw== 03:41:08 INFO - x-amz-version-id: Y0cH2BgdfltiApwEfjGfZiybxdf1mkEP 03:41:09 INFO - Expected file size: 16267116 03:41:09 INFO - Obtained file size: 16267116 03:41:15 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:41:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 03:41:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:41:15 INFO - Fetch https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 03:41:16 INFO - Http code: 200 03:41:16 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 03:41:16 INFO - x-amz-cf-id: bajk-tYqMaSkeR55O6ZjDuPPuIr31IsO9pF68cA--F4GWBrI9xANhA== 03:41:16 INFO - x-amz-version-id: Y0cH2BgdfltiApwEfjGfZiybxdf1mkEP 03:41:16 INFO - Expected file size: 16267116 03:41:16 INFO - Obtained file size: 16267116 03:41:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 03:41:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:41:23 INFO - Fetch https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 03:41:24 INFO - Http code: 200 03:41:24 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 03:41:24 INFO - x-amz-cf-id: IKIrCYF4v06IELfK--FfVrWc7iAsrFzEixUAjJaVMY9yBvXvQvAL8w== 03:41:24 INFO - x-amz-version-id: QKv25A8vsiXEMPkig97LaO3.TpcCu0e9 03:41:24 INFO - Expected file size: 14409506 03:41:24 INFO - Obtained file size: 14409506 03:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:24 INFO - trying https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:41:24 INFO - Downloading https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 03:41:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 03:41:27 INFO - Downloaded 107550864 bytes. 03:41:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:41:27 INFO - mkdir: /builds/slave/test/properties 03:41:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:41:27 INFO - Writing to file /builds/slave/test/properties/build_url 03:41:27 INFO - Contents: 03:41:27 INFO - build_url:https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:41:28 INFO - Running post-action listener: _resource_record_post_action 03:41:28 INFO - Running post-action listener: set_extra_try_arguments 03:41:28 INFO - [mozharness: 2016-11-25 11:41:28.370853Z] Finished download-and-extract step (success) 03:41:28 INFO - [mozharness: 2016-11-25 11:41:28.370984Z] Running populate-webroot step. 03:41:28 INFO - Running pre-action listener: _resource_record_pre_action 03:41:28 INFO - Running main action method: populate_webroot 03:41:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:41:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:41:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:41:28 INFO - '--tppagecycles', 03:41:28 INFO - '7'], 03:41:28 INFO - 'tests': ['tsvgm']}}, 03:41:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:41:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:41:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:41:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:41:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:41:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:41:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:41:28 INFO - 'talos_options': ['--disable-e10s'], 03:41:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:41:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:41:28 INFO - 'talos_options': ['--disable-e10s'], 03:41:28 INFO - 'tests': ['damp', 'tps']}, 03:41:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:41:28 INFO - 'tests': ['damp', 'tps']}, 03:41:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:41:28 INFO - 'tests': ['dromaeo_dom']}, 03:41:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:41:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:41:28 INFO - 'tests': ['basic_compositor_video']}, 03:41:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:41:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:41:28 INFO - 'tests': ['a11yr', 03:41:28 INFO - 'ts_paint', 03:41:28 INFO - 'tpaint', 03:41:28 INFO - 'sessionrestore', 03:41:28 INFO - 'sessionrestore_no_auto_restore', 03:41:28 INFO - 'tabpaint']}, 03:41:28 INFO - 'other-e10s': {'tests': ['a11yr', 03:41:28 INFO - 'ts_paint', 03:41:28 INFO - 'tpaint', 03:41:28 INFO - 'sessionrestore', 03:41:28 INFO - 'sessionrestore_no_auto_restore', 03:41:28 INFO - 'tabpaint']}, 03:41:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:41:28 INFO - 'ts_paint', 03:41:28 INFO - 'tpaint', 03:41:28 INFO - 'sessionrestore', 03:41:28 INFO - 'sessionrestore_no_auto_restore', 03:41:28 INFO - 'tabpaint']}, 03:41:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:41:28 INFO - 'ts_paint', 03:41:28 INFO - 'tpaint', 03:41:28 INFO - 'sessionrestore', 03:41:28 INFO - 'sessionrestore_no_auto_restore', 03:41:28 INFO - 'tabpaint']}, 03:41:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:41:28 INFO - 'tests': ['a11yr', 03:41:28 INFO - 'ts_paint', 03:41:28 INFO - 'tpaint', 03:41:28 INFO - 'sessionrestore', 03:41:28 INFO - 'sessionrestore_no_auto_restore', 03:41:28 INFO - 'tabpaint']}, 03:41:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:41:28 INFO - 'tests': ['a11yr', 03:41:28 INFO - 'ts_paint', 03:41:28 INFO - 'tpaint', 03:41:28 INFO - 'sessionrestore', 03:41:28 INFO - 'sessionrestore_no_auto_restore', 03:41:28 INFO - 'tabpaint']}, 03:41:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:41:28 INFO - 'tests': ['tsvgx', 03:41:28 INFO - 'tsvgr_opacity', 03:41:28 INFO - 'tart', 03:41:28 INFO - 'tscrollx', 03:41:28 INFO - 'cart']}, 03:41:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:41:28 INFO - 'tsvgr_opacity', 03:41:28 INFO - 'tart', 03:41:28 INFO - 'tscrollx', 03:41:28 INFO - 'cart']}, 03:41:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:41:28 INFO - 'talos_options': ['--disable-e10s'], 03:41:28 INFO - 'tests': ['tp5o']}, 03:41:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:41:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:41:28 INFO - 'talos_options': ['--disable-e10s', 03:41:28 INFO - '--xperf_path', 03:41:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:28 INFO - 'tests': ['tp5n']}, 03:41:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:41:28 INFO - 'talos_options': ['--xperf_path', 03:41:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:28 INFO - 'tests': ['tp5n']}}, 03:41:28 INFO - 'talos.zip': {'path': '', 03:41:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:41:28 INFO - Running post-action listener: _resource_record_post_action 03:41:28 INFO - [mozharness: 2016-11-25 11:41:28.389544Z] Finished populate-webroot step (success) 03:41:28 INFO - [mozharness: 2016-11-25 11:41:28.389661Z] Running create-virtualenv step. 03:41:28 INFO - Running pre-action listener: _resource_record_pre_action 03:41:28 INFO - Running main action method: create_virtualenv 03:41:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:41:28 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 03:41:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:41:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:41:28 INFO - Using real prefix '/tools/python27' 03:41:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:41:29 INFO - Installing distribute.............................................................................................................................................................................................done. 03:41:32 INFO - Installing pip.................done. 03:41:32 INFO - Return code: 0 03:41:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:41:32 INFO - Reading from file tmpfile_stdout 03:41:32 INFO - Output received: 03:41:32 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) 03:41:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101edd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2aa5444c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf3d30>, '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 0x101b5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cebb20>, '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.vOCEChi2qC/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.EJrHizkeae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 03:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOCEChi2qC/Render', 03:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:32 INFO - 'HOME': '/Users/cltbld', 03:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:32 INFO - 'LOGNAME': 'cltbld', 03:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:32 INFO - 'MOZ_NO_REMOTE': '1', 03:41:32 INFO - 'NO_EM_RESTART': '1', 03:41:32 INFO - 'PAGER': '/bin/cat', 03:41:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:32 INFO - 'PWD': '/builds/slave/test', 03:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:32 INFO - 'SHELL': '/bin/bash', 03:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EJrHizkeae/Listeners', 03:41:32 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:32 INFO - 'USER': 'cltbld', 03:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:32 INFO - 'XPC_FLAGS': '0x0', 03:41:32 INFO - 'XPC_SERVICE_NAME': '0', 03:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:32 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 03:41:32 INFO - Cleaning up... 03:41:32 INFO - Return code: 0 03:41:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101edd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2aa5444c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf3d30>, '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 0x101b5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cebb20>, '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.vOCEChi2qC/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.EJrHizkeae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 03:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOCEChi2qC/Render', 03:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:32 INFO - 'HOME': '/Users/cltbld', 03:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:32 INFO - 'LOGNAME': 'cltbld', 03:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:32 INFO - 'MOZ_NO_REMOTE': '1', 03:41:32 INFO - 'NO_EM_RESTART': '1', 03:41:32 INFO - 'PAGER': '/bin/cat', 03:41:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:32 INFO - 'PWD': '/builds/slave/test', 03:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:32 INFO - 'SHELL': '/bin/bash', 03:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EJrHizkeae/Listeners', 03:41:32 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:32 INFO - 'USER': 'cltbld', 03:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:32 INFO - 'XPC_FLAGS': '0x0', 03:41:32 INFO - 'XPC_SERVICE_NAME': '0', 03:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:32 INFO - Downloading/unpacking psutil>=3.1.1 03:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:36 INFO - Installing collected packages: psutil 03:41:36 INFO - Running setup.py install for psutil 03:41:36 INFO - building 'psutil._psutil_osx' extension 03:41:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:41:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:41:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:41:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:41:37 INFO - building 'psutil._psutil_posix' extension 03:41:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:41:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:41:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:41:37 INFO - ^ 03:41:37 INFO - 1 warning generated. 03:41:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:41:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:37 INFO - Successfully installed psutil 03:41:37 INFO - Cleaning up... 03:41:37 INFO - Return code: 0 03:41:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101edd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2aa5444c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf3d30>, '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 0x101b5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cebb20>, '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.vOCEChi2qC/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.EJrHizkeae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 03:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:41:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOCEChi2qC/Render', 03:41:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:37 INFO - 'HOME': '/Users/cltbld', 03:41:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:37 INFO - 'LOGNAME': 'cltbld', 03:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:37 INFO - 'MOZ_NO_REMOTE': '1', 03:41:37 INFO - 'NO_EM_RESTART': '1', 03:41:37 INFO - 'PAGER': '/bin/cat', 03:41:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:37 INFO - 'PWD': '/builds/slave/test', 03:41:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:37 INFO - 'SHELL': '/bin/bash', 03:41:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EJrHizkeae/Listeners', 03:41:37 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:41:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:37 INFO - 'USER': 'cltbld', 03:41:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:37 INFO - 'XPC_FLAGS': '0x0', 03:41:37 INFO - 'XPC_SERVICE_NAME': '0', 03:41:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:41:41 INFO - Installing collected packages: mozsystemmonitor 03:41:41 INFO - Running setup.py install for mozsystemmonitor 03:41:41 INFO - Successfully installed mozsystemmonitor 03:41:41 INFO - Cleaning up... 03:41:41 INFO - Return code: 0 03:41:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:41: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')]} 03:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41: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')]} 03:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101edd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2aa5444c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf3d30>, '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 0x101b5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cebb20>, '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.vOCEChi2qC/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.EJrHizkeae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 03:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:41:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOCEChi2qC/Render', 03:41:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:41 INFO - 'HOME': '/Users/cltbld', 03:41:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:41 INFO - 'LOGNAME': 'cltbld', 03:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:41 INFO - 'MOZ_NO_REMOTE': '1', 03:41:41 INFO - 'NO_EM_RESTART': '1', 03:41:41 INFO - 'PAGER': '/bin/cat', 03:41:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:41 INFO - 'PWD': '/builds/slave/test', 03:41:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:41 INFO - 'SHELL': '/bin/bash', 03:41:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EJrHizkeae/Listeners', 03:41:41 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:41:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:41 INFO - 'USER': 'cltbld', 03:41:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:41 INFO - 'XPC_FLAGS': '0x0', 03:41:41 INFO - 'XPC_SERVICE_NAME': '0', 03:41:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:41 INFO - Downloading/unpacking jsonschema==2.5.1 03:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:41:44 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 03:41:44 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 03:41:44 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 03:41:44 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 03:41:44 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 03:41:44 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 03:41:44 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:44 INFO - warning: no files found matching '*.txt' 03:41:44 INFO - no previously-included directories found matching 'build' 03:41:44 INFO - no previously-included directories found matching 'dist' 03:41:44 INFO - no previously-included directories found matching '.git*' 03:41:44 INFO - Installing collected packages: jsonschema, functools32 03:41:44 INFO - Running setup.py install for functools32 03:41:45 INFO - warning: no files found matching '*.txt' 03:41:45 INFO - no previously-included directories found matching 'build' 03:41:45 INFO - no previously-included directories found matching 'dist' 03:41:45 INFO - no previously-included directories found matching '.git*' 03:41:45 INFO - Successfully installed jsonschema functools32 03:41:45 INFO - Cleaning up... 03:41:45 INFO - Return code: 0 03:41:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101edd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2aa5444c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf3d30>, '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 0x101b5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cebb20>, '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.vOCEChi2qC/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.EJrHizkeae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 03:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOCEChi2qC/Render', 03:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:45 INFO - 'HOME': '/Users/cltbld', 03:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:45 INFO - 'LOGNAME': 'cltbld', 03:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:45 INFO - 'MOZ_NO_REMOTE': '1', 03:41:45 INFO - 'NO_EM_RESTART': '1', 03:41:45 INFO - 'PAGER': '/bin/cat', 03:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:45 INFO - 'PWD': '/builds/slave/test', 03:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:45 INFO - 'SHELL': '/bin/bash', 03:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EJrHizkeae/Listeners', 03:41:45 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:45 INFO - 'USER': 'cltbld', 03:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:45 INFO - 'XPC_FLAGS': '0x0', 03:41:45 INFO - 'XPC_SERVICE_NAME': '0', 03:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:41:45 INFO - Cleaning up... 03:41:45 INFO - Return code: 0 03:41:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101edd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2aa5444c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf3d30>, '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 0x101b5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cebb20>, '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.vOCEChi2qC/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.EJrHizkeae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 03:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOCEChi2qC/Render', 03:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:45 INFO - 'HOME': '/Users/cltbld', 03:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:45 INFO - 'LOGNAME': 'cltbld', 03:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:45 INFO - 'MOZ_NO_REMOTE': '1', 03:41:45 INFO - 'NO_EM_RESTART': '1', 03:41:45 INFO - 'PAGER': '/bin/cat', 03:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:45 INFO - 'PWD': '/builds/slave/test', 03:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:45 INFO - 'SHELL': '/bin/bash', 03:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EJrHizkeae/Listeners', 03:41:45 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:45 INFO - 'USER': 'cltbld', 03:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:45 INFO - 'XPC_FLAGS': '0x0', 03:41:45 INFO - 'XPC_SERVICE_NAME': '0', 03:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:48 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:49 INFO - Downloading docopt-0.6.1.tar.gz 03:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:49 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:49 INFO - Running setup.py install for blobuploader 03:41:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:49 INFO - Running setup.py install for requests 03:41:50 INFO - Running setup.py install for docopt 03:41:50 INFO - Successfully installed blobuploader requests docopt 03:41:50 INFO - Cleaning up... 03:41:50 INFO - Return code: 0 03:41:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:50 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')]} 03:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:50 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')]} 03:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:50 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 0x101edd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2aa5444c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf3d30>, '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 0x101b5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cebb20>, '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.vOCEChi2qC/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.EJrHizkeae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 03:41:50 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 03:41:50 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 03:41:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOCEChi2qC/Render', 03:41:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:50 INFO - 'HOME': '/Users/cltbld', 03:41:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:50 INFO - 'LOGNAME': 'cltbld', 03:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:50 INFO - 'MOZ_NO_REMOTE': '1', 03:41:50 INFO - 'NO_EM_RESTART': '1', 03:41:50 INFO - 'PAGER': '/bin/cat', 03:41:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:50 INFO - 'PWD': '/builds/slave/test', 03:41:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:50 INFO - 'SHELL': '/bin/bash', 03:41:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EJrHizkeae/Listeners', 03:41:50 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:41:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:50 INFO - 'USER': 'cltbld', 03:41:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:50 INFO - 'XPC_FLAGS': '0x0', 03:41:50 INFO - 'XPC_SERVICE_NAME': '0', 03:41:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:50 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-mILUDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:50 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-zg6TGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:50 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-grlAnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:50 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-jsL2Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-KOokEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-NNfBYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Vj6vQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-SwkOsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Vaqno3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-KX6ga6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-uNAILE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-O7t5TV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-jvnJ4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-FAq9O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-HwbmDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-rUuMrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-vBf4OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:52 INFO - Running setup.py install for manifestparser 03:41:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:52 INFO - Running setup.py install for mozcrash 03:41:52 INFO - Running setup.py install for mozdebug 03:41:52 INFO - Running setup.py install for mozdevice 03:41:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:53 INFO - Running setup.py install for mozfile 03:41:53 INFO - Running setup.py install for mozhttpd 03:41:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:53 INFO - Running setup.py install for mozinfo 03:41:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:53 INFO - Running setup.py install for mozInstall 03:41:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:53 INFO - Running setup.py install for mozleak 03:41:53 INFO - Running setup.py install for mozlog 03:41:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:53 INFO - Running setup.py install for moznetwork 03:41:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:54 INFO - Running setup.py install for mozprocess 03:41:54 INFO - Running setup.py install for mozprofile 03:41:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:54 INFO - Running setup.py install for mozrunner 03:41:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:54 INFO - Running setup.py install for mozscreenshot 03:41:54 INFO - Running setup.py install for moztest 03:41:54 INFO - Running setup.py install for mozversion 03:41:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:54 INFO - Cleaning up... 03:41:55 INFO - Return code: 0 03:41:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101edd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2aa5444c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf3d30>, '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 0x101b5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cebb20>, '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.vOCEChi2qC/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.EJrHizkeae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 03:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOCEChi2qC/Render', 03:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:55 INFO - 'HOME': '/Users/cltbld', 03:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:55 INFO - 'LOGNAME': 'cltbld', 03:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:55 INFO - 'MOZ_NO_REMOTE': '1', 03:41:55 INFO - 'NO_EM_RESTART': '1', 03:41:55 INFO - 'PAGER': '/bin/cat', 03:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:55 INFO - 'PWD': '/builds/slave/test', 03:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:55 INFO - 'SHELL': '/bin/bash', 03:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EJrHizkeae/Listeners', 03:41:55 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:55 INFO - 'USER': 'cltbld', 03:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:55 INFO - 'XPC_FLAGS': '0x0', 03:41:55 INFO - 'XPC_SERVICE_NAME': '0', 03:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:55 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-XypQAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:55 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)) 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:55 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-7kInG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:55 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)) 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:55 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-0Xv29I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:55 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)) 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:55 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-mWNhte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:55 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-8iYww8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:55 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)) 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:55 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-BVPEL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:55 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)) 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:55 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-h44QDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:56 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-vB4W7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:56 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-i1p5K6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:56 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)) 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:56 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-hTAwox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:56 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)) 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:56 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-kfwSA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:56 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)) 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:56 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-jI_1MR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:56 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)) 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:56 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-s3l4Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:56 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)) 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:56 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-yIJrKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:56 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)) 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:56 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-70UIg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:56 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)) 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:56 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Zmwgc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:56 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-BIjo91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:59 INFO - Downloading blessings-1.6.tar.gz 03:41:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:42:00 INFO - Installing collected packages: blessings 03:42:00 INFO - Running setup.py install for blessings 03:42:00 INFO - Successfully installed blessings 03:42:00 INFO - Cleaning up... 03:42:00 INFO - Return code: 0 03:42:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:42:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:00 INFO - Reading from file tmpfile_stdout 03:42:00 INFO - Current package versions: 03:42:00 INFO - blessings == 1.6 03:42:00 INFO - blobuploader == 1.2.4 03:42:00 INFO - docopt == 0.6.1 03:42:00 INFO - functools32 == 3.2.3-2 03:42:00 INFO - jsonschema == 2.5.1 03:42:00 INFO - manifestparser == 1.1 03:42:00 INFO - mozInstall == 1.12 03:42:00 INFO - mozcrash == 1.0 03:42:00 INFO - mozdebug == 0.1 03:42:00 INFO - mozdevice == 0.49 03:42:00 INFO - mozfile == 1.2 03:42:00 INFO - mozhttpd == 0.7 03:42:00 INFO - mozinfo == 0.9 03:42:00 INFO - mozleak == 0.1 03:42:00 INFO - mozlog == 3.4 03:42:00 INFO - moznetwork == 0.27 03:42:00 INFO - mozprocess == 0.23 03:42:00 INFO - mozprofile == 0.28 03:42:00 INFO - mozrunner == 6.13 03:42:00 INFO - mozscreenshot == 0.1 03:42:00 INFO - mozsystemmonitor == 0.3 03:42:00 INFO - moztest == 0.7 03:42:00 INFO - mozversion == 1.4 03:42:00 INFO - psutil == 3.1.1 03:42:00 INFO - requests == 1.2.3 03:42:00 INFO - wsgiref == 0.1.2 03:42:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:00 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 0x101edd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2aa5444c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf3d30>, '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 0x101b5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cebb20>, '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.vOCEChi2qC/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.EJrHizkeae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 03:42:00 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 03:42:00 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 03:42:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOCEChi2qC/Render', 03:42:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:00 INFO - 'HOME': '/Users/cltbld', 03:42:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:00 INFO - 'LOGNAME': 'cltbld', 03:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:00 INFO - 'MOZ_NO_REMOTE': '1', 03:42:00 INFO - 'NO_EM_RESTART': '1', 03:42:00 INFO - 'PAGER': '/bin/cat', 03:42:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:00 INFO - 'PWD': '/builds/slave/test', 03:42:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:00 INFO - 'SHELL': '/bin/bash', 03:42:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EJrHizkeae/Listeners', 03:42:00 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:42:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:00 INFO - 'USER': 'cltbld', 03:42:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:00 INFO - 'XPC_FLAGS': '0x0', 03:42:00 INFO - 'XPC_SERVICE_NAME': '0', 03:42:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:42:01 INFO - Cleaning up... 03:42:01 INFO - Return code: 0 03:42:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101edd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2aa5444c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf3d30>, '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 0x101b5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cebb20>, '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.vOCEChi2qC/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.EJrHizkeae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 03:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:42:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOCEChi2qC/Render', 03:42:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:01 INFO - 'HOME': '/Users/cltbld', 03:42:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:01 INFO - 'LOGNAME': 'cltbld', 03:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:01 INFO - 'MOZ_NO_REMOTE': '1', 03:42:01 INFO - 'NO_EM_RESTART': '1', 03:42:01 INFO - 'PAGER': '/bin/cat', 03:42:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:01 INFO - 'PWD': '/builds/slave/test', 03:42:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:01 INFO - 'SHELL': '/bin/bash', 03:42:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EJrHizkeae/Listeners', 03:42:01 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:42:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:01 INFO - 'USER': 'cltbld', 03:42:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:01 INFO - 'XPC_FLAGS': '0x0', 03:42:01 INFO - 'XPC_SERVICE_NAME': '0', 03:42:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:42:01 INFO - Cleaning up... 03:42:01 INFO - Return code: 0 03:42:01 INFO - Running post-action listener: _resource_record_post_action 03:42:01 INFO - Running post-action listener: _start_resource_monitoring 03:42:01 INFO - Starting resource monitoring. 03:42:01 INFO - [mozharness: 2016-11-25 11:42:01.434378Z] Finished create-virtualenv step (success) 03:42:01 INFO - [mozharness: 2016-11-25 11:42:01.435348Z] Running install step. 03:42:01 INFO - Running pre-action listener: _resource_record_pre_action 03:42:01 INFO - Running main action method: install 03:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:01 INFO - Reading from file tmpfile_stdout 03:42:01 INFO - Detecting whether we're running mozinstall >=1.0... 03:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:42:01 INFO - Reading from file tmpfile_stdout 03:42:01 INFO - Output received: 03:42:01 INFO - Usage: mozinstall [options] installer 03:42:01 INFO - Options: 03:42:01 INFO - -h, --help show this help message and exit 03:42:01 INFO - -d DEST, --destination=DEST 03:42:01 INFO - Directory to install application into. [default: 03:42:01 INFO - "/builds/slave/test"] 03:42:01 INFO - --app=APP Application being installed. [default: firefox] 03:42:01 INFO - mkdir: /builds/slave/test/build/application 03:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:42:34 INFO - Reading from file tmpfile_stdout 03:42:34 INFO - Output received: 03:42:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:42:34 INFO - Running post-action listener: _resource_record_post_action 03:42:34 INFO - [mozharness: 2016-11-25 11:42:34.553013Z] Finished install step (success) 03:42:34 INFO - [mozharness: 2016-11-25 11:42:34.553193Z] Running run-tests step. 03:42:34 INFO - Running pre-action listener: _resource_record_pre_action 03:42:34 INFO - Running main action method: run_tests 03:42:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:42:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:42:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:42:34 INFO - 2016-11-25 03:42:34.567 screenresolution[1645:7463] starting screenresolution argv=screenresolution get 03:42:34 INFO - 2016-11-25 03:42:34.570 screenresolution[1645:7463] Display 0: 1600x1200x32@60 03:42:34 INFO - 2016-11-25 03:42:34.575 screenresolution[1646:7465] starting screenresolution argv=screenresolution list 03:42:34 INFO - Available Modes on Display 0 03:42:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:42:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:42:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:42:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:42:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:42:34 INFO - Intel Iris: 03:42:34 INFO - Chipset Model: Intel Iris 03:42:34 INFO - Type: GPU 03:42:34 INFO - Bus: Built-In 03:42:34 INFO - VRAM (Dynamic, Max): 1536 MB 03:42:34 INFO - Vendor: Intel (0x8086) 03:42:34 INFO - Device ID: 0x0a2e 03:42:34 INFO - Revision ID: 0x0009 03:42:34 INFO - Displays: 03:42:34 INFO - Display: 03:42:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:42:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:42:34 INFO - Display Serial Number: 1600x1200 60 03:42:34 INFO - Main Display: Yes 03:42:34 INFO - Mirror: Off 03:42:34 INFO - Online: Yes 03:42:34 INFO - Rotation: Supported 03:42:34 INFO - Return code: 0 03:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:42:34 INFO - Python 2.7.3 03:42:34 INFO - Return code: 0 03:42:34 INFO - grabbing minidump binary from tooltool 03:42:34 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')]} 03:42:34 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 0x101cf3d30>, '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 0x101b5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cebb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:42:34 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 03:42:34 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 03:42:34 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 03:42:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:42:34 INFO - Return code: 0 03:42:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:42:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:42:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:42:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:42:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 03:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --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 03:42:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOCEChi2qC/Render', 03:42:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:34 INFO - 'HOME': '/Users/cltbld', 03:42:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:34 INFO - 'LOGNAME': 'cltbld', 03:42:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:34 INFO - 'MOZ_NO_REMOTE': '1', 03:42:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:34 INFO - 'NO_EM_RESTART': '1', 03:42:34 INFO - 'PAGER': '/bin/cat', 03:42:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:34 INFO - 'PWD': '/builds/slave/test', 03:42:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:34 INFO - 'SHELL': '/bin/bash', 03:42:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EJrHizkeae/Listeners', 03:42:34 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:42:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:34 INFO - 'USER': 'cltbld', 03:42:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:34 INFO - 'XPC_FLAGS': '0x0', 03:42:34 INFO - 'XPC_SERVICE_NAME': '0', 03:42:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 03:42:35 INFO - mozversion application_buildid: 20161125021618 03:42:35 INFO - mozversion application_changeset: 75453f12b616711e72c5a090b2041ae32450345e 03:42:35 INFO - mozversion application_display_name: Nightly 03:42:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:42:35 INFO - mozversion application_name: Firefox 03:42:35 INFO - mozversion application_remotingname: firefox 03:42:35 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 03:42:35 INFO - mozversion application_vendor: Mozilla 03:42:35 INFO - mozversion application_version: 53.0a1 03:42:35 INFO - mozversion platform_buildid: 20161125021618 03:42:35 INFO - mozversion platform_changeset: 75453f12b616711e72c5a090b2041ae32450345e 03:42:35 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 03:42:35 INFO - mozversion platform_version: 53.0a1 03:42:35 INFO - using testdate: 1480074155 03:42:35 INFO - actual date: 1480074155 03:42:35 INFO - starting webserver on 'localhost:49243' 03:42:35 INFO - SUITE-START | Running 2 tests 03:42:35 INFO - TEST-START | dromaeo_css 03:42:35 INFO - operating with platform_type : mac_ 03:42:35 INFO - Initialising browser for dromaeo_css test... 03:42:35 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpir6wbg/profile http://localhost:49243/getInfo.html) 03:42:38 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 03:42:38 INFO - PROCESS | 1656 | colorDepth:24 03:42:38 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 03:42:38 INFO - PROCESS | 1656 | __metrics 03:42:38 INFO - PROCESS | 1656 | 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" 03:42:38 INFO - PROCESS | 1656 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:42:39 INFO - TEST-INFO | 1656: exit 0 03:42:39 INFO - Browser initialized. 03:42:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:42:39 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpir6wbg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:51 INFO - PROCESS | 1659 | RSS: Main: 244047872 03:42:51 INFO - PROCESS | 1659 | 03:43:43 INFO - PROCESS | 1659 | 1480074223208 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:45:55 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 03:45:57 INFO - PROCESS | 1659 | RSS: Main: 450711552 03:45:57 INFO - PROCESS | 1659 | 03:49:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 03:49:01 INFO - PROCESS | 1659 | RSS: Main: 370237440 03:49:01 INFO - PROCESS | 1659 | 03:52:03 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 03:52:04 INFO - PROCESS | 1659 | RSS: Main: 348123136 03:52:04 INFO - PROCESS | 1659 | 03:55:06 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 03:55:07 INFO - PROCESS | 1659 | RSS: Main: 345112576 03:55:07 INFO - PROCESS | 1659 | 03:58:10 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 03:58:11 INFO - PROCESS | 1659 | RSS: Main: 332447744 03:58:11 INFO - PROCESS | 1659 | 04:01:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 04:01:15 INFO - PROCESS | 1659 | RSS: Main: 452534272 04:01:15 INFO - PROCESS | 1659 | 04:01:15 INFO - PROCESS | 1659 | __start_tp_report 04:01:15 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 04:01:15 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 04:01:15 INFO - PROCESS | 1659 | |i|pagename|runs| 04:01:15 INFO - PROCESS | 1659 | |0;dojo.html;2923.707629237076;3309.056918778147;3325.7173140283076;3335.082852215642;3373.0724050886;4483.439570053743;5517.806876759314;5637.774489020439;5748.942510574893;5787.21872547206;5615.494605485505;5667.659940403579;5779.797707080253;5781.277340332469;5787.074068149097;5114.641975061747;5148.485151484841;5156.8710782230555;5159.819406320779;5215.921761173567;5209.947900520984;5313.840584782443;5324.1747529133045;5326.786928522854;5333.919991200135;5141.38303403594;5282.2340760589495;5300.628955973045;5328.5470734987575;5388.757505912244;5185.092608793446;5194.610404219661;5216.686998780086;5231.581473482151;5244.737763111829;5136.178211486144;5178.0679477694;5179.249008893727;5192.948070519285;5240.79036838526;5751.194832723422;5756.280464941882;5787;5812.593118481708;5851.151583020438;6017.729202185868;6083.482903953125;6099.237595300588;6106.9764206718655;6212.65830379329;6115.51416190291;6154.292256390528;6174.660393678346;6174.9073763893575;6185.443310102112;5666.688332141731;5747.82756517301;5761.53907687384;5761.88476230473;5767.394423585505;6146.678464130234;6178.876422471525;6198.256209254918;6208.379162083846;6211.503079753609;6059.212302400748;6117.12715980571;6133.377250111103;6138.815835524942;6140.600860944024;5273.736313184402;6195.659238741822;6205;6215.098810672517;6231.626102433868;6182.598131121463;6183.134361189437;6186.938130618636;6188.257409110935;6199.535034872402;6101.176341193971;6123.353943808615;6139.201903752573;6163.229596300463;6170.10533472644;4905.950940490621;4913.557779799764;4916.680415772963;4932.457429682732;4953.281774142729;4267.722598031118;4317.784110794448;4391.7584532851;4392.231359512072;4430.756308403069;5580.693061881554;5645.435456454322;5647.407022262685;5714.142878568165;5765.1928729977835;5660.575456840754;6158.261008678987;6182.505399568024;6231.563790534709;6284.5600807943;4623.745693986796;5757.424257574293;5760.798372057042;5771.653700777967;5774.047282198474;4702.177119004161;5287.656302340336;5382.434844341366;5402.945970540244;5404.864878378072;6173.629582225081;6229.626222426669;6245.781397651061;6248.656323902047;6260.999999999909;6219.689015549295;6299.244090709144;6299.874002520016;6314.494840412848;6324.683765811783;6262.906056409249;6271.905921411274;6279.372062793684;6279.591826531261;6296.118543403835;5970.58205925581;5988.520918326436;6008.54935879802;6084;6156.507479401547;6100.08498725177;6107.249501910372;6124.877502449837;6145.385461453998;6181.96909015452;6104.944249919257;6115.909724157069;6132.08018797184;6141.631502109888;6143.419763699347;6042.516598672184;6104.8779024420155;6107.633541987318;6109.327973922954;6120.357362477054;5339.813106541253;5657.264555607745;5762.193292939076;5818.040023396092;5945.970270148621;5752.367239603724;5817.534597232296;5873.618214816023;5874.941250587611;5944.64332140073;5822.2140011099655;5880.382559831327;5880.470757631833;5883.264591926009;5932.525397968238 04:01:15 INFO - PROCESS | 1659 | |1;ext.html;484.50096400707287;515.1422880903295;516.966397184183;542.9493929246905;572.3360901354428;37433.43849842251;38602.03494912628;38713.80643096781;38733.41899871501;38977.80511097448;39844.203115937664;39974.400383994194;40089;40110.799446002726;40126.79936600313;8399.874001889977;9175.449473031606;9346.392484488486;9352;9389.248860091211;8335.624896879624;10953.945230273837;11199.832002519928;11217.831732524019;11383;10025.248106392013;10932.797392286842;11095.223334366598;11178.105751539899;11192.720181995433;8407.159284071544;11135.721606959809;11218.66344009681;11218.943905280503;11258.04306633937;8413.158684131598;10765.677029689123;11086.667399978014;11113.499892504857;11246.606368777053;38345.61654383448;38426.42360364597;38444.423333649735;38553.61446385556;38684.61315386866;3274.67253274673;3276.8689252429876;3278.852451639682;3332.6000879894327;3416.9658303417145;27763.861180693966;29249.853750731323;29380.26549336262;29488.756236813933;29629;3132.295233572451;3195.6964088411796;3195.856186471591;3196.8081915085168;3288.358770039843;410509;421473;422096;427452.9999999969;430909;54129.45870541323;54528;54690;54819.725901370235;54844;56029.719851400485;56047.43952560504;56234;56255.718721406134;56264.156037659464;15217.771733424008;15446.691066178613;15451.690966180839;15476.22618869052;15491.767623485657;10844.078253348396;11104.833427498594;12031.458584363725;12058.216215945935;12113.939430302793;12945;13004.024698147678;13042.673933151747;13051.543195988095;14301.642458938402;5517.586181036439;6466.612003279818;6492.513061520405;6516.934830651728;6554.180727409074;877.1798368525449;889.6930558957149;958.7171784323501;1020.3673722292078;1037.0355569320454;24926.5014699705;28255.57616635752;28490;28924.843006279934;28967.275818104717;1025.564135242519;1074.5970261152067;1089.0906093411932;1133.8185890257685;1152.7521582859727;12641.925436338015;13878.236696981763;14839.5548133554;14919.030263032868;15181.924090379478;561740;564004;565003;565578;573304;46691.53308466872;47610;52358.47641523536;53248;53725;1334.5262431836559;1357.7013057127417;1374.0450386980951;1383.4673650644372;1384.3701115992199;24632.384190395383;26907.865460672572;29144;29325.85337073301;29331.12006639804;47034.76482617565;47346.526534734214;47416.76291618658;47593.52406475891;47607;525754;528406;529407;529549;530693;24103;36796.63203368039;36983.815080924425;37076.629233708394;37088;41743;42565.57434425616;43169.35245971376;43650.34524482199;43738.34392484179;35890.82054589815;36101.638983609824;36602.45096323504;36882;37151;35966;36381.45427818638;36437.63562364342;37524.43713344247;37633.81183094067;35446;35619.82190089033;36441.63558364382;36538.63461365352;36686.082847929014;26712.065077722185;31699.36601268008;32531.512027319135;32811.67188328086;33067;24137.758622413552;24315.635265471385;24446.511069778862;24876.751232487444;24933.0026798926 04:01:15 INFO - PROCESS | 1659 | |2;jquery.html;320.1739512058888;349.2996541933423;365.0708945733109;369.4753450100857;400.27949690557006;14480.637984050403;14858;15436.845631543682;19176.42470725877;19660.016999150022;18762.62474750504;18778.812211877877;19990.60018799623;20271.189152433886;20271.49321266969;4308.3537469379535;5347.946520534783;5348.673327102703;5352.4915133062495;5355.223492593572;4922.360093187881;5141.742912854361;5302.3902251241025;5316.680999140064;5360.597955153379;5355.143177091666;5361.169018802072;5364.980653675809;5365.114756065244;5378.46215378463;5096.541311282002;5226.764795584208;5274.4198138204765;5288.947110528884;5349.197620356938;5139.820106296299;5142.897142057175;5148.974255128738;5149.227615857614;5150.4334523202415;13724.588262352145;23522.882385588135;24187;24191.637125443132;24507.774611269364;2107.2729908181655;2275.943101422461;2384.284714585617;2494.3140636324974;2665.4935562243113;9559.952200239024;9578.281628877792;9732.513374331325;10245.077942985092;10263.538140783683;1736.8957862528289;1765.8940463572226;1781.7861856577165;1790.7313902914536;1791.587934774996;114753.85246147598;118419.40790295994;121321.87182599613;121701.49536531497;122141.38929305386;9109.726708198765;9631.807363852684;9644.614215431304;9784.608615655436;9900.158486528582;11986.400679965967;12196.329201893981;12250.81623775644;12307.26156430617;12399.318037508023;7625.513024960191;7713.451812166466;7733.072031356273;7827.060752709711;7915.287624113857;7125.3230943060325;8089.555074470961;8098.51408915467;8254.339652827879;8261.091279959199;3758.755680880734;3761.586225515191;3765.849366025383;3844.154286057063;3852.845886164578;1818.6544556534216;1864.4499872537633;1870.345379117298;1875.9437216883516;1876.1557299215408;786.0292538714683;919.7838507950627;934.6635211324054;964.8118616869643;966.9371490853072;19830.603387932162;21075.26236581712;21208.893955530122;21215.787842121383;21466.24868129639;855.7603870916029;871.0723079919865;916.9449833010041;944.9385789923633;965.5751469353462;10583.735406614896;11013.944930275296;11092.001719845253;11126.499307531181;11342.432878356214;461140;465065.6746716245;469230;541479;548464;111986;117988.41005794916;123330;126864.36567817102;131345;929.1776777551916;978.1148061004802;991.9336713033517;994.7165057958447;995.2933417273816;16243.350265989227;18566.535836604195;18832.435026949213;18954.52613684669;19211.751236169603;52017.7399113002;52977.67555810981;54163;54347;55625.44374556364;56938;75216;75480;79124.60437697775;83773.58113209395;6741.752775736504;6768.695408706521;7063;7157.176924653523;7336.486445948733;8909.509976951329;10709.410982396043;11509.654710358702;12458.626241212778;12545.93727031359;10409.9479502602;10690.632450777981;11006.944965275123;11092.889071109186;11147.331160130418;10468.319559228627;10597.735056623646;10677.519511622151;11035.61375351891;11095.278806877526;10925.289856159325;10971.970185515385;11136.832947505633;11205.495752690986;11385;6848.794536163923;7865.921340786747;7958.283754462126;7966.3626909848235;8000.679972801023;9096.727098187064;10475.685729428129;10501.9474902625;10911.454427278446;10982.670519884416 04:01:15 INFO - PROCESS | 1659 | |3;mootools.html;1343.1739480219667;1484.2430360516134;1507.871830894374;1689.7465380192968;1861.525311045684;7484.176740558534;7905.209479052099;8074.838503229939;8401.789955251123;8411.579421028939;8259.21537453941;8340.165983401657;8347.582620868947;8374.455660382086;8386.580670966458;2052.8563000589966;2141.015133038804;2279.0541925101065;2327.5461285049423;2330.8718020508863;2195.802377785999;2196.7258989785964;2268.4555706630454;2344.542814151241;2348.802110923433;2301.309607117866;2315.4327189838514;2321.918732844351;2325.0002498925455;2326.9883650581723;2307.0541078157958;2308.0306271366067;2326.3718795925092;2327.185485080225;2327.5103933482583;2305;2328.9650655240184;2330.4057465346395;2331.75516570761;2333.230034088747;7352.117745870476;8320.7087751929;8335.54154521501;8391.580420978988;8430.156984301582;4312.805923733439;5097.082525145473;5151.742412879378;5170.870728231786;5174.068667639824;3196.488561830096;3283.40898638245;3506.1409954561295;3529.9647003529894;3530.947035794465;1034.7051090439263;1045.8547890060372;1057.7778666480049;1071.7481391872982;1081.1512962324616;10709;10776.5689372425;10848.620298289601;10882.455877206186;10886.346819190794;4453.621442177387;4530.207213737583;4669.276262179367;4669.486356500782;4672.719636821802;9305.348625596278;9316.8602470963;9324.90675093254;9325.906740932503;9333.859992100124;5129.692218466904;5230.895382092413;5231.921521177185;5245.895082098413;5250.422453530108;4001.519817621904;4183.581641835792;4759.286107083896;4780.617550595944;4784.593309568656;3692.132348898007;3698.7225958053255;3760.304343696425;3812.7331086823656;3823.3118038752737;1253.1228140301826;1259.3577275589516;1266.2529107826426;1274.4519856461811;1276.6744480157686;823.5964377455124;840.0759164918663;878.1613559051091;887.8546674789578;916.6012784438791;5432.945670543244;5550.946979161445;5743.8564035899435;5788.131780232999;5900.1149827526215;863.2921004776024;903.712210100604;911.1162172692477;917.7200953709049;950.4297421547154;3452.37857185709;3607.9278414431565;3739.719521035933;3808.3716186828865;3837.0982819037504;9514.38156519824;9825.754356141153;10001.699949001542;10111.64609238673;10143.442110683836;9793.510324483746;10072;10081;10086.546105425274;10097;7739.34215591681;7741.1871753465075;7764.61176941162;7883.2905038546805;7899.684012639545;5353.304070470814;5364.302640656846;5446.455354464521;5461.371942226695;5526.89462107572;9103.408278461879;9289.72130836076;9340.206082483064;9388.202002829836;9465.337426380087;8048.356131509582;9231.76920576964;9469.47917864524;9562.90437095648;9573.042695730372;6581.769638062645;6790.490713196629;6810.353016463626;7042.6126563039525;7197.424206063398;7568.962155189189;7806.57063861493;7870.881936771068;7940.6029698515995;7950.165232650488;6960.79117626472;7076.858462830817;7152.821179470555;7183.425325974014;7229.602371869598;6891.37977582;6961.164660240804;6970.790876273517;7048.365647091787;7055;5996.4603185713495;6599.043138744951;6666.433353164842;6667.699953502201;6670.733170673313;4722.126406614787;4731.929021064618;4753.191957367187;4786.018866132504;4911.435184953633;4660.277656963176;4742.383490146259;4823.758812059453;4886.438059623189;4977.303177555217 04:01:15 INFO - PROCESS | 1659 | |4;prototype.html;250.80061351225774;251.66402852192323;300.8465682501923;306.6488870243571;309.3117812866374;5261.973690131549;5290.254216108685;5309.840704778853;5325.591621362321;5327.36071671399;4912.792440013579;4986.653603527055;5064.797408103681;5156;5234.450382709818;3630.3828349180703;3819.541655001404;4029.858954936578;4030.7581545107387;4057.2696914555368;4017.7857713828967;4034.878953631381;4044.878653640381;4046.210988857174;4048.392741088831;3343.916402089955;3634.418493041114;3799.544054713438;3989.7606143631474;4009.939850902239;3389.254364039907;3965.4931126172014;3976.642102210786;3984.382420724792;4027.7180597358342;3452.361313157074;3479.356319080978;3480;3484.8083355415442;3484.9128771780656;4863.975680121612;5055.879458241521;5070.72111033893;5073.670211436245;5074.45229205096;4486.102779444124;4527.185106680796;4557.863264102082;4565.954340456587;4572.862814115582;4828.637852161102;5416.471105163825;5426.565874730012;5447.836564903059;5451.727413629303;3241.7406607471344;3809.3714537101346;3817.396693388783;3827;3830.8276127574327;5503.532199762985;5659.320881494205;5731.856703582361;5738.684372359518;5767.394423585505;3420.785621104522;3496.230829217619;3641.417373220272;3866.2074274773604;3885.9222815544094;3444.105741841977;3897.8830635080994;3900.4452083884535;3917.4711413958753;3932.2725295820364;3809.9238015240094;4254.340577210537;4473.977630111829;4510.300903359985;4530.750808705487;5034.194528875362;5130.409573032372;5140.974295128501;5474.425185355481;5491.835244942658;1089.6948854320804;1162.7558212775243;1255.2405794494382;1277.9073891822543;1286.5304163980268;766.4979438467813;816.7753867686433;825.9834803303901;838.1116017021976;870.216804875617;4216.746995180299;4671.556202160789;4827.903441931142;4856.8300109495995;4869.2939523768855;4669.579737823612;4716.113554578127;5272;5346.674196724437;5365.370968225541;4471.575200355961;4791.664583479123;4808.63935204861;4819.6867203631655;5214.426413094557;2235.3681812277127;2646.2159112469353;2844.7297506736827;2855.400365923138;2872.9138125856257;5039.823606173766;5224.928889577627;5669.533752817538;5674;5692.459216374438;5276.354410228331;5556.861078473071;5589.189567512688;5607.439256074442;5625.71871406428;5329.86675333112;5407.513323800798;5624.971875140762;5632.746526406321;5670.943290567042;4744;4933.309336692794;5418.972905135449;5470.617056806144;5477.561795056306;5271.472852714851;5643.887122257614;5712.773077345713;5713.914291285717;5718.285214348207;5936.109583562327;5946.28644562638;5963.70181490915;5973.850653733692;5976.312724036791;3671.5777685565436;3773.1887644156636;3793.6016718244186;3819.6371344722206;3825.800164905246;5665.546756259571;5709.7145142741865;5711.514521265739;5725.7137143141845;5737.397573254915;5119.029173768052;5547.41752116022;5567.051531963781;5569.888602227852;5575.888482230252;5247.396549396868;5488.408361575099;5527.479943015703;5551.916721249266;5555.694436806015;5447.291852059207;5447.945520544744;5448.918266226089;5453.64551304164;5517.944820551904;5276.736163191748;5286.731184515766;5407.810281738011;5497.945020549903;5521.889562208814;4660.743659098782;5472.644278121909;5477.342718873601;5478.863028424162;5515.31782806248 04:01:15 INFO - PROCESS | 1659 | |5;yui.html;720.9927900720991;751.6918063593928;757.257887270475;787.1066339704436;788.9092754333246;14286.428542858286;14767.630809229775;14779.334929928153;14787.704245915089;14833.184174870377;13157.473701051946;13324;13328.266945318004;13339.266340351276;13342.266175360352;635.282131191755;659.1859054068221;659.8251463362213;783.7844592736986;788.5347644889529;803.9276465118138;810.2748040503745;817.7056259746487;817.791463176889;820.4379999700195;854.8888644476209;860.513809697522;864.5936409887343;865.5931712095305;865.8614621660536;663.6515829189666;695.6243628440636;856.443311847298;858.1632907914827;859.3984211052289;601.2844714789387;628.4249911331126;633.1958412815699;635.9809205723835;637.3753721353054;13535.864641353657;13566.253856037914;13575.117617354841;13596.864031359659;13600.455981760717;12657.367131643381;12679.93660031694;12809;12855.807162892565;13069.607911762663;10647.627333043307;11845.88154118465;11860.647116587632;11965.401729913556;12408.255504669749;4319.481662200525;4337.219300525904;4429.9778501107285;4525.70582912113;4526.298423744325;80306.79539806908;81354;83260.75108873371;83680.58159709163;84174.99999999939;10230.64192753265;10300.845487317696;10309.484525773682;10324.174066074846;10690.518926648165;18073.819261807475;18911.338103166323;19421;19460.610787784164;19561.706574401396;7450.329470347695;7454.40364770817;7639.541627502367;7748.496347737379;7784.416168787364;4263.573642635712;4345;4353.085851971058;4418.226810308183;4533.795979180944;3415.55597772293;3500.6149323574386;3523.4714792780774;3539.2567560812004;3553.07620018797;636.7930422612669;650.6453982579505;652.6149571752688;660.5970358081566;672.2672287206968;556.8691357530977;581.668448984075;643.6974621927686;647.8639485708054;652.425865238587;8432.915670843213;8460.873086903579;8577.02129350858;8950.68672596469;9013.278937684969;538.6095081066273;542.9348478182643;567.5686478276457;628.1614045249552;641.4131070070833;4025.826053930903;4201.722507094177;4239.491261048633;4435.977820110878;4484.170428470743;97502;101727;104715.47642261893;108630.45684771525;108686;68947.65526172337;92532.14935701383;94362;96043.51978240065;100146.99853001376;57444.99999999916;59250;83330;85659.5717021411;87419.56290218636;9122.361434699507;9553.23574114083;9554;9583.616655333988;9629.566669499749;41792.791036044626;49067.50932490629;49607.503924960285;51448.22827657663;54586.63533411697;57818;61584.38415615787;66427.33572664211;75928.62035689787;76178.8573171414;12052.939735301268;12142.785721427786;12239.75520489603;12312.291295914885;12647.114701970773;13878;14293.285335732964;14530;14561.417543298574;14705.191214482878;12779.105462617528;12862.292573908151;13397.53108641193;13637.522686705917;13810.033297669066;13066.412011459317;13165.934170329087;13549.32253387307;13606.727865442834;13625.727485450434;12660.366981651065;13233.735325293634;13334.866651333363;13443.596692099252;13479.797803033158;10415.270931034755;10691.946540267249;10696.83954740664;10875.673729788119;11174.329540227613;8047.114817369968;8293.482452757331;9934.304598678023;10841.241113122005;10911.399873007062 04:01:15 INFO - PROCESS | 1659 | __end_tp_report 04:01:15 INFO - PROCESS | 1659 | __start_cc_report 04:01:15 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2461 04:01:15 INFO - PROCESS | 1659 | __end_cc_report 04:01:15 INFO - PROCESS | 1659 | __startTimestamp1480075275375__endTimestamp 04:01:15 INFO - PROCESS | 1659 | 04:01:15 INFO - PROCESS | 1659 | ------- Summary: start ------- 04:01:15 INFO - PROCESS | 1659 | Number of tests: 6 04:01:15 INFO - PROCESS | 1659 | 04:01:15 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5681.46 Median:5822.21 stddev:648.59 (11.1%) stddev-sans-first:613.44 04:01:15 INFO - PROCESS | 1659 | Values: 2923.7 3309.1 3325.7 3335.1 3373.1 4483.4 5517.8 5637.8 5748.9 5787.2 5615.5 5667.7 5779.8 5781.3 5787.1 5114.6 5148.5 5156.9 5159.8 5215.9 5209.9 5313.8 5324.2 5326.8 5333.9 5141.4 5282.2 5300.6 5328.5 5388.8 5185.1 5194.6 5216.7 5231.6 5244.7 5136.2 5178.1 5179.2 5192.9 5240.8 5751.2 5756.3 5787.0 5812.6 5851.2 6017.7 6083.5 6099.2 6107.0 6212.7 6115.5 6154.3 6174.7 6174.9 6185.4 5666.7 5747.8 5761.5 5761.9 5767.4 6146.7 6178.9 6198.3 6208.4 6211.5 6059.2 6117.1 6133.4 6138.8 6140.6 5273.7 6195.7 6205.0 6215.1 6231.6 6182.6 6183.1 6186.9 6188.3 6199.5 6101.2 6123.4 6139.2 6163.2 6170.1 4906.0 4913.6 4916.7 4932.5 4953.3 4267.7 4317.8 4391.8 4392.2 4430.8 5580.7 5645.4 5647.4 5714.1 5765.2 5660.6 6158.3 6182.5 6231.6 6284.6 4623.7 5757.4 5760.8 5771.7 5774.0 4702.2 5287.7 5382.4 5402.9 5404.9 6173.6 6229.6 6245.8 6248.7 6261.0 6219.7 6299.2 6299.9 6314.5 6324.7 6262.9 6271.9 6279.4 6279.6 6296.1 5970.6 5988.5 6008.5 6084.0 6156.5 6100.1 6107.2 6124.9 6145.4 6182.0 6104.9 6115.9 6132.1 6141.6 6143.4 6042.5 6104.9 6107.6 6109.3 6120.4 5339.8 5657.3 5762.2 5818.0 5946.0 5752.4 5817.5 5873.6 5874.9 5944.6 5822.2 5880.4 5880.5 5883.3 5932.5 04:01:15 INFO - PROCESS | 1659 | 04:01:15 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:63719.58 Median:36409.54 stddev:135799.31 (373.0%) stddev-sans-first:136097.27 04:01:15 INFO - PROCESS | 1659 | Values: 484.5 515.1 517.0 542.9 572.3 37433.4 38602.0 38713.8 38733.4 38977.8 39844.2 39974.4 40089.0 40110.8 40126.8 8399.9 9175.4 9346.4 9352.0 9389.2 8335.6 10953.9 11199.8 11217.8 11383.0 10025.2 10932.8 11095.2 11178.1 11192.7 8407.2 11135.7 11218.7 11218.9 11258.0 8413.2 10765.7 11086.7 11113.5 11246.6 38345.6 38426.4 38444.4 38553.6 38684.6 3274.7 3276.9 3278.9 3332.6 3417.0 27763.9 29249.9 29380.3 29488.8 29629.0 3132.3 3195.7 3195.9 3196.8 3288.4 410509.0 421473.0 422096.0 427453.0 430909.0 54129.5 54528.0 54690.0 54819.7 54844.0 56029.7 56047.4 56234.0 56255.7 56264.2 15217.8 15446.7 15451.7 15476.2 15491.8 10844.1 11104.8 12031.5 12058.2 12113.9 12945.0 13004.0 13042.7 13051.5 14301.6 5517.6 6466.6 6492.5 6516.9 6554.2 877.2 889.7 958.7 1020.4 1037.0 24926.5 28255.6 28490.0 28924.8 28967.3 1025.6 1074.6 1089.1 1133.8 1152.8 12641.9 13878.2 14839.6 14919.0 15181.9 561740.0 564004.0 565003.0 565578.0 573304.0 46691.5 47610.0 52358.5 53248.0 53725.0 1334.5 1357.7 1374.0 1383.5 1384.4 24632.4 26907.9 29144.0 29325.9 29331.1 47034.8 47346.5 47416.8 47593.5 47607.0 525754.0 528406.0 529407.0 529549.0 530693.0 24103.0 36796.6 36983.8 37076.6 37088.0 41743.0 42565.6 43169.4 43650.3 43738.3 35890.8 36101.6 36602.5 36882.0 37151.0 35966.0 36381.5 36437.6 37524.4 37633.8 35446.0 35619.8 36441.6 36538.6 36686.1 26712.1 31699.4 32531.5 32811.7 33067.0 24137.8 24315.6 24446.5 24876.8 24933.0 04:01:15 INFO - PROCESS | 1659 | 04:01:15 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:31426.77 Median:3763.72 stddev:84278.23 (2239.2%) stddev-sans-first:84482.29 04:01:15 INFO - PROCESS | 1659 | Values: 320.2 349.3 365.1 369.5 400.3 14480.6 14858.0 15436.8 19176.4 19660.0 18762.6 18778.8 19990.6 20271.2 20271.5 4308.4 5347.9 5348.7 5352.5 5355.2 4922.4 5141.7 5302.4 5316.7 5360.6 5355.1 5361.2 5365.0 5365.1 5378.5 5096.5 5226.8 5274.4 5288.9 5349.2 5139.8 5142.9 5149.0 5149.2 5150.4 13724.6 23522.9 24187.0 24191.6 24507.8 2107.3 2275.9 2384.3 2494.3 2665.5 9560.0 9578.3 9732.5 10245.1 10263.5 1736.9 1765.9 1781.8 1790.7 1791.6 114753.9 118419.4 121321.9 121701.5 122141.4 9109.7 9631.8 9644.6 9784.6 9900.2 11986.4 12196.3 12250.8 12307.3 12399.3 7625.5 7713.5 7733.1 7827.1 7915.3 7125.3 8089.6 8098.5 8254.3 8261.1 3758.8 3761.6 3765.8 3844.2 3852.8 1818.7 1864.4 1870.3 1875.9 1876.2 786.0 919.8 934.7 964.8 966.9 19830.6 21075.3 21208.9 21215.8 21466.2 855.8 871.1 916.9 944.9 965.6 10583.7 11013.9 11092.0 11126.5 11342.4 461140.0 465065.7 469230.0 541479.0 548464.0 111986.0 117988.4 123330.0 126864.4 131345.0 929.2 978.1 991.9 994.7 995.3 16243.4 18566.5 18832.4 18954.5 19211.8 52017.7 52977.7 54163.0 54347.0 55625.4 56938.0 75216.0 75480.0 79124.6 83773.6 6741.8 6768.7 7063.0 7157.2 7336.5 8909.5 10709.4 11509.7 12458.6 12545.9 10409.9 10690.6 11006.9 11092.9 11147.3 10468.3 10597.7 10677.5 11035.6 11095.3 10925.3 10972.0 11136.8 11205.5 11385.0 6848.8 7865.9 7958.3 7966.4 8000.7 9096.7 10475.7 10501.9 10911.5 10982.7 04:01:15 INFO - PROCESS | 1659 | 04:01:15 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5397.16 Median:5161.31 stddev:2956.89 (57.3%) stddev-sans-first:2949.49 04:01:15 INFO - PROCESS | 1659 | Values: 1343.2 1484.2 1507.9 1689.7 1861.5 7484.2 7905.2 8074.8 8401.8 8411.6 8259.2 8340.2 8347.6 8374.5 8386.6 2052.9 2141.0 2279.1 2327.5 2330.9 2195.8 2196.7 2268.5 2344.5 2348.8 2301.3 2315.4 2321.9 2325.0 2327.0 2307.1 2308.0 2326.4 2327.2 2327.5 2305.0 2329.0 2330.4 2331.8 2333.2 7352.1 8320.7 8335.5 8391.6 8430.2 4312.8 5097.1 5151.7 5170.9 5174.1 3196.5 3283.4 3506.1 3530.0 3530.9 1034.7 1045.9 1057.8 1071.7 1081.2 10709.0 10776.6 10848.6 10882.5 10886.3 4453.6 4530.2 4669.3 4669.5 4672.7 9305.3 9316.9 9324.9 9325.9 9333.9 5129.7 5230.9 5231.9 5245.9 5250.4 4001.5 4183.6 4759.3 4780.6 4784.6 3692.1 3698.7 3760.3 3812.7 3823.3 1253.1 1259.4 1266.3 1274.5 1276.7 823.6 840.1 878.2 887.9 916.6 5432.9 5550.9 5743.9 5788.1 5900.1 863.3 903.7 911.1 917.7 950.4 3452.4 3607.9 3739.7 3808.4 3837.1 9514.4 9825.8 10001.7 10111.6 10143.4 9793.5 10072.0 10081.0 10086.5 10097.0 7739.3 7741.2 7764.6 7883.3 7899.7 5353.3 5364.3 5446.5 5461.4 5526.9 9103.4 9289.7 9340.2 9388.2 9465.3 8048.4 9231.8 9469.5 9562.9 9573.0 6581.8 6790.5 6810.4 7042.6 7197.4 7569.0 7806.6 7870.9 7940.6 7950.2 6960.8 7076.9 7152.8 7183.4 7229.6 6891.4 6961.2 6970.8 7048.4 7055.0 5996.5 6599.0 6666.4 6667.7 6670.7 4722.1 4731.9 4753.2 4786.0 4911.4 4660.3 4742.4 4823.8 4886.4 4977.3 04:01:15 INFO - PROCESS | 1659 | 04:01:15 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4451.85 Median:5060.34 stddev:1382.11 (27.3%) stddev-sans-first:1349.54 04:01:15 INFO - PROCESS | 1659 | Values: 250.8 251.7 300.8 306.6 309.3 5262.0 5290.3 5309.8 5325.6 5327.4 4912.8 4986.7 5064.8 5156.0 5234.5 3630.4 3819.5 4029.9 4030.8 4057.3 4017.8 4034.9 4044.9 4046.2 4048.4 3343.9 3634.4 3799.5 3989.8 4009.9 3389.3 3965.5 3976.6 3984.4 4027.7 3452.4 3479.4 3480.0 3484.8 3484.9 4864.0 5055.9 5070.7 5073.7 5074.5 4486.1 4527.2 4557.9 4566.0 4572.9 4828.6 5416.5 5426.6 5447.8 5451.7 3241.7 3809.4 3817.4 3827.0 3830.8 5503.5 5659.3 5731.9 5738.7 5767.4 3420.8 3496.2 3641.4 3866.2 3885.9 3444.1 3897.9 3900.4 3917.5 3932.3 3809.9 4254.3 4474.0 4510.3 4530.8 5034.2 5130.4 5141.0 5474.4 5491.8 1089.7 1162.8 1255.2 1277.9 1286.5 766.5 816.8 826.0 838.1 870.2 4216.7 4671.6 4827.9 4856.8 4869.3 4669.6 4716.1 5272.0 5346.7 5365.4 4471.6 4791.7 4808.6 4819.7 5214.4 2235.4 2646.2 2844.7 2855.4 2872.9 5039.8 5224.9 5669.5 5674.0 5692.5 5276.4 5556.9 5589.2 5607.4 5625.7 5329.9 5407.5 5625.0 5632.7 5670.9 4744.0 4933.3 5419.0 5470.6 5477.6 5271.5 5643.9 5712.8 5713.9 5718.3 5936.1 5946.3 5963.7 5973.9 5976.3 3671.6 3773.2 3793.6 3819.6 3825.8 5665.5 5709.7 5711.5 5725.7 5737.4 5119.0 5547.4 5567.1 5569.9 5575.9 5247.4 5488.4 5527.5 5551.9 5555.7 5447.3 5447.9 5448.9 5453.6 5517.9 5276.7 5286.7 5407.8 5497.9 5521.9 4660.7 5472.6 5477.3 5478.9 5515.3 04:01:15 INFO - PROCESS | 1659 | 04:01:15 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:19446.66 Median:4526.00 stddev:27942.71 (617.4%) stddev-sans-first:27985.72 04:01:15 INFO - PROCESS | 1659 | Values: 721.0 751.7 757.3 787.1 788.9 14286.4 14767.6 14779.3 14787.7 14833.2 13157.5 13324.0 13328.3 13339.3 13342.3 635.3 659.2 659.8 783.8 788.5 803.9 810.3 817.7 817.8 820.4 854.9 860.5 864.6 865.6 865.9 663.7 695.6 856.4 858.2 859.4 601.3 628.4 633.2 636.0 637.4 13535.9 13566.3 13575.1 13596.9 13600.5 12657.4 12679.9 12809.0 12855.8 13069.6 10647.6 11845.9 11860.6 11965.4 12408.3 4319.5 4337.2 4430.0 4525.7 4526.3 80306.8 81354.0 83260.8 83680.6 84175.0 10230.6 10300.8 10309.5 10324.2 10690.5 18073.8 18911.3 19421.0 19460.6 19561.7 7450.3 7454.4 7639.5 7748.5 7784.4 4263.6 4345.0 4353.1 4418.2 4533.8 3415.6 3500.6 3523.5 3539.3 3553.1 636.8 650.6 652.6 660.6 672.3 556.9 581.7 643.7 647.9 652.4 8432.9 8460.9 8577.0 8950.7 9013.3 538.6 542.9 567.6 628.2 641.4 4025.8 4201.7 4239.5 4436.0 4484.2 97502.0 101727.0 104715.5 108630.5 108686.0 68947.7 92532.1 94362.0 96043.5 100147.0 57445.0 59250.0 83330.0 85659.6 87419.6 9122.4 9553.2 9554.0 9583.6 9629.6 41792.8 49067.5 49607.5 51448.2 54586.6 57818.0 61584.4 66427.3 75928.6 76178.9 12052.9 12142.8 12239.8 12312.3 12647.1 13878.0 14293.3 14530.0 14561.4 14705.2 12779.1 12862.3 13397.5 13637.5 13810.0 13066.4 13165.9 13549.3 13606.7 13625.7 12660.4 13233.7 13334.9 13443.6 13479.8 10415.3 10691.9 10696.8 10875.7 11174.3 8047.1 8293.5 9934.3 10841.2 10911.4 04:01:15 INFO - PROCESS | 1659 | -------- Summary: end -------- 04:01:15 INFO - PROCESS | 1659 | 04:01:15 INFO - TEST-INFO | 1659: exit 0 04:01:16 INFO - TEST-OK | dromaeo_css | took 1120853ms 04:01:16 INFO - TEST-START | kraken 04:01:16 INFO - operating with platform_type : mac_ 04:01:16 INFO - Initialising browser for kraken test... 04:01:16 INFO - TEST-INFO | started process 1784 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpiD7PJy/profile http://localhost:49243/getInfo.html) 04:01:18 INFO - PROCESS | 1784 | __metrics Screen width/height:1600/1200 04:01:18 INFO - PROCESS | 1784 | colorDepth:24 04:01:18 INFO - PROCESS | 1784 | Browser inner width/height: 1024/689 04:01:18 INFO - PROCESS | 1784 | __metrics 04:01:18 INFO - PROCESS | 1784 | 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" 04:01:18 INFO - PROCESS | 1784 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:01:19 INFO - TEST-INFO | 1784: exit 0 04:01:19 INFO - Browser initialized. 04:01:19 INFO - Running cycle 1/1 for kraken test... 04:01:19 INFO - TEST-INFO | started process 1786 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpiD7PJy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:31 INFO - PROCESS | 1786 | RSS: Main: 243814400 04:01:31 INFO - PROCESS | 1786 | 04:01:34 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 04:01:35 INFO - PROCESS | 1786 | RSS: Main: 294166528 04:01:35 INFO - PROCESS | 1786 | 04:01:37 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 04:01:38 INFO - PROCESS | 1786 | RSS: Main: 294158336 04:01:38 INFO - PROCESS | 1786 | 04:01:41 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 04:01:42 INFO - PROCESS | 1786 | RSS: Main: 386277376 04:01:42 INFO - PROCESS | 1786 | 04:01:44 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 04:01:45 INFO - PROCESS | 1786 | RSS: Main: 289484800 04:01:45 INFO - PROCESS | 1786 | 04:01:47 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:01:47 INFO - PROCESS | 1786 | RSS: Main: 293937152 04:01:47 INFO - PROCESS | 1786 | 04:01:50 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 04:01:51 INFO - PROCESS | 1786 | RSS: Main: 335716352 04:01:51 INFO - PROCESS | 1786 | 04:01:54 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 04:01:55 INFO - PROCESS | 1786 | RSS: Main: 337055744 04:01:55 INFO - PROCESS | 1786 | 04:01:57 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 04:01:58 INFO - PROCESS | 1786 | RSS: Main: 333352960 04:01:58 INFO - PROCESS | 1786 | 04:02:00 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:02:00 INFO - PROCESS | 1786 | RSS: Main: 311336960 04:02:00 INFO - PROCESS | 1786 | 04:02:02 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:02:03 INFO - PROCESS | 1786 | RSS: Main: 315109376 04:02:03 INFO - PROCESS | 1786 | 04:02:05 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:02:06 INFO - PROCESS | 1786 | RSS: Main: 316030976 04:02:06 INFO - PROCESS | 1786 | 04:02:09 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:02:09 INFO - PROCESS | 1786 | RSS: Main: 333725696 04:02:09 INFO - PROCESS | 1786 | 04:02:12 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:02:13 INFO - PROCESS | 1786 | RSS: Main: 327741440 04:02:13 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 04:02:15 INFO - PROCESS | 1786 | RSS: Main: 371159040 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | __start_tp_report 04:02:15 INFO - PROCESS | 1786 | _x_x_mozilla_page_load 04:02:15 INFO - PROCESS | 1786 | _x_x_mozilla_page_load_details 04:02:15 INFO - PROCESS | 1786 | |i|pagename|runs| 04:02:15 INFO - PROCESS | 1786 | |0;ai-astar;115;116;117;116;116;116;116;115;116;115 04:02:15 INFO - PROCESS | 1786 | |1;audio-beat-detection;152;135;112;151;117;115;112;111;131;112 04:02:15 INFO - PROCESS | 1786 | |2;audio-dft;182;183;184;184;185;184;183;180;182;182 04:02:15 INFO - PROCESS | 1786 | |3;audio-fft;78;60;58;85;80;73;79;78;88;58 04:02:15 INFO - PROCESS | 1786 | |4;audio-oscillator;90;69;99;98;95;93;82;68;69;84 04:02:15 INFO - PROCESS | 1786 | |5;imaging-gaussian-blur;89;86;90;125;130;87;97;126;111;86 04:02:15 INFO - PROCESS | 1786 | |6;imaging-darkroom;94;95;100;142;94;96;95;95;94;100 04:02:15 INFO - PROCESS | 1786 | |7;imaging-desaturate;87;84;85;87;85;102;136;130;89;86 04:02:15 INFO - PROCESS | 1786 | |8;json-parse-financial;58;53;54;53;54;55;54;55;55;55 04:02:15 INFO - PROCESS | 1786 | |9;json-stringify-tinderbox;66;82;74;76;72;69;71;68;72;73 04:02:15 INFO - PROCESS | 1786 | |10;stanford-crypto-aes;89;88;86;87;91;85;95;108;105;88 04:02:15 INFO - PROCESS | 1786 | |11;stanford-crypto-ccm;150;153;154;152;166;147;148;149;189;162 04:02:15 INFO - PROCESS | 1786 | |12;stanford-crypto-pbkdf2;172;173;193;219;189;173;170;172;169;171 04:02:15 INFO - PROCESS | 1786 | |13;stanford-crypto-sha256-iterative;66;85;84;72;68;68;68;66;66;68 04:02:15 INFO - PROCESS | 1786 | __end_tp_report 04:02:15 INFO - PROCESS | 1786 | __start_cc_report 04:02:15 INFO - PROCESS | 1786 | _x_x_mozilla_cycle_collect,1949 04:02:15 INFO - PROCESS | 1786 | __end_cc_report 04:02:15 INFO - PROCESS | 1786 | __startTimestamp1480075335582__endTimestamp 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | ------- Summary: start ------- 04:02:15 INFO - PROCESS | 1786 | Number of tests: 14 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 04:02:15 INFO - PROCESS | 1786 | Values: 115.0 116.0 117.0 116.0 116.0 116.0 116.0 115.0 116.0 115.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:124.00 stddev:16.36 (13.2%) stddev-sans-first:14.08 04:02:15 INFO - PROCESS | 1786 | Values: 152.0 135.0 112.0 151.0 117.0 115.0 112.0 111.0 131.0 112.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.50 stddev:1.45 (0.8%) stddev-sans-first:1.50 04:02:15 INFO - PROCESS | 1786 | Values: 182.0 183.0 184.0 184.0 185.0 184.0 183.0 180.0 182.0 182.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#3] audio-fft Cycles:10 Average:73.70 Median:78.50 stddev:11.15 (14.2%) stddev-sans-first:11.71 04:02:15 INFO - PROCESS | 1786 | Values: 78.0 60.0 58.0 85.0 80.0 73.0 79.0 78.0 88.0 58.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#4] audio-oscillator Cycles:10 Average:84.70 Median:91.50 stddev:12.31 (13.5%) stddev-sans-first:12.91 04:02:15 INFO - PROCESS | 1786 | Values: 90.0 69.0 99.0 98.0 95.0 93.0 82.0 68.0 69.0 84.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#5] imaging-gaussian-blur Cycles:10 Average:102.70 Median:86.50 stddev:18.38 (21.2%) stddev-sans-first:18.81 04:02:15 INFO - PROCESS | 1786 | Values: 89.0 86.0 90.0 125.0 130.0 87.0 97.0 126.0 111.0 86.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:94.50 stddev:14.76 (15.6%) stddev-sans-first:15.47 04:02:15 INFO - PROCESS | 1786 | Values: 94.0 95.0 100.0 142.0 94.0 96.0 95.0 95.0 94.0 100.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:85.50 stddev:19.66 (23.0%) stddev-sans-first:20.50 04:02:15 INFO - PROCESS | 1786 | Values: 87.0 84.0 85.0 87.0 85.0 102.0 136.0 130.0 89.0 86.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.43 (2.6%) stddev-sans-first:0.83 04:02:15 INFO - PROCESS | 1786 | Values: 58.0 53.0 54.0 53.0 54.0 55.0 54.0 55.0 55.0 55.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:72.50 stddev:4.50 (6.2%) stddev-sans-first:4.15 04:02:15 INFO - PROCESS | 1786 | Values: 66.0 82.0 74.0 76.0 72.0 69.0 71.0 68.0 72.0 73.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:88.00 stddev:8.07 (9.2%) stddev-sans-first:8.47 04:02:15 INFO - PROCESS | 1786 | Values: 89.0 88.0 86.0 87.0 91.0 85.0 95.0 108.0 105.0 88.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#11] stanford-crypto-ccm Cycles:10 Average:157.00 Median:153.50 stddev:12.80 (8.3%) stddev-sans-first:13.32 04:02:15 INFO - PROCESS | 1786 | Values: 150.0 153.0 154.0 152.0 166.0 147.0 148.0 149.0 189.0 162.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:173.00 stddev:15.98 (9.2%) stddev-sans-first:16.68 04:02:15 INFO - PROCESS | 1786 | Values: 172.0 173.0 193.0 219.0 189.0 173.0 170.0 172.0 169.0 171.0 04:02:15 INFO - PROCESS | 1786 | 04:02:15 INFO - PROCESS | 1786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:68.00 stddev:7.28 (10.7%) stddev-sans-first:7.48 04:02:15 INFO - PROCESS | 1786 | Values: 66.0 85.0 84.0 72.0 68.0 68.0 68.0 66.0 66.0 68.0 04:02:15 INFO - PROCESS | 1786 | -------- Summary: end -------- 04:02:15 INFO - PROCESS | 1786 | 04:02:16 INFO - TEST-INFO | 1786: exit 0 04:02:16 INFO - TEST-OK | kraken | took 60709ms 04:02:16 INFO - SUITE-END | took 1181s 04:02:16 INFO - Completed test suite (00:19:41) 04:02:16 INFO - javascript benchmark 04:02:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2923.707629237076, 3309.056918778147, 3325.7173140283076, 3335.082852215642, 3373.0724050886, 4483.439570053743, 5517.806876759314, 5637.774489020439, 5748.942510574893, 5787.21872547206, 5615.494605485505, 5667.659940403579, 5779.797707080253, 5781.277340332469, 5787.074068149097, 5114.641975061747, 5148.485151484841, 5156.8710782230555, 5159.819406320779, 5215.921761173567, 5209.947900520984, 5313.840584782443, 5324.1747529133045, 5326.786928522854, 5333.919991200135, 5141.38303403594, 5282.2340760589495, 5300.628955973045, 5328.5470734987575, 5388.757505912244, 5185.092608793446, 5194.610404219661, 5216.686998780086, 5231.581473482151, 5244.737763111829, 5136.178211486144, 5178.0679477694, 5179.249008893727, 5192.948070519285, 5240.79036838526, 5751.194832723422, 5756.280464941882, 5787.0, 5812.593118481708, 5851.151583020438, 6017.729202185868, 6083.482903953125, 6099.237595300588, 6106.9764206718655, 6212.65830379329, 6115.51416190291, 6154.292256390528, 6174.660393678346, 6174.9073763893575, 6185.443310102112, 5666.688332141731, 5747.82756517301, 5761.53907687384, 5761.88476230473, 5767.394423585505, 6146.678464130234, 6178.876422471525, 6198.256209254918, 6208.379162083846, 6211.503079753609, 6059.212302400748, 6117.12715980571, 6133.377250111103, 6138.815835524942, 6140.600860944024, 5273.736313184402, 6195.659238741822, 6205.0, 6215.098810672517, 6231.626102433868, 6182.598131121463, 6183.134361189437, 6186.938130618636, 6188.257409110935, 6199.535034872402, 6101.176341193971, 6123.353943808615, 6139.201903752573, 6163.229596300463, 6170.10533472644, 4905.950940490621, 4913.557779799764, 4916.680415772963, 4932.457429682732, 4953.281774142729, 4267.722598031118, 4317.784110794448, 4391.7584532851, 4392.231359512072, 4430.756308403069, 5580.693061881554, 5645.435456454322, 5647.407022262685, 5714.142878568165, 5765.1928729977835, 5660.575456840754, 6158.261008678987, 6182.505399568024, 6231.563790534709, 6284.5600807943, 4623.745693986796, 5757.424257574293, 5760.798372057042, 5771.653700777967, 5774.047282198474, 4702.177119004161, 5287.656302340336, 5382.434844341366, 5402.945970540244, 5404.864878378072, 6173.629582225081, 6229.626222426669, 6245.781397651061, 6248.656323902047, 6260.999999999909, 6219.689015549295, 6299.244090709144, 6299.874002520016, 6314.494840412848, 6324.683765811783, 6262.906056409249, 6271.905921411274, 6279.372062793684, 6279.591826531261, 6296.118543403835, 5970.58205925581, 5988.520918326436, 6008.54935879802, 6084.0, 6156.507479401547, 6100.08498725177, 6107.249501910372, 6124.877502449837, 6145.385461453998, 6181.96909015452, 6104.944249919257, 6115.909724157069, 6132.08018797184, 6141.631502109888, 6143.419763699347, 6042.516598672184, 6104.8779024420155, 6107.633541987318, 6109.327973922954, 6120.357362477054, 5339.813106541253, 5657.264555607745, 5762.193292939076, 5818.040023396092, 5945.970270148621, 5752.367239603724, 5817.534597232296, 5873.618214816023, 5874.941250587611, 5944.64332140073, 5822.2140011099655, 5880.382559831327, 5880.470757631833, 5883.264591926009, 5932.525397968238], "value": 5639.6150823006665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.50096400707287, 515.1422880903295, 516.966397184183, 542.9493929246905, 572.3360901354428, 37433.43849842251, 38602.03494912628, 38713.80643096781, 38733.41899871501, 38977.80511097448, 39844.203115937664, 39974.400383994194, 40089.0, 40110.799446002726, 40126.79936600313, 8399.874001889977, 9175.449473031606, 9346.392484488486, 9352.0, 9389.248860091211, 8335.624896879624, 10953.945230273837, 11199.832002519928, 11217.831732524019, 11383.0, 10025.248106392013, 10932.797392286842, 11095.223334366598, 11178.105751539899, 11192.720181995433, 8407.159284071544, 11135.721606959809, 11218.66344009681, 11218.943905280503, 11258.04306633937, 8413.158684131598, 10765.677029689123, 11086.667399978014, 11113.499892504857, 11246.606368777053, 38345.61654383448, 38426.42360364597, 38444.423333649735, 38553.61446385556, 38684.61315386866, 3274.67253274673, 3276.8689252429876, 3278.852451639682, 3332.6000879894327, 3416.9658303417145, 27763.861180693966, 29249.853750731323, 29380.26549336262, 29488.756236813933, 29629.0, 3132.295233572451, 3195.6964088411796, 3195.856186471591, 3196.8081915085168, 3288.358770039843, 410509.0, 421473.0, 422096.0, 427452.9999999969, 430909.0, 54129.45870541323, 54528.0, 54690.0, 54819.725901370235, 54844.0, 56029.719851400485, 56047.43952560504, 56234.0, 56255.718721406134, 56264.156037659464, 15217.771733424008, 15446.691066178613, 15451.690966180839, 15476.22618869052, 15491.767623485657, 10844.078253348396, 11104.833427498594, 12031.458584363725, 12058.216215945935, 12113.939430302793, 12945.0, 13004.024698147678, 13042.673933151747, 13051.543195988095, 14301.642458938402, 5517.586181036439, 6466.612003279818, 6492.513061520405, 6516.934830651728, 6554.180727409074, 877.1798368525449, 889.6930558957149, 958.7171784323501, 1020.3673722292078, 1037.0355569320454, 24926.5014699705, 28255.57616635752, 28490.0, 28924.843006279934, 28967.275818104717, 1025.564135242519, 1074.5970261152067, 1089.0906093411932, 1133.8185890257685, 1152.7521582859727, 12641.925436338015, 13878.236696981763, 14839.5548133554, 14919.030263032868, 15181.924090379478, 561740.0, 564004.0, 565003.0, 565578.0, 573304.0, 46691.53308466872, 47610.0, 52358.47641523536, 53248.0, 53725.0, 1334.5262431836559, 1357.7013057127417, 1374.0450386980951, 1383.4673650644372, 1384.3701115992199, 24632.384190395383, 26907.865460672572, 29144.0, 29325.85337073301, 29331.12006639804, 47034.76482617565, 47346.526534734214, 47416.76291618658, 47593.52406475891, 47607.0, 525754.0, 528406.0, 529407.0, 529549.0, 530693.0, 24103.0, 36796.63203368039, 36983.815080924425, 37076.629233708394, 37088.0, 41743.0, 42565.57434425616, 43169.35245971376, 43650.34524482199, 43738.34392484179, 35890.82054589815, 36101.638983609824, 36602.45096323504, 36882.0, 37151.0, 35966.0, 36381.45427818638, 36437.63562364342, 37524.43713344247, 37633.81183094067, 35446.0, 35619.82190089033, 36441.63558364382, 36538.63461365352, 36686.082847929014, 26712.065077722185, 31699.36601268008, 32531.512027319135, 32811.67188328086, 33067.0, 24137.758622413552, 24315.635265471385, 24446.511069778862, 24876.751232487444, 24933.0026798926], "value": 19139.904490675024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.1739512058888, 349.2996541933423, 365.0708945733109, 369.4753450100857, 400.27949690557006, 14480.637984050403, 14858.0, 15436.845631543682, 19176.42470725877, 19660.016999150022, 18762.62474750504, 18778.812211877877, 19990.60018799623, 20271.189152433886, 20271.49321266969, 4308.3537469379535, 5347.946520534783, 5348.673327102703, 5352.4915133062495, 5355.223492593572, 4922.360093187881, 5141.742912854361, 5302.3902251241025, 5316.680999140064, 5360.597955153379, 5355.143177091666, 5361.169018802072, 5364.980653675809, 5365.114756065244, 5378.46215378463, 5096.541311282002, 5226.764795584208, 5274.4198138204765, 5288.947110528884, 5349.197620356938, 5139.820106296299, 5142.897142057175, 5148.974255128738, 5149.227615857614, 5150.4334523202415, 13724.588262352145, 23522.882385588135, 24187.0, 24191.637125443132, 24507.774611269364, 2107.2729908181655, 2275.943101422461, 2384.284714585617, 2494.3140636324974, 2665.4935562243113, 9559.952200239024, 9578.281628877792, 9732.513374331325, 10245.077942985092, 10263.538140783683, 1736.8957862528289, 1765.8940463572226, 1781.7861856577165, 1790.7313902914536, 1791.587934774996, 114753.85246147598, 118419.40790295994, 121321.87182599613, 121701.49536531497, 122141.38929305386, 9109.726708198765, 9631.807363852684, 9644.614215431304, 9784.608615655436, 9900.158486528582, 11986.400679965967, 12196.329201893981, 12250.81623775644, 12307.26156430617, 12399.318037508023, 7625.513024960191, 7713.451812166466, 7733.072031356273, 7827.060752709711, 7915.287624113857, 7125.3230943060325, 8089.555074470961, 8098.51408915467, 8254.339652827879, 8261.091279959199, 3758.755680880734, 3761.586225515191, 3765.849366025383, 3844.154286057063, 3852.845886164578, 1818.6544556534216, 1864.4499872537633, 1870.345379117298, 1875.9437216883516, 1876.1557299215408, 786.0292538714683, 919.7838507950627, 934.6635211324054, 964.8118616869643, 966.9371490853072, 19830.603387932162, 21075.26236581712, 21208.893955530122, 21215.787842121383, 21466.24868129639, 855.7603870916029, 871.0723079919865, 916.9449833010041, 944.9385789923633, 965.5751469353462, 10583.735406614896, 11013.944930275296, 11092.001719845253, 11126.499307531181, 11342.432878356214, 461140.0, 465065.6746716245, 469230.0, 541479.0, 548464.0, 111986.0, 117988.41005794916, 123330.0, 126864.36567817102, 131345.0, 929.1776777551916, 978.1148061004802, 991.9336713033517, 994.7165057958447, 995.2933417273816, 16243.350265989227, 18566.535836604195, 18832.435026949213, 18954.52613684669, 19211.751236169603, 52017.7399113002, 52977.67555810981, 54163.0, 54347.0, 55625.44374556364, 56938.0, 75216.0, 75480.0, 79124.60437697775, 83773.58113209395, 6741.752775736504, 6768.695408706521, 7063.0, 7157.176924653523, 7336.486445948733, 8909.509976951329, 10709.410982396043, 11509.654710358702, 12458.626241212778, 12545.93727031359, 10409.9479502602, 10690.632450777981, 11006.944965275123, 11092.889071109186, 11147.331160130418, 10468.319559228627, 10597.735056623646, 10677.519511622151, 11035.61375351891, 11095.278806877526, 10925.289856159325, 10971.970185515385, 11136.832947505633, 11205.495752690986, 11385.0, 6848.794536163923, 7865.921340786747, 7958.283754462126, 7966.3626909848235, 8000.679972801023, 9096.727098187064, 10475.685729428129, 10501.9474902625, 10911.454427278446, 10982.670519884416], "value": 8945.012867773865, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.1739480219667, 1484.2430360516134, 1507.871830894374, 1689.7465380192968, 1861.525311045684, 7484.176740558534, 7905.209479052099, 8074.838503229939, 8401.789955251123, 8411.579421028939, 8259.21537453941, 8340.165983401657, 8347.582620868947, 8374.455660382086, 8386.580670966458, 2052.8563000589966, 2141.015133038804, 2279.0541925101065, 2327.5461285049423, 2330.8718020508863, 2195.802377785999, 2196.7258989785964, 2268.4555706630454, 2344.542814151241, 2348.802110923433, 2301.309607117866, 2315.4327189838514, 2321.918732844351, 2325.0002498925455, 2326.9883650581723, 2307.0541078157958, 2308.0306271366067, 2326.3718795925092, 2327.185485080225, 2327.5103933482583, 2305.0, 2328.9650655240184, 2330.4057465346395, 2331.75516570761, 2333.230034088747, 7352.117745870476, 8320.7087751929, 8335.54154521501, 8391.580420978988, 8430.156984301582, 4312.805923733439, 5097.082525145473, 5151.742412879378, 5170.870728231786, 5174.068667639824, 3196.488561830096, 3283.40898638245, 3506.1409954561295, 3529.9647003529894, 3530.947035794465, 1034.7051090439263, 1045.8547890060372, 1057.7778666480049, 1071.7481391872982, 1081.1512962324616, 10709.0, 10776.5689372425, 10848.620298289601, 10882.455877206186, 10886.346819190794, 4453.621442177387, 4530.207213737583, 4669.276262179367, 4669.486356500782, 4672.719636821802, 9305.348625596278, 9316.8602470963, 9324.90675093254, 9325.906740932503, 9333.859992100124, 5129.692218466904, 5230.895382092413, 5231.921521177185, 5245.895082098413, 5250.422453530108, 4001.519817621904, 4183.581641835792, 4759.286107083896, 4780.617550595944, 4784.593309568656, 3692.132348898007, 3698.7225958053255, 3760.304343696425, 3812.7331086823656, 3823.3118038752737, 1253.1228140301826, 1259.3577275589516, 1266.2529107826426, 1274.4519856461811, 1276.6744480157686, 823.5964377455124, 840.0759164918663, 878.1613559051091, 887.8546674789578, 916.6012784438791, 5432.945670543244, 5550.946979161445, 5743.8564035899435, 5788.131780232999, 5900.1149827526215, 863.2921004776024, 903.712210100604, 911.1162172692477, 917.7200953709049, 950.4297421547154, 3452.37857185709, 3607.9278414431565, 3739.719521035933, 3808.3716186828865, 3837.0982819037504, 9514.38156519824, 9825.754356141153, 10001.699949001542, 10111.64609238673, 10143.442110683836, 9793.510324483746, 10072.0, 10081.0, 10086.546105425274, 10097.0, 7739.34215591681, 7741.1871753465075, 7764.61176941162, 7883.2905038546805, 7899.684012639545, 5353.304070470814, 5364.302640656846, 5446.455354464521, 5461.371942226695, 5526.89462107572, 9103.408278461879, 9289.72130836076, 9340.206082483064, 9388.202002829836, 9465.337426380087, 8048.356131509582, 9231.76920576964, 9469.47917864524, 9562.90437095648, 9573.042695730372, 6581.769638062645, 6790.490713196629, 6810.353016463626, 7042.6126563039525, 7197.424206063398, 7568.962155189189, 7806.57063861493, 7870.881936771068, 7940.6029698515995, 7950.165232650488, 6960.79117626472, 7076.858462830817, 7152.821179470555, 7183.425325974014, 7229.602371869598, 6891.37977582, 6961.164660240804, 6970.790876273517, 7048.365647091787, 7055.0, 5996.4603185713495, 6599.043138744951, 6666.433353164842, 6667.699953502201, 6670.733170673313, 4722.126406614787, 4731.929021064618, 4753.191957367187, 4786.018866132504, 4911.435184953633, 4660.277656963176, 4742.383490146259, 4823.758812059453, 4886.438059623189, 4977.303177555217], "value": 4379.026026085329, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [250.80061351225774, 251.66402852192323, 300.8465682501923, 306.6488870243571, 309.3117812866374, 5261.973690131549, 5290.254216108685, 5309.840704778853, 5325.591621362321, 5327.36071671399, 4912.792440013579, 4986.653603527055, 5064.797408103681, 5156.0, 5234.450382709818, 3630.3828349180703, 3819.541655001404, 4029.858954936578, 4030.7581545107387, 4057.2696914555368, 4017.7857713828967, 4034.878953631381, 4044.878653640381, 4046.210988857174, 4048.392741088831, 3343.916402089955, 3634.418493041114, 3799.544054713438, 3989.7606143631474, 4009.939850902239, 3389.254364039907, 3965.4931126172014, 3976.642102210786, 3984.382420724792, 4027.7180597358342, 3452.361313157074, 3479.356319080978, 3480.0, 3484.8083355415442, 3484.9128771780656, 4863.975680121612, 5055.879458241521, 5070.72111033893, 5073.670211436245, 5074.45229205096, 4486.102779444124, 4527.185106680796, 4557.863264102082, 4565.954340456587, 4572.862814115582, 4828.637852161102, 5416.471105163825, 5426.565874730012, 5447.836564903059, 5451.727413629303, 3241.7406607471344, 3809.3714537101346, 3817.396693388783, 3827.0, 3830.8276127574327, 5503.532199762985, 5659.320881494205, 5731.856703582361, 5738.684372359518, 5767.394423585505, 3420.785621104522, 3496.230829217619, 3641.417373220272, 3866.2074274773604, 3885.9222815544094, 3444.105741841977, 3897.8830635080994, 3900.4452083884535, 3917.4711413958753, 3932.2725295820364, 3809.9238015240094, 4254.340577210537, 4473.977630111829, 4510.300903359985, 4530.750808705487, 5034.194528875362, 5130.409573032372, 5140.974295128501, 5474.425185355481, 5491.835244942658, 1089.6948854320804, 1162.7558212775243, 1255.2405794494382, 1277.9073891822543, 1286.5304163980268, 766.4979438467813, 816.7753867686433, 825.9834803303901, 838.1116017021976, 870.216804875617, 4216.746995180299, 4671.556202160789, 4827.903441931142, 4856.8300109495995, 4869.2939523768855, 4669.579737823612, 4716.113554578127, 5272.0, 5346.674196724437, 5365.370968225541, 4471.575200355961, 4791.664583479123, 4808.63935204861, 4819.6867203631655, 5214.426413094557, 2235.3681812277127, 2646.2159112469353, 2844.7297506736827, 2855.400365923138, 2872.9138125856257, 5039.823606173766, 5224.928889577627, 5669.533752817538, 5674.0, 5692.459216374438, 5276.354410228331, 5556.861078473071, 5589.189567512688, 5607.439256074442, 5625.71871406428, 5329.86675333112, 5407.513323800798, 5624.971875140762, 5632.746526406321, 5670.943290567042, 4744.0, 4933.309336692794, 5418.972905135449, 5470.617056806144, 5477.561795056306, 5271.472852714851, 5643.887122257614, 5712.773077345713, 5713.914291285717, 5718.285214348207, 5936.109583562327, 5946.28644562638, 5963.70181490915, 5973.850653733692, 5976.312724036791, 3671.5777685565436, 3773.1887644156636, 3793.6016718244186, 3819.6371344722206, 3825.800164905246, 5665.546756259571, 5709.7145142741865, 5711.514521265739, 5725.7137143141845, 5737.397573254915, 5119.029173768052, 5547.41752116022, 5567.051531963781, 5569.888602227852, 5575.888482230252, 5247.396549396868, 5488.408361575099, 5527.479943015703, 5551.916721249266, 5555.694436806015, 5447.291852059207, 5447.945520544744, 5448.918266226089, 5453.64551304164, 5517.944820551904, 5276.736163191748, 5286.731184515766, 5407.810281738011, 5497.945020549903, 5521.889562208814, 4660.743659098782, 5472.644278121909, 5477.342718873601, 5478.863028424162, 5515.31782806248], "value": 3995.0065156572336, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.9927900720991, 751.6918063593928, 757.257887270475, 787.1066339704436, 788.9092754333246, 14286.428542858286, 14767.630809229775, 14779.334929928153, 14787.704245915089, 14833.184174870377, 13157.473701051946, 13324.0, 13328.266945318004, 13339.266340351276, 13342.266175360352, 635.282131191755, 659.1859054068221, 659.8251463362213, 783.7844592736986, 788.5347644889529, 803.9276465118138, 810.2748040503745, 817.7056259746487, 817.791463176889, 820.4379999700195, 854.8888644476209, 860.513809697522, 864.5936409887343, 865.5931712095305, 865.8614621660536, 663.6515829189666, 695.6243628440636, 856.443311847298, 858.1632907914827, 859.3984211052289, 601.2844714789387, 628.4249911331126, 633.1958412815699, 635.9809205723835, 637.3753721353054, 13535.864641353657, 13566.253856037914, 13575.117617354841, 13596.864031359659, 13600.455981760717, 12657.367131643381, 12679.93660031694, 12809.0, 12855.807162892565, 13069.607911762663, 10647.627333043307, 11845.88154118465, 11860.647116587632, 11965.401729913556, 12408.255504669749, 4319.481662200525, 4337.219300525904, 4429.9778501107285, 4525.70582912113, 4526.298423744325, 80306.79539806908, 81354.0, 83260.75108873371, 83680.58159709163, 84174.99999999939, 10230.64192753265, 10300.845487317696, 10309.484525773682, 10324.174066074846, 10690.518926648165, 18073.819261807475, 18911.338103166323, 19421.0, 19460.610787784164, 19561.706574401396, 7450.329470347695, 7454.40364770817, 7639.541627502367, 7748.496347737379, 7784.416168787364, 4263.573642635712, 4345.0, 4353.085851971058, 4418.226810308183, 4533.795979180944, 3415.55597772293, 3500.6149323574386, 3523.4714792780774, 3539.2567560812004, 3553.07620018797, 636.7930422612669, 650.6453982579505, 652.6149571752688, 660.5970358081566, 672.2672287206968, 556.8691357530977, 581.668448984075, 643.6974621927686, 647.8639485708054, 652.425865238587, 8432.915670843213, 8460.873086903579, 8577.02129350858, 8950.68672596469, 9013.278937684969, 538.6095081066273, 542.9348478182643, 567.5686478276457, 628.1614045249552, 641.4131070070833, 4025.826053930903, 4201.722507094177, 4239.491261048633, 4435.977820110878, 4484.170428470743, 97502.0, 101727.0, 104715.47642261893, 108630.45684771525, 108686.0, 68947.65526172337, 92532.14935701383, 94362.0, 96043.51978240065, 100146.99853001376, 57444.99999999916, 59250.0, 83330.0, 85659.5717021411, 87419.56290218636, 9122.361434699507, 9553.23574114083, 9554.0, 9583.616655333988, 9629.566669499749, 41792.791036044626, 49067.50932490629, 49607.503924960285, 51448.22827657663, 54586.63533411697, 57818.0, 61584.38415615787, 66427.33572664211, 75928.62035689787, 76178.8573171414, 12052.939735301268, 12142.785721427786, 12239.75520489603, 12312.291295914885, 12647.114701970773, 13878.0, 14293.285335732964, 14530.0, 14561.417543298574, 14705.191214482878, 12779.105462617528, 12862.292573908151, 13397.53108641193, 13637.522686705917, 13810.033297669066, 13066.412011459317, 13165.934170329087, 13549.32253387307, 13606.727865442834, 13625.727485450434, 12660.366981651065, 13233.735325293634, 13334.866651333363, 13443.596692099252, 13479.797803033158, 10415.270931034755, 10691.946540267249, 10696.83954740664, 10875.673729788119, 11174.329540227613, 8047.114817369968, 8293.482452757331, 9934.304598678023, 10841.241113122005, 10911.399873007062], "value": 7137.041271901145, "unit": "score"}], "name": "dromaeo_css", "value": 7028.645030774684, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 115.0, 116.0, 115.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 135.0, 112.0, 151.0, 117.0, 115.0, 112.0, 111.0, 131.0, 112.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 184.0, 184.0, 185.0, 184.0, 183.0, 180.0, 182.0, 182.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 58.0, 85.0, 80.0, 73.0, 79.0, 78.0, 88.0, 58.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 99.0, 98.0, 95.0, 93.0, 82.0, 68.0, 69.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 125.0, 130.0, 87.0, 97.0, 126.0, 111.0, 86.0], "value": 102.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 100.0, 142.0, 94.0, 96.0, 95.0, 95.0, 94.0, 100.0], "value": 100.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 87.0, 85.0, 102.0, 136.0, 130.0, 89.0, 86.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 54.0, 53.0, 54.0, 55.0, 54.0, 55.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 82.0, 74.0, 76.0, 72.0, 69.0, 71.0, 68.0, 72.0, 73.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 86.0, 87.0, 91.0, 85.0, 95.0, 108.0, 105.0, 88.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 153.0, 154.0, 152.0, 166.0, 147.0, 148.0, 149.0, 189.0, 162.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 193.0, 219.0, 189.0, 173.0, 170.0, 172.0, 169.0, 171.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 85.0, 84.0, 72.0, 68.0, 68.0, 68.0, 66.0, 66.0, 68.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1509.4999999999998, "alertThreshold": 2.0}]} 04:02:16 INFO - Return code: 0 04:02:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:02:16 INFO - # TBPL SUCCESS # 04:02:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:02:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:02:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:02:16 INFO - 2016-11-25 04:02:16.889 screenresolution[1795:10026] starting screenresolution argv=screenresolution get 04:02:16 INFO - 2016-11-25 04:02:16.893 screenresolution[1795:10026] Display 0: 1600x1200x32@60 04:02:16 INFO - 2016-11-25 04:02:16.899 screenresolution[1796:10029] starting screenresolution argv=screenresolution list 04:02:16 INFO - Available Modes on Display 0 04:02:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:02:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:02:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:02:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:02:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:02:17 INFO - Intel Iris: 04:02:17 INFO - Chipset Model: Intel Iris 04:02:17 INFO - Type: GPU 04:02:17 INFO - Bus: Built-In 04:02:17 INFO - VRAM (Dynamic, Max): 1536 MB 04:02:17 INFO - Vendor: Intel (0x8086) 04:02:17 INFO - Device ID: 0x0a2e 04:02:17 INFO - Revision ID: 0x0009 04:02:17 INFO - Displays: 04:02:17 INFO - Display: 04:02:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:02:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:02:17 INFO - Display Serial Number: 1600x1200 60 04:02:17 INFO - Main Display: Yes 04:02:17 INFO - Mirror: Off 04:02:17 INFO - Online: Yes 04:02:17 INFO - Rotation: Supported 04:02:17 INFO - Return code: 0 04:02:17 INFO - Running post-action listener: _resource_record_post_action 04:02:17 INFO - [mozharness: 2016-11-25 12:02:17.148934Z] Finished run-tests step (success) 04:02:17 INFO - Running post-run listener: _resource_record_post_run 04:02:17 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37827584; Write bytes: 701024256; Read time: 240; Write time: 2097 04:02:17 INFO - TinderboxPrint: CPU usage
54.1% 04:02:17 INFO - TinderboxPrint: I/O read bytes / time
37,827,584 / 240 04:02:17 INFO - TinderboxPrint: I/O write bytes / time
701,024,256 / 2,097 04:02:17 INFO - TinderboxPrint: CPU idle
2,232.4 (45.9%) 04:02:17 INFO - TinderboxPrint: CPU system
981.9 (20.2%) 04:02:17 INFO - TinderboxPrint: CPU user
1,647.2 (33.9%) 04:02:17 INFO - TinderboxPrint: Swap in / out
420,941,824 / 0 04:02:17 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 384293376; Write bytes: 387676160; Read time: 28957; Write time: 855 04:02:17 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 34673664; Write bytes: 310290432; Read time: 216; Write time: 1226 04:02:17 INFO - Running post-run listener: _upload_blobber_files 04:02:17 INFO - Blob upload gear active. 04:02:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:02:17 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 04:02:17 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:02:17 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:02:18 INFO - (blobuploader) - INFO - Open directory for files ... 04:02:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:02:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:02:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:19 INFO - (blobuploader) - INFO - Done attempting. 04:02:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:02:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:02:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:20 INFO - (blobuploader) - INFO - Done attempting. 04:02:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:02:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:02:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:22 INFO - (blobuploader) - INFO - Done attempting. 04:02:22 INFO - (blobuploader) - INFO - Iteration through files over. 04:02:22 INFO - Return code: 0 04:02:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:02:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:02:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f50ef18ec82f9183b4492f496e5b39f1837e9d51cae7b7daad674a34527d4a9b806ce2996df407426ec297572c51afc9d8b4a1ec2cb0d29a2bb11477a19f7b8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7b3738d628b4acb1cdc0c4efa9d4dea2e041c1acfb46a61bccbbd549a4f1bc7bfda5f52920ee8bc8fc0a4bc63496fe510a8ec2c01b6080e62ac3c36c94c0b184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2b017158d345956840db48bcacdce39d067357b85e510bd61d9cd6a39073e24b7aa0cecb0960a029c414e5bc8a3992a7dcbf7c6c66d87373288a7a4e7e7957eb"} 04:02:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:02:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:02:22 INFO - Contents: 04:02:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f50ef18ec82f9183b4492f496e5b39f1837e9d51cae7b7daad674a34527d4a9b806ce2996df407426ec297572c51afc9d8b4a1ec2cb0d29a2bb11477a19f7b8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7b3738d628b4acb1cdc0c4efa9d4dea2e041c1acfb46a61bccbbd549a4f1bc7bfda5f52920ee8bc8fc0a4bc63496fe510a8ec2c01b6080e62ac3c36c94c0b184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2b017158d345956840db48bcacdce39d067357b85e510bd61d9cd6a39073e24b7aa0cecb0960a029c414e5bc8a3992a7dcbf7c6c66d87373288a7a4e7e7957eb"} 04:02:22 INFO - Running post-run listener: copy_logs_to_upload_dir 04:02:22 INFO - Copying logs to upload dir... 04:02:22 INFO - mkdir: /builds/slave/test/build/upload/logs 04:02:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.086488 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-25 04:02:22.779720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 04:02:22.783366) ========= 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.vOCEChi2qC/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.EJrHizkeae/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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/Graphics/sha512/f50ef18ec82f9183b4492f496e5b39f1837e9d51cae7b7daad674a34527d4a9b806ce2996df407426ec297572c51afc9d8b4a1ec2cb0d29a2bb11477a19f7b8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7b3738d628b4acb1cdc0c4efa9d4dea2e041c1acfb46a61bccbbd549a4f1bc7bfda5f52920ee8bc8fc0a4bc63496fe510a8ec2c01b6080e62ac3c36c94c0b184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2b017158d345956840db48bcacdce39d067357b85e510bd61d9cd6a39073e24b7aa0cecb0960a029c414e5bc8a3992a7dcbf7c6c66d87373288a7a4e7e7957eb"} build_url:https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009937 build_url: 'https://queue.taskcluster.net/v1/task/TBCxDV-0RtiJWRgygvWYvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f50ef18ec82f9183b4492f496e5b39f1837e9d51cae7b7daad674a34527d4a9b806ce2996df407426ec297572c51afc9d8b4a1ec2cb0d29a2bb11477a19f7b8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7b3738d628b4acb1cdc0c4efa9d4dea2e041c1acfb46a61bccbbd549a4f1bc7bfda5f52920ee8bc8fc0a4bc63496fe510a8ec2c01b6080e62ac3c36c94c0b184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2b017158d345956840db48bcacdce39d067357b85e510bd61d9cd6a39073e24b7aa0cecb0960a029c414e5bc8a3992a7dcbf7c6c66d87373288a7a4e7e7957eb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 04:02:22.814358) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:02:22.814674) ========= 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.vOCEChi2qC/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.EJrHizkeae/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.004308 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:02:22.863911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 04:02:22.864589) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 04:02:22.865203) ========= ========= Total master_lag: 0.25 =========