builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0020 starttime: 1487909780.08 results: success (0) buildid: 20170223185858 builduid: 1a15fe9b53e94c7d9f4f1cab857019f4 revision: 61519976b35f2947eeaabefcad83186b7e004167 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:20.076545) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:20.077002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:20.077275) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:20.103216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:20.103608) ========= 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.gyWI91P66N/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.fYIGcKc4wi/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-23 20:16:20-- 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% 15.0M=0.001s 2017-02-23 20:16:20 (15.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118690 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:20.245483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:20.245806) ========= 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.gyWI91P66N/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.fYIGcKc4wi/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.028507 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:20.294775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 20:16:20.295118) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 61519976b35f2947eeaabefcad83186b7e004167 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 61519976b35f2947eeaabefcad83186b7e004167 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gyWI91P66N/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.fYIGcKc4wi/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-23 20:16:20,396 truncating revision to first 12 chars 2017-02-23 20:16:20,397 Setting DEBUG logging. 2017-02-23 20:16:20,397 attempt 1/10 2017-02-23 20:16:20,397 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/61519976b35f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 20:16:21,962 unpacking tar archive at: mozilla-beta-61519976b35f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.834640 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 20:16:22.152343) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:22.152718) ========= script_repo_revision: 61519976b35f2947eeaabefcad83186b7e004167 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:22.153242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:22.153504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 20:16:22.172928) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-23 20:16:22.173311) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gyWI91P66N/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.fYIGcKc4wi/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 20:16:22 INFO - MultiFileLogger online at 20170223 20:16:22 in /builds/slave/test 20:16:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:16:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:16:22 INFO - {'append_to_log': False, 20:16:22 INFO - 'base_work_dir': '/builds/slave/test', 20:16:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:16:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:16:22 INFO - 'branch': 'Mozilla-Beta', 20:16:22 INFO - 'buildbot_json_path': 'buildprops.json', 20:16:22 INFO - 'config_files': ('talos/mac_config.py',), 20:16:22 INFO - 'default_actions': ('clobber', 20:16:22 INFO - 'read-buildbot-config', 20:16:22 INFO - 'download-and-extract', 20:16:22 INFO - 'populate-webroot', 20:16:22 INFO - 'create-virtualenv', 20:16:22 INFO - 'install', 20:16:22 INFO - 'run-tests'), 20:16:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:16:22 INFO - 'download_minidump_stackwalk': True, 20:16:22 INFO - 'download_symbols': 'ondemand', 20:16:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:16:22 INFO - 'tooltool.py': '/tools/tooltool.py', 20:16:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:16:22 INFO - '/tools/misc-python/virtualenv.py')}, 20:16:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:16:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:16:22 INFO - 'installer_path': 'installer.exe', 20:16:22 INFO - 'log_level': 'info', 20:16:22 INFO - 'log_name': 'talos', 20:16:22 INFO - 'log_to_console': True, 20:16:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:16:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:16:22 INFO - 'opt_config_files': (), 20:16:22 INFO - 'pip_index': False, 20:16:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:16:22 INFO - 'cmd': ('bash', 20:16:22 INFO - '-c', 20:16:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:16:22 INFO - 'enabled': True, 20:16:22 INFO - 'halt_on_failure': False, 20:16:22 INFO - 'name': 'check_screen_resolution'},), 20:16:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:16:22 INFO - 'cmd': ('bash', 20:16:22 INFO - '-c', 20:16:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:16:22 INFO - 'enabled': True, 20:16:22 INFO - 'halt_on_failure': False, 20:16:22 INFO - 'name': 'check_screen_resolution'},), 20:16:22 INFO - 'run_cmd_checks_enabled': True, 20:16:22 INFO - 'sps_profile': False, 20:16:22 INFO - 'sps_profile_interval': 0, 20:16:22 INFO - 'suite': 'dromaeojs', 20:16:22 INFO - 'system_bits': '32', 20:16:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:16:22 INFO - 'title': 't-yosemite-r7-0020', 20:16:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:16:22 INFO - 'use_talos_json': True, 20:16:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:16:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:16:22 INFO - 'work_dir': 'build'} 20:16:22 INFO - [mozharness: 2017-02-24 04:16:22.386386Z] Running clobber step. 20:16:22 INFO - Running pre-action listener: _resource_record_pre_action 20:16:22 INFO - Running main action method: clobber 20:16:22 INFO - rmtree: /builds/slave/test/build 20:16:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:16:24 INFO - Running post-action listener: _resource_record_post_action 20:16:24 INFO - [mozharness: 2017-02-24 04:16:24.890848Z] Finished clobber step (success) 20:16:24 INFO - [mozharness: 2017-02-24 04:16:24.890974Z] Running read-buildbot-config step. 20:16:24 INFO - Running pre-action listener: _resource_record_pre_action 20:16:24 INFO - Running main action method: read_buildbot_config 20:16:24 INFO - Using buildbot properties: 20:16:24 INFO - { 20:16:24 INFO - "project": "", 20:16:24 INFO - "product": "firefox", 20:16:24 INFO - "script_repo_revision": "production", 20:16:24 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 20:16:24 INFO - "repository": "", 20:16:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 20:16:24 INFO - "buildid": "20170223185858", 20:16:24 INFO - "pgo_build": "False", 20:16:24 INFO - "basedir": "/builds/slave/test", 20:16:24 INFO - "buildnumber": 44, 20:16:24 INFO - "slavename": "t-yosemite-r7-0020", 20:16:24 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 20:16:24 INFO - "platform": "yosemite_r7", 20:16:24 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:16:24 INFO - "branch": "mozilla-beta", 20:16:24 INFO - "repo_path": "releases/mozilla-beta", 20:16:24 INFO - "revision": "61519976b35f2947eeaabefcad83186b7e004167", 20:16:24 INFO - "stage_platform": "macosx64", 20:16:24 INFO - "builduid": "1a15fe9b53e94c7d9f4f1cab857019f4", 20:16:24 INFO - "slavebuilddir": "test" 20:16:24 INFO - } 20:16:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 20:16:24 INFO - Running post-action listener: _resource_record_post_action 20:16:24 INFO - [mozharness: 2017-02-24 04:16:24.894205Z] Finished read-buildbot-config step (success) 20:16:24 INFO - [mozharness: 2017-02-24 04:16:24.894334Z] Running download-and-extract step. 20:16:24 INFO - Running pre-action listener: _resource_record_pre_action 20:16:24 INFO - Running main action method: download_and_extract 20:16:24 INFO - mkdir: /builds/slave/test/build/tests 20:16: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')]} 20:16:24 INFO - trying https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 20:16:24 INFO - Downloading https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 20:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 20:16:26 INFO - Downloaded 1165 bytes. 20:16:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 20:16:26 INFO - Using the following test package requirements: 20:16:26 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 20:16:26 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 20:16:26 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 20:16:26 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:16:26 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 20:16:26 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 20:16:26 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 20:16:26 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 20:16:26 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 20:16:26 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 20:16:26 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 20:16:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 20:16:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 20:16:26 INFO - Fetch https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 20:16:26 INFO - Http code: 200 20:16:26 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 20:16:26 INFO - x-amz-cf-id: yN5t8J1ccj1znfOB-7xGfxI32zl9w1k8cTOkaR9Awt6B1W4ddYPPMA== 20:16:26 INFO - x-amz-version-id: wjJIFriHyk1uGlZf2Jyi.1yAiLFxHSSX 20:16:27 INFO - Expected file size: 16093331 20:16:27 INFO - Obtained file size: 16093331 20:16:33 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 20:16:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 20:16:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 20:16:33 INFO - Fetch https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 20:16:34 INFO - Http code: 200 20:16:34 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 20:16:34 INFO - x-amz-cf-id: 8d1X2hd5BnVq3HDzBFmersk4__KF3gAiqLnF3RQpaNoXWDxV_V266Q== 20:16:34 INFO - x-amz-version-id: wjJIFriHyk1uGlZf2Jyi.1yAiLFxHSSX 20:16:34 INFO - Expected file size: 16093331 20:16:34 INFO - Obtained file size: 16093331 20:16:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 20:16:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 20:16:40 INFO - Fetch https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 20:16:41 INFO - Http code: 200 20:16:41 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 20:16:41 INFO - x-amz-cf-id: RCG8w0ZK-ILT0WHJ5ktJ5DMU1EG8ULLOJpuriPUjdY9e1g2a0r3K2w== 20:16:41 INFO - x-amz-version-id: 7MrE99DXQab3J0xrk0ShsYuX8uSVI0Qq 20:16:41 INFO - Expected file size: 14402992 20:16:41 INFO - Obtained file size: 14402992 20:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:42 INFO - trying https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:16:42 INFO - Downloading https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 20:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 20:16:44 INFO - Downloaded 82111757 bytes. 20:16:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:16:44 INFO - mkdir: /builds/slave/test/properties 20:16:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:16:44 INFO - Writing to file /builds/slave/test/properties/build_url 20:16:44 INFO - Contents: 20:16:44 INFO - build_url:https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:16:45 INFO - Running post-action listener: _resource_record_post_action 20:16:45 INFO - Running post-action listener: set_extra_try_arguments 20:16:45 INFO - [mozharness: 2017-02-24 04:16:45.160606Z] Finished download-and-extract step (success) 20:16:45 INFO - [mozharness: 2017-02-24 04:16:45.160712Z] Running populate-webroot step. 20:16:45 INFO - Running pre-action listener: _resource_record_pre_action 20:16:45 INFO - Running main action method: populate_webroot 20:16:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:16:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:16:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:16:45 INFO - '--tppagecycles', 20:16:45 INFO - '7'], 20:16:45 INFO - 'tests': ['tsvgm']}}, 20:16:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:16:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:16:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:16:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:16:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:16:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:16:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'talos_options': ['--disable-e10s'], 20:16:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'talos_options': ['--disable-e10s'], 20:16:45 INFO - 'tests': ['damp', 'tps']}, 20:16:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'tests': ['damp', 'tps']}, 20:16:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:16:45 INFO - 'tests': ['dromaeo_dom']}, 20:16:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:16:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:16:45 INFO - 'tests': ['basic_compositor_video']}, 20:16:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:16:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:16:45 INFO - 'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'other-e10s': {'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:16:45 INFO - 'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:16:45 INFO - 'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:16:45 INFO - 'tests': ['tsvgx', 20:16:45 INFO - 'tsvgr_opacity', 20:16:45 INFO - 'tart', 20:16:45 INFO - 'tscrollx', 20:16:45 INFO - 'cart']}, 20:16:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:16:45 INFO - 'tsvgr_opacity', 20:16:45 INFO - 'tart', 20:16:45 INFO - 'tscrollx', 20:16:45 INFO - 'cart']}, 20:16:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'talos_options': ['--disable-e10s'], 20:16:45 INFO - 'tests': ['tp5o']}, 20:16:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'tests': ['tp5o']}, 20:16:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'talos_options': ['--disable-e10s', 20:16:45 INFO - '--xperf_path', 20:16:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:45 INFO - 'tests': ['tp5n']}, 20:16:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'talos_options': ['--xperf_path', 20:16:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:45 INFO - 'tests': ['tp5n']}}, 20:16:45 INFO - 'talos.zip': {'path': '', 20:16:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:16:45 INFO - Running post-action listener: _resource_record_post_action 20:16:45 INFO - [mozharness: 2017-02-24 04:16:45.179508Z] Finished populate-webroot step (success) 20:16:45 INFO - [mozharness: 2017-02-24 04:16:45.179644Z] Running create-virtualenv step. 20:16:45 INFO - Running pre-action listener: _resource_record_pre_action 20:16:45 INFO - Running main action method: create_virtualenv 20:16:45 INFO - Creating virtualenv /builds/slave/test/build/venv 20:16:45 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 20:16:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:16:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:16:45 INFO - Using real prefix '/tools/python27' 20:16:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:16:46 INFO - Installing distribute.............................................................................................................................................................................................done. 20:16:48 INFO - Installing pip.................done. 20:16:48 INFO - Return code: 0 20:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:16:49 INFO - Reading from file tmpfile_stdout 20:16:49 INFO - Output received: 20:16:49 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) 20:16:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e926490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e89c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb9ad7bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e73ad30>, '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 0x10e5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e732b20>, '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.gyWI91P66N/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.fYIGcKc4wi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 20:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:16:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyWI91P66N/Render', 20:16:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:16:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:16:49 INFO - 'HOME': '/Users/cltbld', 20:16:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:16:49 INFO - 'LOGNAME': 'cltbld', 20:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:49 INFO - 'MOZ_NO_REMOTE': '1', 20:16:49 INFO - 'NO_EM_RESTART': '1', 20:16:49 INFO - 'PAGER': '/bin/cat', 20:16:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:49 INFO - 'PWD': '/builds/slave/test', 20:16:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:16:49 INFO - 'SHELL': '/bin/bash', 20:16:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYIGcKc4wi/Listeners', 20:16:49 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 20:16:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:16:49 INFO - 'USER': 'cltbld', 20:16:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:16:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:49 INFO - 'XPC_FLAGS': '0x0', 20:16:49 INFO - 'XPC_SERVICE_NAME': '0', 20:16:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:49 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 20:16:49 INFO - Cleaning up... 20:16:49 INFO - Return code: 0 20:16:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e926490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e89c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb9ad7bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e73ad30>, '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 0x10e5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e732b20>, '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.gyWI91P66N/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.fYIGcKc4wi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 20:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:16:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyWI91P66N/Render', 20:16:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:16:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:16:49 INFO - 'HOME': '/Users/cltbld', 20:16:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:16:49 INFO - 'LOGNAME': 'cltbld', 20:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:49 INFO - 'MOZ_NO_REMOTE': '1', 20:16:49 INFO - 'NO_EM_RESTART': '1', 20:16:49 INFO - 'PAGER': '/bin/cat', 20:16:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:49 INFO - 'PWD': '/builds/slave/test', 20:16:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:16:49 INFO - 'SHELL': '/bin/bash', 20:16:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYIGcKc4wi/Listeners', 20:16:49 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 20:16:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:16:49 INFO - 'USER': 'cltbld', 20:16:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:16:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:49 INFO - 'XPC_FLAGS': '0x0', 20:16:49 INFO - 'XPC_SERVICE_NAME': '0', 20:16:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:49 INFO - Downloading/unpacking psutil>=3.1.1 20:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:16:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:53 INFO - Installing collected packages: psutil 20:16:53 INFO - Running setup.py install for psutil 20:16:53 INFO - building 'psutil._psutil_osx' extension 20:16:53 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 20:16:53 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 20:16:53 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 20:16:54 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 20:16:54 INFO - building 'psutil._psutil_posix' extension 20:16:54 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 20:16:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:16:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:16:54 INFO - ^ 20:16:54 INFO - 1 warning generated. 20:16:54 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 20:16:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:54 INFO - Successfully installed psutil 20:16:54 INFO - Cleaning up... 20:16:54 INFO - Return code: 0 20:16:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:54 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 0x10e926490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e89c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb9ad7bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e73ad30>, '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 0x10e5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e732b20>, '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.gyWI91P66N/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.fYIGcKc4wi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 20:16:54 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 20:16:54 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 20:16:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyWI91P66N/Render', 20:16:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:16:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:16:54 INFO - 'HOME': '/Users/cltbld', 20:16:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:16:54 INFO - 'LOGNAME': 'cltbld', 20:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:54 INFO - 'MOZ_NO_REMOTE': '1', 20:16:54 INFO - 'NO_EM_RESTART': '1', 20:16:54 INFO - 'PAGER': '/bin/cat', 20:16:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:54 INFO - 'PWD': '/builds/slave/test', 20:16:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:16:54 INFO - 'SHELL': '/bin/bash', 20:16:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYIGcKc4wi/Listeners', 20:16:54 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 20:16:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:16:54 INFO - 'USER': 'cltbld', 20:16:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:16:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:54 INFO - 'XPC_FLAGS': '0x0', 20:16:54 INFO - 'XPC_SERVICE_NAME': '0', 20:16:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:16:54 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 20:16:54 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 20:16:54 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 20:16:54 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 20:16:54 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 20:16:54 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 20:16:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:16:57 INFO - Installing collected packages: mozsystemmonitor 20:16:57 INFO - Running setup.py install for mozsystemmonitor 20:16:57 INFO - Successfully installed mozsystemmonitor 20:16:57 INFO - Cleaning up... 20:16:57 INFO - Return code: 0 20:16:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:16:57 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')]} 20:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:57 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')]} 20:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:57 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 0x10e926490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e89c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb9ad7bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e73ad30>, '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 0x10e5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e732b20>, '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.gyWI91P66N/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.fYIGcKc4wi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 20:16:57 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 20:16:57 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 20:16:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyWI91P66N/Render', 20:16:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:16:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:16:57 INFO - 'HOME': '/Users/cltbld', 20:16:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:16:57 INFO - 'LOGNAME': 'cltbld', 20:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:57 INFO - 'MOZ_NO_REMOTE': '1', 20:16:57 INFO - 'NO_EM_RESTART': '1', 20:16:57 INFO - 'PAGER': '/bin/cat', 20:16:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:57 INFO - 'PWD': '/builds/slave/test', 20:16:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:16:57 INFO - 'SHELL': '/bin/bash', 20:16:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYIGcKc4wi/Listeners', 20:16:57 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 20:16:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:16:57 INFO - 'USER': 'cltbld', 20:16:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:16:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:57 INFO - 'XPC_FLAGS': '0x0', 20:16:57 INFO - 'XPC_SERVICE_NAME': '0', 20:16:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:57 INFO - Downloading/unpacking jsonschema==2.5.1 20:16: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 20:16: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 20:16: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 20:16: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 20:16: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 20:16: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 20:17:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:17:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:17:00 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 20:17:00 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 20:17:00 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 20:17:00 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 20:17:00 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 20:17:00 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 20:17:00 INFO - Downloading functools32-3.2.3-2.tar.gz 20:17:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:17:00 INFO - warning: no files found matching '*.txt' 20:17:00 INFO - no previously-included directories found matching 'build' 20:17:00 INFO - no previously-included directories found matching 'dist' 20:17:00 INFO - no previously-included directories found matching '.git*' 20:17:00 INFO - Installing collected packages: jsonschema, functools32 20:17:01 INFO - Running setup.py install for functools32 20:17:01 INFO - warning: no files found matching '*.txt' 20:17:01 INFO - no previously-included directories found matching 'build' 20:17:01 INFO - no previously-included directories found matching 'dist' 20:17:01 INFO - no previously-included directories found matching '.git*' 20:17:01 INFO - Successfully installed jsonschema functools32 20:17:01 INFO - Cleaning up... 20:17:01 INFO - Return code: 0 20:17:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:17: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')]} 20:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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')]} 20:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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', '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 0x10e926490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e89c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb9ad7bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e73ad30>, '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 0x10e5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e732b20>, '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.gyWI91P66N/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.fYIGcKc4wi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 20:17: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:17: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 functools32==3.2.3-2 20:17:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyWI91P66N/Render', 20:17:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:01 INFO - 'HOME': '/Users/cltbld', 20:17:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:01 INFO - 'LOGNAME': 'cltbld', 20:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:01 INFO - 'MOZ_NO_REMOTE': '1', 20:17:01 INFO - 'NO_EM_RESTART': '1', 20:17:01 INFO - 'PAGER': '/bin/cat', 20:17:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:01 INFO - 'PWD': '/builds/slave/test', 20:17:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:01 INFO - 'SHELL': '/bin/bash', 20:17:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYIGcKc4wi/Listeners', 20:17:01 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 20:17:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:01 INFO - 'USER': 'cltbld', 20:17:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:01 INFO - 'XPC_FLAGS': '0x0', 20:17:01 INFO - 'XPC_SERVICE_NAME': '0', 20:17:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:17:01 INFO - Cleaning up... 20:17:01 INFO - Return code: 0 20:17:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:17: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')]} 20:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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')]} 20:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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', '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 0x10e926490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e89c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb9ad7bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e73ad30>, '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 0x10e5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e732b20>, '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.gyWI91P66N/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.fYIGcKc4wi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 20:17: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:17: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 blobuploader==1.2.4 20:17:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyWI91P66N/Render', 20:17:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:01 INFO - 'HOME': '/Users/cltbld', 20:17:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:01 INFO - 'LOGNAME': 'cltbld', 20:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:01 INFO - 'MOZ_NO_REMOTE': '1', 20:17:01 INFO - 'NO_EM_RESTART': '1', 20:17:01 INFO - 'PAGER': '/bin/cat', 20:17:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:01 INFO - 'PWD': '/builds/slave/test', 20:17:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:01 INFO - 'SHELL': '/bin/bash', 20:17:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYIGcKc4wi/Listeners', 20:17:01 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 20:17:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:01 INFO - 'USER': 'cltbld', 20:17:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:01 INFO - 'XPC_FLAGS': '0x0', 20:17:01 INFO - 'XPC_SERVICE_NAME': '0', 20:17:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:01 INFO - Downloading/unpacking blobuploader==1.2.4 20:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:04 INFO - Downloading blobuploader-1.2.4.tar.gz 20:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:17:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:17:04 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 20:17:04 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 20:17:04 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 20:17:04 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 20:17:04 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 20:17:04 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 20:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:17:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:17:05 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 20:17:05 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 20:17:05 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 20:17:05 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 20:17:05 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 20:17:05 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 20:17:05 INFO - Downloading docopt-0.6.1.tar.gz 20:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:17:05 INFO - Installing collected packages: blobuploader, requests, docopt 20:17:05 INFO - Running setup.py install for blobuploader 20:17:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:17:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:17:05 INFO - Running setup.py install for requests 20:17:06 INFO - Running setup.py install for docopt 20:17:06 INFO - Successfully installed blobuploader requests docopt 20:17:06 INFO - Cleaning up... 20:17:06 INFO - Return code: 0 20:17:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:06 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')]} 20:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:06 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')]} 20:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:06 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 0x10e926490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e89c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb9ad7bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e73ad30>, '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 0x10e5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e732b20>, '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.gyWI91P66N/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.fYIGcKc4wi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 20:17:06 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 20:17:06 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 20:17:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyWI91P66N/Render', 20:17:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:06 INFO - 'HOME': '/Users/cltbld', 20:17:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:06 INFO - 'LOGNAME': 'cltbld', 20:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:06 INFO - 'MOZ_NO_REMOTE': '1', 20:17:06 INFO - 'NO_EM_RESTART': '1', 20:17:06 INFO - 'PAGER': '/bin/cat', 20:17:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:06 INFO - 'PWD': '/builds/slave/test', 20:17:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:06 INFO - 'SHELL': '/bin/bash', 20:17:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYIGcKc4wi/Listeners', 20:17:06 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 20:17:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:06 INFO - 'USER': 'cltbld', 20:17:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:06 INFO - 'XPC_FLAGS': '0x0', 20:17:06 INFO - 'XPC_SERVICE_NAME': '0', 20:17:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:17:06 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-uMa0_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:17:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-tkXLdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:17:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Jv8Kbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:17:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-mzc7TB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:17:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-GZC_qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:17:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-W9nDxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:17:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-cKfrT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-5707_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-WrFWet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-nBreu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:07 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-hYZnuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-GGAG_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-1qOi1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-0JajQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-EALxab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-wmYDOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:08 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-AU34Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:17:08 INFO - Running setup.py install for manifestparser 20:17:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:17:08 INFO - Running setup.py install for mozcrash 20:17:08 INFO - Running setup.py install for mozdebug 20:17:09 INFO - Running setup.py install for mozdevice 20:17:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Running setup.py install for mozfile 20:17:09 INFO - Running setup.py install for mozhttpd 20:17:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Running setup.py install for mozinfo 20:17:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Running setup.py install for mozInstall 20:17:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Running setup.py install for mozleak 20:17:09 INFO - Running setup.py install for mozlog 20:17:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for moznetwork 20:17:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for mozprocess 20:17:10 INFO - Running setup.py install for mozprofile 20:17:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for mozrunner 20:17:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for mozscreenshot 20:17:10 INFO - Running setup.py install for moztest 20:17:11 INFO - Running setup.py install for mozversion 20:17:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:17:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:17:11 INFO - Cleaning up... 20:17:11 INFO - Return code: 0 20:17:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:11 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')]} 20:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:11 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')]} 20:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:11 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 0x10e926490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e89c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb9ad7bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e73ad30>, '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 0x10e5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e732b20>, '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.gyWI91P66N/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.fYIGcKc4wi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 20:17:11 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 20:17:11 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 20:17:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyWI91P66N/Render', 20:17:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:11 INFO - 'HOME': '/Users/cltbld', 20:17:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:11 INFO - 'LOGNAME': 'cltbld', 20:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:11 INFO - 'MOZ_NO_REMOTE': '1', 20:17:11 INFO - 'NO_EM_RESTART': '1', 20:17:11 INFO - 'PAGER': '/bin/cat', 20:17:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:11 INFO - 'PWD': '/builds/slave/test', 20:17:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:11 INFO - 'SHELL': '/bin/bash', 20:17:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYIGcKc4wi/Listeners', 20:17:11 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 20:17:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:11 INFO - 'USER': 'cltbld', 20:17:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:11 INFO - 'XPC_FLAGS': '0x0', 20:17:11 INFO - 'XPC_SERVICE_NAME': '0', 20:17:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:17:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-E97XHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:17:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-5BVOHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:17:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-7UVcWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:17:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-xS4yeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:17:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:17:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-6rzNKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:17:12 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-z1NQxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:17:12 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-gMBeBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:12 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-4ymsw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:12 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-MbykxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:12 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-RBMJht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:12 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-S97sYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:12 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-_m0pgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:12 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-F2yfUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:12 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-boUx6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:13 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)) 20:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:13 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-sI0FcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:13 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)) 20:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:13 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-WWu1aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:13 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-mKUOHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:13 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)) 20:17:13 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)) 20:17:13 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)) 20:17:13 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)) 20:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:17:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:17:13 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 20:17:13 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 20:17:13 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 20:17:13 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 20:17:13 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 20:17:13 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 20:17:15 INFO - Downloading blessings-1.6.tar.gz 20:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:17:16 INFO - Installing collected packages: blessings 20:17:16 INFO - Running setup.py install for blessings 20:17:16 INFO - Successfully installed blessings 20:17:16 INFO - Cleaning up... 20:17:16 INFO - Return code: 0 20:17:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:17:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:16 INFO - Reading from file tmpfile_stdout 20:17:16 INFO - Current package versions: 20:17:16 INFO - blessings == 1.6 20:17:16 INFO - blobuploader == 1.2.4 20:17:16 INFO - docopt == 0.6.1 20:17:16 INFO - functools32 == 3.2.3-2 20:17:16 INFO - jsonschema == 2.5.1 20:17:16 INFO - manifestparser == 1.1 20:17:16 INFO - mozInstall == 1.12 20:17:16 INFO - mozcrash == 1.0 20:17:16 INFO - mozdebug == 0.1 20:17:16 INFO - mozdevice == 0.48 20:17:16 INFO - mozfile == 1.2 20:17:16 INFO - mozhttpd == 0.7 20:17:16 INFO - mozinfo == 0.9 20:17:16 INFO - mozleak == 0.1 20:17:16 INFO - mozlog == 3.4 20:17:16 INFO - moznetwork == 0.27 20:17:16 INFO - mozprocess == 0.23 20:17:16 INFO - mozprofile == 0.28 20:17:16 INFO - mozrunner == 6.13 20:17:16 INFO - mozscreenshot == 0.1 20:17:16 INFO - mozsystemmonitor == 0.3 20:17:16 INFO - moztest == 0.8 20:17:16 INFO - mozversion == 1.4 20:17:16 INFO - psutil == 3.1.1 20:17:16 INFO - requests == 1.2.3 20:17:16 INFO - wsgiref == 0.1.2 20:17:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:17 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')]} 20:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:17 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 0x10e926490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e89c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb9ad7bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e73ad30>, '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 0x10e5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e732b20>, '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.gyWI91P66N/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.fYIGcKc4wi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 20:17:17 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 20:17:17 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 20:17:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyWI91P66N/Render', 20:17:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:17 INFO - 'HOME': '/Users/cltbld', 20:17:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:17 INFO - 'LOGNAME': 'cltbld', 20:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:17 INFO - 'MOZ_NO_REMOTE': '1', 20:17:17 INFO - 'NO_EM_RESTART': '1', 20:17:17 INFO - 'PAGER': '/bin/cat', 20:17:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:17 INFO - 'PWD': '/builds/slave/test', 20:17:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:17 INFO - 'SHELL': '/bin/bash', 20:17:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYIGcKc4wi/Listeners', 20:17:17 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 20:17:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:17 INFO - 'USER': 'cltbld', 20:17:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:17 INFO - 'XPC_FLAGS': '0x0', 20:17:17 INFO - 'XPC_SERVICE_NAME': '0', 20:17:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:18 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)) 20:17:18 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)) 20:17:18 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)) 20:17:18 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)) 20:17:18 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)) 20:17:18 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)) 20:17:18 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)) 20:17:18 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)) 20:17:18 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)) 20:17:18 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)) 20:17:18 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)) 20:17:18 INFO - Cleaning up... 20:17:18 INFO - Return code: 0 20:17:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:17:18 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')]} 20:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:18 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')]} 20:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:18 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 0x10e926490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e89c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb9ad7bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e73ad30>, '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 0x10e5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e732b20>, '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.gyWI91P66N/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.fYIGcKc4wi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 20:17:18 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 20:17:18 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 20:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyWI91P66N/Render', 20:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:18 INFO - 'HOME': '/Users/cltbld', 20:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:18 INFO - 'LOGNAME': 'cltbld', 20:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:18 INFO - 'MOZ_NO_REMOTE': '1', 20:17:18 INFO - 'NO_EM_RESTART': '1', 20:17:18 INFO - 'PAGER': '/bin/cat', 20:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:18 INFO - 'PWD': '/builds/slave/test', 20:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:18 INFO - 'SHELL': '/bin/bash', 20:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYIGcKc4wi/Listeners', 20:17:18 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 20:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:18 INFO - 'USER': 'cltbld', 20:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:18 INFO - 'XPC_FLAGS': '0x0', 20:17:18 INFO - 'XPC_SERVICE_NAME': '0', 20:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:17:18 INFO - Cleaning up... 20:17:18 INFO - Return code: 0 20:17:18 INFO - Running post-action listener: _resource_record_post_action 20:17:18 INFO - Running post-action listener: _start_resource_monitoring 20:17:18 INFO - Starting resource monitoring. 20:17:18 INFO - [mozharness: 2017-02-24 04:17:18.734238Z] Finished create-virtualenv step (success) 20:17:18 INFO - [mozharness: 2017-02-24 04:17:18.735247Z] Running install step. 20:17:18 INFO - Running pre-action listener: _resource_record_pre_action 20:17:18 INFO - Running main action method: install 20:17:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:18 INFO - Reading from file tmpfile_stdout 20:17:18 INFO - Detecting whether we're running mozinstall >=1.0... 20:17:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:17:19 INFO - Reading from file tmpfile_stdout 20:17:19 INFO - Output received: 20:17:19 INFO - Usage: mozinstall [options] installer 20:17:19 INFO - Options: 20:17:19 INFO - -h, --help show this help message and exit 20:17:19 INFO - -d DEST, --destination=DEST 20:17:19 INFO - Directory to install application into. [default: 20:17:19 INFO - "/builds/slave/test"] 20:17:19 INFO - --app=APP Application being installed. [default: firefox] 20:17:19 INFO - mkdir: /builds/slave/test/build/application 20:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 20:17:40 INFO - Reading from file tmpfile_stdout 20:17:40 INFO - Output received: 20:17:40 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:17:40 INFO - Running post-action listener: _resource_record_post_action 20:17:40 INFO - [mozharness: 2017-02-24 04:17:40.345617Z] Finished install step (success) 20:17:40 INFO - [mozharness: 2017-02-24 04:17:40.345755Z] Running run-tests step. 20:17:40 INFO - Running pre-action listener: _resource_record_pre_action 20:17:40 INFO - Running main action method: run_tests 20:17:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:17:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:17:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:17:40 INFO - 2017-02-23 20:17:40.359 screenresolution[1619:7458] starting screenresolution argv=screenresolution get 20:17:40 INFO - 2017-02-23 20:17:40.362 screenresolution[1619:7458] Display 0: 1600x1200x32@60 20:17:40 INFO - 2017-02-23 20:17:40.368 screenresolution[1620:7460] starting screenresolution argv=screenresolution list 20:17:40 INFO - Available Modes on Display 0 20:17:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:17:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:17:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:17:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:17:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:17:40 INFO - Intel Iris: 20:17:40 INFO - Chipset Model: Intel Iris 20:17:40 INFO - Type: GPU 20:17:40 INFO - Bus: Built-In 20:17:40 INFO - VRAM (Dynamic, Max): 1536 MB 20:17:40 INFO - Vendor: Intel (0x8086) 20:17:40 INFO - Device ID: 0x0a2e 20:17:40 INFO - Revision ID: 0x0009 20:17:40 INFO - Displays: 20:17:40 INFO - Display: 20:17:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:17:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:17:40 INFO - Display Serial Number: 1600x1200 60 20:17:40 INFO - Main Display: Yes 20:17:40 INFO - Mirror: Off 20:17:40 INFO - Online: Yes 20:17:40 INFO - Rotation: Supported 20:17:40 INFO - Return code: 0 20:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:17:40 INFO - Python 2.7.3 20:17:40 INFO - Return code: 0 20:17:40 INFO - grabbing minidump binary from tooltool 20:17:40 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')]} 20:17:40 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 0x10e73ad30>, '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 0x10e5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e732b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:17:40 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 20:17:40 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 20:17:40 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 20:17:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:17:40 INFO - Return code: 0 20:17:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:17:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:17:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:17:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:17:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 20:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0020 --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 20:17:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyWI91P66N/Render', 20:17:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:40 INFO - 'HOME': '/Users/cltbld', 20:17:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:40 INFO - 'LOGNAME': 'cltbld', 20:17:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:17:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:40 INFO - 'MOZ_NO_REMOTE': '1', 20:17:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:17:40 INFO - 'NO_EM_RESTART': '1', 20:17:40 INFO - 'PAGER': '/bin/cat', 20:17:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:40 INFO - 'PWD': '/builds/slave/test', 20:17:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:17:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:40 INFO - 'SHELL': '/bin/bash', 20:17:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYIGcKc4wi/Listeners', 20:17:40 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 20:17:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:40 INFO - 'USER': 'cltbld', 20:17:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:40 INFO - 'XPC_FLAGS': '0x0', 20:17:40 INFO - 'XPC_SERVICE_NAME': '0', 20:17:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 20:17:40 INFO - mozversion application_buildid: 20170223185858 20:17:40 INFO - mozversion application_changeset: 61519976b35f2947eeaabefcad83186b7e004167 20:17:40 INFO - mozversion application_display_name: Firefox 20:17:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:17:40 INFO - mozversion application_name: Firefox 20:17:40 INFO - mozversion application_remotingname: firefox 20:17:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:17:40 INFO - mozversion application_vendor: Mozilla 20:17:40 INFO - mozversion application_version: 52.0 20:17:40 INFO - mozversion platform_buildid: 20170223185858 20:17:40 INFO - mozversion platform_changeset: 61519976b35f2947eeaabefcad83186b7e004167 20:17:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:17:40 INFO - mozversion platform_version: 52.0 20:17:40 INFO - using testdate: 1487909860 20:17:40 INFO - actual date: 1487909860 20:17:40 INFO - starting webserver on 'localhost:49241' 20:17:40 INFO - SUITE-START | Running 2 tests 20:17:40 INFO - TEST-START | dromaeo_css 20:17:40 INFO - operating with platform_type : mac_ 20:17:40 INFO - Initialising browser for dromaeo_css test... 20:17:40 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpuYzWc8/profile http://localhost:49241/getInfo.html) 20:17:43 INFO - PROCESS | 1630 | __metrics Screen width/height:1600/1200 20:17:43 INFO - PROCESS | 1630 | colorDepth:24 20:17:43 INFO - PROCESS | 1630 | Browser inner width/height: 1024/689 20:17:43 INFO - PROCESS | 1630 | __metrics 20:17:43 INFO - PROCESS | 1630 | 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" 20:17:43 INFO - PROCESS | 1630 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:17:44 INFO - TEST-INFO | 1630: exit 0 20:17:44 INFO - Browser initialized. 20:17:44 INFO - Running cycle 1/1 for dromaeo_css test... 20:17:44 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpuYzWc8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:56 INFO - PROCESS | 1633 | RSS: Main: 167612416 20:17:56 INFO - PROCESS | 1633 | 20:21:01 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 20:21:03 INFO - PROCESS | 1633 | RSS: Main: 342863872 20:21:03 INFO - PROCESS | 1633 | 20:24:06 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 20:24:06 INFO - PROCESS | 1633 | RSS: Main: 305762304 20:24:06 INFO - PROCESS | 1633 | 20:27:09 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 20:27:09 INFO - PROCESS | 1633 | RSS: Main: 259973120 20:27:09 INFO - PROCESS | 1633 | 20:30:12 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 20:30:12 INFO - PROCESS | 1633 | RSS: Main: 264495104 20:30:12 INFO - PROCESS | 1633 | 20:33:15 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 20:33:16 INFO - PROCESS | 1633 | RSS: Main: 257806336 20:33:16 INFO - PROCESS | 1633 | 20:36:20 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 20:36:20 INFO - PROCESS | 1633 | RSS: Main: 307433472 20:36:20 INFO - PROCESS | 1633 | 20:36:20 INFO - PROCESS | 1633 | __start_tp_report 20:36:20 INFO - PROCESS | 1633 | _x_x_mozilla_page_load 20:36:20 INFO - PROCESS | 1633 | _x_x_mozilla_page_load_details 20:36:20 INFO - PROCESS | 1633 | |i|pagename|runs| 20:36:20 INFO - PROCESS | 1633 | |0;dojo.html;3444.380011597912;3521.630228825973;3543.5216245806823;3551.875684351048;3593.478945552895;5899.941000589993;5906.0845568936775;5980.252468441445;5989.760409583611;6006.729697163627;5978.4918281945975;6041.637501749898;6054.212952316204;6058.454739073482;6076.6961651917445;4174.582541745816;5308.203769434577;5373.462653734615;5382.650127741704;5411.404745477994;5281.577473802086;5295.417504074549;5305.098133317326;5427.0773968425465;5445.782168713266;5380.704061276629;5387.515123638872;5400.675959442446;5404.810831620894;5411.648242864221;5371.81198658049;5378.2470454136255;5386.676799392049;5396.757145928404;5398.460153984609;5265.262863199156;5288.206768984683;5306.363236411656;5337.546308563777;5381.677099374011;6060.303065147476;6142.6314421134875;6155.476784473325;6166.969165154191;6175;6276.560640755149;6292.024736165856;6309.274433440167;6320.810375688737;6352.80941571749;6214.161088253119;6262.812115636538;6277.7175027123885;6298.338674439209;6412.551121421502;6046.3349031606485;6048.334683184846;6048.667323297261;6065;6117.694115294217;6528.038944779967;6578.177727784027;6588.275289718127;6592.373724496165;6593.604383736895;6199.783007594712;6253.812385628438;6262.248530176408;6280.811575652738;6285.96857015712;6331.746730130743;6370.649614271167;6379.298277189506;6390.520710946697;6401.391867772554;5263.894722105537;6273.99616061428;6289.968550157311;6291.937080629135;6297.748090076438;6219.191505104398;6245.406686364879;6263.3736626337;6274.623522588659;6305.18032655761;5013.699178049329;5025.924611130836;5027.798888044437;5057.544820966057;5066;4456.309272062836;4478.081993191453;4481.596656300949;4484.394606728115;4516.1419330327135;5902.498287645598;5965.13505541694;5973.1936188614845;6016.037434010625;6104.542159338067;6291.087792270096;6292.150559674477;6302.873942521124;6353.110564520971;6407.199100112486;6140.907886381708;6147.354527774609;6148.938510614926;6153.323134455206;6169.2288463942;5624.85937851557;5628.577856660685;5631.662100273997;5636.661800291996;5646.040173170489;6009.90985135232;6021.157038014769;6313.337099604475;6471.967640161957;6529.738810447719;6262.561620686508;6303.527235457267;6312.179416675803;6321.830461364662;6339.3343698912795;5589.245451863946;6600.174978127734;6643.036759669917;6650.235222949423;6655.434288085567;6258.687065646608;6293.307736148929;6322.114903913363;6332.461740751904;6334.461570766536;5340.866478338073;6253.937460625336;6295.905561416491;6316.242050953915;6359.586626869239;6175.722092505938;6310.495160387066;6315.842103947254;6325.272593651789;6337.081123237197;6223.844403889939;6228.937710623017;6305.873882522415;6310.116583678197;6320.051992201206;5010.073136469765;6039.4262545058145;6077.088436734525;6140.4473597376455;6237.064440333987;6242.219722534684;6262.091996660368;6293.118963345044;6299.874002520016;6315.905261421174;6091.756329746938;6106.346483705045;6111.602745821508;6126.23422072241;6139.048447490646 20:36:20 INFO - PROCESS | 1633 | |1;ext.html;517.6764522173642;525.700350800044;540.7161240348817;589.9911501327483;595.5741644724021;25042;40267.395989060155;41006.974825629375;41324.38013429801;43646.781766091204;43362.132757344836;43640.781796091054;43833.90415239621;43865.780671096676;43889.34165987513;9524.5237738113;9705.466199359033;9720.513974301257;9720.902790972106;9733.415995040321;9467.053294670546;9557.044295570457;9560.952195239013;9568.952155239214;9600.279979001569;9541.809163816719;9607.855882161773;9609.903900960971;9613.855792163124;9617.42295462271;9555.952220238889;9583.424994500352;9599.808003839918;9600.855987160197;9609.327347085708;9544.904550954541;9616.615335386647;9622.230221582256;9631.036896310383;9638.228941684649;40921.79539102315;41228.587714122776;41280.96797580084;41305.586944130475;41314.38028429576;3213.8393080346123;3229.5963004624423;3296.307775367176;3300.834958252102;3326.9500957485416;29806;30397.24006899823;30450.086497405115;30775.38449231003;30894.22764430885;3205.727513161384;3253.235489659928;3253.902382928516;3259.26666500038;3313.7514686398376;507657;509259;509419;509975.4501227507;510616;61721.69139154276;61957.38042619516;62136.68931655313;62217.68891155515;62263.37736622666;35733.64266357303;35838.92483225508;37851.24297514034;65166.34833651603;65294.67352663206;16985.49043528696;17076.914615427093;17077.82922170787;17083.743743843854;17085.402010929556;12992.545260915822;13068.346582670829;13073.869261307265;13074.869251307555;13126.343682816012;19193.04657020105;19541.508126087578;19548.79715828036;19553.50192610918;19571.804281957284;6511.706973186218;7857.607119643995;7902.881456778153;7916.802079947932;7955.602219888982;820.6143112737004;883.969061082859;955.8375076236917;993.4933184076173;1037.8131936251395;29491.55762663562;30182.54726179109;30224.69775302219;31128.22179445532;31271.374572508423;1038.4288641247283;1050.238577031646;1180.135057686085;1180.4333919718583;1232.100566586397;15784.763228551581;15817.446389376317;15832.28754706041;15845.920770396306;16125.274362653709;664289;666800;668252;668473;668502;51493.970120598126;59586.808263835344;60188.39811601828;60314;60419.79160416767;1241.4599649152647;1378.9933348655338;1389.201209304654;1458.4457905995653;1466.5013895275658;29789.10632681023;31523.21191970219;31798;31950.520742188422;32247;50922.49077509178;51714.741426292625;51726.22410663768;51776.482235177165;51913.7404312976;528036;542847;604270;613987;615532;36062.63937360698;36460.270794583426;36486.27027459489;36508;36554.451683224244;37404.43893341657;47588.762056189495;49051.75474122607;49658.75170624124;49696.50303496919;32566;36689;38650.8404747858;38952.026199345244;40875;38511.61488385192;39191;39216.411753824286;39859;40361.79819100886;37963.43054854235;38271.42592861165;38950.41574376443;39074.80462597783;39469.80265098771;31685.207869802518;33044.669553305124;34020.48969265512;34466.655333446346;34829.825850871595;23846;24520;25518.617220741333;25761.484770304865;26703 20:36:20 INFO - PROCESS | 1633 | |2;jquery.html;330.6082292483407;385.57394079542104;392.1666458775104;400.9979950100249;417.80154426647346;15052.623684407896;15761;18617.53456163595;21284.4678883028;21408.785912140895;17321.48035558932;18100.547486312847;19856;20563.28028519002;21035.474113147142;5701.344345400291;5725.7995970141055;5996.340402555716;5996.640201587918;6014.067819487965;5759.971200143993;5937.079752638348;5937.168796368512;5938.613990090652;5938.940610593882;4292.635126014293;4506.819727210907;5893.673923367251;6166.414190651881;6472.190976127984;5697.4587414195585;6483.578567393104;6522.347765223487;6534.705938232791;6541.116949211867;5747.936631723144;5869.50109240715;5870.911936320958;5881.70591470429;5883.823485295448;13440.991925605618;13517.32413379327;13592.864071359358;13768.793468097987;13789.241591712453;1756.8858024228512;1979.6832506798844;2054.1783286685295;2093.7382827146607;2878.654561452639;10033.949830250875;10135.189184865267;10140.239482038876;10619.20355973305;10669.946650266776;1829.4328758085037;1929.0547631660525;1930.7007413850736;1943.232423192831;1954.7947465516058;119516.60966780703;120047.3997630015;128288;129404.99999999905;132191.6780832189;11266;11492.85071492844;11564.074874010228;11705.648830535098;11738.94130529342;12767.489300428064;15085.47200847965;15091.924540377227;15117.09297442157;15139.697206056038;8434.662613495515;8704.303655707528;8720.476771393736;8874.423162494417;8905.243054340324;8649.697260595975;8661.263792577576;8672.653093876173;8813.722010308598;8897.599608017656;3739.7195210358786;4581.610563102174;4600.1949658810245;4669.3851443191925;4672.415948006499;1864.8344784509682;1919.6928491441302;1921.8366438852574;1924.162989099746;1986.2750096215066;699.5221086584396;818.9877151842727;885.7741275974586;942.5711301357866;976.6630512473185;20800.791992080187;21640.56718865614;21672.458188545414;21696.89151554232;21755.206459607303;716.8351279205708;917.8623206518942;920.861870719384;940.6989763275686;980.2501086668705;10647.787044259072;11154.60958866452;11281.21031527785;11286;12096.274223546616;629596.5915327178;630132.5480117801;631409;641168;644415.7779211074;126063;131505;134686;135164.32417837848;136952;867.8367351005676;869.9956500217585;900.9864852027225;906.2115959115612;907.4872696926216;16641.66716665684;19261.807381926003;19384.903075484533;19956.802591844535;21029.369118926457;57487.71256143692;58415;59023.40976590179;59555.70222148862;59653.70173149106;72687.72905219384;73269.63365183353;80323;83381.16618833735;84964.57517712371;7284.344409003215;7448;7506.774796756106;7956.482828616122;8094.352451803959;12856.485740570273;12904.870951290366;12932.41804118798;13176;13519.459221631025;7800.726974555863;8912.598933048159;11244.04425623831;11486.138539609396;11664.94167529157;10901.964313390215;11183.944080279547;11213.775724485302;11589.536418543164;11691.240069395802;11320.830187547028;11482.311061336346;11721.296722196696;11846.822297665714;11943;7224.205337412775;7401.740939067106;7525;7715.459917805924;8689.782755431164;9385.812283754423;10829.350238985686;11269.154813389192;11549.249298795552;11598.88401115978 20:36:20 INFO - PROCESS | 1633 | |3;mootools.html;1487.4199062365678;1530.357249955019;1676.4886709553589;1841.5027942455545;1845.0221382667182;8100.432969692117;8528.701495447669;8542.359323050772;8550.95724521378;8559.700410485619;7533.472656914018;7738.690452381912;8184.713535026275;8335.708250211244;8392.916070839305;2336.2874323331375;2369.9289021329387;2373.288013595923;2380.9880950595225;2384.6780684607616;2062.391594479632;2365.7989070928993;2384.9642255366184;2413.263954493879;2426;2348.612478940973;2364.3143488388346;2364.3970787449175;2370.6562548430466;2388.5819981503255;2346.741858395575;2349.0721165139844;2370.360002799252;2370.9051637934376;2377.2749311459997;2138.4226258910007;2257.006916956534;2367.1596583212886;2393.700787401575;2395.38917576017;8382.371322150802;8423.536705481196;8502.914970850274;8503.23470887623;8506.78733031679;4914.3611330527165;5237.973810130925;5242.187460943522;5246.160614301732;5246.580273578104;3365.6129545102135;3496.7552271341015;3563.8574457021687;3630.618785027587;3632.5640923089136;948.340903072365;1051.831706926888;1060.4803646213377;1103.194667892435;1117.3966058328574;10870.782584348348;10976.341419514774;10988.395638239894;10996.670099896935;11034;4503.459584849839;4621.145088158634;4717.315989181549;4730.668853180245;4798.928016079762;9485.952570237105;9488.051194880456;9489.620415183315;9490.240780737524;9497.667581634609;5261.3686357637325;5264.078786212397;5266.236395722675;5268.578513718893;5269.209618557171;4327.675424343124;4353.564643535685;4747.121782470254;4798.184308667535;4853.611711063107;3317.7558415594153;3363.983180084084;3500.2824420993634;3673.2286219893585;3852.1332700142243;1100.40304880482;1285.8199852020725;1295.9352032398342;1307.5031488034485;1308.4896890212824;681.5672048249397;801.9278264956065;898.5058217980215;904.4980036079908;910.7404389749022;4820.239414542583;5428.158635411518;5607.186957891083;5778.884422311614;5867.325257595346;948.9667861624948;954.6992697300328;963.3545524498603;975.7024107647236;998.1066945084254;3545.397282461936;3683.931659818676;3791.6777073949024;3850.537935447764;3858.9421158682644;9985.700428987142;10222.846657300146;10333.483325833678;10344.741381465374;10350.01674840904;10305.381677099249;10306;10309.175265978854;10315.123214526699;10317.174626029899;6945.51381403307;7547.245275472409;7905.130435652074;7996.120426753053;8006.439549231614;5428.348598168245;5516.503514683698;5554.222408862682;5718.971405142947;5751.166080918327;9382.859257111286;9392.154706076486;9459.479728614991;9517.666881659108;9561.235101191749;7591;9541.713748587554;9672.322937394314;9693.27300452483;9706.56320465595;6293.213348331458;6486.05952136947;6596.571222870498;6764.966175169093;6891.689873955785;7906.446548741533;8106.675732970615;8108.472949258279;8120.228578285053;8122.634481448231;7110.431165506644;7246.949192367183;7311.524750891175;7322.0847394075745;7401.777946661608;7046.154461464657;7066.364027237573;7127.928720712726;7174.461915356474;7292.671829767779;6675.198976122896;6824.249332573314;6838.692258848463;6850.45196384298;6850.725970961105;4812.975935120442;4865.318855360323;4883.023395321021;4890.755462226945;4932.4327702314695;4201.684873634428;4805.951940480551;4943.456219815889;4992.15133427311;5006.421692828124 20:36:20 INFO - PROCESS | 1633 | |4;prototype.html;266.8518971970557;281.5804451367462;315.26700421519973;317.9777415580909;320.2170692656456;4061.6953728470335;5118.129917913954;5147.099257629919;5162.586993040557;5211.8697032574155;3997.560268370477;4268.72253303535;4769.618430525558;4946.208606622941;5078.619103567229;3907.7850718210416;3942.80285985701;3973.443717879499;3977.82099805508;3987.6211759882763;3744.868929587465;3863.860161252423;3972.1459886124476;3974.264761019206;3975.44197942841;3685.470529730159;3823.9044023899487;3902.2585708715255;3933.8426462941447;3969.741966772165;3280.3439312137666;3914.549826769901;3933.5869733677982;3940.665043471294;3946.9737868154198;3485.1112966193714;3487.4132269817173;3498.3528047311074;3502.282032183422;3515.5078289039557;4052.351623740217;4169.665706973769;4839.225723884161;4855.635827312965;5033.773480193364;4537.6143027842345;4546.136234115541;4550.658700597435;4557.544245575449;4577.809769459965;4523.321501774727;4954.603631709455;5422.15956526739;5436.91844622331;5441.646292990943;3304.6695330467;3632.7820330780237;3834.8466061357512;3842.7502212356108;3857.5949525300002;5112.721819545114;5315.803944112582;5681.971590142064;5728.4769866532615;5770.7691692332255;3485.721142308609;3654.908627284286;3665.149099704632;3681.9447708284397;3962.286788378062;4009.8997525061523;4016.49793775778;4028.683506983496;4035.475388199574;4053.2298863216483;3791.545014598266;4459.46486421625;4530.365748795171;4554.95445045552;4583.862484125481;4293.656507479394;5387.892242155135;5431.945680543144;5447.618666693373;5454.954392102962;1233.340163012802;1256.849178098634;1273.4969686973593;1300.2263653126374;1311.4623004568082;793.2543409195338;859.7893516088599;869.7173418638968;881.2421317666801;905.3300557587338;4507.5267096955;4903.754812259373;4906.362172917569;4969.962315450648;5071.416787069535;4336.479622445327;5336.306280183629;5379.6819779153575;5390.3020548527875;5401.216823560561;4185.686073544496;4845.30414354973;4852.778083067754;4901.995091006335;4904.96443975746;2485.540175067582;2708.9729102709116;2790.8046436749637;2805.284652413662;2846.34534057168;4963.8014479421145;5250.377239704591;5427.83716488506;5524.861878453071;5608.6073974821375;4502.774861256924;5051.318072060299;5227.686338819683;5380.7309634518115;5458.789190377904;5351.518363347317;5468.835934922038;5505.449455054542;5536.972315138399;5549.528290095387;4282.507511636201;4506.443125252815;5127.769250383667;5232.476752324737;5247.527722504993;4579.5878370946775;4641.3734145889875;4715.599174070242;5043.319151914445;5234.659747116425;4445.110827898195;4846.418429788307;5257.790708137073;5312.707801070978;5439.809606663748;3451.3097380524496;3555.591107022622;3726.621150174453;3741.4659989404213;3866.478025466526;4853.029394121119;5159.535641792107;5267.341582302212;5420.75606597712;5677.261955945701;5513.338399391938;5516.972415137899;5524.66851988882;5527.972360138174;5580.381689310055;5159.922601160911;5462.535684466865;5477.20580515815;5509.338879334506;5534.972325138348;5180.533751962342;5221.556167725634;5348;5391.811286605107;5451.591130665137;4618.905333426679;4824.565789079;5456.7544460498575;5539.390667026543;5554.611177217556;4530.88672783183;4906.95093049065;5209.906521760553;5374.247605335335;5395.892082158413 20:36:20 INFO - PROCESS | 1633 | |5;yui.html;613.8219916224296;664.143255200791;697.4072038767049;734.6069852628845;736.6905899522196;14125.434982600696;15132.092074475539;15148.772768408482;15158.317875695606;15160.848391516081;13133.934330328335;13465.66335841602;13484.595462136127;13565.982551308667;13588.456461741518;827.433208252346;832.9583520823965;834.1116710703081;835.3776436554745;860.1613426908776;685.8765422223997;866.030046348091;869.1612593846936;870.0516437083578;873.1137895036543;735.6468894930437;898.0256421782374;926.0091701878993;927.8886533615942;927.9860802087974;879.7580665317025;881.8192270584515;882.0561998661435;882.8940527136721;886.7871710789397;652.2857471069171;653.993460065398;654.254150268694;655.0109334904281;658.9670516474205;11211.439428028647;13313.068085234037;13593.252371119584;13596.252206128658;13609;12889.484420623165;12922.418491167826;12984;13111.934440327832;13138.211707297593;11688.474018669096;11942.641720748392;12073.094517911104;12128.878711212863;12600.369981500888;4276.657867370603;4347.413099231595;4473.351364052227;4579.038401935598;4605.769711514445;91943;92214.61678074834;92340.53829730875;92385;92936.53531732298;9860.556777577689;10145.137663298554;10410.791784164274;10450.790984180427;10555.47222638865;19552.90223548873;19572.119254633577;19585.510362241057;19592.608147836963;19596.902015490115;7045.506814523037;7136.179339375934;7428.702851885972;7495.66269517873;7608.657610407545;4262.42457268271;4275.187714334266;4282.229198744194;4356.978215108904;4413.7793110345;3178.761592880497;3220.2754380264255;3269.346130773807;3290.52287418323;3298.86804527821;625.0624063904144;637.1430426076919;638.4644928945893;639.9584027038228;652.9151210342625;498.37453995235745;530.9893802123936;544.8065936592532;601.8204319533676;611.0711718188329;8028.277455028959;8680.131986801269;8699.695510657224;8706;8844.417036344554;530.7346326836582;581.8109114537707;603.1947350287328;620.3052581109187;641.0544446940725;4138.544760076389;4221.197972385237;4249.490061192677;4253.2769429197115;4415.779211039435;87400;90786;95312;102033.48983255036;118237.4088129571;90054;90380.6442903357;90852;92459.5377023124;94363;64500.67749661222;65776.67111664507;67631.66184169146;86891;87170;9513.857292140761;9869.753256168653;9875.308728388944;10008.849867252142;10024.548895299584;52909.677258068856;53743.46256537385;54376.91246175134;54779.45220547903;54789;71673;72891;74945.87581186395;75026;76965.61517192378;12480.812787808372;12532.749345013232;12662.746745065231;12998.415071321624;13197.406116724962;13885.930570347084;14142.575722728334;14165.43338266499;14230.928845355707;14850;12569.685757856127;12644.683882903;12922.806157907828;13618.591442256748;14037.649058773612;12473;13117.08180427361;13430.127041742646;13455.259960701864;13883.930580347034;11826.763464730486;12572.748545029232;12696;12727.045471589483;13145.014123940933;10756.354618722902;11104.833427498432;11443.027342675965;11448.3703396314;11724.062075034148;10930.617428389969;11206.43967801623;11372.886271137182;11432.828507572227;11449.542018319175 20:36:20 INFO - PROCESS | 1633 | __end_tp_report 20:36:20 INFO - PROCESS | 1633 | __start_cc_report 20:36:20 INFO - PROCESS | 1633 | _x_x_mozilla_cycle_collect,2058 20:36:20 INFO - PROCESS | 1633 | __end_cc_report 20:36:20 INFO - PROCESS | 1633 | __startTimestamp1487910980395__endTimestamp 20:36:20 INFO - PROCESS | 1633 | 20:36:20 INFO - PROCESS | 1633 | ------- Summary: start ------- 20:36:20 INFO - PROCESS | 1633 | Number of tests: 6 20:36:20 INFO - PROCESS | 1633 | 20:36:20 INFO - PROCESS | 1633 | [#0] dojo.html Cycles:165 Average:5890.75 Median:6147.35 stddev:656.56 (10.7%) stddev-sans-first:629.90 20:36:20 INFO - PROCESS | 1633 | Values: 3444.4 3521.6 3543.5 3551.9 3593.5 5899.9 5906.1 5980.3 5989.8 6006.7 5978.5 6041.6 6054.2 6058.5 6076.7 4174.6 5308.2 5373.5 5382.7 5411.4 5281.6 5295.4 5305.1 5427.1 5445.8 5380.7 5387.5 5400.7 5404.8 5411.6 5371.8 5378.2 5386.7 5396.8 5398.5 5265.3 5288.2 5306.4 5337.5 5381.7 6060.3 6142.6 6155.5 6167.0 6175.0 6276.6 6292.0 6309.3 6320.8 6352.8 6214.2 6262.8 6277.7 6298.3 6412.6 6046.3 6048.3 6048.7 6065.0 6117.7 6528.0 6578.2 6588.3 6592.4 6593.6 6199.8 6253.8 6262.2 6280.8 6286.0 6331.7 6370.6 6379.3 6390.5 6401.4 5263.9 6274.0 6290.0 6291.9 6297.7 6219.2 6245.4 6263.4 6274.6 6305.2 5013.7 5025.9 5027.8 5057.5 5066.0 4456.3 4478.1 4481.6 4484.4 4516.1 5902.5 5965.1 5973.2 6016.0 6104.5 6291.1 6292.2 6302.9 6353.1 6407.2 6140.9 6147.4 6148.9 6153.3 6169.2 5624.9 5628.6 5631.7 5636.7 5646.0 6009.9 6021.2 6313.3 6472.0 6529.7 6262.6 6303.5 6312.2 6321.8 6339.3 5589.2 6600.2 6643.0 6650.2 6655.4 6258.7 6293.3 6322.1 6332.5 6334.5 5340.9 6253.9 6295.9 6316.2 6359.6 6175.7 6310.5 6315.8 6325.3 6337.1 6223.8 6228.9 6305.9 6310.1 6320.1 5010.1 6039.4 6077.1 6140.4 6237.1 6242.2 6262.1 6293.1 6299.9 6315.9 6091.8 6106.3 6111.6 6126.2 6139.0 20:36:20 INFO - PROCESS | 1633 | 20:36:20 INFO - PROCESS | 1633 | [#1] ext.html Cycles:180 Average:71738.72 Median:40618.40 stddev:157685.91 (388.2%) stddev-sans-first:158037.59 20:36:20 INFO - PROCESS | 1633 | Values: 517.7 525.7 540.7 590.0 595.6 25042.0 40267.4 41007.0 41324.4 43646.8 43362.1 43640.8 43833.9 43865.8 43889.3 9524.5 9705.5 9720.5 9720.9 9733.4 9467.1 9557.0 9561.0 9569.0 9600.3 9541.8 9607.9 9609.9 9613.9 9617.4 9556.0 9583.4 9599.8 9600.9 9609.3 9544.9 9616.6 9622.2 9631.0 9638.2 40921.8 41228.6 41281.0 41305.6 41314.4 3213.8 3229.6 3296.3 3300.8 3327.0 29806.0 30397.2 30450.1 30775.4 30894.2 3205.7 3253.2 3253.9 3259.3 3313.8 507657.0 509259.0 509419.0 509975.5 510616.0 61721.7 61957.4 62136.7 62217.7 62263.4 35733.6 35838.9 37851.2 65166.3 65294.7 16985.5 17076.9 17077.8 17083.7 17085.4 12992.5 13068.3 13073.9 13074.9 13126.3 19193.0 19541.5 19548.8 19553.5 19571.8 6511.7 7857.6 7902.9 7916.8 7955.6 820.6 884.0 955.8 993.5 1037.8 29491.6 30182.5 30224.7 31128.2 31271.4 1038.4 1050.2 1180.1 1180.4 1232.1 15784.8 15817.4 15832.3 15845.9 16125.3 664289.0 666800.0 668252.0 668473.0 668502.0 51494.0 59586.8 60188.4 60314.0 60419.8 1241.5 1379.0 1389.2 1458.4 1466.5 29789.1 31523.2 31798.0 31950.5 32247.0 50922.5 51714.7 51726.2 51776.5 51913.7 528036.0 542847.0 604270.0 613987.0 615532.0 36062.6 36460.3 36486.3 36508.0 36554.5 37404.4 47588.8 49051.8 49658.8 49696.5 32566.0 36689.0 38650.8 38952.0 40875.0 38511.6 39191.0 39216.4 39859.0 40361.8 37963.4 38271.4 38950.4 39074.8 39469.8 31685.2 33044.7 34020.5 34466.7 34829.8 23846.0 24520.0 25518.6 25761.5 26703.0 20:36:20 INFO - PROCESS | 1633 | 20:36:20 INFO - PROCESS | 1633 | [#2] jquery.html Cycles:180 Average:36245.63 Median:12316.93 stddev:106117.18 (861.6%) stddev-sans-first:106380.60 20:36:20 INFO - PROCESS | 1633 | Values: 330.6 385.6 392.2 401.0 417.8 15052.6 15761.0 18617.5 21284.5 21408.8 17321.5 18100.5 19856.0 20563.3 21035.5 5701.3 5725.8 5996.3 5996.6 6014.1 5760.0 5937.1 5937.2 5938.6 5938.9 4292.6 4506.8 5893.7 6166.4 6472.2 5697.5 6483.6 6522.3 6534.7 6541.1 5747.9 5869.5 5870.9 5881.7 5883.8 13441.0 13517.3 13592.9 13768.8 13789.2 1756.9 1979.7 2054.2 2093.7 2878.7 10033.9 10135.2 10140.2 10619.2 10669.9 1829.4 1929.1 1930.7 1943.2 1954.8 119516.6 120047.4 128288.0 129405.0 132191.7 11266.0 11492.9 11564.1 11705.6 11738.9 12767.5 15085.5 15091.9 15117.1 15139.7 8434.7 8704.3 8720.5 8874.4 8905.2 8649.7 8661.3 8672.7 8813.7 8897.6 3739.7 4581.6 4600.2 4669.4 4672.4 1864.8 1919.7 1921.8 1924.2 1986.3 699.5 819.0 885.8 942.6 976.7 20800.8 21640.6 21672.5 21696.9 21755.2 716.8 917.9 920.9 940.7 980.3 10647.8 11154.6 11281.2 11286.0 12096.3 629596.6 630132.5 631409.0 641168.0 644415.8 126063.0 131505.0 134686.0 135164.3 136952.0 867.8 870.0 901.0 906.2 907.5 16641.7 19261.8 19384.9 19956.8 21029.4 57487.7 58415.0 59023.4 59555.7 59653.7 72687.7 73269.6 80323.0 83381.2 84964.6 7284.3 7448.0 7506.8 7956.5 8094.4 12856.5 12904.9 12932.4 13176.0 13519.5 7800.7 8912.6 11244.0 11486.1 11664.9 10902.0 11183.9 11213.8 11589.5 11691.2 11320.8 11482.3 11721.3 11846.8 11943.0 7224.2 7401.7 7525.0 7715.5 8689.8 9385.8 10829.4 11269.2 11549.2 11598.9 20:36:20 INFO - PROCESS | 1633 | 20:36:20 INFO - PROCESS | 1633 | [#3] mootools.html Cycles:180 Average:5475.83 Median:5240.08 stddev:3010.63 (57.5%) stddev-sans-first:3004.16 20:36:20 INFO - PROCESS | 1633 | Values: 1487.4 1530.4 1676.5 1841.5 1845.0 8100.4 8528.7 8542.4 8551.0 8559.7 7533.5 7738.7 8184.7 8335.7 8392.9 2336.3 2369.9 2373.3 2381.0 2384.7 2062.4 2365.8 2385.0 2413.3 2426.0 2348.6 2364.3 2364.4 2370.7 2388.6 2346.7 2349.1 2370.4 2370.9 2377.3 2138.4 2257.0 2367.2 2393.7 2395.4 8382.4 8423.5 8502.9 8503.2 8506.8 4914.4 5238.0 5242.2 5246.2 5246.6 3365.6 3496.8 3563.9 3630.6 3632.6 948.3 1051.8 1060.5 1103.2 1117.4 10870.8 10976.3 10988.4 10996.7 11034.0 4503.5 4621.1 4717.3 4730.7 4798.9 9486.0 9488.1 9489.6 9490.2 9497.7 5261.4 5264.1 5266.2 5268.6 5269.2 4327.7 4353.6 4747.1 4798.2 4853.6 3317.8 3364.0 3500.3 3673.2 3852.1 1100.4 1285.8 1295.9 1307.5 1308.5 681.6 801.9 898.5 904.5 910.7 4820.2 5428.2 5607.2 5778.9 5867.3 949.0 954.7 963.4 975.7 998.1 3545.4 3683.9 3791.7 3850.5 3858.9 9985.7 10222.8 10333.5 10344.7 10350.0 10305.4 10306.0 10309.2 10315.1 10317.2 6945.5 7547.2 7905.1 7996.1 8006.4 5428.3 5516.5 5554.2 5719.0 5751.2 9382.9 9392.2 9459.5 9517.7 9561.2 7591.0 9541.7 9672.3 9693.3 9706.6 6293.2 6486.1 6596.6 6765.0 6891.7 7906.4 8106.7 8108.5 8120.2 8122.6 7110.4 7246.9 7311.5 7322.1 7401.8 7046.2 7066.4 7127.9 7174.5 7292.7 6675.2 6824.2 6838.7 6850.5 6850.7 4813.0 4865.3 4883.0 4890.8 4932.4 4201.7 4806.0 4943.5 4992.2 5006.4 20:36:20 INFO - PROCESS | 1633 | 20:36:20 INFO - PROCESS | 1633 | [#4] prototype.html Cycles:180 Average:4322.14 Median:4831.90 stddev:1294.40 (26.8%) stddev-sans-first:1261.74 20:36:20 INFO - PROCESS | 1633 | Values: 266.9 281.6 315.3 318.0 320.2 4061.7 5118.1 5147.1 5162.6 5211.9 3997.6 4268.7 4769.6 4946.2 5078.6 3907.8 3942.8 3973.4 3977.8 3987.6 3744.9 3863.9 3972.1 3974.3 3975.4 3685.5 3823.9 3902.3 3933.8 3969.7 3280.3 3914.5 3933.6 3940.7 3947.0 3485.1 3487.4 3498.4 3502.3 3515.5 4052.4 4169.7 4839.2 4855.6 5033.8 4537.6 4546.1 4550.7 4557.5 4577.8 4523.3 4954.6 5422.2 5436.9 5441.6 3304.7 3632.8 3834.8 3842.8 3857.6 5112.7 5315.8 5682.0 5728.5 5770.8 3485.7 3654.9 3665.1 3681.9 3962.3 4009.9 4016.5 4028.7 4035.5 4053.2 3791.5 4459.5 4530.4 4555.0 4583.9 4293.7 5387.9 5431.9 5447.6 5455.0 1233.3 1256.8 1273.5 1300.2 1311.5 793.3 859.8 869.7 881.2 905.3 4507.5 4903.8 4906.4 4970.0 5071.4 4336.5 5336.3 5379.7 5390.3 5401.2 4185.7 4845.3 4852.8 4902.0 4905.0 2485.5 2709.0 2790.8 2805.3 2846.3 4963.8 5250.4 5427.8 5524.9 5608.6 4502.8 5051.3 5227.7 5380.7 5458.8 5351.5 5468.8 5505.4 5537.0 5549.5 4282.5 4506.4 5127.8 5232.5 5247.5 4579.6 4641.4 4715.6 5043.3 5234.7 4445.1 4846.4 5257.8 5312.7 5439.8 3451.3 3555.6 3726.6 3741.5 3866.5 4853.0 5159.5 5267.3 5420.8 5677.3 5513.3 5517.0 5524.7 5528.0 5580.4 5159.9 5462.5 5477.2 5509.3 5535.0 5180.5 5221.6 5348.0 5391.8 5451.6 4618.9 4824.6 5456.8 5539.4 5554.6 4530.9 4907.0 5209.9 5374.2 5395.9 20:36:20 INFO - PROCESS | 1633 | 20:36:20 INFO - PROCESS | 1633 | [#5] yui.html Cycles:180 Average:19979.06 Median:4526.19 stddev:28624.41 (632.4%) stddev-sans-first:28667.77 20:36:20 INFO - PROCESS | 1633 | Values: 613.8 664.1 697.4 734.6 736.7 14125.4 15132.1 15148.8 15158.3 15160.8 13133.9 13465.7 13484.6 13566.0 13588.5 827.4 833.0 834.1 835.4 860.2 685.9 866.0 869.2 870.1 873.1 735.6 898.0 926.0 927.9 928.0 879.8 881.8 882.1 882.9 886.8 652.3 654.0 654.3 655.0 659.0 11211.4 13313.1 13593.3 13596.3 13609.0 12889.5 12922.4 12984.0 13111.9 13138.2 11688.5 11942.6 12073.1 12128.9 12600.4 4276.7 4347.4 4473.4 4579.0 4605.8 91943.0 92214.6 92340.5 92385.0 92936.5 9860.6 10145.1 10410.8 10450.8 10555.5 19552.9 19572.1 19585.5 19592.6 19596.9 7045.5 7136.2 7428.7 7495.7 7608.7 4262.4 4275.2 4282.2 4357.0 4413.8 3178.8 3220.3 3269.3 3290.5 3298.9 625.1 637.1 638.5 640.0 652.9 498.4 531.0 544.8 601.8 611.1 8028.3 8680.1 8699.7 8706.0 8844.4 530.7 581.8 603.2 620.3 641.1 4138.5 4221.2 4249.5 4253.3 4415.8 87400.0 90786.0 95312.0 102033.5 118237.4 90054.0 90380.6 90852.0 92459.5 94363.0 64500.7 65776.7 67631.7 86891.0 87170.0 9513.9 9869.8 9875.3 10008.8 10024.5 52909.7 53743.5 54376.9 54779.5 54789.0 71673.0 72891.0 74945.9 75026.0 76965.6 12480.8 12532.7 12662.7 12998.4 13197.4 13885.9 14142.6 14165.4 14230.9 14850.0 12569.7 12644.7 12922.8 13618.6 14037.6 12473.0 13117.1 13430.1 13455.3 13883.9 11826.8 12572.7 12696.0 12727.0 13145.0 10756.4 11104.8 11443.0 11448.4 11724.1 10930.6 11206.4 11372.9 11432.8 11449.5 20:36:20 INFO - PROCESS | 1633 | -------- Summary: end -------- 20:36:20 INFO - PROCESS | 1633 | 20:36:21 INFO - TEST-INFO | 1633: exit 0 20:36:21 INFO - TEST-OK | dromaeo_css | took 1120089ms 20:36:21 INFO - TEST-START | kraken 20:36:21 INFO - operating with platform_type : mac_ 20:36:21 INFO - Initialising browser for kraken test... 20:36:21 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpKt8Mjt/profile http://localhost:49241/getInfo.html) 20:36:23 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 20:36:23 INFO - PROCESS | 1644 | colorDepth:24 20:36:23 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 20:36:23 INFO - PROCESS | 1644 | __metrics 20:36:23 INFO - PROCESS | 1644 | 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" 20:36:23 INFO - PROCESS | 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:36:24 INFO - TEST-INFO | 1644: exit 0 20:36:24 INFO - Browser initialized. 20:36:24 INFO - Running cycle 1/1 for kraken test... 20:36:24 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpKt8Mjt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:36:36 INFO - PROCESS | 1646 | RSS: Main: 171675648 20:36:36 INFO - PROCESS | 1646 | 20:36:39 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 20:36:40 INFO - PROCESS | 1646 | RSS: Main: 221552640 20:36:40 INFO - PROCESS | 1646 | 20:36:42 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 20:36:43 INFO - PROCESS | 1646 | RSS: Main: 232390656 20:36:43 INFO - PROCESS | 1646 | 20:36:46 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 20:36:46 INFO - PROCESS | 1646 | RSS: Main: 330252288 20:36:46 INFO - PROCESS | 1646 | 20:36:48 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 20:36:49 INFO - PROCESS | 1646 | RSS: Main: 231886848 20:36:49 INFO - PROCESS | 1646 | 20:36:51 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:36:52 INFO - PROCESS | 1646 | RSS: Main: 232841216 20:36:52 INFO - PROCESS | 1646 | 20:36:54 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 20:36:55 INFO - PROCESS | 1646 | RSS: Main: 273899520 20:36:55 INFO - PROCESS | 1646 | 20:36:58 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 20:36:58 INFO - PROCESS | 1646 | RSS: Main: 274804736 20:36:58 INFO - PROCESS | 1646 | 20:37:01 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 20:37:02 INFO - PROCESS | 1646 | RSS: Main: 273653760 20:37:02 INFO - PROCESS | 1646 | 20:37:03 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:37:04 INFO - PROCESS | 1646 | RSS: Main: 249503744 20:37:04 INFO - PROCESS | 1646 | 20:37:06 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:37:06 INFO - PROCESS | 1646 | RSS: Main: 247808000 20:37:06 INFO - PROCESS | 1646 | 20:37:08 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:37:09 INFO - PROCESS | 1646 | RSS: Main: 250486784 20:37:09 INFO - PROCESS | 1646 | 20:37:12 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:37:13 INFO - PROCESS | 1646 | RSS: Main: 265478144 20:37:13 INFO - PROCESS | 1646 | 20:37:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:37:16 INFO - PROCESS | 1646 | RSS: Main: 265449472 20:37:16 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 20:37:18 INFO - PROCESS | 1646 | RSS: Main: 309010432 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | __start_tp_report 20:37:18 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 20:37:18 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 20:37:18 INFO - PROCESS | 1646 | |i|pagename|runs| 20:37:18 INFO - PROCESS | 1646 | |0;ai-astar;114;110;112;111;111;111;110;111;111;113 20:37:18 INFO - PROCESS | 1646 | |1;audio-beat-detection;136;108;106;140;107;111;107;107;137;105 20:37:18 INFO - PROCESS | 1646 | |2;audio-dft;182;184;182;184;185;182;184;183;184;184 20:37:18 INFO - PROCESS | 1646 | |3;audio-fft;81;73;81;117;85;59;60;58;81;57 20:37:18 INFO - PROCESS | 1646 | |4;audio-oscillator;81;69;94;70;66;69;88;68;69;90 20:37:18 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;88;84;88;85;87;84;87;84;88;85 20:37:18 INFO - PROCESS | 1646 | |6;imaging-darkroom;95;96;96;96;96;96;96;96;96;96 20:37:18 INFO - PROCESS | 1646 | |7;imaging-desaturate;81;84;79;78;84;84;83;82;81;82 20:37:18 INFO - PROCESS | 1646 | |8;json-parse-financial;55;53;54;54;56;56;58;56;57;56 20:37:18 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;63;70;69;73;70;68;66;68;69;68 20:37:18 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;80;83;83;81;86;90;91;95;98;78 20:37:18 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;137;137;136;135;141;149;144;135;173;147 20:37:18 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;174;160;161;162;161;161;161;162;160;161 20:37:18 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;67;65;64;65;79;83;83;84;56;64 20:37:18 INFO - PROCESS | 1646 | __end_tp_report 20:37:18 INFO - PROCESS | 1646 | __start_cc_report 20:37:18 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1925 20:37:18 INFO - PROCESS | 1646 | __end_cc_report 20:37:18 INFO - PROCESS | 1646 | __startTimestamp1487911038565__endTimestamp 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | ------- Summary: start ------- 20:37:18 INFO - PROCESS | 1646 | Number of tests: 14 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:1.26 (1.1%) stddev-sans-first:0.93 20:37:18 INFO - PROCESS | 1646 | Values: 114.0 110.0 112.0 111.0 111.0 111.0 110.0 111.0 111.0 113.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:116.40 Median:109.50 stddev:14.79 (13.5%) stddev-sans-first:13.88 20:37:18 INFO - PROCESS | 1646 | Values: 136.0 108.0 106.0 140.0 107.0 111.0 107.0 107.0 137.0 105.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.07 (0.6%) stddev-sans-first:1.01 20:37:18 INFO - PROCESS | 1646 | Values: 182.0 184.0 182.0 184.0 185.0 182.0 184.0 183.0 184.0 184.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:75.20 Median:77.00 stddev:18.47 (24.0%) stddev-sans-first:19.47 20:37:18 INFO - PROCESS | 1646 | Values: 81.0 73.0 81.0 117.0 85.0 59.0 60.0 58.0 81.0 57.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:75.50 stddev:10.72 (14.2%) stddev-sans-first:11.24 20:37:18 INFO - PROCESS | 1646 | Values: 81.0 69.0 94.0 70.0 66.0 69.0 88.0 68.0 69.0 90.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:1.76 (2.0%) stddev-sans-first:1.72 20:37:18 INFO - PROCESS | 1646 | Values: 88.0 84.0 88.0 85.0 87.0 84.0 87.0 84.0 88.0 85.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 20:37:18 INFO - PROCESS | 1646 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:81.80 Median:82.50 stddev:2.10 (2.5%) stddev-sans-first:2.20 20:37:18 INFO - PROCESS | 1646 | Values: 81.0 84.0 79.0 78.0 84.0 84.0 83.0 82.0 81.0 82.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.51 (2.7%) stddev-sans-first:1.59 20:37:18 INFO - PROCESS | 1646 | Values: 55.0 53.0 54.0 54.0 56.0 56.0 58.0 56.0 57.0 56.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:2.63 (3.8%) stddev-sans-first:1.94 20:37:18 INFO - PROCESS | 1646 | Values: 63.0 70.0 69.0 73.0 70.0 68.0 66.0 68.0 69.0 68.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:88.00 stddev:6.72 (7.6%) stddev-sans-first:6.70 20:37:18 INFO - PROCESS | 1646 | Values: 80.0 83.0 83.0 81.0 86.0 90.0 91.0 95.0 98.0 78.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:142.50 stddev:11.57 (8.1%) stddev-sans-first:12.04 20:37:18 INFO - PROCESS | 1646 | Values: 137.0 137.0 136.0 135.0 141.0 149.0 144.0 135.0 173.0 147.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:161.00 stddev:4.16 (2.6%) stddev-sans-first:0.71 20:37:18 INFO - PROCESS | 1646 | Values: 174.0 160.0 161.0 162.0 161.0 161.0 161.0 162.0 160.0 161.0 20:37:18 INFO - PROCESS | 1646 | 20:37:18 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:73.00 stddev:10.18 (13.9%) stddev-sans-first:10.69 20:37:18 INFO - PROCESS | 1646 | Values: 67.0 65.0 64.0 65.0 79.0 83.0 83.0 84.0 56.0 64.0 20:37:18 INFO - PROCESS | 1646 | -------- Summary: end -------- 20:37:18 INFO - PROCESS | 1646 | 20:37:19 INFO - TEST-INFO | 1646: exit 0 20:37:19 INFO - TEST-OK | kraken | took 58839ms 20:37:19 INFO - SUITE-END | took 1178s 20:37:20 INFO - Completed test suite (00:19:39) 20:37:20 INFO - javascript benchmark 20:37:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3444.380011597912, 3521.630228825973, 3543.5216245806823, 3551.875684351048, 3593.478945552895, 5899.941000589993, 5906.0845568936775, 5980.252468441445, 5989.760409583611, 6006.729697163627, 5978.4918281945975, 6041.637501749898, 6054.212952316204, 6058.454739073482, 6076.6961651917445, 4174.582541745816, 5308.203769434577, 5373.462653734615, 5382.650127741704, 5411.404745477994, 5281.577473802086, 5295.417504074549, 5305.098133317326, 5427.0773968425465, 5445.782168713266, 5380.704061276629, 5387.515123638872, 5400.675959442446, 5404.810831620894, 5411.648242864221, 5371.81198658049, 5378.2470454136255, 5386.676799392049, 5396.757145928404, 5398.460153984609, 5265.262863199156, 5288.206768984683, 5306.363236411656, 5337.546308563777, 5381.677099374011, 6060.303065147476, 6142.6314421134875, 6155.476784473325, 6166.969165154191, 6175.0, 6276.560640755149, 6292.024736165856, 6309.274433440167, 6320.810375688737, 6352.80941571749, 6214.161088253119, 6262.812115636538, 6277.7175027123885, 6298.338674439209, 6412.551121421502, 6046.3349031606485, 6048.334683184846, 6048.667323297261, 6065.0, 6117.694115294217, 6528.038944779967, 6578.177727784027, 6588.275289718127, 6592.373724496165, 6593.604383736895, 6199.783007594712, 6253.812385628438, 6262.248530176408, 6280.811575652738, 6285.96857015712, 6331.746730130743, 6370.649614271167, 6379.298277189506, 6390.520710946697, 6401.391867772554, 5263.894722105537, 6273.99616061428, 6289.968550157311, 6291.937080629135, 6297.748090076438, 6219.191505104398, 6245.406686364879, 6263.3736626337, 6274.623522588659, 6305.18032655761, 5013.699178049329, 5025.924611130836, 5027.798888044437, 5057.544820966057, 5066.0, 4456.309272062836, 4478.081993191453, 4481.596656300949, 4484.394606728115, 4516.1419330327135, 5902.498287645598, 5965.13505541694, 5973.1936188614845, 6016.037434010625, 6104.542159338067, 6291.087792270096, 6292.150559674477, 6302.873942521124, 6353.110564520971, 6407.199100112486, 6140.907886381708, 6147.354527774609, 6148.938510614926, 6153.323134455206, 6169.2288463942, 5624.85937851557, 5628.577856660685, 5631.662100273997, 5636.661800291996, 5646.040173170489, 6009.90985135232, 6021.157038014769, 6313.337099604475, 6471.967640161957, 6529.738810447719, 6262.561620686508, 6303.527235457267, 6312.179416675803, 6321.830461364662, 6339.3343698912795, 5589.245451863946, 6600.174978127734, 6643.036759669917, 6650.235222949423, 6655.434288085567, 6258.687065646608, 6293.307736148929, 6322.114903913363, 6332.461740751904, 6334.461570766536, 5340.866478338073, 6253.937460625336, 6295.905561416491, 6316.242050953915, 6359.586626869239, 6175.722092505938, 6310.495160387066, 6315.842103947254, 6325.272593651789, 6337.081123237197, 6223.844403889939, 6228.937710623017, 6305.873882522415, 6310.116583678197, 6320.051992201206, 5010.073136469765, 6039.4262545058145, 6077.088436734525, 6140.4473597376455, 6237.064440333987, 6242.219722534684, 6262.091996660368, 6293.118963345044, 6299.874002520016, 6315.905261421174, 6091.756329746938, 6106.346483705045, 6111.602745821508, 6126.23422072241, 6139.048447490646], "value": 5850.452194318218, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.6764522173642, 525.700350800044, 540.7161240348817, 589.9911501327483, 595.5741644724021, 25042.0, 40267.395989060155, 41006.974825629375, 41324.38013429801, 43646.781766091204, 43362.132757344836, 43640.781796091054, 43833.90415239621, 43865.780671096676, 43889.34165987513, 9524.5237738113, 9705.466199359033, 9720.513974301257, 9720.902790972106, 9733.415995040321, 9467.053294670546, 9557.044295570457, 9560.952195239013, 9568.952155239214, 9600.279979001569, 9541.809163816719, 9607.855882161773, 9609.903900960971, 9613.855792163124, 9617.42295462271, 9555.952220238889, 9583.424994500352, 9599.808003839918, 9600.855987160197, 9609.327347085708, 9544.904550954541, 9616.615335386647, 9622.230221582256, 9631.036896310383, 9638.228941684649, 40921.79539102315, 41228.587714122776, 41280.96797580084, 41305.586944130475, 41314.38028429576, 3213.8393080346123, 3229.5963004624423, 3296.307775367176, 3300.834958252102, 3326.9500957485416, 29806.0, 30397.24006899823, 30450.086497405115, 30775.38449231003, 30894.22764430885, 3205.727513161384, 3253.235489659928, 3253.902382928516, 3259.26666500038, 3313.7514686398376, 507657.0, 509259.0, 509419.0, 509975.4501227507, 510616.0, 61721.69139154276, 61957.38042619516, 62136.68931655313, 62217.68891155515, 62263.37736622666, 35733.64266357303, 35838.92483225508, 37851.24297514034, 65166.34833651603, 65294.67352663206, 16985.49043528696, 17076.914615427093, 17077.82922170787, 17083.743743843854, 17085.402010929556, 12992.545260915822, 13068.346582670829, 13073.869261307265, 13074.869251307555, 13126.343682816012, 19193.04657020105, 19541.508126087578, 19548.79715828036, 19553.50192610918, 19571.804281957284, 6511.706973186218, 7857.607119643995, 7902.881456778153, 7916.802079947932, 7955.602219888982, 820.6143112737004, 883.969061082859, 955.8375076236917, 993.4933184076173, 1037.8131936251395, 29491.55762663562, 30182.54726179109, 30224.69775302219, 31128.22179445532, 31271.374572508423, 1038.4288641247283, 1050.238577031646, 1180.135057686085, 1180.4333919718583, 1232.100566586397, 15784.763228551581, 15817.446389376317, 15832.28754706041, 15845.920770396306, 16125.274362653709, 664289.0, 666800.0, 668252.0, 668473.0, 668502.0, 51493.970120598126, 59586.808263835344, 60188.39811601828, 60314.0, 60419.79160416767, 1241.4599649152647, 1378.9933348655338, 1389.201209304654, 1458.4457905995653, 1466.5013895275658, 29789.10632681023, 31523.21191970219, 31798.0, 31950.520742188422, 32247.0, 50922.49077509178, 51714.741426292625, 51726.22410663768, 51776.482235177165, 51913.7404312976, 528036.0, 542847.0, 604270.0, 613987.0, 615532.0, 36062.63937360698, 36460.270794583426, 36486.27027459489, 36508.0, 36554.451683224244, 37404.43893341657, 47588.762056189495, 49051.75474122607, 49658.75170624124, 49696.50303496919, 32566.0, 36689.0, 38650.8404747858, 38952.026199345244, 40875.0, 38511.61488385192, 39191.0, 39216.411753824286, 39859.0, 40361.79819100886, 37963.43054854235, 38271.42592861165, 38950.41574376443, 39074.80462597783, 39469.80265098771, 31685.207869802518, 33044.669553305124, 34020.48969265512, 34466.655333446346, 34829.825850871595, 23846.0, 24520.0, 25518.617220741333, 25761.484770304865, 26703.0], "value": 20270.78789316725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.6082292483407, 385.57394079542104, 392.1666458775104, 400.9979950100249, 417.80154426647346, 15052.623684407896, 15761.0, 18617.53456163595, 21284.4678883028, 21408.785912140895, 17321.48035558932, 18100.547486312847, 19856.0, 20563.28028519002, 21035.474113147142, 5701.344345400291, 5725.7995970141055, 5996.340402555716, 5996.640201587918, 6014.067819487965, 5759.971200143993, 5937.079752638348, 5937.168796368512, 5938.613990090652, 5938.940610593882, 4292.635126014293, 4506.819727210907, 5893.673923367251, 6166.414190651881, 6472.190976127984, 5697.4587414195585, 6483.578567393104, 6522.347765223487, 6534.705938232791, 6541.116949211867, 5747.936631723144, 5869.50109240715, 5870.911936320958, 5881.70591470429, 5883.823485295448, 13440.991925605618, 13517.32413379327, 13592.864071359358, 13768.793468097987, 13789.241591712453, 1756.8858024228512, 1979.6832506798844, 2054.1783286685295, 2093.7382827146607, 2878.654561452639, 10033.949830250875, 10135.189184865267, 10140.239482038876, 10619.20355973305, 10669.946650266776, 1829.4328758085037, 1929.0547631660525, 1930.7007413850736, 1943.232423192831, 1954.7947465516058, 119516.60966780703, 120047.3997630015, 128288.0, 129404.99999999905, 132191.6780832189, 11266.0, 11492.85071492844, 11564.074874010228, 11705.648830535098, 11738.94130529342, 12767.489300428064, 15085.47200847965, 15091.924540377227, 15117.09297442157, 15139.697206056038, 8434.662613495515, 8704.303655707528, 8720.476771393736, 8874.423162494417, 8905.243054340324, 8649.697260595975, 8661.263792577576, 8672.653093876173, 8813.722010308598, 8897.599608017656, 3739.7195210358786, 4581.610563102174, 4600.1949658810245, 4669.3851443191925, 4672.415948006499, 1864.8344784509682, 1919.6928491441302, 1921.8366438852574, 1924.162989099746, 1986.2750096215066, 699.5221086584396, 818.9877151842727, 885.7741275974586, 942.5711301357866, 976.6630512473185, 20800.791992080187, 21640.56718865614, 21672.458188545414, 21696.89151554232, 21755.206459607303, 716.8351279205708, 917.8623206518942, 920.861870719384, 940.6989763275686, 980.2501086668705, 10647.787044259072, 11154.60958866452, 11281.21031527785, 11286.0, 12096.274223546616, 629596.5915327178, 630132.5480117801, 631409.0, 641168.0, 644415.7779211074, 126063.0, 131505.0, 134686.0, 135164.32417837848, 136952.0, 867.8367351005676, 869.9956500217585, 900.9864852027225, 906.2115959115612, 907.4872696926216, 16641.66716665684, 19261.807381926003, 19384.903075484533, 19956.802591844535, 21029.369118926457, 57487.71256143692, 58415.0, 59023.40976590179, 59555.70222148862, 59653.70173149106, 72687.72905219384, 73269.63365183353, 80323.0, 83381.16618833735, 84964.57517712371, 7284.344409003215, 7448.0, 7506.774796756106, 7956.482828616122, 8094.352451803959, 12856.485740570273, 12904.870951290366, 12932.41804118798, 13176.0, 13519.459221631025, 7800.726974555863, 8912.598933048159, 11244.04425623831, 11486.138539609396, 11664.94167529157, 10901.964313390215, 11183.944080279547, 11213.775724485302, 11589.536418543164, 11691.240069395802, 11320.830187547028, 11482.311061336346, 11721.296722196696, 11846.822297665714, 11943.0, 7224.205337412775, 7401.740939067106, 7525.0, 7715.459917805924, 8689.782755431164, 9385.812283754423, 10829.350238985686, 11269.154813389192, 11549.249298795552, 11598.88401115978], "value": 9413.65434420444, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.4199062365678, 1530.357249955019, 1676.4886709553589, 1841.5027942455545, 1845.0221382667182, 8100.432969692117, 8528.701495447669, 8542.359323050772, 8550.95724521378, 8559.700410485619, 7533.472656914018, 7738.690452381912, 8184.713535026275, 8335.708250211244, 8392.916070839305, 2336.2874323331375, 2369.9289021329387, 2373.288013595923, 2380.9880950595225, 2384.6780684607616, 2062.391594479632, 2365.7989070928993, 2384.9642255366184, 2413.263954493879, 2426.0, 2348.612478940973, 2364.3143488388346, 2364.3970787449175, 2370.6562548430466, 2388.5819981503255, 2346.741858395575, 2349.0721165139844, 2370.360002799252, 2370.9051637934376, 2377.2749311459997, 2138.4226258910007, 2257.006916956534, 2367.1596583212886, 2393.700787401575, 2395.38917576017, 8382.371322150802, 8423.536705481196, 8502.914970850274, 8503.23470887623, 8506.78733031679, 4914.3611330527165, 5237.973810130925, 5242.187460943522, 5246.160614301732, 5246.580273578104, 3365.6129545102135, 3496.7552271341015, 3563.8574457021687, 3630.618785027587, 3632.5640923089136, 948.340903072365, 1051.831706926888, 1060.4803646213377, 1103.194667892435, 1117.3966058328574, 10870.782584348348, 10976.341419514774, 10988.395638239894, 10996.670099896935, 11034.0, 4503.459584849839, 4621.145088158634, 4717.315989181549, 4730.668853180245, 4798.928016079762, 9485.952570237105, 9488.051194880456, 9489.620415183315, 9490.240780737524, 9497.667581634609, 5261.3686357637325, 5264.078786212397, 5266.236395722675, 5268.578513718893, 5269.209618557171, 4327.675424343124, 4353.564643535685, 4747.121782470254, 4798.184308667535, 4853.611711063107, 3317.7558415594153, 3363.983180084084, 3500.2824420993634, 3673.2286219893585, 3852.1332700142243, 1100.40304880482, 1285.8199852020725, 1295.9352032398342, 1307.5031488034485, 1308.4896890212824, 681.5672048249397, 801.9278264956065, 898.5058217980215, 904.4980036079908, 910.7404389749022, 4820.239414542583, 5428.158635411518, 5607.186957891083, 5778.884422311614, 5867.325257595346, 948.9667861624948, 954.6992697300328, 963.3545524498603, 975.7024107647236, 998.1066945084254, 3545.397282461936, 3683.931659818676, 3791.6777073949024, 3850.537935447764, 3858.9421158682644, 9985.700428987142, 10222.846657300146, 10333.483325833678, 10344.741381465374, 10350.01674840904, 10305.381677099249, 10306.0, 10309.175265978854, 10315.123214526699, 10317.174626029899, 6945.51381403307, 7547.245275472409, 7905.130435652074, 7996.120426753053, 8006.439549231614, 5428.348598168245, 5516.503514683698, 5554.222408862682, 5718.971405142947, 5751.166080918327, 9382.859257111286, 9392.154706076486, 9459.479728614991, 9517.666881659108, 9561.235101191749, 7591.0, 9541.713748587554, 9672.322937394314, 9693.27300452483, 9706.56320465595, 6293.213348331458, 6486.05952136947, 6596.571222870498, 6764.966175169093, 6891.689873955785, 7906.446548741533, 8106.675732970615, 8108.472949258279, 8120.228578285053, 8122.634481448231, 7110.431165506644, 7246.949192367183, 7311.524750891175, 7322.0847394075745, 7401.777946661608, 7046.154461464657, 7066.364027237573, 7127.928720712726, 7174.461915356474, 7292.671829767779, 6675.198976122896, 6824.249332573314, 6838.692258848463, 6850.45196384298, 6850.725970961105, 4812.975935120442, 4865.318855360323, 4883.023395321021, 4890.755462226945, 4932.4327702314695, 4201.684873634428, 4805.951940480551, 4943.456219815889, 4992.15133427311, 5006.421692828124], "value": 4442.569639171524, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.8518971970557, 281.5804451367462, 315.26700421519973, 317.9777415580909, 320.2170692656456, 4061.6953728470335, 5118.129917913954, 5147.099257629919, 5162.586993040557, 5211.8697032574155, 3997.560268370477, 4268.72253303535, 4769.618430525558, 4946.208606622941, 5078.619103567229, 3907.7850718210416, 3942.80285985701, 3973.443717879499, 3977.82099805508, 3987.6211759882763, 3744.868929587465, 3863.860161252423, 3972.1459886124476, 3974.264761019206, 3975.44197942841, 3685.470529730159, 3823.9044023899487, 3902.2585708715255, 3933.8426462941447, 3969.741966772165, 3280.3439312137666, 3914.549826769901, 3933.5869733677982, 3940.665043471294, 3946.9737868154198, 3485.1112966193714, 3487.4132269817173, 3498.3528047311074, 3502.282032183422, 3515.5078289039557, 4052.351623740217, 4169.665706973769, 4839.225723884161, 4855.635827312965, 5033.773480193364, 4537.6143027842345, 4546.136234115541, 4550.658700597435, 4557.544245575449, 4577.809769459965, 4523.321501774727, 4954.603631709455, 5422.15956526739, 5436.91844622331, 5441.646292990943, 3304.6695330467, 3632.7820330780237, 3834.8466061357512, 3842.7502212356108, 3857.5949525300002, 5112.721819545114, 5315.803944112582, 5681.971590142064, 5728.4769866532615, 5770.7691692332255, 3485.721142308609, 3654.908627284286, 3665.149099704632, 3681.9447708284397, 3962.286788378062, 4009.8997525061523, 4016.49793775778, 4028.683506983496, 4035.475388199574, 4053.2298863216483, 3791.545014598266, 4459.46486421625, 4530.365748795171, 4554.95445045552, 4583.862484125481, 4293.656507479394, 5387.892242155135, 5431.945680543144, 5447.618666693373, 5454.954392102962, 1233.340163012802, 1256.849178098634, 1273.4969686973593, 1300.2263653126374, 1311.4623004568082, 793.2543409195338, 859.7893516088599, 869.7173418638968, 881.2421317666801, 905.3300557587338, 4507.5267096955, 4903.754812259373, 4906.362172917569, 4969.962315450648, 5071.416787069535, 4336.479622445327, 5336.306280183629, 5379.6819779153575, 5390.3020548527875, 5401.216823560561, 4185.686073544496, 4845.30414354973, 4852.778083067754, 4901.995091006335, 4904.96443975746, 2485.540175067582, 2708.9729102709116, 2790.8046436749637, 2805.284652413662, 2846.34534057168, 4963.8014479421145, 5250.377239704591, 5427.83716488506, 5524.861878453071, 5608.6073974821375, 4502.774861256924, 5051.318072060299, 5227.686338819683, 5380.7309634518115, 5458.789190377904, 5351.518363347317, 5468.835934922038, 5505.449455054542, 5536.972315138399, 5549.528290095387, 4282.507511636201, 4506.443125252815, 5127.769250383667, 5232.476752324737, 5247.527722504993, 4579.5878370946775, 4641.3734145889875, 4715.599174070242, 5043.319151914445, 5234.659747116425, 4445.110827898195, 4846.418429788307, 5257.790708137073, 5312.707801070978, 5439.809606663748, 3451.3097380524496, 3555.591107022622, 3726.621150174453, 3741.4659989404213, 3866.478025466526, 4853.029394121119, 5159.535641792107, 5267.341582302212, 5420.75606597712, 5677.261955945701, 5513.338399391938, 5516.972415137899, 5524.66851988882, 5527.972360138174, 5580.381689310055, 5159.922601160911, 5462.535684466865, 5477.20580515815, 5509.338879334506, 5534.972325138348, 5180.533751962342, 5221.556167725634, 5348.0, 5391.811286605107, 5451.591130665137, 4618.905333426679, 4824.565789079, 5456.7544460498575, 5539.390667026543, 5554.611177217556, 4530.88672783183, 4906.95093049065, 5209.906521760553, 5374.247605335335, 5395.892082158413], "value": 3912.9254254790926, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.8219916224296, 664.143255200791, 697.4072038767049, 734.6069852628845, 736.6905899522196, 14125.434982600696, 15132.092074475539, 15148.772768408482, 15158.317875695606, 15160.848391516081, 13133.934330328335, 13465.66335841602, 13484.595462136127, 13565.982551308667, 13588.456461741518, 827.433208252346, 832.9583520823965, 834.1116710703081, 835.3776436554745, 860.1613426908776, 685.8765422223997, 866.030046348091, 869.1612593846936, 870.0516437083578, 873.1137895036543, 735.6468894930437, 898.0256421782374, 926.0091701878993, 927.8886533615942, 927.9860802087974, 879.7580665317025, 881.8192270584515, 882.0561998661435, 882.8940527136721, 886.7871710789397, 652.2857471069171, 653.993460065398, 654.254150268694, 655.0109334904281, 658.9670516474205, 11211.439428028647, 13313.068085234037, 13593.252371119584, 13596.252206128658, 13609.0, 12889.484420623165, 12922.418491167826, 12984.0, 13111.934440327832, 13138.211707297593, 11688.474018669096, 11942.641720748392, 12073.094517911104, 12128.878711212863, 12600.369981500888, 4276.657867370603, 4347.413099231595, 4473.351364052227, 4579.038401935598, 4605.769711514445, 91943.0, 92214.61678074834, 92340.53829730875, 92385.0, 92936.53531732298, 9860.556777577689, 10145.137663298554, 10410.791784164274, 10450.790984180427, 10555.47222638865, 19552.90223548873, 19572.119254633577, 19585.510362241057, 19592.608147836963, 19596.902015490115, 7045.506814523037, 7136.179339375934, 7428.702851885972, 7495.66269517873, 7608.657610407545, 4262.42457268271, 4275.187714334266, 4282.229198744194, 4356.978215108904, 4413.7793110345, 3178.761592880497, 3220.2754380264255, 3269.346130773807, 3290.52287418323, 3298.86804527821, 625.0624063904144, 637.1430426076919, 638.4644928945893, 639.9584027038228, 652.9151210342625, 498.37453995235745, 530.9893802123936, 544.8065936592532, 601.8204319533676, 611.0711718188329, 8028.277455028959, 8680.131986801269, 8699.695510657224, 8706.0, 8844.417036344554, 530.7346326836582, 581.8109114537707, 603.1947350287328, 620.3052581109187, 641.0544446940725, 4138.544760076389, 4221.197972385237, 4249.490061192677, 4253.2769429197115, 4415.779211039435, 87400.0, 90786.0, 95312.0, 102033.48983255036, 118237.4088129571, 90054.0, 90380.6442903357, 90852.0, 92459.5377023124, 94363.0, 64500.67749661222, 65776.67111664507, 67631.66184169146, 86891.0, 87170.0, 9513.857292140761, 9869.753256168653, 9875.308728388944, 10008.849867252142, 10024.548895299584, 52909.677258068856, 53743.46256537385, 54376.91246175134, 54779.45220547903, 54789.0, 71673.0, 72891.0, 74945.87581186395, 75026.0, 76965.61517192378, 12480.812787808372, 12532.749345013232, 12662.746745065231, 12998.415071321624, 13197.406116724962, 13885.930570347084, 14142.575722728334, 14165.43338266499, 14230.928845355707, 14850.0, 12569.685757856127, 12644.683882903, 12922.806157907828, 13618.591442256748, 14037.649058773612, 12473.0, 13117.08180427361, 13430.127041742646, 13455.259960701864, 13883.930580347034, 11826.763464730486, 12572.748545029232, 12696.0, 12727.045471589483, 13145.014123940933, 10756.354618722902, 11104.833427498432, 11443.027342675965, 11448.3703396314, 11724.062075034148, 10930.617428389969, 11206.43967801623, 11372.886271137182, 11432.828507572227, 11449.542018319175], "value": 7246.934009712387, "unit": "score"}], "name": "dromaeo_css", "value": 7211.510809378846, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 112.0, 111.0, 111.0, 111.0, 110.0, 111.0, 111.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 108.0, 106.0, 140.0, 107.0, 111.0, 107.0, 107.0, 137.0, 105.0], "value": 116.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 182.0, 184.0, 185.0, 182.0, 184.0, 183.0, 184.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 73.0, 81.0, 117.0, 85.0, 59.0, 60.0, 58.0, 81.0, 57.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 69.0, 94.0, 70.0, 66.0, 69.0, 88.0, 68.0, 69.0, 90.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 85.0, 87.0, 84.0, 87.0, 84.0, 88.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 79.0, 78.0, 84.0, 84.0, 83.0, 82.0, 81.0, 82.0], "value": 81.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 56.0, 56.0, 58.0, 56.0, 57.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 69.0, 73.0, 70.0, 68.0, 66.0, 68.0, 69.0, 68.0], "value": 68.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 83.0, 81.0, 86.0, 90.0, 91.0, 95.0, 98.0, 78.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 136.0, 135.0, 141.0, 149.0, 144.0, 135.0, 173.0, 147.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 160.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 160.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 65.0, 79.0, 83.0, 83.0, 84.0, 56.0, 64.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1413.6000000000001, "alertThreshold": 2.0}]} 20:37:20 INFO - Return code: 0 20:37:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:37:20 INFO - # TBPL SUCCESS # 20:37:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:37:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:37:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:37:20 INFO - 2017-02-23 20:37:20.385 screenresolution[1650:9944] starting screenresolution argv=screenresolution get 20:37:20 INFO - 2017-02-23 20:37:20.388 screenresolution[1650:9944] Display 0: 1600x1200x32@60 20:37:20 INFO - 2017-02-23 20:37:20.394 screenresolution[1651:9947] starting screenresolution argv=screenresolution list 20:37:20 INFO - Available Modes on Display 0 20:37:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:37:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:37:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:37:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:37:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:37:20 INFO - Intel Iris: 20:37:20 INFO - Chipset Model: Intel Iris 20:37:20 INFO - Type: GPU 20:37:20 INFO - Bus: Built-In 20:37:20 INFO - VRAM (Dynamic, Max): 1536 MB 20:37:20 INFO - Vendor: Intel (0x8086) 20:37:20 INFO - Device ID: 0x0a2e 20:37:20 INFO - Revision ID: 0x0009 20:37:20 INFO - Displays: 20:37:20 INFO - Display: 20:37:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:37:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:37:20 INFO - Display Serial Number: 1600x1200 60 20:37:20 INFO - Main Display: Yes 20:37:20 INFO - Mirror: Off 20:37:20 INFO - Online: Yes 20:37:20 INFO - Rotation: Supported 20:37:20 INFO - Return code: 0 20:37:20 INFO - Running post-action listener: _resource_record_post_action 20:37:20 INFO - [mozharness: 2017-02-24 04:37:20.628811Z] Finished run-tests step (success) 20:37:20 INFO - Running post-run listener: _resource_record_post_run 20:37:20 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 39240704; Write bytes: 499877888; Read time: 378; Write time: 1703 20:37:20 INFO - TinderboxPrint: CPU usage
53.6% 20:37:20 INFO - TinderboxPrint: I/O read bytes / time
39,240,704 / 378 20:37:20 INFO - TinderboxPrint: I/O write bytes / time
499,877,888 / 1,703 20:37:20 INFO - TinderboxPrint: CPU idle
2,228.9 (46.4%) 20:37:20 INFO - TinderboxPrint: CPU system
965.5 (20.1%) 20:37:20 INFO - TinderboxPrint: CPU user
1,611.3 (33.5%) 20:37:20 INFO - TinderboxPrint: Swap in / out
231,063,552 / 0 20:37:20 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 185666048; Write bytes: 178008064; Read time: 16879; Write time: 320 20:37:20 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 37450752; Write bytes: 306415616; Read time: 360; Write time: 1334 20:37:21 INFO - Running post-run listener: _upload_blobber_files 20:37:21 INFO - Blob upload gear active. 20:37:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:37:21 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 20:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:37:21 INFO - (blobuploader) - INFO - Open directory for files ... 20:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:37:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:22 INFO - (blobuploader) - INFO - Done attempting. 20:37:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:37:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:23 INFO - (blobuploader) - INFO - Done attempting. 20:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:37:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:25 INFO - (blobuploader) - INFO - Done attempting. 20:37:25 INFO - (blobuploader) - INFO - Iteration through files over. 20:37:25 INFO - Return code: 0 20:37:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:37:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:37:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34f0d5287112120b9b02c98ade32f4d5a8f42036f0c968cc910d641d2d99bb2692bc63cba1c0d6b2964fc284063920074c7aee5280831048041d3b68d84b82fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/471a38bf73b05ceb1ee52bf01b7ed4bea0cbddcae2f1ee04894b3ddffd6e8db67f81b7e414098cb741eebe2c7e4aec836c20c4036f8f07cad9f4cfe765347036", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d5a2292504376c6a00461be8a601e26bde4f877216bf592c17a990193ab207fef0ec48374c9bc55105e29f11da83e357d432d7f0d0fa6c027c58310f54baaa2"} 20:37:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:37:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:37:25 INFO - Contents: 20:37:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34f0d5287112120b9b02c98ade32f4d5a8f42036f0c968cc910d641d2d99bb2692bc63cba1c0d6b2964fc284063920074c7aee5280831048041d3b68d84b82fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/471a38bf73b05ceb1ee52bf01b7ed4bea0cbddcae2f1ee04894b3ddffd6e8db67f81b7e414098cb741eebe2c7e4aec836c20c4036f8f07cad9f4cfe765347036", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d5a2292504376c6a00461be8a601e26bde4f877216bf592c17a990193ab207fef0ec48374c9bc55105e29f11da83e357d432d7f0d0fa6c027c58310f54baaa2"} 20:37:25 INFO - Running post-run listener: copy_logs_to_upload_dir 20:37:25 INFO - Copying logs to upload dir... 20:37:25 INFO - mkdir: /builds/slave/test/build/upload/logs 20:37:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.696312 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-23 20:37:25.910815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 20:37:25.914156) ========= 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.gyWI91P66N/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.fYIGcKc4wi/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34f0d5287112120b9b02c98ade32f4d5a8f42036f0c968cc910d641d2d99bb2692bc63cba1c0d6b2964fc284063920074c7aee5280831048041d3b68d84b82fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/471a38bf73b05ceb1ee52bf01b7ed4bea0cbddcae2f1ee04894b3ddffd6e8db67f81b7e414098cb741eebe2c7e4aec836c20c4036f8f07cad9f4cfe765347036", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d5a2292504376c6a00461be8a601e26bde4f877216bf592c17a990193ab207fef0ec48374c9bc55105e29f11da83e357d432d7f0d0fa6c027c58310f54baaa2"} build_url:https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/dxUPhstYRqeIpSJoYmlQvw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34f0d5287112120b9b02c98ade32f4d5a8f42036f0c968cc910d641d2d99bb2692bc63cba1c0d6b2964fc284063920074c7aee5280831048041d3b68d84b82fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/471a38bf73b05ceb1ee52bf01b7ed4bea0cbddcae2f1ee04894b3ddffd6e8db67f81b7e414098cb741eebe2c7e4aec836c20c4036f8f07cad9f4cfe765347036", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d5a2292504376c6a00461be8a601e26bde4f877216bf592c17a990193ab207fef0ec48374c9bc55105e29f11da83e357d432d7f0d0fa6c027c58310f54baaa2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 20:37:25.948350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:37:25.948698) ========= 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.gyWI91P66N/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.fYIGcKc4wi/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.004990 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:37:25.997432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 20:37:25.997921) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 20:37:25.998491) ========= ========= Total master_lag: 0.17 =========