builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1480647113.28 results: success (0) buildid: 20161201170644 builduid: 41172c6345c747998e97069a64103ae8 revision: 2dad401646555866725cde37f72299234d71032b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:53.282907) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:53.283406) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:53.283709) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:53.311740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:53.312161) ========= 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.819BZZlrov/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.xBLMZLOEER/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-01 18:51:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.6M=0.001s 2016-12-01 18:51:53 (20.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129937 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:53.465997) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:53.466324) ========= 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.819BZZlrov/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.xBLMZLOEER/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.029220 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:53.516856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:53.517226) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 2dad401646555866725cde37f72299234d71032b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 2dad401646555866725cde37f72299234d71032b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.819BZZlrov/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.xBLMZLOEER/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-01 18:51:53,609 truncating revision to first 12 chars 2016-12-01 18:51:53,609 Setting DEBUG logging. 2016-12-01 18:51:53,610 attempt 1/10 2016-12-01 18:51:53,610 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/2dad40164655?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 18:51:53,934 unpacking tar archive at: graphics-2dad40164655/testing/mozharness/ program finished with exit code 0 elapsedTime=0.595776 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:54.136405) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:54.136717) ========= script_repo_revision: 2dad401646555866725cde37f72299234d71032b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:54.137141) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:54.137414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 18:51:54.157938) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-01 18:51:54.158305) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.819BZZlrov/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.xBLMZLOEER/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 18:51:54 INFO - MultiFileLogger online at 20161201 18:51:54 in /builds/slave/test 18:51:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 18:51:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:51:54 INFO - {'append_to_log': False, 18:51:54 INFO - 'base_work_dir': '/builds/slave/test', 18:51:54 INFO - 'blob_upload_branch': 'Graphics', 18:51:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:51:54 INFO - 'branch': 'Graphics', 18:51:54 INFO - 'buildbot_json_path': 'buildprops.json', 18:51:54 INFO - 'config_files': ('talos/mac_config.py',), 18:51:54 INFO - 'default_actions': ('clobber', 18:51:54 INFO - 'read-buildbot-config', 18:51:54 INFO - 'download-and-extract', 18:51:54 INFO - 'populate-webroot', 18:51:54 INFO - 'create-virtualenv', 18:51:54 INFO - 'install', 18:51:54 INFO - 'run-tests'), 18:51:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:51:54 INFO - 'download_minidump_stackwalk': True, 18:51:54 INFO - 'download_symbols': 'ondemand', 18:51:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:51:54 INFO - 'tooltool.py': '/tools/tooltool.py', 18:51:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:51:54 INFO - '/tools/misc-python/virtualenv.py')}, 18:51:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:51:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:51:54 INFO - 'installer_path': 'installer.exe', 18:51:54 INFO - 'log_level': 'info', 18:51:54 INFO - 'log_name': 'talos', 18:51:54 INFO - 'log_to_console': True, 18:51:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:51:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:51:54 INFO - 'opt_config_files': (), 18:51:54 INFO - 'pip_index': False, 18:51:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:51:54 INFO - 'cmd': ('bash', 18:51:54 INFO - '-c', 18:51:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:51:54 INFO - 'enabled': True, 18:51:54 INFO - 'halt_on_failure': False, 18:51:54 INFO - 'name': 'check_screen_resolution'},), 18:51:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:51:54 INFO - 'cmd': ('bash', 18:51:54 INFO - '-c', 18:51:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:51:54 INFO - 'enabled': True, 18:51:54 INFO - 'halt_on_failure': False, 18:51:54 INFO - 'name': 'check_screen_resolution'},), 18:51:54 INFO - 'run_cmd_checks_enabled': True, 18:51:54 INFO - 'sps_profile': False, 18:51:54 INFO - 'sps_profile_interval': 0, 18:51:54 INFO - 'suite': 'dromaeojs', 18:51:54 INFO - 'system_bits': '32', 18:51:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:51:54 INFO - 'title': 't-yosemite-r7-0032', 18:51:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:51:54 INFO - 'use_talos_json': True, 18:51:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:51:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:51:54 INFO - 'work_dir': 'build'} 18:51:54 INFO - [mozharness: 2016-12-02 02:51:54.362415Z] Running clobber step. 18:51:54 INFO - Running pre-action listener: _resource_record_pre_action 18:51:54 INFO - Running main action method: clobber 18:51:54 INFO - rmtree: /builds/slave/test/build 18:51:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:51:55 INFO - Running post-action listener: _resource_record_post_action 18:51:55 INFO - [mozharness: 2016-12-02 02:51:55.786964Z] Finished clobber step (success) 18:51:55 INFO - [mozharness: 2016-12-02 02:51:55.787087Z] Running read-buildbot-config step. 18:51:55 INFO - Running pre-action listener: _resource_record_pre_action 18:51:55 INFO - Running main action method: read_buildbot_config 18:51:55 INFO - Using buildbot properties: 18:51:55 INFO - { 18:51:55 INFO - "project": "", 18:51:55 INFO - "product": "firefox", 18:51:55 INFO - "script_repo_revision": "default", 18:51:55 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 18:51:55 INFO - "repository": "", 18:51:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 18:51:55 INFO - "buildid": "20161201170644", 18:51:55 INFO - "pgo_build": "False", 18:51:55 INFO - "basedir": "/builds/slave/test", 18:51:55 INFO - "buildnumber": 8, 18:51:55 INFO - "slavename": "t-yosemite-r7-0032", 18:51:55 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:51:55 INFO - "platform": "yosemite_r7", 18:51:55 INFO - "scheduler": "tests-graphics-macosx64-talos", 18:51:55 INFO - "branch": "graphics", 18:51:55 INFO - "repo_path": "projects/graphics", 18:51:55 INFO - "revision": "2dad401646555866725cde37f72299234d71032b", 18:51:55 INFO - "stage_platform": "macosx64", 18:51:55 INFO - "builduid": "41172c6345c747998e97069a64103ae8", 18:51:55 INFO - "slavebuilddir": "test" 18:51:55 INFO - } 18:51:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 18:51:55 INFO - Running post-action listener: _resource_record_post_action 18:51:55 INFO - [mozharness: 2016-12-02 02:51:55.790294Z] Finished read-buildbot-config step (success) 18:51:55 INFO - [mozharness: 2016-12-02 02:51:55.790399Z] Running download-and-extract step. 18:51:55 INFO - Running pre-action listener: _resource_record_pre_action 18:51:55 INFO - Running main action method: download_and_extract 18:51:55 INFO - mkdir: /builds/slave/test/build/tests 18:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:55 INFO - trying https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 18:51:55 INFO - Downloading https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:51:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 18:51:56 INFO - Downloaded 1199 bytes. 18:51:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:51:56 INFO - Using the following test package requirements: 18:51:56 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:51:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:51:56 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 18:51:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:51:56 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 18:51:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:51:56 INFO - u'jsshell-mac.zip'], 18:51:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:51:56 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 18:51:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:51:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:51:56 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 18:51:56 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:51:56 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 18:51:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:51:56 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 18:51:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:51:56 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 18:51:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:51:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:51:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:51:56 INFO - Fetch https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:51:57 INFO - Http code: 200 18:51:57 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 18:51:57 INFO - x-amz-cf-id: 1U2z7fTPuhpj6REXOhbnl8Q3gRjpWJepNAViK23HvNxJ0eaoTnoIow== 18:51:57 INFO - x-amz-version-id: xDSCF2Yr4XZ9RSCI.ep4bf._Jh4YakKx 18:51:57 INFO - Expected file size: 16282503 18:51:57 INFO - Obtained file size: 16282503 18:52:04 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:52:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:52:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:52:04 INFO - Fetch https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:52:04 INFO - Http code: 200 18:52:04 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 18:52:04 INFO - x-amz-cf-id: qKIcifAx1jeJiPxanWe-d1SMtZ9xvruYjgdhflNTiYBUpsj_rK6m4g== 18:52:04 INFO - x-amz-version-id: xDSCF2Yr4XZ9RSCI.ep4bf._Jh4YakKx 18:52:05 INFO - Expected file size: 16282503 18:52:05 INFO - Obtained file size: 16282503 18:52:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 18:52:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:52:11 INFO - Fetch https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 18:52:12 INFO - Http code: 200 18:52:12 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 18:52:12 INFO - x-amz-cf-id: 9O_oNrqPq6lMWcEUGvct7Teoo1P8sjU19gGPAdGyN17NaggYd1U2Bw== 18:52:12 INFO - x-amz-version-id: vy1XRRL.EfpWUTYhsjfbof6F6RBs_WML 18:52:12 INFO - Expected file size: 14409702 18:52:12 INFO - Obtained file size: 14409702 18:52:12 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')]} 18:52:12 INFO - trying https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:52:12 INFO - Downloading https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 18:52:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 18:52:15 INFO - Downloaded 107604437 bytes. 18:52:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:52:15 INFO - mkdir: /builds/slave/test/properties 18:52:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:52:15 INFO - Writing to file /builds/slave/test/properties/build_url 18:52:15 INFO - Contents: 18:52:15 INFO - build_url:https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:52:16 INFO - Running post-action listener: _resource_record_post_action 18:52:16 INFO - Running post-action listener: set_extra_try_arguments 18:52:16 INFO - [mozharness: 2016-12-02 02:52:16.450528Z] Finished download-and-extract step (success) 18:52:16 INFO - [mozharness: 2016-12-02 02:52:16.450657Z] Running populate-webroot step. 18:52:16 INFO - Running pre-action listener: _resource_record_pre_action 18:52:16 INFO - Running main action method: populate_webroot 18:52:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:52:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:52:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:52:16 INFO - '--tppagecycles', 18:52:16 INFO - '7'], 18:52:16 INFO - 'tests': ['tsvgm']}}, 18:52:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:52:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:52:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:52:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:52:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:52:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:52:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:52:16 INFO - 'talos_options': ['--disable-e10s'], 18:52:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:52:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:52:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:52:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:52:16 INFO - 'talos_options': ['--disable-e10s'], 18:52:16 INFO - 'tests': ['damp', 'tps']}, 18:52:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:52:16 INFO - 'tests': ['damp', 'tps']}, 18:52:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:52:16 INFO - 'tests': ['dromaeo_dom']}, 18:52:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:52:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:52:16 INFO - 'tests': ['basic_compositor_video']}, 18:52:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:52:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:52:16 INFO - 'tests': ['a11yr', 18:52:16 INFO - 'ts_paint', 18:52:16 INFO - 'tpaint', 18:52:16 INFO - 'sessionrestore', 18:52:16 INFO - 'sessionrestore_no_auto_restore', 18:52:16 INFO - 'tabpaint']}, 18:52:16 INFO - 'other-e10s': {'tests': ['a11yr', 18:52:16 INFO - 'ts_paint', 18:52:16 INFO - 'tpaint', 18:52:16 INFO - 'sessionrestore', 18:52:16 INFO - 'sessionrestore_no_auto_restore', 18:52:16 INFO - 'tabpaint']}, 18:52:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:52:16 INFO - 'ts_paint', 18:52:16 INFO - 'tpaint', 18:52:16 INFO - 'sessionrestore', 18:52:16 INFO - 'sessionrestore_no_auto_restore', 18:52:16 INFO - 'tabpaint']}, 18:52:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:52:16 INFO - 'ts_paint', 18:52:16 INFO - 'tpaint', 18:52:16 INFO - 'sessionrestore', 18:52:16 INFO - 'sessionrestore_no_auto_restore', 18:52:16 INFO - 'tabpaint']}, 18:52:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:52:16 INFO - 'tests': ['a11yr', 18:52:16 INFO - 'ts_paint', 18:52:16 INFO - 'tpaint', 18:52:16 INFO - 'sessionrestore', 18:52:16 INFO - 'sessionrestore_no_auto_restore', 18:52:16 INFO - 'tabpaint']}, 18:52:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:52:16 INFO - 'tests': ['a11yr', 18:52:16 INFO - 'ts_paint', 18:52:16 INFO - 'tpaint', 18:52:16 INFO - 'sessionrestore', 18:52:16 INFO - 'sessionrestore_no_auto_restore', 18:52:16 INFO - 'tabpaint']}, 18:52:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:52:16 INFO - 'tests': ['tsvgx', 18:52:16 INFO - 'tsvgr_opacity', 18:52:16 INFO - 'tart', 18:52:16 INFO - 'tscrollx', 18:52:16 INFO - 'cart', 18:52:16 INFO - 'tsvg_static']}, 18:52:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:52:16 INFO - 'tsvgr_opacity', 18:52:16 INFO - 'tart', 18:52:16 INFO - 'tscrollx', 18:52:16 INFO - 'cart', 18:52:16 INFO - 'tsvg_static']}, 18:52:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:52:16 INFO - 'talos_options': ['--disable-e10s'], 18:52:16 INFO - 'tests': ['tp5o']}, 18:52:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:52:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:52:16 INFO - 'talos_options': ['--disable-e10s', 18:52:16 INFO - '--xperf_path', 18:52:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:52:16 INFO - 'tests': ['tp5n']}, 18:52:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:52:16 INFO - 'talos_options': ['--xperf_path', 18:52:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:52:16 INFO - 'tests': ['tp5n']}}, 18:52:16 INFO - 'talos.zip': {'path': '', 18:52:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:52:16 INFO - Running post-action listener: _resource_record_post_action 18:52:16 INFO - [mozharness: 2016-12-02 02:52:16.468894Z] Finished populate-webroot step (success) 18:52:16 INFO - [mozharness: 2016-12-02 02:52:16.468991Z] Running create-virtualenv step. 18:52:16 INFO - Running pre-action listener: _resource_record_pre_action 18:52:16 INFO - Running main action method: create_virtualenv 18:52:16 INFO - Creating virtualenv /builds/slave/test/build/venv 18:52:16 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 18:52:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:52:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:52:16 INFO - Using real prefix '/tools/python27' 18:52:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:52:17 INFO - Installing distribute.............................................................................................................................................................................................done. 18:52:20 INFO - Installing pip.................done. 18:52:20 INFO - Return code: 0 18:52:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:52:20 INFO - Reading from file tmpfile_stdout 18:52:20 INFO - Output received: 18:52:20 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) 18:52:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:52:20 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')]} 18:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:20 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')]} 18:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:20 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 0x1079f53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda1d99980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780bd30>, '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 0x107672db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107803b20>, '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.819BZZlrov/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.xBLMZLOEER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 18:52:20 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 18:52:20 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 18:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.819BZZlrov/Render', 18:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:20 INFO - 'HOME': '/Users/cltbld', 18:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:20 INFO - 'LOGNAME': 'cltbld', 18:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:20 INFO - 'MOZ_NO_REMOTE': '1', 18:52:20 INFO - 'NO_EM_RESTART': '1', 18:52:20 INFO - 'PAGER': '/bin/cat', 18:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:20 INFO - 'PWD': '/builds/slave/test', 18:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:20 INFO - 'SHELL': '/bin/bash', 18:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBLMZLOEER/Listeners', 18:52:20 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 18:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:20 INFO - 'USER': 'cltbld', 18:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:20 INFO - 'XPC_FLAGS': '0x0', 18:52:20 INFO - 'XPC_SERVICE_NAME': '0', 18:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:20 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 18:52:20 INFO - Cleaning up... 18:52:20 INFO - Return code: 0 18:52:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:52:20 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')]} 18:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:20 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')]} 18:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:20 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 0x1079f53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda1d99980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780bd30>, '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 0x107672db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107803b20>, '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.819BZZlrov/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.xBLMZLOEER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 18:52:20 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 18:52:20 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 18:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.819BZZlrov/Render', 18:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:20 INFO - 'HOME': '/Users/cltbld', 18:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:20 INFO - 'LOGNAME': 'cltbld', 18:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:20 INFO - 'MOZ_NO_REMOTE': '1', 18:52:20 INFO - 'NO_EM_RESTART': '1', 18:52:20 INFO - 'PAGER': '/bin/cat', 18:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:20 INFO - 'PWD': '/builds/slave/test', 18:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:20 INFO - 'SHELL': '/bin/bash', 18:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBLMZLOEER/Listeners', 18:52:20 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 18:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:20 INFO - 'USER': 'cltbld', 18:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:20 INFO - 'XPC_FLAGS': '0x0', 18:52:20 INFO - 'XPC_SERVICE_NAME': '0', 18:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:21 INFO - Downloading/unpacking psutil>=3.1.1 18:52:21 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 18:52:21 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 18:52:21 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 18:52:21 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 18:52:21 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 18:52:21 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 18:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:52:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:52:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:52:24 INFO - Installing collected packages: psutil 18:52:24 INFO - Running setup.py install for psutil 18:52:24 INFO - building 'psutil._psutil_osx' extension 18:52:24 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 18:52:25 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 18:52:25 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 18:52:25 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 18:52:25 INFO - building 'psutil._psutil_posix' extension 18:52:25 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 18:52:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:52:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:52:25 INFO - ^ 18:52:25 INFO - 1 warning generated. 18:52:25 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 18:52:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:52:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:52:25 INFO - Successfully installed psutil 18:52:25 INFO - Cleaning up... 18:52:25 INFO - Return code: 0 18:52:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:52:25 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')]} 18:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:25 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')]} 18:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:25 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 0x1079f53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda1d99980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780bd30>, '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 0x107672db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107803b20>, '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.819BZZlrov/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.xBLMZLOEER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 18:52:25 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 18:52:25 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 18:52:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.819BZZlrov/Render', 18:52:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:25 INFO - 'HOME': '/Users/cltbld', 18:52:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:25 INFO - 'LOGNAME': 'cltbld', 18:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:25 INFO - 'MOZ_NO_REMOTE': '1', 18:52:25 INFO - 'NO_EM_RESTART': '1', 18:52:25 INFO - 'PAGER': '/bin/cat', 18:52:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:25 INFO - 'PWD': '/builds/slave/test', 18:52:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:25 INFO - 'SHELL': '/bin/bash', 18:52:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBLMZLOEER/Listeners', 18:52:25 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 18:52:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:25 INFO - 'USER': 'cltbld', 18:52:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:25 INFO - 'XPC_FLAGS': '0x0', 18:52:25 INFO - 'XPC_SERVICE_NAME': '0', 18:52:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:52:28 INFO - Installing collected packages: mozsystemmonitor 18:52:28 INFO - Running setup.py install for mozsystemmonitor 18:52:28 INFO - Successfully installed mozsystemmonitor 18:52:28 INFO - Cleaning up... 18:52:28 INFO - Return code: 0 18:52:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:52:28 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')]} 18:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:28 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')]} 18:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:28 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 0x1079f53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda1d99980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780bd30>, '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 0x107672db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107803b20>, '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.819BZZlrov/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.xBLMZLOEER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 18:52:28 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 18:52:28 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 18:52:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.819BZZlrov/Render', 18:52:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:28 INFO - 'HOME': '/Users/cltbld', 18:52:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:28 INFO - 'LOGNAME': 'cltbld', 18:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:28 INFO - 'MOZ_NO_REMOTE': '1', 18:52:28 INFO - 'NO_EM_RESTART': '1', 18:52:28 INFO - 'PAGER': '/bin/cat', 18:52:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:28 INFO - 'PWD': '/builds/slave/test', 18:52:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:28 INFO - 'SHELL': '/bin/bash', 18:52:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBLMZLOEER/Listeners', 18:52:28 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 18:52:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:28 INFO - 'USER': 'cltbld', 18:52:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:28 INFO - 'XPC_FLAGS': '0x0', 18:52:28 INFO - 'XPC_SERVICE_NAME': '0', 18:52:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:29 INFO - Downloading/unpacking jsonschema==2.5.1 18:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:52:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:32 INFO - Downloading functools32-3.2.3-2.tar.gz 18:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:52:32 INFO - warning: no files found matching '*.txt' 18:52:32 INFO - no previously-included directories found matching 'build' 18:52:32 INFO - no previously-included directories found matching 'dist' 18:52:32 INFO - no previously-included directories found matching '.git*' 18:52:32 INFO - Installing collected packages: jsonschema, functools32 18:52:32 INFO - Running setup.py install for functools32 18:52:32 INFO - warning: no files found matching '*.txt' 18:52:32 INFO - no previously-included directories found matching 'build' 18:52:32 INFO - no previously-included directories found matching 'dist' 18:52:32 INFO - no previously-included directories found matching '.git*' 18:52:32 INFO - Successfully installed jsonschema functools32 18:52:32 INFO - Cleaning up... 18:52:32 INFO - Return code: 0 18:52:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1079f53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda1d99980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780bd30>, '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 0x107672db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107803b20>, '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.819BZZlrov/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.xBLMZLOEER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 18:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:52:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.819BZZlrov/Render', 18:52:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:32 INFO - 'HOME': '/Users/cltbld', 18:52:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:32 INFO - 'LOGNAME': 'cltbld', 18:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:32 INFO - 'MOZ_NO_REMOTE': '1', 18:52:32 INFO - 'NO_EM_RESTART': '1', 18:52:32 INFO - 'PAGER': '/bin/cat', 18:52:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:32 INFO - 'PWD': '/builds/slave/test', 18:52:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:32 INFO - 'SHELL': '/bin/bash', 18:52:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBLMZLOEER/Listeners', 18:52:32 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 18:52:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:32 INFO - 'USER': 'cltbld', 18:52:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:32 INFO - 'XPC_FLAGS': '0x0', 18:52:32 INFO - 'XPC_SERVICE_NAME': '0', 18:52:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:52:32 INFO - Cleaning up... 18:52:32 INFO - Return code: 0 18:52:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1079f53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda1d99980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780bd30>, '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 0x107672db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107803b20>, '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.819BZZlrov/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.xBLMZLOEER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 18:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:52:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.819BZZlrov/Render', 18:52:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:32 INFO - 'HOME': '/Users/cltbld', 18:52:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:32 INFO - 'LOGNAME': 'cltbld', 18:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:32 INFO - 'MOZ_NO_REMOTE': '1', 18:52:32 INFO - 'NO_EM_RESTART': '1', 18:52:32 INFO - 'PAGER': '/bin/cat', 18:52:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:32 INFO - 'PWD': '/builds/slave/test', 18:52:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:32 INFO - 'SHELL': '/bin/bash', 18:52:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBLMZLOEER/Listeners', 18:52:32 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 18:52:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:32 INFO - 'USER': 'cltbld', 18:52:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:32 INFO - 'XPC_FLAGS': '0x0', 18:52:32 INFO - 'XPC_SERVICE_NAME': '0', 18:52:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:33 INFO - Downloading/unpacking blobuploader==1.2.4 18:52:33 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 18:52:33 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 18:52:33 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 18:52:33 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 18:52:33 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 18:52:33 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 18:52:35 INFO - Downloading blobuploader-1.2.4.tar.gz 18:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:52:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:52:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:36 INFO - Downloading docopt-0.6.1.tar.gz 18:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:52:37 INFO - Installing collected packages: blobuploader, requests, docopt 18:52:37 INFO - Running setup.py install for blobuploader 18:52:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:52:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:52:37 INFO - Running setup.py install for requests 18:52:37 INFO - Running setup.py install for docopt 18:52:37 INFO - Successfully installed blobuploader requests docopt 18:52:37 INFO - Cleaning up... 18:52:37 INFO - Return code: 0 18:52:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:37 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 0x1079f53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda1d99980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780bd30>, '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 0x107672db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107803b20>, '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.819BZZlrov/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.xBLMZLOEER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 18:52:37 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 18:52:37 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 18:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.819BZZlrov/Render', 18:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:37 INFO - 'HOME': '/Users/cltbld', 18:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:37 INFO - 'LOGNAME': 'cltbld', 18:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:37 INFO - 'MOZ_NO_REMOTE': '1', 18:52:37 INFO - 'NO_EM_RESTART': '1', 18:52:37 INFO - 'PAGER': '/bin/cat', 18:52:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:37 INFO - 'PWD': '/builds/slave/test', 18:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:37 INFO - 'SHELL': '/bin/bash', 18:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBLMZLOEER/Listeners', 18:52:37 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 18:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:37 INFO - 'USER': 'cltbld', 18:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:37 INFO - 'XPC_FLAGS': '0x0', 18:52:37 INFO - 'XPC_SERVICE_NAME': '0', 18:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:52:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-a1ofjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:52:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-uihIP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:52:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-j1quGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:52:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-APlzWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:52:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-qdJF2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:52:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-DM6Wtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:52:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-sqwSvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:52:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-X_NHmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:52:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-c4TIhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:52:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-iJbFAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:52:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-foZn_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:52:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ResgnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:52:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-gGZ4zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:52:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6sUbIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-SQBYsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:52:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-xX71kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:52:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-J98lkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:52:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:52:40 INFO - Running setup.py install for manifestparser 18:52:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Running setup.py install for mozcrash 18:52:40 INFO - Running setup.py install for mozdebug 18:52:40 INFO - Running setup.py install for mozdevice 18:52:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Running setup.py install for mozfile 18:52:40 INFO - Running setup.py install for mozhttpd 18:52:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Running setup.py install for mozinfo 18:52:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:52:41 INFO - Running setup.py install for mozInstall 18:52:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:52:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:52:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:52:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:52:41 INFO - Running setup.py install for mozleak 18:52:41 INFO - Running setup.py install for mozlog 18:52:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:52:41 INFO - Running setup.py install for moznetwork 18:52:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:52:41 INFO - Running setup.py install for mozprocess 18:52:41 INFO - Running setup.py install for mozprofile 18:52:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:52:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:52:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:52:41 INFO - Running setup.py install for mozrunner 18:52:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:52:42 INFO - Running setup.py install for mozscreenshot 18:52:42 INFO - Running setup.py install for moztest 18:52:42 INFO - Running setup.py install for mozversion 18:52:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:52:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:52:42 INFO - Cleaning up... 18:52:42 INFO - Return code: 0 18:52:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x1079f53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda1d99980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780bd30>, '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 0x107672db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107803b20>, '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.819BZZlrov/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.xBLMZLOEER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 18:52:42 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 18:52:42 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 18:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.819BZZlrov/Render', 18:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:42 INFO - 'HOME': '/Users/cltbld', 18:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:42 INFO - 'LOGNAME': 'cltbld', 18:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:42 INFO - 'MOZ_NO_REMOTE': '1', 18:52:42 INFO - 'NO_EM_RESTART': '1', 18:52:42 INFO - 'PAGER': '/bin/cat', 18:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:42 INFO - 'PWD': '/builds/slave/test', 18:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:42 INFO - 'SHELL': '/bin/bash', 18:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBLMZLOEER/Listeners', 18:52:42 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 18:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:42 INFO - 'USER': 'cltbld', 18:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:42 INFO - 'XPC_FLAGS': '0x0', 18:52:42 INFO - 'XPC_SERVICE_NAME': '0', 18:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:52:42 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-zjk4MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:52:43 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)) 18:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:52:43 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-3oXPoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:52:43 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)) 18:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:52:43 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-y3dNu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:52:43 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)) 18:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:52:43 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-qc7Z_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:52:43 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-NxJf2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:52:43 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)) 18:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:52:43 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-wLX3rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:52:43 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)) 18:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:52:43 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-xBItGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:52:43 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)) 18:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:52:43 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-FbGnHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:52:43 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)) 18:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:52:43 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-8fyuAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:52:43 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)) 18:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:52:43 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-HouoHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:52:43 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)) 18:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:52:43 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-rjt9TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:52:44 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)) 18:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:52:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-1WRVTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:52:44 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)) 18:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:52:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-YUk84C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:52:44 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)) 18:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:52:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-GgUH1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:52:44 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)) 18:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-5eCAas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:44 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)) 18:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:52:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-zMH4h0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:52:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-H56W0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:52:44 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)) 18:52:44 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)) 18:52:44 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)) 18:52:44 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)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:47 INFO - Downloading blessings-1.6.tar.gz 18:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:52:47 INFO - Installing collected packages: blessings 18:52:47 INFO - Running setup.py install for blessings 18:52:47 INFO - Successfully installed blessings 18:52:47 INFO - Cleaning up... 18:52:47 INFO - Return code: 0 18:52:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:52:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:52:47 INFO - Reading from file tmpfile_stdout 18:52:47 INFO - Current package versions: 18:52:47 INFO - blessings == 1.6 18:52:47 INFO - blobuploader == 1.2.4 18:52:47 INFO - docopt == 0.6.1 18:52:47 INFO - functools32 == 3.2.3-2 18:52:47 INFO - jsonschema == 2.5.1 18:52:47 INFO - manifestparser == 1.1 18:52:47 INFO - mozInstall == 1.12 18:52:47 INFO - mozcrash == 1.0 18:52:47 INFO - mozdebug == 0.1 18:52:47 INFO - mozdevice == 0.49 18:52:47 INFO - mozfile == 1.2 18:52:47 INFO - mozhttpd == 0.7 18:52:47 INFO - mozinfo == 0.9 18:52:47 INFO - mozleak == 0.1 18:52:47 INFO - mozlog == 3.4 18:52:47 INFO - moznetwork == 0.27 18:52:47 INFO - mozprocess == 0.23 18:52:47 INFO - mozprofile == 0.28 18:52:47 INFO - mozrunner == 6.13 18:52:47 INFO - mozscreenshot == 0.1 18:52:47 INFO - mozsystemmonitor == 0.3 18:52:47 INFO - moztest == 0.7 18:52:47 INFO - mozversion == 1.4 18:52:47 INFO - psutil == 3.1.1 18:52:47 INFO - requests == 1.2.3 18:52:47 INFO - wsgiref == 0.1.2 18:52:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:47 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 0x1079f53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda1d99980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780bd30>, '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 0x107672db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107803b20>, '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.819BZZlrov/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.xBLMZLOEER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 18:52:47 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 18:52:47 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 18:52:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.819BZZlrov/Render', 18:52:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:47 INFO - 'HOME': '/Users/cltbld', 18:52:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:47 INFO - 'LOGNAME': 'cltbld', 18:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:47 INFO - 'MOZ_NO_REMOTE': '1', 18:52:47 INFO - 'NO_EM_RESTART': '1', 18:52:47 INFO - 'PAGER': '/bin/cat', 18:52:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:47 INFO - 'PWD': '/builds/slave/test', 18:52:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:47 INFO - 'SHELL': '/bin/bash', 18:52:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBLMZLOEER/Listeners', 18:52:47 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 18:52:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:47 INFO - 'USER': 'cltbld', 18:52:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:47 INFO - 'XPC_FLAGS': '0x0', 18:52:47 INFO - 'XPC_SERVICE_NAME': '0', 18:52:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:48 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)) 18:52:48 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)) 18:52:48 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)) 18:52:48 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)) 18:52:48 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)) 18:52:48 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)) 18:52:48 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)) 18:52:48 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)) 18:52:48 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)) 18:52:48 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)) 18:52:48 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)) 18:52:48 INFO - Cleaning up... 18:52:48 INFO - Return code: 0 18:52:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:52:48 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')]} 18:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:48 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')]} 18:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:48 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 0x1079f53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda1d99980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780bd30>, '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 0x107672db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107803b20>, '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.819BZZlrov/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.xBLMZLOEER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 18:52:48 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 18:52:48 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 18:52:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.819BZZlrov/Render', 18:52:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:48 INFO - 'HOME': '/Users/cltbld', 18:52:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:48 INFO - 'LOGNAME': 'cltbld', 18:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:48 INFO - 'MOZ_NO_REMOTE': '1', 18:52:48 INFO - 'NO_EM_RESTART': '1', 18:52:48 INFO - 'PAGER': '/bin/cat', 18:52:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:48 INFO - 'PWD': '/builds/slave/test', 18:52:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:48 INFO - 'SHELL': '/bin/bash', 18:52:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBLMZLOEER/Listeners', 18:52:48 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 18:52:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:48 INFO - 'USER': 'cltbld', 18:52:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:48 INFO - 'XPC_FLAGS': '0x0', 18:52:48 INFO - 'XPC_SERVICE_NAME': '0', 18:52:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:52:48 INFO - Cleaning up... 18:52:48 INFO - Return code: 0 18:52:48 INFO - Running post-action listener: _resource_record_post_action 18:52:48 INFO - Running post-action listener: _start_resource_monitoring 18:52:48 INFO - Starting resource monitoring. 18:52:48 INFO - [mozharness: 2016-12-02 02:52:48.488544Z] Finished create-virtualenv step (success) 18:52:48 INFO - [mozharness: 2016-12-02 02:52:48.489585Z] Running install step. 18:52:48 INFO - Running pre-action listener: _resource_record_pre_action 18:52:48 INFO - Running main action method: install 18:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:52:48 INFO - Reading from file tmpfile_stdout 18:52:48 INFO - Detecting whether we're running mozinstall >=1.0... 18:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:52:48 INFO - Reading from file tmpfile_stdout 18:52:48 INFO - Output received: 18:52:48 INFO - Usage: mozinstall [options] installer 18:52:48 INFO - Options: 18:52:48 INFO - -h, --help show this help message and exit 18:52:48 INFO - -d DEST, --destination=DEST 18:52:48 INFO - Directory to install application into. [default: 18:52:48 INFO - "/builds/slave/test"] 18:52:48 INFO - --app=APP Application being installed. [default: firefox] 18:52:48 INFO - mkdir: /builds/slave/test/build/application 18:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:53:21 INFO - Reading from file tmpfile_stdout 18:53:21 INFO - Output received: 18:53:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:53:21 INFO - Running post-action listener: _resource_record_post_action 18:53:21 INFO - [mozharness: 2016-12-02 02:53:21.904050Z] Finished install step (success) 18:53:21 INFO - [mozharness: 2016-12-02 02:53:21.904181Z] Running run-tests step. 18:53:21 INFO - Running pre-action listener: _resource_record_pre_action 18:53:21 INFO - Running main action method: run_tests 18:53:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:53:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:53:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:53:21 INFO - 2016-12-01 18:53:21.918 screenresolution[1624:7293] starting screenresolution argv=screenresolution get 18:53:21 INFO - 2016-12-01 18:53:21.921 screenresolution[1624:7293] Display 0: 1600x1200x32@60 18:53:21 INFO - 2016-12-01 18:53:21.927 screenresolution[1625:7295] starting screenresolution argv=screenresolution list 18:53:21 INFO - Available Modes on Display 0 18:53:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:53:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:53:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:53:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:53:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:53:22 INFO - Intel Iris: 18:53:22 INFO - Chipset Model: Intel Iris 18:53:22 INFO - Type: GPU 18:53:22 INFO - Bus: Built-In 18:53:22 INFO - VRAM (Dynamic, Max): 1536 MB 18:53:22 INFO - Vendor: Intel (0x8086) 18:53:22 INFO - Device ID: 0x0a2e 18:53:22 INFO - Revision ID: 0x0009 18:53:22 INFO - Displays: 18:53:22 INFO - Display: 18:53:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:53:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:53:22 INFO - Display Serial Number: 1600x1200 60 18:53:22 INFO - Main Display: Yes 18:53:22 INFO - Mirror: Off 18:53:22 INFO - Online: Yes 18:53:22 INFO - Rotation: Supported 18:53:22 INFO - Return code: 0 18:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:53:22 INFO - Python 2.7.3 18:53:22 INFO - Return code: 0 18:53:22 INFO - grabbing minidump binary from tooltool 18:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780bd30>, '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 0x107672db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107803b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:53:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:53:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:53:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:53:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:53:22 INFO - Return code: 0 18:53:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:53:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:53:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:53:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:53:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 18:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --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 18:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.819BZZlrov/Render', 18:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:53:22 INFO - 'HOME': '/Users/cltbld', 18:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:53:22 INFO - 'LOGNAME': 'cltbld', 18:53:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:53:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:22 INFO - 'MOZ_NO_REMOTE': '1', 18:53:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:53:22 INFO - 'NO_EM_RESTART': '1', 18:53:22 INFO - 'PAGER': '/bin/cat', 18:53:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:22 INFO - 'PWD': '/builds/slave/test', 18:53:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:53:22 INFO - 'SHELL': '/bin/bash', 18:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBLMZLOEER/Listeners', 18:53:22 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 18:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:53:22 INFO - 'USER': 'cltbld', 18:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:22 INFO - 'XPC_FLAGS': '0x0', 18:53:22 INFO - 'XPC_SERVICE_NAME': '0', 18:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:53:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 18:53:22 INFO - mozversion application_buildid: 20161201170644 18:53:22 INFO - mozversion application_changeset: 2dad401646555866725cde37f72299234d71032b 18:53:22 INFO - mozversion application_display_name: Nightly 18:53:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:53:22 INFO - mozversion application_name: Firefox 18:53:22 INFO - mozversion application_remotingname: firefox 18:53:22 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 18:53:22 INFO - mozversion application_vendor: Mozilla 18:53:22 INFO - mozversion application_version: 53.0a1 18:53:22 INFO - mozversion platform_buildid: 20161201170644 18:53:22 INFO - mozversion platform_changeset: 2dad401646555866725cde37f72299234d71032b 18:53:22 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 18:53:22 INFO - mozversion platform_version: 53.0a1 18:53:22 INFO - using testdate: 1480647202 18:53:22 INFO - actual date: 1480647202 18:53:22 INFO - starting webserver on 'localhost:49236' 18:53:22 INFO - SUITE-START | Running 2 tests 18:53:22 INFO - TEST-START | dromaeo_css 18:53:22 INFO - operating with platform_type : mac_ 18:53:22 INFO - Initialising browser for dromaeo_css test... 18:53:22 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpqooSrA/profile http://localhost:49236/getInfo.html) 18:53:25 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 18:53:25 INFO - PROCESS | 1635 | colorDepth:24 18:53:25 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 18:53:25 INFO - PROCESS | 1635 | __metrics 18:53:25 INFO - PROCESS | 1635 | 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" 18:53:25 INFO - PROCESS | 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:53:26 INFO - TEST-INFO | 1635: exit 0 18:53:26 INFO - Browser initialized. 18:53:26 INFO - Running cycle 1/1 for dromaeo_css test... 18:53:26 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpqooSrA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:53:38 INFO - PROCESS | 1637 | RSS: Main: 243990528 18:53:38 INFO - PROCESS | 1637 | 18:54:29 INFO - PROCESS | 1637 | 1480647269317 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:56:44 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 18:56:46 INFO - PROCESS | 1637 | RSS: Main: 437866496 18:56:46 INFO - PROCESS | 1637 | 18:59:49 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 18:59:50 INFO - PROCESS | 1637 | RSS: Main: 377548800 18:59:50 INFO - PROCESS | 1637 | 19:02:52 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 19:02:53 INFO - PROCESS | 1637 | RSS: Main: 365633536 19:02:53 INFO - PROCESS | 1637 | 19:05:55 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 19:05:56 INFO - PROCESS | 1637 | RSS: Main: 365805568 19:05:56 INFO - PROCESS | 1637 | 19:08:59 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 19:09:00 INFO - PROCESS | 1637 | RSS: Main: 341499904 19:09:00 INFO - PROCESS | 1637 | 19:12:04 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 19:12:04 INFO - PROCESS | 1637 | RSS: Main: 378269696 19:12:04 INFO - PROCESS | 1637 | 19:12:04 INFO - PROCESS | 1637 | __start_tp_report 19:12:04 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 19:12:04 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 19:12:04 INFO - PROCESS | 1637 | |i|pagename|runs| 19:12:04 INFO - PROCESS | 1637 | |0;dojo.html;3312.1554003729048;3316.054924346561;3336.683015113565;3339.2653616204443;3412.3857705612995;5536.252605898202;5550.389457159714;5593.972030139844;5674.063779476387;5675.744591493377;4679.415073115861;5598.384177740456;5613.158026296048;5689.658620482774;5699.145128230767;5112.616553758483;5128.153854614003;5161.922571161435;5165.612579056567;5197.558207552363;5038.244263360489;5242.501962313574;5255.921161182585;5272.340957380327;5302.125149350352;4391.670624703144;5065.594752419797;5229.869253268699;5238.292830467876;5319.946800532003;5138.075146473633;5181.5077567631015;5182.352205974254;5183.118869792144;5188.325517682715;5087.56755675768;5127.743612819344;5147.22791581262;5156.845294641167;5166.04428180784;5600.551955843523;5614.214010038598;5621.578381621354;5628.099504079369;5652.858678533028;6079.848003799896;6092.72582733778;6094.573379863411;6095.786647467317;6099.69501524922;5422.864428389283;6121.969390153021;6135.398101970447;6136.838005452737;6160.907586386208;5623.662580245198;5703.515201207861;5706.686132262683;5729.713514324267;5732.455416735404;6306.306306306303;6320.209973753281;6320.841978950563;6321.146645202931;6326.367363263636;5810.970945145247;5836.06622940336;5849.385814489502;5952.375000624958;5966;5359.732013399393;5903.435589568768;6098.8923736551815;6101.065651476929;6112.41229444207;4966.279889416014;6052.54605904559;6054.848628784315;6060.060690592965;6069.180660610849;6071.51427885768;6072.362401947732;6090.269167699816;6099.207103076572;6103.35914728956;4323.351497275371;4723.291506274018;4771.355866957916;4816.964352664194;4837;3639.6724294813594;4254.617084462351;4273.9358909616385;4392.956070439254;4402.119576084796;5582.665040097526;5666.716664166775;5683.062294721407;5685.829425117253;5686.346070201897;6197.442230199304;6197.96901015492;6222.066689996536;6225.439710426083;6235.844103897439;4811.711297322172;5396.001739678172;5602.607817452739;5631.380548139701;5647.124695672095;5340.732963351817;5346.946530534723;5350.6254562180275;5364.597655175878;5399.541039011649;6317.368263173646;6323.810285691437;6334.778282760081;6343.333949935375;6343.746250149942;6047.455728984412;6051.273847138372;6080.0575910733905;6222.253329600477;6246.312905580292;6260.7495700171485;6264.655443950626;6302.621842689453;6325.240971083499;6330.905036424365;6141.385861413823;6151.630902145886;6163.537734669828;6164.969175154096;6168.982117950488;5963.91054134197;6203.658798766111;6211.844703882439;6242.375762423721;6253.249610046823;5144.331236939174;5853.2976042875125;5930.881382372415;5934.9109763354445;5940.524758019262;5796.188533605215;5865.384134665798;5954.612950158225;5996.220491336098;6001.4298641628975;4783.497732738151;5785.6817875015595;5799.449052340021;5800.332961709289;5800.6809625471005;5941.881162376815;5948.10778383246;5955.791547295998;5968.701564921824;5971.373005834499;5652.123920792284;5726.0838265877255;5732.054211055296;5787.131930210502;5791.8552036199435 19:12:04 INFO - PROCESS | 1637 | |1;ext.html;453.19783982351237;493.79507504385657;495.3609843302138;518.776925921854;529.1401472607013;20230.797692023076;31574.842125789368;38451.03872403191;39419.40870886939;39479.21041579174;40823.979400515;41042.794786026025;41156.38265426021;41189.58810411895;41226.793866030705;9073.909260907389;9302.441853488812;9313.534323283842;9317.39436936597;9318.161365477106;8378.329733621296;8597.441166324168;10914.290571112891;11170.720731981684;11185.776284474307;11117.888821111766;11119.221654484189;11191.66425007251;11194.496247668834;11207.495662695199;11028.5037173327;11042;11100.278481898731;11104.888951110466;11125.388103654295;8306.916930830675;8527.360447966428;10728.678139655824;11048.944755276172;11053.889461105366;37763.81118094392;38493.42259866104;38903.80548097241;38919.41620875689;39135.41296880549;3222.5649537312634;3248.415285248654;3299.307145499448;3379.307242015381;3525.3301872644115;22662;29287.12138635823;29711.662975166168;29776.10671679853;29939;3186.7291280241207;3196.6643502432375;3257.1042963185077;3304.0583433721513;3311.6357200707903;455131;464841;471639.64180179226;471925;473040.6347968273;57609;57974.42025579775;58081.70959145177;58244.4175558239;58260.4173958255;60324.09513857296;60522.394776052555;60531;60624.39375606276;60650.78698426007;15399.384024639114;15644.765328520081;15653.98249113804;15689.68620627581;15726.606834829221;12022.278663280056;12098.81851772224;12107.757844843054;12113.878861211451;12130.332831694164;12881;14284.42862285497;14510.854891451161;15759.29083191259;15992.36030558788;5333.413324534298;6023.819285421444;6054.51563874889;6065.636061836216;6077.453029227302;838.1827717974926;953.1993125774383;1002.1972777617658;1023.0025724918294;1072.0780129088978;21788.782112178676;27805.443891122064;28871.85564072166;29154.868383597714;29558.261043473656;983.7442265011149;1007.66243308491;1048.5334026358198;1069.390447444949;1081.8918108189118;14506.637334066732;15070.321835517429;15170.696586068218;15209.771853422208;15345.539633811004;184453;185279;185680;186640.06679966784;611475;55061.62345941384;55196.17205741917;55319.72340138273;55327;55451.89096218053;1309.1425116548676;1345.4281930179634;1363.0799210532653;1363.1889026029496;1365.5903229031449;25957.831897565033;28058.01796937179;28868.71131288744;29307.560386594643;29630.85184574063;49408.75295623499;49802.00395992133;49935;49952;49956;444728;451925;452171;453138;454395;31688.20779480439;37897.831238564286;39127.413088804264;39131.80434097811;39221.803890980365;43892;44411.777941110086;45377.54622453865;45434.77282613566;45723.856903577675;36403.90788276356;37251.254974899806;37646.54539683795;38031;38238;36503.63496365002;36506.634933650326;37845;37979.62020379761;38029.429558557196;35909.56361745501;36085.91742247737;36776;37371.25257494889;37382.439263411616;31829;33375.98976245635;33514.329713406085;33537.66462335443;33728.49407258844;23708.407289817893;24209.515809683355;24391.26826195217;24558;25266.36834079163 19:12:04 INFO - PROCESS | 1637 | |2;jquery.html;305.31304564729356;346.6481521255924;363.99636003639955;366.19254543731074;396.3539430727915;14927;15468.767968480468;17128.22922968468;20142.798572014275;20182.89908550459;16604.83395166051;18632.34786782463;20151.49621259469;20179.991000449954;20200.38396928246;5655.773769049243;5952.166696662471;5962.463378295953;5968.492678122365;5978.940210597882;3634.67287944085;4061.959380406188;6257.342978987209;6505.544611877147;6606.603603783764;5656.519195868356;6608.207015158164;6615.437687796543;6619.569727967667;6638.302978187269;5846.707664616773;6034.909476357858;6036.426539478743;6040.335563088057;6045;5037.521435463662;5303.4166241713765;5361.758720857571;5798.681072541009;5828.154917536934;12800.359982000862;13034.283114428703;13082.280474573894;14672.779908301383;24422.877885610458;2156.741191057083;2168.7421295648487;2258.48054947363;2368.4078980254935;2611.569091099966;9386.718398448058;10172.186225102048;12223.899849013631;12949.417276222594;13599.844013258886;1757.6045389787323;1798.9370372036915;1810.9405997491483;1827.6892928202237;1900.429871038683;103781.48109259405;108214;111499;118616;118906;9161.541922903829;9371.203447706885;11141.16441266892;11233.32600044;11606.30362178272;14149.575512734635;14211.64470888236;14399.352029158714;14422.42310307597;14424.783628245585;7954.721584744506;8255.298299644477;8262.215089566482;8373.706920257762;8380.413371064089;8029.357651387992;8038.758837234892;8060.234277743605;8194;8230.588470576447;4425.159219748238;4425.822967081345;4446.911061778746;4450.132224216247;4600.148972440043;1528.7171873203492;1847.3349594146366;1878.8684792064698;1887.7357169996212;1914.4161030885714;747.8429529798804;831.8003679116969;864.1444969480169;882.3029806452959;938.2494004796135;20300.157977883107;20965.895170524356;20975.580488390147;20976.685349719766;20998.895005524875;829.8381815546031;878.5870640798942;906.207068814787;912.6030176873081;938.7230766923774;10398.480075996169;10436.060754532129;10647.030299394637;11025.944870275598;11046.944765276283;537853;543460;546703;552554;556845;119935;125771.3711431437;127050.24448235927;127236;129394.35302823425;993.513178542509;994.1053052252886;1002.4887307473241;1010.8028934357877;1057.03281497429;17740.46778596644;18053.187606558;18311.191666500963;18330.450086497425;18340.174692139153;52227;52317.47682523126;52387.47612523979;53788.73105634447;54278;74440;74958.62520687362;75449;75840.62079689566;77553;7486.92513074884;7768.689252430066;7835.921640783519;7989.680412783424;8107.216412389265;11819.82270265964;12311.569095081988;12589.370531473207;12727.490900363882;12916.547920822726;8727.46903398033;10834;10952.233343665866;11028.062614677521;11035.724106897393;10173.338732982333;10583.100436462986;10583.788324233317;11000.944995274973;11065.557377705123;10954.945225273823;11191.265353870163;11411.54353825871;11536.711582210512;11565.363904985306;6653.201615806134;6893.655317234218;7272.636368181676;7401.370883474965;8227.218414250636;9258.518637018045;10667.410503036022;10992.780144397228;11008.936407883035;11184.328940263611 19:12:04 INFO - PROCESS | 1637 | |3;mootools.html;1309.6725818545365;1361.5302720561403;1453.2080016391067;1488.9106653600784;1824.8905065696051;7337.449691273149;7690.269424404687;7761.107472640648;8160.224778646019;8161;8034.5982700865015;8143.185681431869;8147.9592602037055;8154;8162.142974987615;2011.8289945354588;2274.442761523429;2303.6890019847274;2312.8034117099983;2313.005407674699;2061.3506745375234;2250.6736523204127;2328.045501344449;2335.8481698689616;2339.099446713019;2251.020805949409;2257.9774202258013;2261.570301642683;2262.8981695823727;2268.6937263469385;2249.640057590786;2273.2043784675398;2276.647119696433;2283.828712846543;2286.1541229745017;2260.683504309398;2261.2311813983324;2290.3701482092556;2297.276357947258;2297.7587353327995;8176.713815016446;8281.503109813431;8282.792930176733;8291.005079390512;8296.087430382653;4985.277134815467;5106.974465127651;5127.564157046656;5135.974320128413;5161.793528258865;3278.7213086887405;3483.512308276843;3561.1809283864854;3565.982170089133;3566.0906468850276;993.9552720127612;1050.8143062430127;1054.0987455725399;1083.2579682917226;1086.190787863047;10311.639092631796;10750;10758.892411075945;10763.784724305548;10782.5686972521;4285.164392943346;4422.624076953431;4457.687961842705;4459.375687403766;4465.620422264144;8584.098669639723;8606.26846718036;8609.397342186112;8610.052894181636;8626.964764228207;5053.0904437200925;5055.393352797614;5061.620378471629;5064.341635587423;5066.898662026739;4003.459532963013;4206.453161089039;4368.060866913629;4721.527847215251;4752.239641657318;3359.3449277390673;3577.713782897362;3600.5499312585926;3659.835307411173;3676.7793932364143;1109.8501702270091;1115.7378016166194;1118.8937050980144;1130.1580322659672;1133.3596517967321;715.1620335737106;852.5864955496579;861.6251930410166;909.8444974881863;915.7802127489488;5237;5254.816081437131;5605.1872478491205;5620.269364982608;5689.544836413077;809.4333966223667;861.9525926074001;886.609891647673;888.29824438694;889.5996801439378;3330.400527904952;3611.8555257789394;3753.6246375362794;3778.414345776409;3847.8076096195077;9147.301546043933;9924.652637157666;10084.2436817239;10088.848667269996;10113.797724045478;9826.459544724965;10004.399736015863;10042.297039207186;10058.59765609382;10070.44612546317;7563.584002879895;7832.0601527817025;7833.33416659579;7842.176571460029;7843.843123137505;4858.757062146808;5327.815595605783;5423.647462914898;5468.562514998711;5478.890422191614;7058.61177635235;7722.806929826799;8969.744235806862;9403.529823508934;9406.200472959876;9322.254219662547;9331.626734930527;9468.242540596599;9486.573104210189;9586.520673966133;6206.596571222856;6568;6670.533062685759;6784.864302714017;6791.626460544718;7288.416926645749;7497.137829149718;7561.2060733622175;7780.3386712130105;7828.686852525835;6905.654717264217;6963.547369420971;6981.232064473005;7035.542689725152;7145.785626431215;6896.655167241517;6929.1684997800585;6937.410320122644;6980.511364204457;6987.650617469208;6559.376859198369;6572.4084832365315;6578.703958321983;6635.535512514078;6645.966770166118;3975.4831871856472;4735.218688916428;4739.099571081483;4743.454502732092;4906.386701662293;4805.3512775774825;4822.855314340435;4833.540813622701;4839.370881785346;4857.101436234308 19:12:04 INFO - PROCESS | 1637 | |4;prototype.html;293.7488447377494;296.7981772394771;303.83176685643707;309.8667572943636;310.18112183834666;5131.666441681293;5191.922121168185;5211.348581427322;5223.738813059342;5226.5034821691925;3887.1448281378052;4907.607391408687;4948.331975183349;5016.6488345815715;5063.772130254139;3358.4794356874722;3728.6084961079105;3741.644543768338;3836.8897106591403;3946.4672269243715;3926.8429262829595;3960.3663413853787;3966.9801650991703;3986.9068738912015;3998.52017757868;3150.1494596458942;3396.5414669019615;3437.9170561273245;3610.476480910266;3729.9067523311865;3961.6830653547936;3973.821178046966;3976.2445135424177;3977.144913843523;4015.9598404016024;2844.5733140028956;2876.4822331980236;3441.82790860456;3447.7414193935306;3448.413769659164;4990.30135780991;4992.400911890596;4998.225275082368;5024.723640199788;5071.7971281149075;3689.538807649044;4219.831206751726;4273.508546517128;4481.439820022497;4509.1883460977015;5381.5425688816495;5393.6763794172475;5397;5410.594205434608;5420.590646431917;3778.678812300958;3780.640839120279;3784.375578029622;3790.5830358660523;3800.2969450651717;5392.892142157174;5573.247611572467;5598;5604.243427137325;5619.01050254324;3231.61040752474;3809.1619843634357;3812.866549670748;3832.291026160169;3853.9979605302265;3417.1376599753194;3857.6528112470014;3871.6709079727975;3871.787051712183;3886.980565097213;4242.787860607019;4467.927697352612;4475.70907890986;4487.003283538859;4498.5501449854755;4559.794809233593;5348.3849357323625;5416.345990464644;5424.321959755031;5464.349790351676;1086.342762628614;1204.6626944455566;1263.7788387032417;1268.752593244327;1270.0665011216747;825.19131251374;834.3783881008687;836.1930736838858;842.5003493781079;876.9123087691307;4152.522459917088;4771.854754858879;4924.267031797387;4933;4947.381577302837;5303.602229832701;5308.92036619451;5346.4386239445075;5351.384590772111;5378.623496355218;3901.7121457946773;4490.9221786771595;4620.653450991189;4790.401199850019;4850.611951043908;2753.9586906196423;2778.360976975307;2786.9442611147665;2788.8187267827525;2789.8186617869774;4449.063618012096;4623.815047398067;5141.460146684619;5206.964602433069;5256.842294731164;4529.773511324421;5314.123169677037;5332.053800362917;5745.3105627324985;5765.077587585966;4545.931811022837;5080.5681517070725;5821.970890145607;5824.388439213991;5904.468597826216;4667.603253723471;5291.470852914677;5615.382307946041;5642.971785141048;5687.744051517609;4722.598579120813;5018.949810501995;5315.335583052119;5512.09050506678;5577.163425486209;5770.538356931519;5775.996481829509;5776.42235776419;5795.652260864362;5837.328707198557;3584.7849129052343;3693.0795986087624;3706.184639379332;3754.6245375462236;3761.8933397296505;4779.944623811794;5503.257060296969;5529.428815600765;5560.888782224414;5614.63504872182;4402.405675233803;5025.5477007068075;5172.663776854643;5348.8767358855075;5488.945110548843;4352.891177720582;5102.43873173958;5421.749973760845;5440.347158341025;5453.15476101205;4609.344561992345;5037.042961837239;5137.5889928806355;5392.406835248198;5394.676319420847;4870.878228044327;5006.674566153189;5326.813561525328;5434.538064264581;5462.235287059894;5345.679259244303;5347.759350829144;5359.705216213146;5399;5407.242985982044 19:12:04 INFO - PROCESS | 1637 | |5;yui.html;679.6567733294686;680.8808458519758;695.6626036372359;734.6179986407066;765.0933643632294;14536.491222807204;15012.924935375335;15366.769498457505;15434.305456254468;15456.536303910887;10743.677689669303;12622.116451848351;12678.746425071493;12752.55366062188;12784.744305113893;651.205529254309;673.3434900971563;809.2595275323087;812.1878121878121;836.0844874862047;839.6011894350165;839.6221700234888;840.474703310431;841.5539763925129;841.7390608911257;890.0832142892831;890.7238755985666;891.558678454166;892.7009451833643;894.5616647842543;686.5262968551708;707.2114592229627;711.0933559711358;716.7813816785879;881.8368601808686;526.6076772804247;634.2832599162916;642.1812189458432;654.1953397321274;661.6063442251852;14340.139591624536;14378;14379.71240575193;14383.496577619837;14408.63978400538;13141.408636611375;13151.802722959163;13258.668533286746;13309.267990260532;13461.326933653376;12206.389680515938;12212.57255996036;12416.875831241752;12590.37048147598;12736.80894786579;4148.7303325284065;4255.893602659928;4311.611954924072;4384.693071484998;4461.732296062214;110905.44547277293;112261;115865.84134158635;115869;116045;10649.627263045757;10670.57317707283;10756.946215268874;10774.784504310026;10959.12327013837;19553.902230488755;20234.392968210977;20800;20899.582008359746;20961.58076838485;7208.098987626547;7238.384737297283;7383.07711536058;7384.2246564111065;7603.4297427693145;3490.0053484756722;4079.571644977294;4181.916361672749;4217;4227.492700875853;3304.5704058472243;3376.1728376547903;3400.9659903401143;3411.403004474207;3414.504896790001;608.8143116349468;625.2871726232099;634.0869148426251;637.1971316141695;649.9610023398611;477.88769639134773;576.6107877182885;601.227422761749;605.4671888737882;621.419170979331;7584.810379740551;8001.399895007898;8291.295239904555;8453.154684531497;8645.913540864636;524.6170295684095;575.6172145523263;585.1690599348934;588.3763210996358;599.1402337645493;3618.222082252328;3686.4101743720876;4222.451081359403;4442;4639.536046395334;89921.45746154105;105403;106172;108333;111694;92584;95163.57254641186;97525.04949900962;99581;99806.50096749469;65782;68103.97844032344;88823.55588222017;89607.55196224237;89625.55187224022;9644.95177524108;9815.901840981498;9912.207023437963;10002.44986525748;10063.647772327933;53736.73131634317;54579.454205457434;56309.71845140912;56377.61734295955;57911.420885790605;77357.1982101356;80097;81547.59226204068;81679;82224.76662849942;9791.706248812547;12095.274283543016;13247.271400072703;13305.75250201101;13470.881599865399;12532;14607.342669580106;14888.330025148678;15061.924690376478;15111.54665360041;13753.217865087181;14096.295185240902;14176.291185440481;14224.502142424966;14658.706825863635;13585.320733963064;13996;14146.292685365484;14412.739350137334;14459.78310325367;13153.473861045451;13747.450101995808;13754.243516606282;14184.078034927697;14206.928965355108;9901.950490247502;10932.289401188897;11425.942870285595;11801.974657233164;11818.586349478071;10649.76354965435;11321.830172547254;11572.24780389272;11585.652430426764;11611.709707257387 19:12:04 INFO - PROCESS | 1637 | __end_tp_report 19:12:04 INFO - PROCESS | 1637 | __start_cc_report 19:12:04 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1943 19:12:04 INFO - PROCESS | 1637 | __end_cc_report 19:12:04 INFO - PROCESS | 1637 | __startTimestamp1480648324637__endTimestamp 19:12:04 INFO - PROCESS | 1637 | 19:12:04 INFO - PROCESS | 1637 | ------- Summary: start ------- 19:12:04 INFO - PROCESS | 1637 | Number of tests: 6 19:12:04 INFO - PROCESS | 1637 | 19:12:04 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5612.24 Median:5732.46 stddev:657.96 (11.5%) stddev-sans-first:634.76 19:12:04 INFO - PROCESS | 1637 | Values: 3312.2 3316.1 3336.7 3339.3 3412.4 5536.3 5550.4 5594.0 5674.1 5675.7 4679.4 5598.4 5613.2 5689.7 5699.1 5112.6 5128.2 5161.9 5165.6 5197.6 5038.2 5242.5 5255.9 5272.3 5302.1 4391.7 5065.6 5229.9 5238.3 5319.9 5138.1 5181.5 5182.4 5183.1 5188.3 5087.6 5127.7 5147.2 5156.8 5166.0 5600.6 5614.2 5621.6 5628.1 5652.9 6079.8 6092.7 6094.6 6095.8 6099.7 5422.9 6122.0 6135.4 6136.8 6160.9 5623.7 5703.5 5706.7 5729.7 5732.5 6306.3 6320.2 6320.8 6321.1 6326.4 5811.0 5836.1 5849.4 5952.4 5966.0 5359.7 5903.4 6098.9 6101.1 6112.4 4966.3 6052.5 6054.8 6060.1 6069.2 6071.5 6072.4 6090.3 6099.2 6103.4 4323.4 4723.3 4771.4 4817.0 4837.0 3639.7 4254.6 4273.9 4393.0 4402.1 5582.7 5666.7 5683.1 5685.8 5686.3 6197.4 6198.0 6222.1 6225.4 6235.8 4811.7 5396.0 5602.6 5631.4 5647.1 5340.7 5346.9 5350.6 5364.6 5399.5 6317.4 6323.8 6334.8 6343.3 6343.7 6047.5 6051.3 6080.1 6222.3 6246.3 6260.7 6264.7 6302.6 6325.2 6330.9 6141.4 6151.6 6163.5 6165.0 6169.0 5963.9 6203.7 6211.8 6242.4 6253.2 5144.3 5853.3 5930.9 5934.9 5940.5 5796.2 5865.4 5954.6 5996.2 6001.4 4783.5 5785.7 5799.4 5800.3 5800.7 5941.9 5948.1 5955.8 5968.7 5971.4 5652.1 5726.1 5732.1 5787.1 5791.9 19:12:04 INFO - PROCESS | 1637 | 19:12:04 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:55208.11 Median:35997.74 stddev:111454.55 (309.6%) stddev-sans-first:111691.39 19:12:04 INFO - PROCESS | 1637 | Values: 453.2 493.8 495.4 518.8 529.1 20230.8 31574.8 38451.0 39419.4 39479.2 40824.0 41042.8 41156.4 41189.6 41226.8 9073.9 9302.4 9313.5 9317.4 9318.2 8378.3 8597.4 10914.3 11170.7 11185.8 11117.9 11119.2 11191.7 11194.5 11207.5 11028.5 11042.0 11100.3 11104.9 11125.4 8306.9 8527.4 10728.7 11048.9 11053.9 37763.8 38493.4 38903.8 38919.4 39135.4 3222.6 3248.4 3299.3 3379.3 3525.3 22662.0 29287.1 29711.7 29776.1 29939.0 3186.7 3196.7 3257.1 3304.1 3311.6 455131.0 464841.0 471639.6 471925.0 473040.6 57609.0 57974.4 58081.7 58244.4 58260.4 60324.1 60522.4 60531.0 60624.4 60650.8 15399.4 15644.8 15654.0 15689.7 15726.6 12022.3 12098.8 12107.8 12113.9 12130.3 12881.0 14284.4 14510.9 15759.3 15992.4 5333.4 6023.8 6054.5 6065.6 6077.5 838.2 953.2 1002.2 1023.0 1072.1 21788.8 27805.4 28871.9 29154.9 29558.3 983.7 1007.7 1048.5 1069.4 1081.9 14506.6 15070.3 15170.7 15209.8 15345.5 184453.0 185279.0 185680.0 186640.1 611475.0 55061.6 55196.2 55319.7 55327.0 55451.9 1309.1 1345.4 1363.1 1363.2 1365.6 25957.8 28058.0 28868.7 29307.6 29630.9 49408.8 49802.0 49935.0 49952.0 49956.0 444728.0 451925.0 452171.0 453138.0 454395.0 31688.2 37897.8 39127.4 39131.8 39221.8 43892.0 44411.8 45377.5 45434.8 45723.9 36403.9 37251.3 37646.5 38031.0 38238.0 36503.6 36506.6 37845.0 37979.6 38029.4 35909.6 36085.9 36776.0 37371.3 37382.4 31829.0 33376.0 33514.3 33537.7 33728.5 23708.4 24209.5 24391.3 24558.0 25266.4 19:12:04 INFO - PROCESS | 1637 | 19:12:04 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:32849.52 Median:13395.64 stddev:91741.04 (684.9%) stddev-sans-first:91965.86 19:12:04 INFO - PROCESS | 1637 | Values: 305.3 346.6 364.0 366.2 396.4 14927.0 15468.8 17128.2 20142.8 20182.9 16604.8 18632.3 20151.5 20180.0 20200.4 5655.8 5952.2 5962.5 5968.5 5978.9 3634.7 4062.0 6257.3 6505.5 6606.6 5656.5 6608.2 6615.4 6619.6 6638.3 5846.7 6034.9 6036.4 6040.3 6045.0 5037.5 5303.4 5361.8 5798.7 5828.2 12800.4 13034.3 13082.3 14672.8 24422.9 2156.7 2168.7 2258.5 2368.4 2611.6 9386.7 10172.2 12223.9 12949.4 13599.8 1757.6 1798.9 1810.9 1827.7 1900.4 103781.5 108214.0 111499.0 118616.0 118906.0 9161.5 9371.2 11141.2 11233.3 11606.3 14149.6 14211.6 14399.4 14422.4 14424.8 7954.7 8255.3 8262.2 8373.7 8380.4 8029.4 8038.8 8060.2 8194.0 8230.6 4425.2 4425.8 4446.9 4450.1 4600.1 1528.7 1847.3 1878.9 1887.7 1914.4 747.8 831.8 864.1 882.3 938.2 20300.2 20965.9 20975.6 20976.7 20998.9 829.8 878.6 906.2 912.6 938.7 10398.5 10436.1 10647.0 11025.9 11046.9 537853.0 543460.0 546703.0 552554.0 556845.0 119935.0 125771.4 127050.2 127236.0 129394.4 993.5 994.1 1002.5 1010.8 1057.0 17740.5 18053.2 18311.2 18330.5 18340.2 52227.0 52317.5 52387.5 53788.7 54278.0 74440.0 74958.6 75449.0 75840.6 77553.0 7486.9 7768.7 7835.9 7989.7 8107.2 11819.8 12311.6 12589.4 12727.5 12916.5 8727.5 10834.0 10952.2 11028.1 11035.7 10173.3 10583.1 10583.8 11000.9 11065.6 10954.9 11191.3 11411.5 11536.7 11565.4 6653.2 6893.7 7272.6 7401.4 8227.2 9258.5 10667.4 10992.8 11008.9 11184.3 19:12:04 INFO - PROCESS | 1637 | 19:12:04 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5292.22 Median:5062.98 stddev:2906.36 (57.4%) stddev-sans-first:2899.10 19:12:04 INFO - PROCESS | 1637 | Values: 1309.7 1361.5 1453.2 1488.9 1824.9 7337.4 7690.3 7761.1 8160.2 8161.0 8034.6 8143.2 8148.0 8154.0 8162.1 2011.8 2274.4 2303.7 2312.8 2313.0 2061.4 2250.7 2328.0 2335.8 2339.1 2251.0 2258.0 2261.6 2262.9 2268.7 2249.6 2273.2 2276.6 2283.8 2286.2 2260.7 2261.2 2290.4 2297.3 2297.8 8176.7 8281.5 8282.8 8291.0 8296.1 4985.3 5107.0 5127.6 5136.0 5161.8 3278.7 3483.5 3561.2 3566.0 3566.1 994.0 1050.8 1054.1 1083.3 1086.2 10311.6 10750.0 10758.9 10763.8 10782.6 4285.2 4422.6 4457.7 4459.4 4465.6 8584.1 8606.3 8609.4 8610.1 8627.0 5053.1 5055.4 5061.6 5064.3 5066.9 4003.5 4206.5 4368.1 4721.5 4752.2 3359.3 3577.7 3600.5 3659.8 3676.8 1109.9 1115.7 1118.9 1130.2 1133.4 715.2 852.6 861.6 909.8 915.8 5237.0 5254.8 5605.2 5620.3 5689.5 809.4 862.0 886.6 888.3 889.6 3330.4 3611.9 3753.6 3778.4 3847.8 9147.3 9924.7 10084.2 10088.8 10113.8 9826.5 10004.4 10042.3 10058.6 10070.4 7563.6 7832.1 7833.3 7842.2 7843.8 4858.8 5327.8 5423.6 5468.6 5478.9 7058.6 7722.8 8969.7 9403.5 9406.2 9322.3 9331.6 9468.2 9486.6 9586.5 6206.6 6568.0 6670.5 6784.9 6791.6 7288.4 7497.1 7561.2 7780.3 7828.7 6905.7 6963.5 6981.2 7035.5 7145.8 6896.7 6929.2 6937.4 6980.5 6987.7 6559.4 6572.4 6578.7 6635.5 6646.0 3975.5 4735.2 4739.1 4743.5 4906.4 4805.4 4822.9 4833.5 4839.4 4857.1 19:12:04 INFO - PROCESS | 1637 | 19:12:04 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4344.04 Median:4915.94 stddev:1341.55 (27.3%) stddev-sans-first:1310.41 19:12:04 INFO - PROCESS | 1637 | Values: 293.7 296.8 303.8 309.9 310.2 5131.7 5191.9 5211.3 5223.7 5226.5 3887.1 4907.6 4948.3 5016.6 5063.8 3358.5 3728.6 3741.6 3836.9 3946.5 3926.8 3960.4 3967.0 3986.9 3998.5 3150.1 3396.5 3437.9 3610.5 3729.9 3961.7 3973.8 3976.2 3977.1 4016.0 2844.6 2876.5 3441.8 3447.7 3448.4 4990.3 4992.4 4998.2 5024.7 5071.8 3689.5 4219.8 4273.5 4481.4 4509.2 5381.5 5393.7 5397.0 5410.6 5420.6 3778.7 3780.6 3784.4 3790.6 3800.3 5392.9 5573.2 5598.0 5604.2 5619.0 3231.6 3809.2 3812.9 3832.3 3854.0 3417.1 3857.7 3871.7 3871.8 3887.0 4242.8 4467.9 4475.7 4487.0 4498.6 4559.8 5348.4 5416.3 5424.3 5464.3 1086.3 1204.7 1263.8 1268.8 1270.1 825.2 834.4 836.2 842.5 876.9 4152.5 4771.9 4924.3 4933.0 4947.4 5303.6 5308.9 5346.4 5351.4 5378.6 3901.7 4490.9 4620.7 4790.4 4850.6 2754.0 2778.4 2786.9 2788.8 2789.8 4449.1 4623.8 5141.5 5207.0 5256.8 4529.8 5314.1 5332.1 5745.3 5765.1 4545.9 5080.6 5822.0 5824.4 5904.5 4667.6 5291.5 5615.4 5643.0 5687.7 4722.6 5018.9 5315.3 5512.1 5577.2 5770.5 5776.0 5776.4 5795.7 5837.3 3584.8 3693.1 3706.2 3754.6 3761.9 4779.9 5503.3 5529.4 5560.9 5614.6 4402.4 5025.5 5172.7 5348.9 5488.9 4352.9 5102.4 5421.7 5440.3 5453.2 4609.3 5037.0 5137.6 5392.4 5394.7 4870.9 5006.7 5326.8 5434.5 5462.2 5345.7 5347.8 5359.7 5399.0 5407.2 19:12:04 INFO - PROCESS | 1637 | 19:12:04 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:21391.38 Median:4219.73 stddev:31736.22 (752.1%) stddev-sans-first:31787.15 19:12:04 INFO - PROCESS | 1637 | Values: 679.7 680.9 695.7 734.6 765.1 14536.5 15012.9 15366.8 15434.3 15456.5 10743.7 12622.1 12678.7 12752.6 12784.7 651.2 673.3 809.3 812.2 836.1 839.6 839.6 840.5 841.6 841.7 890.1 890.7 891.6 892.7 894.6 686.5 707.2 711.1 716.8 881.8 526.6 634.3 642.2 654.2 661.6 14340.1 14378.0 14379.7 14383.5 14408.6 13141.4 13151.8 13258.7 13309.3 13461.3 12206.4 12212.6 12416.9 12590.4 12736.8 4148.7 4255.9 4311.6 4384.7 4461.7 110905.4 112261.0 115865.8 115869.0 116045.0 10649.6 10670.6 10756.9 10774.8 10959.1 19553.9 20234.4 20800.0 20899.6 20961.6 7208.1 7238.4 7383.1 7384.2 7603.4 3490.0 4079.6 4181.9 4217.0 4227.5 3304.6 3376.2 3401.0 3411.4 3414.5 608.8 625.3 634.1 637.2 650.0 477.9 576.6 601.2 605.5 621.4 7584.8 8001.4 8291.3 8453.2 8645.9 524.6 575.6 585.2 588.4 599.1 3618.2 3686.4 4222.5 4442.0 4639.5 89921.5 105403.0 106172.0 108333.0 111694.0 92584.0 95163.6 97525.0 99581.0 99806.5 65782.0 68104.0 88823.6 89607.6 89625.6 9645.0 9815.9 9912.2 10002.4 10063.6 53736.7 54579.5 56309.7 56377.6 57911.4 77357.2 80097.0 81547.6 81679.0 82224.8 9791.7 12095.3 13247.3 13305.8 13470.9 12532.0 14607.3 14888.3 15061.9 15111.5 13753.2 14096.3 14176.3 14224.5 14658.7 13585.3 13996.0 14146.3 14412.7 14459.8 13153.5 13747.5 13754.2 14184.1 14206.9 9902.0 10932.3 11425.9 11802.0 11818.6 10649.8 11321.8 11572.2 11585.7 11611.7 19:12:04 INFO - PROCESS | 1637 | -------- Summary: end -------- 19:12:04 INFO - PROCESS | 1637 | 19:12:05 INFO - TEST-INFO | 1637: exit 0 19:12:05 INFO - TEST-OK | dromaeo_css | took 1122765ms 19:12:05 INFO - TEST-START | kraken 19:12:05 INFO - operating with platform_type : mac_ 19:12:05 INFO - Initialising browser for kraken test... 19:12:05 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpDvaCS6/profile http://localhost:49236/getInfo.html) 19:12:07 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 19:12:07 INFO - PROCESS | 1646 | colorDepth:24 19:12:07 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 19:12:07 INFO - PROCESS | 1646 | __metrics 19:12:07 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:12:07 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:12:08 INFO - TEST-INFO | 1646: exit 0 19:12:08 INFO - Browser initialized. 19:12:08 INFO - Running cycle 1/1 for kraken test... 19:12:08 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpDvaCS6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:21 INFO - PROCESS | 1647 | RSS: Main: 244031488 19:12:21 INFO - PROCESS | 1647 | 19:12:24 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 19:12:25 INFO - PROCESS | 1647 | RSS: Main: 296112128 19:12:25 INFO - PROCESS | 1647 | 19:12:27 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 19:12:28 INFO - PROCESS | 1647 | RSS: Main: 296734720 19:12:28 INFO - PROCESS | 1647 | 19:12:31 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 19:12:32 INFO - PROCESS | 1647 | RSS: Main: 389181440 19:12:32 INFO - PROCESS | 1647 | 19:12:34 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 19:12:34 INFO - PROCESS | 1647 | RSS: Main: 291131392 19:12:34 INFO - PROCESS | 1647 | 19:12:36 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:12:37 INFO - PROCESS | 1647 | RSS: Main: 294342656 19:12:37 INFO - PROCESS | 1647 | 19:12:40 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 19:12:40 INFO - PROCESS | 1647 | RSS: Main: 337686528 19:12:40 INFO - PROCESS | 1647 | 19:12:43 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 19:12:44 INFO - PROCESS | 1647 | RSS: Main: 338030592 19:12:44 INFO - PROCESS | 1647 | 19:12:47 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 19:12:47 INFO - PROCESS | 1647 | RSS: Main: 334876672 19:12:47 INFO - PROCESS | 1647 | 19:12:49 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:12:50 INFO - PROCESS | 1647 | RSS: Main: 310943744 19:12:50 INFO - PROCESS | 1647 | 19:12:51 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:12:52 INFO - PROCESS | 1647 | RSS: Main: 314687488 19:12:52 INFO - PROCESS | 1647 | 19:12:54 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:12:55 INFO - PROCESS | 1647 | RSS: Main: 316682240 19:12:55 INFO - PROCESS | 1647 | 19:12:58 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:12:59 INFO - PROCESS | 1647 | RSS: Main: 333635584 19:12:59 INFO - PROCESS | 1647 | 19:13:02 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:13:02 INFO - PROCESS | 1647 | RSS: Main: 327364608 19:13:02 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 19:13:04 INFO - PROCESS | 1647 | RSS: Main: 371232768 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | __start_tp_report 19:13:04 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 19:13:04 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 19:13:04 INFO - PROCESS | 1647 | |i|pagename|runs| 19:13:04 INFO - PROCESS | 1647 | |0;ai-astar;114;115;111;113;113;114;113;114;114;114 19:13:04 INFO - PROCESS | 1647 | |1;audio-beat-detection;142;115;112;150;116;116;112;114;156;141 19:13:04 INFO - PROCESS | 1647 | |2;audio-dft;182;180;184;185;194;230;184;183;183;181 19:13:04 INFO - PROCESS | 1647 | |3;audio-fft;76;59;60;87;61;59;59;59;72;59 19:13:04 INFO - PROCESS | 1647 | |4;audio-oscillator;90;71;87;69;69;69;83;68;71;83 19:13:04 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;87;86;89;86;89;86;88;86;88;85 19:13:04 INFO - PROCESS | 1647 | |6;imaging-darkroom;97;95;95;95;96;94;96;96;96;96 19:13:04 INFO - PROCESS | 1647 | |7;imaging-desaturate;85;85;85;87;85;85;88;91;121;84 19:13:04 INFO - PROCESS | 1647 | |8;json-parse-financial;58;57;56;56;55;56;55;56;56;55 19:13:04 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;65;78;76;73;71;69;69;71;71;71 19:13:04 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;93;107;110;87;89;87;88;88;89;86 19:13:04 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;150;159;136;151;147;148;149;148;198;161 19:13:04 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;177;177;208;195;176;176;175;174;178;176 19:13:04 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;71;70;68;70;69;71;71;95;75;69 19:13:04 INFO - PROCESS | 1647 | __end_tp_report 19:13:04 INFO - PROCESS | 1647 | __start_cc_report 19:13:04 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1966 19:13:04 INFO - PROCESS | 1647 | __end_cc_report 19:13:04 INFO - PROCESS | 1647 | __startTimestamp1480648384906__endTimestamp 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | ------- Summary: start ------- 19:13:04 INFO - PROCESS | 1647 | Number of tests: 14 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.08 (0.9%) stddev-sans-first:1.13 19:13:04 INFO - PROCESS | 1647 | Values: 114.0 115.0 111.0 113.0 113.0 114.0 113.0 114.0 114.0 114.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:128.50 stddev:17.62 (13.7%) stddev-sans-first:17.88 19:13:04 INFO - PROCESS | 1647 | Values: 142.0 115.0 112.0 150.0 116.0 116.0 112.0 114.0 156.0 141.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:188.60 Median:184.00 stddev:15.04 (8.2%) stddev-sans-first:15.76 19:13:04 INFO - PROCESS | 1647 | Values: 182.0 180.0 184.0 185.0 194.0 230.0 184.0 183.0 183.0 181.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:65.10 Median:60.50 stddev:9.86 (16.3%) stddev-sans-first:9.64 19:13:04 INFO - PROCESS | 1647 | Values: 76.0 59.0 60.0 87.0 61.0 59.0 59.0 59.0 72.0 59.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:77.00 stddev:8.67 (11.3%) stddev-sans-first:7.57 19:13:04 INFO - PROCESS | 1647 | Values: 90.0 71.0 87.0 69.0 69.0 69.0 83.0 68.0 71.0 83.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:87.50 stddev:1.41 (1.6%) stddev-sans-first:1.50 19:13:04 INFO - PROCESS | 1647 | Values: 87.0 86.0 89.0 86.0 89.0 86.0 88.0 86.0 88.0 85.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.84 (0.9%) stddev-sans-first:0.73 19:13:04 INFO - PROCESS | 1647 | Values: 97.0 95.0 95.0 95.0 96.0 94.0 96.0 96.0 96.0 96.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:89.60 Median:85.00 stddev:11.23 (13.2%) stddev-sans-first:11.78 19:13:04 INFO - PROCESS | 1647 | Values: 85.0 85.0 85.0 87.0 85.0 85.0 88.0 91.0 121.0 84.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:0.94 (1.7%) stddev-sans-first:0.67 19:13:04 INFO - PROCESS | 1647 | Values: 58.0 57.0 56.0 56.0 55.0 56.0 55.0 56.0 56.0 55.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.00 stddev:3.66 (5.2%) stddev-sans-first:3.06 19:13:04 INFO - PROCESS | 1647 | Values: 65.0 78.0 76.0 73.0 71.0 69.0 69.0 71.0 71.0 71.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:88.00 stddev:8.72 (9.9%) stddev-sans-first:9.25 19:13:04 INFO - PROCESS | 1647 | Values: 93.0 107.0 110.0 87.0 89.0 87.0 88.0 88.0 89.0 86.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:154.70 Median:150.50 stddev:16.67 (11.1%) stddev-sans-first:17.59 19:13:04 INFO - PROCESS | 1647 | Values: 150.0 159.0 136.0 151.0 147.0 148.0 149.0 148.0 198.0 161.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.20 Median:177.00 stddev:11.18 (6.3%) stddev-sans-first:11.76 19:13:04 INFO - PROCESS | 1647 | Values: 177.0 177.0 208.0 195.0 176.0 176.0 175.0 174.0 178.0 176.0 19:13:04 INFO - PROCESS | 1647 | 19:13:04 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:71.00 stddev:7.99 (11.3%) stddev-sans-first:8.45 19:13:04 INFO - PROCESS | 1647 | Values: 71.0 70.0 68.0 70.0 69.0 71.0 71.0 95.0 75.0 69.0 19:13:04 INFO - PROCESS | 1647 | -------- Summary: end -------- 19:13:04 INFO - PROCESS | 1647 | 19:13:05 INFO - TEST-INFO | 1647: exit 0 19:13:06 INFO - TEST-OK | kraken | took 60729ms 19:13:06 INFO - SUITE-END | took 1183s 19:13:06 INFO - Completed test suite (00:19:43) 19:13:06 INFO - javascript benchmark 19:13:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3312.1554003729048, 3316.054924346561, 3336.683015113565, 3339.2653616204443, 3412.3857705612995, 5536.252605898202, 5550.389457159714, 5593.972030139844, 5674.063779476387, 5675.744591493377, 4679.415073115861, 5598.384177740456, 5613.158026296048, 5689.658620482774, 5699.145128230767, 5112.616553758483, 5128.153854614003, 5161.922571161435, 5165.612579056567, 5197.558207552363, 5038.244263360489, 5242.501962313574, 5255.921161182585, 5272.340957380327, 5302.125149350352, 4391.670624703144, 5065.594752419797, 5229.869253268699, 5238.292830467876, 5319.946800532003, 5138.075146473633, 5181.5077567631015, 5182.352205974254, 5183.118869792144, 5188.325517682715, 5087.56755675768, 5127.743612819344, 5147.22791581262, 5156.845294641167, 5166.04428180784, 5600.551955843523, 5614.214010038598, 5621.578381621354, 5628.099504079369, 5652.858678533028, 6079.848003799896, 6092.72582733778, 6094.573379863411, 6095.786647467317, 6099.69501524922, 5422.864428389283, 6121.969390153021, 6135.398101970447, 6136.838005452737, 6160.907586386208, 5623.662580245198, 5703.515201207861, 5706.686132262683, 5729.713514324267, 5732.455416735404, 6306.306306306303, 6320.209973753281, 6320.841978950563, 6321.146645202931, 6326.367363263636, 5810.970945145247, 5836.06622940336, 5849.385814489502, 5952.375000624958, 5966.0, 5359.732013399393, 5903.435589568768, 6098.8923736551815, 6101.065651476929, 6112.41229444207, 4966.279889416014, 6052.54605904559, 6054.848628784315, 6060.060690592965, 6069.180660610849, 6071.51427885768, 6072.362401947732, 6090.269167699816, 6099.207103076572, 6103.35914728956, 4323.351497275371, 4723.291506274018, 4771.355866957916, 4816.964352664194, 4837.0, 3639.6724294813594, 4254.617084462351, 4273.9358909616385, 4392.956070439254, 4402.119576084796, 5582.665040097526, 5666.716664166775, 5683.062294721407, 5685.829425117253, 5686.346070201897, 6197.442230199304, 6197.96901015492, 6222.066689996536, 6225.439710426083, 6235.844103897439, 4811.711297322172, 5396.001739678172, 5602.607817452739, 5631.380548139701, 5647.124695672095, 5340.732963351817, 5346.946530534723, 5350.6254562180275, 5364.597655175878, 5399.541039011649, 6317.368263173646, 6323.810285691437, 6334.778282760081, 6343.333949935375, 6343.746250149942, 6047.455728984412, 6051.273847138372, 6080.0575910733905, 6222.253329600477, 6246.312905580292, 6260.7495700171485, 6264.655443950626, 6302.621842689453, 6325.240971083499, 6330.905036424365, 6141.385861413823, 6151.630902145886, 6163.537734669828, 6164.969175154096, 6168.982117950488, 5963.91054134197, 6203.658798766111, 6211.844703882439, 6242.375762423721, 6253.249610046823, 5144.331236939174, 5853.2976042875125, 5930.881382372415, 5934.9109763354445, 5940.524758019262, 5796.188533605215, 5865.384134665798, 5954.612950158225, 5996.220491336098, 6001.4298641628975, 4783.497732738151, 5785.6817875015595, 5799.449052340021, 5800.332961709289, 5800.6809625471005, 5941.881162376815, 5948.10778383246, 5955.791547295998, 5968.701564921824, 5971.373005834499, 5652.123920792284, 5726.0838265877255, 5732.054211055296, 5787.131930210502, 5791.8552036199435], "value": 5570.772297701584, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.19783982351237, 493.79507504385657, 495.3609843302138, 518.776925921854, 529.1401472607013, 20230.797692023076, 31574.842125789368, 38451.03872403191, 39419.40870886939, 39479.21041579174, 40823.979400515, 41042.794786026025, 41156.38265426021, 41189.58810411895, 41226.793866030705, 9073.909260907389, 9302.441853488812, 9313.534323283842, 9317.39436936597, 9318.161365477106, 8378.329733621296, 8597.441166324168, 10914.290571112891, 11170.720731981684, 11185.776284474307, 11117.888821111766, 11119.221654484189, 11191.66425007251, 11194.496247668834, 11207.495662695199, 11028.5037173327, 11042.0, 11100.278481898731, 11104.888951110466, 11125.388103654295, 8306.916930830675, 8527.360447966428, 10728.678139655824, 11048.944755276172, 11053.889461105366, 37763.81118094392, 38493.42259866104, 38903.80548097241, 38919.41620875689, 39135.41296880549, 3222.5649537312634, 3248.415285248654, 3299.307145499448, 3379.307242015381, 3525.3301872644115, 22662.0, 29287.12138635823, 29711.662975166168, 29776.10671679853, 29939.0, 3186.7291280241207, 3196.6643502432375, 3257.1042963185077, 3304.0583433721513, 3311.6357200707903, 455131.0, 464841.0, 471639.64180179226, 471925.0, 473040.6347968273, 57609.0, 57974.42025579775, 58081.70959145177, 58244.4175558239, 58260.4173958255, 60324.09513857296, 60522.394776052555, 60531.0, 60624.39375606276, 60650.78698426007, 15399.384024639114, 15644.765328520081, 15653.98249113804, 15689.68620627581, 15726.606834829221, 12022.278663280056, 12098.81851772224, 12107.757844843054, 12113.878861211451, 12130.332831694164, 12881.0, 14284.42862285497, 14510.854891451161, 15759.29083191259, 15992.36030558788, 5333.413324534298, 6023.819285421444, 6054.51563874889, 6065.636061836216, 6077.453029227302, 838.1827717974926, 953.1993125774383, 1002.1972777617658, 1023.0025724918294, 1072.0780129088978, 21788.782112178676, 27805.443891122064, 28871.85564072166, 29154.868383597714, 29558.261043473656, 983.7442265011149, 1007.66243308491, 1048.5334026358198, 1069.390447444949, 1081.8918108189118, 14506.637334066732, 15070.321835517429, 15170.696586068218, 15209.771853422208, 15345.539633811004, 184453.0, 185279.0, 185680.0, 186640.06679966784, 611475.0, 55061.62345941384, 55196.17205741917, 55319.72340138273, 55327.0, 55451.89096218053, 1309.1425116548676, 1345.4281930179634, 1363.0799210532653, 1363.1889026029496, 1365.5903229031449, 25957.831897565033, 28058.01796937179, 28868.71131288744, 29307.560386594643, 29630.85184574063, 49408.75295623499, 49802.00395992133, 49935.0, 49952.0, 49956.0, 444728.0, 451925.0, 452171.0, 453138.0, 454395.0, 31688.20779480439, 37897.831238564286, 39127.413088804264, 39131.80434097811, 39221.803890980365, 43892.0, 44411.777941110086, 45377.54622453865, 45434.77282613566, 45723.856903577675, 36403.90788276356, 37251.254974899806, 37646.54539683795, 38031.0, 38238.0, 36503.63496365002, 36506.634933650326, 37845.0, 37979.62020379761, 38029.429558557196, 35909.56361745501, 36085.91742247737, 36776.0, 37371.25257494889, 37382.439263411616, 31829.0, 33375.98976245635, 33514.329713406085, 33537.66462335443, 33728.49407258844, 23708.407289817893, 24209.515809683355, 24391.26826195217, 24558.0, 25266.36834079163], "value": 18937.25921487308, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.31304564729356, 346.6481521255924, 363.99636003639955, 366.19254543731074, 396.3539430727915, 14927.0, 15468.767968480468, 17128.22922968468, 20142.798572014275, 20182.89908550459, 16604.83395166051, 18632.34786782463, 20151.49621259469, 20179.991000449954, 20200.38396928246, 5655.773769049243, 5952.166696662471, 5962.463378295953, 5968.492678122365, 5978.940210597882, 3634.67287944085, 4061.959380406188, 6257.342978987209, 6505.544611877147, 6606.603603783764, 5656.519195868356, 6608.207015158164, 6615.437687796543, 6619.569727967667, 6638.302978187269, 5846.707664616773, 6034.909476357858, 6036.426539478743, 6040.335563088057, 6045.0, 5037.521435463662, 5303.4166241713765, 5361.758720857571, 5798.681072541009, 5828.154917536934, 12800.359982000862, 13034.283114428703, 13082.280474573894, 14672.779908301383, 24422.877885610458, 2156.741191057083, 2168.7421295648487, 2258.48054947363, 2368.4078980254935, 2611.569091099966, 9386.718398448058, 10172.186225102048, 12223.899849013631, 12949.417276222594, 13599.844013258886, 1757.6045389787323, 1798.9370372036915, 1810.9405997491483, 1827.6892928202237, 1900.429871038683, 103781.48109259405, 108214.0, 111499.0, 118616.0, 118906.0, 9161.541922903829, 9371.203447706885, 11141.16441266892, 11233.32600044, 11606.30362178272, 14149.575512734635, 14211.64470888236, 14399.352029158714, 14422.42310307597, 14424.783628245585, 7954.721584744506, 8255.298299644477, 8262.215089566482, 8373.706920257762, 8380.413371064089, 8029.357651387992, 8038.758837234892, 8060.234277743605, 8194.0, 8230.588470576447, 4425.159219748238, 4425.822967081345, 4446.911061778746, 4450.132224216247, 4600.148972440043, 1528.7171873203492, 1847.3349594146366, 1878.8684792064698, 1887.7357169996212, 1914.4161030885714, 747.8429529798804, 831.8003679116969, 864.1444969480169, 882.3029806452959, 938.2494004796135, 20300.157977883107, 20965.895170524356, 20975.580488390147, 20976.685349719766, 20998.895005524875, 829.8381815546031, 878.5870640798942, 906.207068814787, 912.6030176873081, 938.7230766923774, 10398.480075996169, 10436.060754532129, 10647.030299394637, 11025.944870275598, 11046.944765276283, 537853.0, 543460.0, 546703.0, 552554.0, 556845.0, 119935.0, 125771.3711431437, 127050.24448235927, 127236.0, 129394.35302823425, 993.513178542509, 994.1053052252886, 1002.4887307473241, 1010.8028934357877, 1057.03281497429, 17740.46778596644, 18053.187606558, 18311.191666500963, 18330.450086497425, 18340.174692139153, 52227.0, 52317.47682523126, 52387.47612523979, 53788.73105634447, 54278.0, 74440.0, 74958.62520687362, 75449.0, 75840.62079689566, 77553.0, 7486.92513074884, 7768.689252430066, 7835.921640783519, 7989.680412783424, 8107.216412389265, 11819.82270265964, 12311.569095081988, 12589.370531473207, 12727.490900363882, 12916.547920822726, 8727.46903398033, 10834.0, 10952.233343665866, 11028.062614677521, 11035.724106897393, 10173.338732982333, 10583.100436462986, 10583.788324233317, 11000.944995274973, 11065.557377705123, 10954.945225273823, 11191.265353870163, 11411.54353825871, 11536.711582210512, 11565.363904985306, 6653.201615806134, 6893.655317234218, 7272.636368181676, 7401.370883474965, 8227.218414250636, 9258.518637018045, 10667.410503036022, 10992.780144397228, 11008.936407883035, 11184.328940263611], "value": 9186.976209021059, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.6725818545365, 1361.5302720561403, 1453.2080016391067, 1488.9106653600784, 1824.8905065696051, 7337.449691273149, 7690.269424404687, 7761.107472640648, 8160.224778646019, 8161.0, 8034.5982700865015, 8143.185681431869, 8147.9592602037055, 8154.0, 8162.142974987615, 2011.8289945354588, 2274.442761523429, 2303.6890019847274, 2312.8034117099983, 2313.005407674699, 2061.3506745375234, 2250.6736523204127, 2328.045501344449, 2335.8481698689616, 2339.099446713019, 2251.020805949409, 2257.9774202258013, 2261.570301642683, 2262.8981695823727, 2268.6937263469385, 2249.640057590786, 2273.2043784675398, 2276.647119696433, 2283.828712846543, 2286.1541229745017, 2260.683504309398, 2261.2311813983324, 2290.3701482092556, 2297.276357947258, 2297.7587353327995, 8176.713815016446, 8281.503109813431, 8282.792930176733, 8291.005079390512, 8296.087430382653, 4985.277134815467, 5106.974465127651, 5127.564157046656, 5135.974320128413, 5161.793528258865, 3278.7213086887405, 3483.512308276843, 3561.1809283864854, 3565.982170089133, 3566.0906468850276, 993.9552720127612, 1050.8143062430127, 1054.0987455725399, 1083.2579682917226, 1086.190787863047, 10311.639092631796, 10750.0, 10758.892411075945, 10763.784724305548, 10782.5686972521, 4285.164392943346, 4422.624076953431, 4457.687961842705, 4459.375687403766, 4465.620422264144, 8584.098669639723, 8606.26846718036, 8609.397342186112, 8610.052894181636, 8626.964764228207, 5053.0904437200925, 5055.393352797614, 5061.620378471629, 5064.341635587423, 5066.898662026739, 4003.459532963013, 4206.453161089039, 4368.060866913629, 4721.527847215251, 4752.239641657318, 3359.3449277390673, 3577.713782897362, 3600.5499312585926, 3659.835307411173, 3676.7793932364143, 1109.8501702270091, 1115.7378016166194, 1118.8937050980144, 1130.1580322659672, 1133.3596517967321, 715.1620335737106, 852.5864955496579, 861.6251930410166, 909.8444974881863, 915.7802127489488, 5237.0, 5254.816081437131, 5605.1872478491205, 5620.269364982608, 5689.544836413077, 809.4333966223667, 861.9525926074001, 886.609891647673, 888.29824438694, 889.5996801439378, 3330.400527904952, 3611.8555257789394, 3753.6246375362794, 3778.414345776409, 3847.8076096195077, 9147.301546043933, 9924.652637157666, 10084.2436817239, 10088.848667269996, 10113.797724045478, 9826.459544724965, 10004.399736015863, 10042.297039207186, 10058.59765609382, 10070.44612546317, 7563.584002879895, 7832.0601527817025, 7833.33416659579, 7842.176571460029, 7843.843123137505, 4858.757062146808, 5327.815595605783, 5423.647462914898, 5468.562514998711, 5478.890422191614, 7058.61177635235, 7722.806929826799, 8969.744235806862, 9403.529823508934, 9406.200472959876, 9322.254219662547, 9331.626734930527, 9468.242540596599, 9486.573104210189, 9586.520673966133, 6206.596571222856, 6568.0, 6670.533062685759, 6784.864302714017, 6791.626460544718, 7288.416926645749, 7497.137829149718, 7561.2060733622175, 7780.3386712130105, 7828.686852525835, 6905.654717264217, 6963.547369420971, 6981.232064473005, 7035.542689725152, 7145.785626431215, 6896.655167241517, 6929.1684997800585, 6937.410320122644, 6980.511364204457, 6987.650617469208, 6559.376859198369, 6572.4084832365315, 6578.703958321983, 6635.535512514078, 6645.966770166118, 3975.4831871856472, 4735.218688916428, 4739.099571081483, 4743.454502732092, 4906.386701662293, 4805.3512775774825, 4822.855314340435, 4833.540813622701, 4839.370881785346, 4857.101436234308], "value": 4283.573064890953, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.7488447377494, 296.7981772394771, 303.83176685643707, 309.8667572943636, 310.18112183834666, 5131.666441681293, 5191.922121168185, 5211.348581427322, 5223.738813059342, 5226.5034821691925, 3887.1448281378052, 4907.607391408687, 4948.331975183349, 5016.6488345815715, 5063.772130254139, 3358.4794356874722, 3728.6084961079105, 3741.644543768338, 3836.8897106591403, 3946.4672269243715, 3926.8429262829595, 3960.3663413853787, 3966.9801650991703, 3986.9068738912015, 3998.52017757868, 3150.1494596458942, 3396.5414669019615, 3437.9170561273245, 3610.476480910266, 3729.9067523311865, 3961.6830653547936, 3973.821178046966, 3976.2445135424177, 3977.144913843523, 4015.9598404016024, 2844.5733140028956, 2876.4822331980236, 3441.82790860456, 3447.7414193935306, 3448.413769659164, 4990.30135780991, 4992.400911890596, 4998.225275082368, 5024.723640199788, 5071.7971281149075, 3689.538807649044, 4219.831206751726, 4273.508546517128, 4481.439820022497, 4509.1883460977015, 5381.5425688816495, 5393.6763794172475, 5397.0, 5410.594205434608, 5420.590646431917, 3778.678812300958, 3780.640839120279, 3784.375578029622, 3790.5830358660523, 3800.2969450651717, 5392.892142157174, 5573.247611572467, 5598.0, 5604.243427137325, 5619.01050254324, 3231.61040752474, 3809.1619843634357, 3812.866549670748, 3832.291026160169, 3853.9979605302265, 3417.1376599753194, 3857.6528112470014, 3871.6709079727975, 3871.787051712183, 3886.980565097213, 4242.787860607019, 4467.927697352612, 4475.70907890986, 4487.003283538859, 4498.5501449854755, 4559.794809233593, 5348.3849357323625, 5416.345990464644, 5424.321959755031, 5464.349790351676, 1086.342762628614, 1204.6626944455566, 1263.7788387032417, 1268.752593244327, 1270.0665011216747, 825.19131251374, 834.3783881008687, 836.1930736838858, 842.5003493781079, 876.9123087691307, 4152.522459917088, 4771.854754858879, 4924.267031797387, 4933.0, 4947.381577302837, 5303.602229832701, 5308.92036619451, 5346.4386239445075, 5351.384590772111, 5378.623496355218, 3901.7121457946773, 4490.9221786771595, 4620.653450991189, 4790.401199850019, 4850.611951043908, 2753.9586906196423, 2778.360976975307, 2786.9442611147665, 2788.8187267827525, 2789.8186617869774, 4449.063618012096, 4623.815047398067, 5141.460146684619, 5206.964602433069, 5256.842294731164, 4529.773511324421, 5314.123169677037, 5332.053800362917, 5745.3105627324985, 5765.077587585966, 4545.931811022837, 5080.5681517070725, 5821.970890145607, 5824.388439213991, 5904.468597826216, 4667.603253723471, 5291.470852914677, 5615.382307946041, 5642.971785141048, 5687.744051517609, 4722.598579120813, 5018.949810501995, 5315.335583052119, 5512.09050506678, 5577.163425486209, 5770.538356931519, 5775.996481829509, 5776.42235776419, 5795.652260864362, 5837.328707198557, 3584.7849129052343, 3693.0795986087624, 3706.184639379332, 3754.6245375462236, 3761.8933397296505, 4779.944623811794, 5503.257060296969, 5529.428815600765, 5560.888782224414, 5614.63504872182, 4402.405675233803, 5025.5477007068075, 5172.663776854643, 5348.8767358855075, 5488.945110548843, 4352.891177720582, 5102.43873173958, 5421.749973760845, 5440.347158341025, 5453.15476101205, 4609.344561992345, 5037.042961837239, 5137.5889928806355, 5392.406835248198, 5394.676319420847, 4870.878228044327, 5006.674566153189, 5326.813561525328, 5434.538064264581, 5462.235287059894, 5345.679259244303, 5347.759350829144, 5359.705216213146, 5399.0, 5407.242985982044], "value": 3917.2950733679772, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.6567733294686, 680.8808458519758, 695.6626036372359, 734.6179986407066, 765.0933643632294, 14536.491222807204, 15012.924935375335, 15366.769498457505, 15434.305456254468, 15456.536303910887, 10743.677689669303, 12622.116451848351, 12678.746425071493, 12752.55366062188, 12784.744305113893, 651.205529254309, 673.3434900971563, 809.2595275323087, 812.1878121878121, 836.0844874862047, 839.6011894350165, 839.6221700234888, 840.474703310431, 841.5539763925129, 841.7390608911257, 890.0832142892831, 890.7238755985666, 891.558678454166, 892.7009451833643, 894.5616647842543, 686.5262968551708, 707.2114592229627, 711.0933559711358, 716.7813816785879, 881.8368601808686, 526.6076772804247, 634.2832599162916, 642.1812189458432, 654.1953397321274, 661.6063442251852, 14340.139591624536, 14378.0, 14379.71240575193, 14383.496577619837, 14408.63978400538, 13141.408636611375, 13151.802722959163, 13258.668533286746, 13309.267990260532, 13461.326933653376, 12206.389680515938, 12212.57255996036, 12416.875831241752, 12590.37048147598, 12736.80894786579, 4148.7303325284065, 4255.893602659928, 4311.611954924072, 4384.693071484998, 4461.732296062214, 110905.44547277293, 112261.0, 115865.84134158635, 115869.0, 116045.0, 10649.627263045757, 10670.57317707283, 10756.946215268874, 10774.784504310026, 10959.12327013837, 19553.902230488755, 20234.392968210977, 20800.0, 20899.582008359746, 20961.58076838485, 7208.098987626547, 7238.384737297283, 7383.07711536058, 7384.2246564111065, 7603.4297427693145, 3490.0053484756722, 4079.571644977294, 4181.916361672749, 4217.0, 4227.492700875853, 3304.5704058472243, 3376.1728376547903, 3400.9659903401143, 3411.403004474207, 3414.504896790001, 608.8143116349468, 625.2871726232099, 634.0869148426251, 637.1971316141695, 649.9610023398611, 477.88769639134773, 576.6107877182885, 601.227422761749, 605.4671888737882, 621.419170979331, 7584.810379740551, 8001.399895007898, 8291.295239904555, 8453.154684531497, 8645.913540864636, 524.6170295684095, 575.6172145523263, 585.1690599348934, 588.3763210996358, 599.1402337645493, 3618.222082252328, 3686.4101743720876, 4222.451081359403, 4442.0, 4639.536046395334, 89921.45746154105, 105403.0, 106172.0, 108333.0, 111694.0, 92584.0, 95163.57254641186, 97525.04949900962, 99581.0, 99806.50096749469, 65782.0, 68103.97844032344, 88823.55588222017, 89607.55196224237, 89625.55187224022, 9644.95177524108, 9815.901840981498, 9912.207023437963, 10002.44986525748, 10063.647772327933, 53736.73131634317, 54579.454205457434, 56309.71845140912, 56377.61734295955, 57911.420885790605, 77357.1982101356, 80097.0, 81547.59226204068, 81679.0, 82224.76662849942, 9791.706248812547, 12095.274283543016, 13247.271400072703, 13305.75250201101, 13470.881599865399, 12532.0, 14607.342669580106, 14888.330025148678, 15061.924690376478, 15111.54665360041, 13753.217865087181, 14096.295185240902, 14176.291185440481, 14224.502142424966, 14658.706825863635, 13585.320733963064, 13996.0, 14146.292685365484, 14412.739350137334, 14459.78310325367, 13153.473861045451, 13747.450101995808, 13754.243516606282, 14184.078034927697, 14206.928965355108, 9901.950490247502, 10932.289401188897, 11425.942870285595, 11801.974657233164, 11818.586349478071, 10649.76354965435, 11321.830172547254, 11572.24780389272, 11585.652430426764, 11611.709707257387], "value": 7339.233711807556, "unit": "score"}], "name": "dromaeo_css", "value": 7016.966804163684, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 111.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 115.0, 112.0, 150.0, 116.0, 116.0, 112.0, 114.0, 156.0, 141.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 180.0, 184.0, 185.0, 194.0, 230.0, 184.0, 183.0, 183.0, 181.0], "value": 188.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 59.0, 60.0, 87.0, 61.0, 59.0, 59.0, 59.0, 72.0, 59.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 87.0, 69.0, 69.0, 69.0, 83.0, 68.0, 71.0, 83.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 89.0, 86.0, 89.0, 86.0, 88.0, 86.0, 88.0, 85.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 95.0, 96.0, 94.0, 96.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 87.0, 85.0, 85.0, 88.0, 91.0, 121.0, 84.0], "value": 89.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 56.0, 55.0, 56.0, 55.0, 56.0, 56.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 78.0, 76.0, 73.0, 71.0, 69.0, 69.0, 71.0, 71.0, 71.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 107.0, 110.0, 87.0, 89.0, 87.0, 88.0, 88.0, 89.0, 86.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 159.0, 136.0, 151.0, 147.0, 148.0, 149.0, 148.0, 198.0, 161.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 208.0, 195.0, 176.0, 176.0, 175.0, 174.0, 178.0, 176.0], "value": 181.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 68.0, 70.0, 69.0, 71.0, 71.0, 95.0, 75.0, 69.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1471.4000000000003, "alertThreshold": 2.0}]} 19:13:06 INFO - Return code: 0 19:13:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:13:06 INFO - # TBPL SUCCESS # 19:13:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:13:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:13:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:13:06 INFO - 2016-12-01 19:13:06.257 screenresolution[1651:9655] starting screenresolution argv=screenresolution get 19:13:06 INFO - 2016-12-01 19:13:06.260 screenresolution[1651:9655] Display 0: 1600x1200x32@60 19:13:06 INFO - 2016-12-01 19:13:06.266 screenresolution[1652:9658] starting screenresolution argv=screenresolution list 19:13:06 INFO - Available Modes on Display 0 19:13:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:13:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:13:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:13:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:13:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:13:06 INFO - Intel Iris: 19:13:06 INFO - Chipset Model: Intel Iris 19:13:06 INFO - Type: GPU 19:13:06 INFO - Bus: Built-In 19:13:06 INFO - VRAM (Dynamic, Max): 1536 MB 19:13:06 INFO - Vendor: Intel (0x8086) 19:13:06 INFO - Device ID: 0x0a2e 19:13:06 INFO - Revision ID: 0x0009 19:13:06 INFO - Displays: 19:13:06 INFO - Display: 19:13:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:13:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:13:06 INFO - Display Serial Number: 1600x1200 60 19:13:06 INFO - Main Display: Yes 19:13:06 INFO - Mirror: Off 19:13:06 INFO - Online: Yes 19:13:06 INFO - Rotation: Supported 19:13:06 INFO - Return code: 0 19:13:06 INFO - Running post-action listener: _resource_record_post_action 19:13:06 INFO - [mozharness: 2016-12-02 03:13:06.514762Z] Finished run-tests step (success) 19:13:06 INFO - Running post-run listener: _resource_record_post_run 19:13:06 INFO - Total resource usage - Wall time: 1217s; CPU: 54.0%; Read bytes: 38712320; Write bytes: 694608384; Read time: 373; Write time: 2084 19:13:06 INFO - TinderboxPrint: CPU usage
53.7% 19:13:06 INFO - TinderboxPrint: I/O read bytes / time
38,712,320 / 373 19:13:06 INFO - TinderboxPrint: I/O write bytes / time
694,608,384 / 2,084 19:13:06 INFO - TinderboxPrint: CPU idle
2,255.2 (46.3%) 19:13:06 INFO - TinderboxPrint: CPU system
978.0 (20.1%) 19:13:06 INFO - TinderboxPrint: CPU user
1,636.5 (33.6%) 19:13:06 INFO - TinderboxPrint: Swap in / out
422,588,416 / 0 19:13:06 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 376982016; Write bytes: 372370944; Read time: 28733; Write time: 668 19:13:06 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 36656128; Write bytes: 305779712; Read time: 350; Write time: 1378 19:13:07 INFO - Running post-run listener: _upload_blobber_files 19:13:07 INFO - Blob upload gear active. 19:13:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:13:07 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 19:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:13:07 INFO - (blobuploader) - INFO - Open directory for files ... 19:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:08 INFO - (blobuploader) - INFO - Done attempting. 19:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:13:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:09 INFO - (blobuploader) - INFO - Done attempting. 19:13:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:13:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:13:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:11 INFO - (blobuploader) - INFO - Done attempting. 19:13:11 INFO - (blobuploader) - INFO - Iteration through files over. 19:13:11 INFO - Return code: 0 19:13:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:13:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:13:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e9c3d17c982251548244a3c10eb41199fda8674b4a0a3f85abd22f18e9d83cf1d7fbbc478c0cffdd1168857e32a51995b44dda9036291f2e01e25e3a1576b0cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/59a93a67d30839830899bb6ac8bc9f686823f3f9ce0437974d1637d70cda64528369c4987acb6375c666997f4d12d00d6db5774b865f8f693cff1bd3adea91ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c5f953f02244bde7e7ab7dc546fd435a17f5fd750adc65bd413ac767a62195e3a44abb73dcd1ff687caa4e0925589799d7d8837c927bffdd9bb1852ba2f649a8"} 19:13:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:13:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:13:11 INFO - Contents: 19:13:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e9c3d17c982251548244a3c10eb41199fda8674b4a0a3f85abd22f18e9d83cf1d7fbbc478c0cffdd1168857e32a51995b44dda9036291f2e01e25e3a1576b0cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/59a93a67d30839830899bb6ac8bc9f686823f3f9ce0437974d1637d70cda64528369c4987acb6375c666997f4d12d00d6db5774b865f8f693cff1bd3adea91ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c5f953f02244bde7e7ab7dc546fd435a17f5fd750adc65bd413ac767a62195e3a44abb73dcd1ff687caa4e0925589799d7d8837c927bffdd9bb1852ba2f649a8"} 19:13:11 INFO - Running post-run listener: copy_logs_to_upload_dir 19:13:11 INFO - Copying logs to upload dir... 19:13:11 INFO - mkdir: /builds/slave/test/build/upload/logs 19:13:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.272508 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-01 19:13:11.469005) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 19:13:11.474419) ========= 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.819BZZlrov/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.xBLMZLOEER/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e9c3d17c982251548244a3c10eb41199fda8674b4a0a3f85abd22f18e9d83cf1d7fbbc478c0cffdd1168857e32a51995b44dda9036291f2e01e25e3a1576b0cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/59a93a67d30839830899bb6ac8bc9f686823f3f9ce0437974d1637d70cda64528369c4987acb6375c666997f4d12d00d6db5774b865f8f693cff1bd3adea91ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c5f953f02244bde7e7ab7dc546fd435a17f5fd750adc65bd413ac767a62195e3a44abb73dcd1ff687caa4e0925589799d7d8837c927bffdd9bb1852ba2f649a8"} build_url:https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/bAl2dtObT9yWNuBC_0QawQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e9c3d17c982251548244a3c10eb41199fda8674b4a0a3f85abd22f18e9d83cf1d7fbbc478c0cffdd1168857e32a51995b44dda9036291f2e01e25e3a1576b0cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/59a93a67d30839830899bb6ac8bc9f686823f3f9ce0437974d1637d70cda64528369c4987acb6375c666997f4d12d00d6db5774b865f8f693cff1bd3adea91ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c5f953f02244bde7e7ab7dc546fd435a17f5fd750adc65bd413ac767a62195e3a44abb73dcd1ff687caa4e0925589799d7d8837c927bffdd9bb1852ba2f649a8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 19:13:11.508058) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 19:13:11.508404) ========= 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.819BZZlrov/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.xBLMZLOEER/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005200 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 19:13:11.557100) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 19:13:11.557495) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 19:13:11.557855) ========= ========= Total master_lag: 0.17 =========