builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0322 starttime: 1479787532.19 results: success (0) buildid: 20161121185750 builduid: 0f09016b289d43789f52069fa037d49c revision: 998a69cbaf54e31bb5d1d95d49cde70cfe89153c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:32.194022) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:32.194457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:32.194728) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:32.221357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:32.221751) ========= 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.PhaVQ1QyiM/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.JeUndm27ev/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-21 20:05:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.1M=0.001s 2016-11-21 20:05:32 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134951 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:32.380775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:32.381098) ========= 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.PhaVQ1QyiM/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.JeUndm27ev/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.025451 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:32.430194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 20:05:32.430668) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 998a69cbaf54e31bb5d1d95d49cde70cfe89153c --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 998a69cbaf54e31bb5d1d95d49cde70cfe89153c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PhaVQ1QyiM/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.JeUndm27ev/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-21 20:05:32,530 truncating revision to first 12 chars 2016-11-21 20:05:32,530 Setting DEBUG logging. 2016-11-21 20:05:32,530 attempt 1/10 2016-11-21 20:05:32,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/998a69cbaf54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 20:05:34,205 unpacking tar archive at: graphics-998a69cbaf54/testing/mozharness/ program finished with exit code 0 elapsedTime=1.954554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 20:05:34.408941) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:34.409275) ========= script_repo_revision: 998a69cbaf54e31bb5d1d95d49cde70cfe89153c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:34.409695) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:34.409980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 20:05:34.429733) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-21 20:05:34.430214) ========= /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.PhaVQ1QyiM/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.JeUndm27ev/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 20:05:34 INFO - MultiFileLogger online at 20161121 20:05:34 in /builds/slave/test 20:05:34 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 20:05:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:34 INFO - {'append_to_log': False, 20:05:34 INFO - 'base_work_dir': '/builds/slave/test', 20:05:34 INFO - 'blob_upload_branch': 'Graphics', 20:05:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:34 INFO - 'branch': 'Graphics', 20:05:34 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:34 INFO - 'config_files': ('talos/mac_config.py',), 20:05:34 INFO - 'default_actions': ('clobber', 20:05:34 INFO - 'read-buildbot-config', 20:05:34 INFO - 'download-and-extract', 20:05:34 INFO - 'populate-webroot', 20:05:34 INFO - 'create-virtualenv', 20:05:34 INFO - 'install', 20:05:34 INFO - 'run-tests'), 20:05:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:34 INFO - 'download_minidump_stackwalk': True, 20:05:34 INFO - 'download_symbols': 'ondemand', 20:05:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:34 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:34 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:34 INFO - 'installer_path': 'installer.exe', 20:05:34 INFO - 'log_level': 'info', 20:05:34 INFO - 'log_name': 'talos', 20:05:34 INFO - 'log_to_console': True, 20:05:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:05:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:05:34 INFO - 'opt_config_files': (), 20:05:34 INFO - 'pip_index': False, 20:05:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:05:34 INFO - 'cmd': ('bash', 20:05:34 INFO - '-c', 20:05:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:05:34 INFO - 'enabled': True, 20:05:34 INFO - 'halt_on_failure': False, 20:05:34 INFO - 'name': 'check_screen_resolution'},), 20:05:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:05:34 INFO - 'cmd': ('bash', 20:05:34 INFO - '-c', 20:05:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:05:34 INFO - 'enabled': True, 20:05:34 INFO - 'halt_on_failure': False, 20:05:34 INFO - 'name': 'check_screen_resolution'},), 20:05:34 INFO - 'run_cmd_checks_enabled': True, 20:05:34 INFO - 'sps_profile': False, 20:05:34 INFO - 'sps_profile_interval': 0, 20:05:34 INFO - 'suite': 'dromaeojs', 20:05:34 INFO - 'system_bits': '32', 20:05:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:34 INFO - 'title': 't-yosemite-r7-0322', 20:05:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:34 INFO - 'use_talos_json': True, 20:05:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:34 INFO - 'work_dir': 'build'} 20:05:34 INFO - [mozharness: 2016-11-22 04:05:34.632635Z] Running clobber step. 20:05:34 INFO - Running pre-action listener: _resource_record_pre_action 20:05:34 INFO - Running main action method: clobber 20:05:34 INFO - rmtree: /builds/slave/test/build 20:05:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:37 INFO - Running post-action listener: _resource_record_post_action 20:05:37 INFO - [mozharness: 2016-11-22 04:05:37.056960Z] Finished clobber step (success) 20:05:37 INFO - [mozharness: 2016-11-22 04:05:37.057207Z] Running read-buildbot-config step. 20:05:37 INFO - Running pre-action listener: _resource_record_pre_action 20:05:37 INFO - Running main action method: read_buildbot_config 20:05:37 INFO - Using buildbot properties: 20:05:37 INFO - { 20:05:37 INFO - "project": "", 20:05:37 INFO - "product": "firefox", 20:05:37 INFO - "script_repo_revision": "default", 20:05:37 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 20:05:37 INFO - "repository": "", 20:05:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 20:05:37 INFO - "buildid": "20161121185750", 20:05:37 INFO - "pgo_build": "False", 20:05:37 INFO - "basedir": "/builds/slave/test", 20:05:37 INFO - "buildnumber": 0, 20:05:37 INFO - "slavename": "t-yosemite-r7-0322", 20:05:37 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 20:05:37 INFO - "platform": "yosemite_r7", 20:05:37 INFO - "scheduler": "tests-graphics-macosx64-talos", 20:05:37 INFO - "branch": "graphics", 20:05:37 INFO - "repo_path": "projects/graphics", 20:05:37 INFO - "revision": "998a69cbaf54e31bb5d1d95d49cde70cfe89153c", 20:05:37 INFO - "stage_platform": "macosx64", 20:05:37 INFO - "builduid": "0f09016b289d43789f52069fa037d49c", 20:05:37 INFO - "slavebuilddir": "test" 20:05:37 INFO - } 20:05:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 20:05:37 INFO - Running post-action listener: _resource_record_post_action 20:05:37 INFO - [mozharness: 2016-11-22 04:05:37.063028Z] Finished read-buildbot-config step (success) 20:05:37 INFO - [mozharness: 2016-11-22 04:05:37.063244Z] Running download-and-extract step. 20:05:37 INFO - Running pre-action listener: _resource_record_pre_action 20:05:37 INFO - Running main action method: download_and_extract 20:05:37 INFO - mkdir: /builds/slave/test/build/tests 20:05: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')]} 20:05:37 INFO - trying https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 20:05:37 INFO - Downloading https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/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 20:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/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 20:05:38 INFO - Downloaded 1199 bytes. 20:05:38 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 20:05:38 INFO - Using the following test package requirements: 20:05:38 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:05:38 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:05:38 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 20:05:38 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:05:38 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 20:05:38 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:05:38 INFO - u'jsshell-mac.zip'], 20:05:38 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:05:38 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 20:05:38 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:05:38 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:05:38 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 20:05:38 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:05:38 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 20:05:38 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:05:38 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 20:05:38 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:05:38 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 20:05:38 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:05:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:05:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:05:38 INFO - Fetch https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:05:38 INFO - Http code: 200 20:05:38 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 20:05:38 INFO - x-amz-cf-id: f5OKAT-4nu5oroRTnVhWjsNDQiJChUljrI4a0mR1IWmz16oTpUp3bw== 20:05:38 INFO - x-amz-version-id: 7too5E18PHwlB2C98R3Uqbz8fjfkZKdg 20:05:38 INFO - Expected file size: 16281993 20:05:38 INFO - Obtained file size: 16281993 20:05:45 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 20:05:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:05:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:05:45 INFO - Fetch https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:05:46 INFO - Http code: 200 20:05:46 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 20:05:46 INFO - x-amz-cf-id: fxrKoFIyFlYyB2ssRhLiLDDeS9smV-QlQCFaFHwmMlpEDDbzHsSQew== 20:05:46 INFO - x-amz-version-id: 7too5E18PHwlB2C98R3Uqbz8fjfkZKdg 20:05:46 INFO - Expected file size: 16281993 20:05:46 INFO - Obtained file size: 16281993 20:05:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 20:05:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:05:52 INFO - Fetch https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 20:05:54 INFO - Http code: 200 20:05:54 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 20:05:54 INFO - x-amz-cf-id: Lj1OPMncWX_j9i79mM9fKS5WaeCrpFMLDnq4_9Dy5bBNYVuev1HtxA== 20:05:54 INFO - x-amz-version-id: GMGAy7RD5y033IDffZUJogBOdSwpi_YA 20:05:54 INFO - Expected file size: 14409392 20:05:54 INFO - Obtained file size: 14409392 20:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:54 INFO - trying https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:05:54 INFO - Downloading https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 20:05:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/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 20:05:57 INFO - Downloaded 107567007 bytes. 20:05:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:05:57 INFO - mkdir: /builds/slave/test/properties 20:05:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:05:57 INFO - Writing to file /builds/slave/test/properties/build_url 20:05:57 INFO - Contents: 20:05:57 INFO - build_url:https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:05:58 INFO - Running post-action listener: _resource_record_post_action 20:05:58 INFO - Running post-action listener: set_extra_try_arguments 20:05:58 INFO - [mozharness: 2016-11-22 04:05:58.148147Z] Finished download-and-extract step (success) 20:05:58 INFO - [mozharness: 2016-11-22 04:05:58.148277Z] Running populate-webroot step. 20:05:58 INFO - Running pre-action listener: _resource_record_pre_action 20:05:58 INFO - Running main action method: populate_webroot 20:05:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:05:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:05:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:05:58 INFO - '--tppagecycles', 20:05:58 INFO - '7'], 20:05:58 INFO - 'tests': ['tsvgm']}}, 20:05:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:05:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:05:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:05:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:05:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:05:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:05:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:05:58 INFO - 'talos_options': ['--disable-e10s'], 20:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:05:58 INFO - 'talos_options': ['--disable-e10s'], 20:05:58 INFO - 'tests': ['damp', 'tps']}, 20:05:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:05:58 INFO - 'tests': ['damp', 'tps']}, 20:05:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:05:58 INFO - 'tests': ['dromaeo_dom']}, 20:05:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:05:58 INFO - 'tests': ['basic_compositor_video']}, 20:05:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:05:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:05:58 INFO - 'tests': ['a11yr', 20:05:58 INFO - 'ts_paint', 20:05:58 INFO - 'tpaint', 20:05:58 INFO - 'sessionrestore', 20:05:58 INFO - 'sessionrestore_no_auto_restore', 20:05:58 INFO - 'tabpaint']}, 20:05:58 INFO - 'other-e10s': {'tests': ['a11yr', 20:05:58 INFO - 'ts_paint', 20:05:58 INFO - 'tpaint', 20:05:58 INFO - 'sessionrestore', 20:05:58 INFO - 'sessionrestore_no_auto_restore', 20:05:58 INFO - 'tabpaint']}, 20:05:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:05:58 INFO - 'ts_paint', 20:05:58 INFO - 'tpaint', 20:05:58 INFO - 'sessionrestore', 20:05:58 INFO - 'sessionrestore_no_auto_restore', 20:05:58 INFO - 'tabpaint']}, 20:05:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:05:58 INFO - 'ts_paint', 20:05:58 INFO - 'tpaint', 20:05:58 INFO - 'sessionrestore', 20:05:58 INFO - 'sessionrestore_no_auto_restore', 20:05:58 INFO - 'tabpaint']}, 20:05:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:05:58 INFO - 'tests': ['a11yr', 20:05:58 INFO - 'ts_paint', 20:05:58 INFO - 'tpaint', 20:05:58 INFO - 'sessionrestore', 20:05:58 INFO - 'sessionrestore_no_auto_restore', 20:05:58 INFO - 'tabpaint']}, 20:05:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:05:58 INFO - 'tests': ['a11yr', 20:05:58 INFO - 'ts_paint', 20:05:58 INFO - 'tpaint', 20:05:58 INFO - 'sessionrestore', 20:05:58 INFO - 'sessionrestore_no_auto_restore', 20:05:58 INFO - 'tabpaint']}, 20:05:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:05:58 INFO - 'tests': ['tsvgx', 20:05:58 INFO - 'tsvgr_opacity', 20:05:58 INFO - 'tart', 20:05:58 INFO - 'tscrollx', 20:05:58 INFO - 'cart']}, 20:05:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:05:58 INFO - 'tsvgr_opacity', 20:05:58 INFO - 'tart', 20:05:58 INFO - 'tscrollx', 20:05:58 INFO - 'cart']}, 20:05:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:05:58 INFO - 'talos_options': ['--disable-e10s'], 20:05:58 INFO - 'tests': ['tp5o']}, 20:05:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:05:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:05:58 INFO - 'talos_options': ['--disable-e10s', 20:05:58 INFO - '--xperf_path', 20:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:58 INFO - 'tests': ['tp5n']}, 20:05:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:05:58 INFO - 'talos_options': ['--xperf_path', 20:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:58 INFO - 'tests': ['tp5n']}}, 20:05:58 INFO - 'talos.zip': {'path': '', 20:05:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:05:58 INFO - Running post-action listener: _resource_record_post_action 20:05:58 INFO - [mozharness: 2016-11-22 04:05:58.166457Z] Finished populate-webroot step (success) 20:05:58 INFO - [mozharness: 2016-11-22 04:05:58.166585Z] Running create-virtualenv step. 20:05:58 INFO - Running pre-action listener: _resource_record_pre_action 20:05:58 INFO - Running main action method: create_virtualenv 20:05:58 INFO - Creating virtualenv /builds/slave/test/build/venv 20:05:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:05:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:05:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:58 INFO - Using real prefix '/tools/python27' 20:05:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:05:59 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:01 INFO - Installing pip.................done. 20:06:01 INFO - Return code: 0 20:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:06:02 INFO - Reading from file tmpfile_stdout 20:06:02 INFO - Output received: 20:06:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:06:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:02 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 0x10dbfb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db71570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e9c8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da11d30>, '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 0x10d878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da09b20>, '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.PhaVQ1QyiM/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.JeUndm27ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:06:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PhaVQ1QyiM/Render', 20:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:02 INFO - 'HOME': '/Users/cltbld', 20:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:02 INFO - 'LOGNAME': 'cltbld', 20:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:02 INFO - 'MOZ_NO_REMOTE': '1', 20:06:02 INFO - 'NO_EM_RESTART': '1', 20:06:02 INFO - 'PAGER': '/bin/cat', 20:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:02 INFO - 'PWD': '/builds/slave/test', 20:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:02 INFO - 'SHELL': '/bin/bash', 20:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JeUndm27ev/Listeners', 20:06:02 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 20:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:02 INFO - 'USER': 'cltbld', 20:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:02 INFO - 'XPC_FLAGS': '0x0', 20:06:02 INFO - 'XPC_SERVICE_NAME': '0', 20:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:06:02 INFO - Cleaning up... 20:06:02 INFO - Return code: 0 20:06:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:02 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 0x10dbfb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db71570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e9c8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da11d30>, '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 0x10d878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da09b20>, '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.PhaVQ1QyiM/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.JeUndm27ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:06:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PhaVQ1QyiM/Render', 20:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:02 INFO - 'HOME': '/Users/cltbld', 20:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:02 INFO - 'LOGNAME': 'cltbld', 20:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:02 INFO - 'MOZ_NO_REMOTE': '1', 20:06:02 INFO - 'NO_EM_RESTART': '1', 20:06:02 INFO - 'PAGER': '/bin/cat', 20:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:02 INFO - 'PWD': '/builds/slave/test', 20:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:02 INFO - 'SHELL': '/bin/bash', 20:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JeUndm27ev/Listeners', 20:06:02 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 20:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:02 INFO - 'USER': 'cltbld', 20:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:02 INFO - 'XPC_FLAGS': '0x0', 20:06:02 INFO - 'XPC_SERVICE_NAME': '0', 20:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:02 INFO - Downloading/unpacking psutil>=3.1.1 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:06 INFO - Installing collected packages: psutil 20:06:06 INFO - Running setup.py install for psutil 20:06:06 INFO - building 'psutil._psutil_osx' extension 20:06:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 20:06:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 20:06:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 20:06:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 20:06:07 INFO - building 'psutil._psutil_posix' extension 20:06:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 20:06:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:06:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:06:07 INFO - ^ 20:06:07 INFO - 1 warning generated. 20:06:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 20:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:07 INFO - Successfully installed psutil 20:06:07 INFO - Cleaning up... 20:06:07 INFO - Return code: 0 20:06:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:07 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 0x10dbfb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db71570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e9c8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da11d30>, '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 0x10d878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da09b20>, '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.PhaVQ1QyiM/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.JeUndm27ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:06:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PhaVQ1QyiM/Render', 20:06:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:07 INFO - 'HOME': '/Users/cltbld', 20:06:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:07 INFO - 'LOGNAME': 'cltbld', 20:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:07 INFO - 'MOZ_NO_REMOTE': '1', 20:06:07 INFO - 'NO_EM_RESTART': '1', 20:06:07 INFO - 'PAGER': '/bin/cat', 20:06:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:07 INFO - 'PWD': '/builds/slave/test', 20:06:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:07 INFO - 'SHELL': '/bin/bash', 20:06:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JeUndm27ev/Listeners', 20:06:07 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 20:06:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:07 INFO - 'USER': 'cltbld', 20:06:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:07 INFO - 'XPC_FLAGS': '0x0', 20:06:07 INFO - 'XPC_SERVICE_NAME': '0', 20:06:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:06:10 INFO - Installing collected packages: mozsystemmonitor 20:06:10 INFO - Running setup.py install for mozsystemmonitor 20:06:10 INFO - Successfully installed mozsystemmonitor 20:06:10 INFO - Cleaning up... 20:06:10 INFO - Return code: 0 20:06:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:10 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 0x10dbfb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db71570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e9c8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da11d30>, '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 0x10d878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da09b20>, '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.PhaVQ1QyiM/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.JeUndm27ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:06:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PhaVQ1QyiM/Render', 20:06:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:10 INFO - 'HOME': '/Users/cltbld', 20:06:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:10 INFO - 'LOGNAME': 'cltbld', 20:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:10 INFO - 'MOZ_NO_REMOTE': '1', 20:06:10 INFO - 'NO_EM_RESTART': '1', 20:06:10 INFO - 'PAGER': '/bin/cat', 20:06:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:10 INFO - 'PWD': '/builds/slave/test', 20:06:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:10 INFO - 'SHELL': '/bin/bash', 20:06:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JeUndm27ev/Listeners', 20:06:10 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 20:06:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:10 INFO - 'USER': 'cltbld', 20:06:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:10 INFO - 'XPC_FLAGS': '0x0', 20:06:10 INFO - 'XPC_SERVICE_NAME': '0', 20:06:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:10 INFO - Downloading/unpacking jsonschema==2.5.1 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:13 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:13 INFO - warning: no files found matching '*.txt' 20:06:13 INFO - no previously-included directories found matching 'build' 20:06:13 INFO - no previously-included directories found matching 'dist' 20:06:13 INFO - no previously-included directories found matching '.git*' 20:06:13 INFO - Installing collected packages: jsonschema, functools32 20:06:13 INFO - Running setup.py install for functools32 20:06:13 INFO - warning: no files found matching '*.txt' 20:06:13 INFO - no previously-included directories found matching 'build' 20:06:13 INFO - no previously-included directories found matching 'dist' 20:06:13 INFO - no previously-included directories found matching '.git*' 20:06:14 INFO - Successfully installed jsonschema functools32 20:06:14 INFO - Cleaning up... 20:06:14 INFO - Return code: 0 20:06:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dbfb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db71570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e9c8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da11d30>, '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 0x10d878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da09b20>, '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.PhaVQ1QyiM/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.JeUndm27ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:06:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PhaVQ1QyiM/Render', 20:06:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:14 INFO - 'HOME': '/Users/cltbld', 20:06:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:14 INFO - 'LOGNAME': 'cltbld', 20:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:14 INFO - 'MOZ_NO_REMOTE': '1', 20:06:14 INFO - 'NO_EM_RESTART': '1', 20:06:14 INFO - 'PAGER': '/bin/cat', 20:06:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:14 INFO - 'PWD': '/builds/slave/test', 20:06:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:14 INFO - 'SHELL': '/bin/bash', 20:06:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JeUndm27ev/Listeners', 20:06:14 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 20:06:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:14 INFO - 'USER': 'cltbld', 20:06:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:14 INFO - 'XPC_FLAGS': '0x0', 20:06:14 INFO - 'XPC_SERVICE_NAME': '0', 20:06:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:06:14 INFO - Cleaning up... 20:06:14 INFO - Return code: 0 20:06:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dbfb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db71570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e9c8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da11d30>, '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 0x10d878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da09b20>, '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.PhaVQ1QyiM/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.JeUndm27ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:06:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PhaVQ1QyiM/Render', 20:06:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:14 INFO - 'HOME': '/Users/cltbld', 20:06:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:14 INFO - 'LOGNAME': 'cltbld', 20:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:14 INFO - 'MOZ_NO_REMOTE': '1', 20:06:14 INFO - 'NO_EM_RESTART': '1', 20:06:14 INFO - 'PAGER': '/bin/cat', 20:06:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:14 INFO - 'PWD': '/builds/slave/test', 20:06:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:14 INFO - 'SHELL': '/bin/bash', 20:06:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JeUndm27ev/Listeners', 20:06:14 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 20:06:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:14 INFO - 'USER': 'cltbld', 20:06:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:14 INFO - 'XPC_FLAGS': '0x0', 20:06:14 INFO - 'XPC_SERVICE_NAME': '0', 20:06:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:14 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:18 INFO - Downloading docopt-0.6.1.tar.gz 20:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:18 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:18 INFO - Running setup.py install for blobuploader 20:06:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:18 INFO - Running setup.py install for requests 20:06:19 INFO - Running setup.py install for docopt 20:06:19 INFO - Successfully installed blobuploader requests docopt 20:06:19 INFO - Cleaning up... 20:06:19 INFO - Return code: 0 20:06:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:19 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 0x10dbfb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db71570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e9c8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da11d30>, '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 0x10d878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da09b20>, '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.PhaVQ1QyiM/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.JeUndm27ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PhaVQ1QyiM/Render', 20:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:19 INFO - 'HOME': '/Users/cltbld', 20:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:19 INFO - 'LOGNAME': 'cltbld', 20:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:19 INFO - 'MOZ_NO_REMOTE': '1', 20:06:19 INFO - 'NO_EM_RESTART': '1', 20:06:19 INFO - 'PAGER': '/bin/cat', 20:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:19 INFO - 'PWD': '/builds/slave/test', 20:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:19 INFO - 'SHELL': '/bin/bash', 20:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JeUndm27ev/Listeners', 20:06:19 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 20:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:19 INFO - 'USER': 'cltbld', 20:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:19 INFO - 'XPC_FLAGS': '0x0', 20:06:19 INFO - 'XPC_SERVICE_NAME': '0', 20:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:19 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-1hUYts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:19 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-iYljGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:19 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-Q2Cghz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:19 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-mhDI8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:20 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-g2k2hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:20 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-Q1naNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:20 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-YV6u2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:20 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-PbfhFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:20 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-1977OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:20 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-EKFk2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:20 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-CeymEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:20 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-gQobHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:20 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-PCx8RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:20 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-HhpGid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:21 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-FJjMYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:21 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-L1zCKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:21 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-a8OHfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:21 INFO - Running setup.py install for manifestparser 20:06:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Running setup.py install for mozcrash 20:06:21 INFO - Running setup.py install for mozdebug 20:06:21 INFO - Running setup.py install for mozdevice 20:06:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Running setup.py install for mozfile 20:06:22 INFO - Running setup.py install for mozhttpd 20:06:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:22 INFO - Running setup.py install for mozinfo 20:06:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:22 INFO - Running setup.py install for mozInstall 20:06:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:22 INFO - Running setup.py install for mozleak 20:06:22 INFO - Running setup.py install for mozlog 20:06:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:22 INFO - Running setup.py install for moznetwork 20:06:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:22 INFO - Running setup.py install for mozprocess 20:06:23 INFO - Running setup.py install for mozprofile 20:06:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:23 INFO - Running setup.py install for mozrunner 20:06:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:23 INFO - Running setup.py install for mozscreenshot 20:06:23 INFO - Running setup.py install for moztest 20:06:23 INFO - Running setup.py install for mozversion 20:06:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:23 INFO - Cleaning up... 20:06:23 INFO - Return code: 0 20:06:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:23 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 0x10dbfb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db71570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e9c8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da11d30>, '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 0x10d878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da09b20>, '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.PhaVQ1QyiM/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.JeUndm27ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PhaVQ1QyiM/Render', 20:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:23 INFO - 'HOME': '/Users/cltbld', 20:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:23 INFO - 'LOGNAME': 'cltbld', 20:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:23 INFO - 'MOZ_NO_REMOTE': '1', 20:06:23 INFO - 'NO_EM_RESTART': '1', 20:06:23 INFO - 'PAGER': '/bin/cat', 20:06:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:23 INFO - 'PWD': '/builds/slave/test', 20:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:23 INFO - 'SHELL': '/bin/bash', 20:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JeUndm27ev/Listeners', 20:06:23 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 20:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:23 INFO - 'USER': 'cltbld', 20:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:23 INFO - 'XPC_FLAGS': '0x0', 20:06:23 INFO - 'XPC_SERVICE_NAME': '0', 20:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:24 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-6ZgSJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:24 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-XTVhfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:24 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-t1YJV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:24 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-QVmJ_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:24 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)) 20:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:24 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-qHiMhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:24 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-HrB_J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:24 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-CxtC91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:24 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-845_pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:25 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-4qwtu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:25 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-Y3Fy51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:25 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-XuwgEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:25 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-uT43Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:25 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-r3IBaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:25 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-QCU9Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:25 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-AeeUDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:25 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-F1seUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:25 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)) 20:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:25 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-oLtjqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:06:26 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)) 20:06:26 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)) 20:06:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:28 INFO - Downloading blessings-1.6.tar.gz 20:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:28 INFO - Installing collected packages: blessings 20:06:28 INFO - Running setup.py install for blessings 20:06:28 INFO - Successfully installed blessings 20:06:28 INFO - Cleaning up... 20:06:28 INFO - Return code: 0 20:06:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:29 INFO - Reading from file tmpfile_stdout 20:06:29 INFO - Current package versions: 20:06:29 INFO - blessings == 1.6 20:06:29 INFO - blobuploader == 1.2.4 20:06:29 INFO - docopt == 0.6.1 20:06:29 INFO - functools32 == 3.2.3-2 20:06:29 INFO - jsonschema == 2.5.1 20:06:29 INFO - manifestparser == 1.1 20:06:29 INFO - mozInstall == 1.12 20:06:29 INFO - mozcrash == 1.0 20:06:29 INFO - mozdebug == 0.1 20:06:29 INFO - mozdevice == 0.49 20:06:29 INFO - mozfile == 1.2 20:06:29 INFO - mozhttpd == 0.7 20:06:29 INFO - mozinfo == 0.9 20:06:29 INFO - mozleak == 0.1 20:06:29 INFO - mozlog == 3.4 20:06:29 INFO - moznetwork == 0.27 20:06:29 INFO - mozprocess == 0.23 20:06:29 INFO - mozprofile == 0.28 20:06:29 INFO - mozrunner == 6.13 20:06:29 INFO - mozscreenshot == 0.1 20:06:29 INFO - mozsystemmonitor == 0.3 20:06:29 INFO - moztest == 0.7 20:06:29 INFO - mozversion == 1.4 20:06:29 INFO - psutil == 3.1.1 20:06:29 INFO - requests == 1.2.3 20:06:29 INFO - wsgiref == 0.1.2 20:06:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:29 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 0x10dbfb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db71570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e9c8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da11d30>, '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 0x10d878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da09b20>, '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.PhaVQ1QyiM/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.JeUndm27ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:06:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:06:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PhaVQ1QyiM/Render', 20:06:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:29 INFO - 'HOME': '/Users/cltbld', 20:06:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:29 INFO - 'LOGNAME': 'cltbld', 20:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:29 INFO - 'MOZ_NO_REMOTE': '1', 20:06:29 INFO - 'NO_EM_RESTART': '1', 20:06:29 INFO - 'PAGER': '/bin/cat', 20:06:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:29 INFO - 'PWD': '/builds/slave/test', 20:06:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:29 INFO - 'SHELL': '/bin/bash', 20:06:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JeUndm27ev/Listeners', 20:06:29 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 20:06:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:29 INFO - 'USER': 'cltbld', 20:06:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:29 INFO - 'XPC_FLAGS': '0x0', 20:06:29 INFO - 'XPC_SERVICE_NAME': '0', 20:06:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:06:30 INFO - Cleaning up... 20:06:30 INFO - Return code: 0 20:06:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:30 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 0x10dbfb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db71570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e9c8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da11d30>, '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 0x10d878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da09b20>, '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.PhaVQ1QyiM/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.JeUndm27ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:06:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PhaVQ1QyiM/Render', 20:06:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:30 INFO - 'HOME': '/Users/cltbld', 20:06:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:30 INFO - 'LOGNAME': 'cltbld', 20:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:30 INFO - 'MOZ_NO_REMOTE': '1', 20:06:30 INFO - 'NO_EM_RESTART': '1', 20:06:30 INFO - 'PAGER': '/bin/cat', 20:06:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:30 INFO - 'PWD': '/builds/slave/test', 20:06:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:30 INFO - 'SHELL': '/bin/bash', 20:06:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JeUndm27ev/Listeners', 20:06:30 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 20:06:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:30 INFO - 'USER': 'cltbld', 20:06:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:30 INFO - 'XPC_FLAGS': '0x0', 20:06:30 INFO - 'XPC_SERVICE_NAME': '0', 20:06:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:30 INFO - Cleaning up... 20:06:30 INFO - Return code: 0 20:06:30 INFO - Running post-action listener: _resource_record_post_action 20:06:30 INFO - Running post-action listener: _start_resource_monitoring 20:06:30 INFO - Starting resource monitoring. 20:06:30 INFO - [mozharness: 2016-11-22 04:06:30.859040Z] Finished create-virtualenv step (success) 20:06:30 INFO - [mozharness: 2016-11-22 04:06:30.860017Z] Running install step. 20:06:30 INFO - Running pre-action listener: _resource_record_pre_action 20:06:30 INFO - Running main action method: install 20:06:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:31 INFO - Reading from file tmpfile_stdout 20:06:31 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:31 INFO - Reading from file tmpfile_stdout 20:06:31 INFO - Output received: 20:06:31 INFO - Usage: mozinstall [options] installer 20:06:31 INFO - Options: 20:06:31 INFO - -h, --help show this help message and exit 20:06:31 INFO - -d DEST, --destination=DEST 20:06:31 INFO - Directory to install application into. [default: 20:06:31 INFO - "/builds/slave/test"] 20:06:31 INFO - --app=APP Application being installed. [default: firefox] 20:06:31 INFO - mkdir: /builds/slave/test/build/application 20:06:31 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'] 20:06:31 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 20:07:03 INFO - Reading from file tmpfile_stdout 20:07:03 INFO - Output received: 20:07:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:07:03 INFO - Running post-action listener: _resource_record_post_action 20:07:03 INFO - [mozharness: 2016-11-22 04:07:03.567760Z] Finished install step (success) 20:07:03 INFO - [mozharness: 2016-11-22 04:07:03.567930Z] Running run-tests step. 20:07:03 INFO - Running pre-action listener: _resource_record_pre_action 20:07:03 INFO - Running main action method: run_tests 20:07:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:07:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:07:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:07:03 INFO - 2016-11-21 20:07:03.582 screenresolution[1626:7351] starting screenresolution argv=screenresolution get 20:07:03 INFO - 2016-11-21 20:07:03.584 screenresolution[1626:7351] Display 0: 1600x1200x32@60 20:07:03 INFO - 2016-11-21 20:07:03.590 screenresolution[1627:7353] starting screenresolution argv=screenresolution list 20:07:03 INFO - Available Modes on Display 0 20:07:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:07:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:07:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:07:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:07:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:07:03 INFO - Intel Iris: 20:07:03 INFO - Chipset Model: Intel Iris 20:07:03 INFO - Type: GPU 20:07:03 INFO - Bus: Built-In 20:07:03 INFO - VRAM (Dynamic, Max): 1536 MB 20:07:03 INFO - Vendor: Intel (0x8086) 20:07:03 INFO - Device ID: 0x0a2e 20:07:03 INFO - Revision ID: 0x0009 20:07:03 INFO - Displays: 20:07:03 INFO - Display: 20:07:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:07:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:07:03 INFO - Display Serial Number: 1600x1200 60 20:07:03 INFO - Main Display: Yes 20:07:03 INFO - Mirror: Off 20:07:03 INFO - Online: Yes 20:07:03 INFO - Rotation: Supported 20:07:03 INFO - Return code: 0 20:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:03 INFO - Python 2.7.3 20:07:03 INFO - Return code: 0 20:07:03 INFO - grabbing minidump binary from tooltool 20:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:03 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 0x10da11d30>, '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 0x10d878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da09b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:07:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 20:07:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:07:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:03 INFO - Return code: 0 20:07:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:07:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:07:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:03 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/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:07:03 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/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0322 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:07:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PhaVQ1QyiM/Render', 20:07:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:07:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:07:03 INFO - 'HOME': '/Users/cltbld', 20:07:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:07:03 INFO - 'LOGNAME': 'cltbld', 20:07:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:03 INFO - 'MOZ_NO_REMOTE': '1', 20:07:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:03 INFO - 'NO_EM_RESTART': '1', 20:07:03 INFO - 'PAGER': '/bin/cat', 20:07:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:03 INFO - 'PWD': '/builds/slave/test', 20:07:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:07:03 INFO - 'SHELL': '/bin/bash', 20:07:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JeUndm27ev/Listeners', 20:07:03 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 20:07:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:07:03 INFO - 'USER': 'cltbld', 20:07:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:07:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:03 INFO - 'XPC_FLAGS': '0x0', 20:07:03 INFO - 'XPC_SERVICE_NAME': '0', 20:07:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:07:03 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/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:07:04 INFO - mozversion application_buildid: 20161121185750 20:07:04 INFO - mozversion application_changeset: 998a69cbaf54e31bb5d1d95d49cde70cfe89153c 20:07:04 INFO - mozversion application_display_name: Nightly 20:07:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:04 INFO - mozversion application_name: Firefox 20:07:04 INFO - mozversion application_remotingname: firefox 20:07:04 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 20:07:04 INFO - mozversion application_vendor: Mozilla 20:07:04 INFO - mozversion application_version: 53.0a1 20:07:04 INFO - mozversion platform_buildid: 20161121185750 20:07:04 INFO - mozversion platform_changeset: 998a69cbaf54e31bb5d1d95d49cde70cfe89153c 20:07:04 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 20:07:04 INFO - mozversion platform_version: 53.0a1 20:07:04 INFO - using testdate: 1479787624 20:07:04 INFO - actual date: 1479787624 20:07:04 INFO - starting webserver on 'localhost:49239' 20:07:04 INFO - SUITE-START | Running 2 tests 20:07:04 INFO - TEST-START | dromaeo_css 20:07:04 INFO - operating with platform_type : mac_ 20:07:04 INFO - Initialising browser for dromaeo_css test... 20:07:04 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpd7WtoY/profile http://localhost:49239/getInfo.html) 20:07:06 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 20:07:06 INFO - PROCESS | 1637 | colorDepth:24 20:07:06 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 20:07:06 INFO - PROCESS | 1637 | __metrics 20:07:06 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:07:06 INFO - PROCESS | 1637 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:07:07 INFO - TEST-INFO | 1637: exit 0 20:07:07 INFO - Browser initialized. 20:07:07 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:07 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpd7WtoY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:20 INFO - PROCESS | 1639 | RSS: Main: 237150208 20:07:20 INFO - PROCESS | 1639 | 20:08:11 INFO - PROCESS | 1639 | 1479787691850 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] 20:10:24 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 20:10:26 INFO - PROCESS | 1639 | RSS: Main: 466415616 20:10:26 INFO - PROCESS | 1639 | 20:13:29 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 20:13:30 INFO - PROCESS | 1639 | RSS: Main: 365240320 20:13:30 INFO - PROCESS | 1639 | 20:16:33 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 20:16:33 INFO - PROCESS | 1639 | RSS: Main: 362225664 20:16:33 INFO - PROCESS | 1639 | 20:19:36 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 20:19:36 INFO - PROCESS | 1639 | RSS: Main: 339144704 20:19:36 INFO - PROCESS | 1639 | 20:22:40 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 20:22:40 INFO - PROCESS | 1639 | RSS: Main: 333750272 20:22:40 INFO - PROCESS | 1639 | 20:25:43 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 20:25:44 INFO - PROCESS | 1639 | RSS: Main: 375603200 20:25:44 INFO - PROCESS | 1639 | 20:25:44 INFO - PROCESS | 1639 | __start_tp_report 20:25:44 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 20:25:44 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 20:25:44 INFO - PROCESS | 1639 | |i|pagename|runs| 20:25:44 INFO - PROCESS | 1639 | |0;dojo.html;3223.661515540868;3263.314703912178;3275.7706960512774;3314.651961544038;3317.5521304623867;5387.919181212285;5475.4524547545225;5479.835604931854;5595.944040559598;5597.2723545939025;5500.22996780451;5517.006938751023;5590.720463976805;5594.664320140794;5623.297087864017;5014.398272207322;5034.949650503503;5035.84892453227;5083.745812709368;5104.285400043997;5089.84730458085;5172.456892026339;5192;5218.530332270095;5241;4971.726555039471;5097.388313402378;5109.156989096795;5134.229865520183;5197;5018.197088465864;5076.568491678212;5100.107481190814;5106.285120083191;5109.948900511022;4992.87517812054;5051.772670229849;5070.69575825448;5071.594272458231;5071.619628527875;5445.591580631429;5471.151971444432;5478.424765399655;5501.779928802843;5506.669599824023;6070.817875463743;6089.847753806191;6093.299270583895;6103.398280005542;6120.816375508742;5017.322661440695;6167.537434692371;6168.87662246757;6170.043643235305;6172.660503672296;5529.529989950819;5535.6955367454375;5582.581306402036;5597.160425936101;5681.375048744635;6161.7227224775;6221.440070393686;6246.968765156145;6265.780697675651;6294.968525157345;5975.133605627159;6004.969975150097;6005.961028651938;6020.187274717857;6033.547483938634;5941.554383421174;6124.816255512342;6144.692765361714;6155.72299246526;6155.938440615626;5150.896982060338;5872.148538461899;5917.940820591825;5956.583039187302;6032;6034.366391528826;6057.545684073624;6101.969490152521;6121.696863452088;6140.6929653517145;4300.741955482618;4842.322074909515;4842.322074909515;4863.294822250754;4905.9018819624125;4246.681498887596;4286.292761694348;4315.244832154361;4322.783860806947;4359.411479450297;5517.172424136332;5568.192612071308;5575.581831362664;5588.86027849307;5600.4959553639555;6025.487833534111;6059.1820104286235;6060.787872424532;6063.333033366326;6064.4845188158615;5563.749631266603;5581.720913954286;5597.74810133545;5600.859978500489;5611.046122159243;5237.319148510745;5246.23929530216;5267.051930652443;5274.3670759509105;5275.050490911673;6239.906401403982;6263.655498947511;6271.560990730787;6273.498120150468;6278.372162783777;4623.283391074388;6020.578559500793;6064.090386441892;6079.939200607937;6082.300535438304;6221.502279817694;6314.684265786784;6316.936830631635;6330.430261276507;6334.651594162181;5748.45389687979;5836.591438599257;5968.880622387441;6007.729652165575;6021.42796434338;5783.537317014713;5937.851553711192;5969.970150149222;5972.402759723993;5977.551683623658;5757.5393968481585;5789.247397838254;5799.94200057994;5810.215620891126;5815.883682326245;5160.458151893997;5705.714714264187;5771.7402716877;5791.623544469765;5896.852578685567;5794.797182098607;5801.94198058014;5833.212516310244;5837.474627283565;5842.357340692435;5824.5340372770925;5917.230760001345;5928.436798504135;5934.109883517507;5942.286925568959;4739.454962679336;5574.247476590608;5633.4084921082695;5749.655020698771;5788.82633520995 20:25:44 INFO - PROCESS | 1639 | |1;ext.html;455.9772011399429;481.566590068938;518.0157700369298;530.4827792901918;550.2846299810245;29763.40473190535;38487.84536463907;39781.60218397815;39866;39911.802645920594;40538.59461405385;41082.97292567687;41137.58862411375;41141.97145071375;41167.38248926269;8371.539565323936;9190.31072669549;9369.390989585689;9377.859332110023;9382.953085234565;8383.413161078726;8548.316134709208;8549.95725021374;8554.657813687445;10978.670639880816;11057.225994180411;11243.60647377342;11278.379689117095;11288.774224515504;11309.830352544719;11177.776444471107;11226.775464490745;11239.157063220291;11257.211995160342;11279.830802537968;11032.28290161137;11118.444077796159;11122.388268645222;11125.833112503238;11131.276467029616;38036.61963380359;38390.80804595987;38406.23187536262;38441.80779096087;38515.42226866599;2937.074821431264;3032.7270545651;3347.364000839857;3492.8952131435844;3504.667056629616;23585;28796.856015719786;29668.8516557418;29987.400251995055;30843;2884.2500949753007;3181.125190572588;3181.2683082891062;3199.6480387157394;3296.456084746014;486618;486784;489746;490482;491106;32453.837730811196;59898.50253743604;60515;60524.39475605276;60525.48686282878;32836;33542;34424.82787586096;34642;34653.13367165841;14123.858761412459;14261.572152835432;14287.214203218922;14305.64235894111;14313.069650472895;12080.154389192672;12139.635810925687;12139.939300303442;12147.696307592381;12149.453274602663;7138.571685698875;7319.085114360705;7333.376662983599;7681.3854891608535;7742.61286935651;3089.938201235963;3125.4374212641487;3182.2362632968384;3271.4275001874576;3290.2596915693775;909.9272058235325;939.3800091939287;943.7546237978175;1019.8062368150028;1038.6053299746047;27954;28629.856850715612;29044.596151257087;29225.269368265963;29381.412371752445;1042.259995403257;1043.4261156363968;1051.6476980211562;1072.3940973350032;1079.9028087472166;12694.42875070624;14504.85495145035;14838.961272710807;15069.09585424878;15298.923505382625;652267;654999;655736;656196;656934;50598.74700626473;51770.48229517732;51892.22161667578;55001.44998550043;55506;1319.2743990805018;1350.4868150103096;1360.1091285208204;1372.835259768834;1374.415873253883;29646.851765741034;30146.84926575353;30468.542971854997;30726;30852.53721194139;48927.51072489372;49385;49414.50585494099;49491;49519;572401;574771;578686;834862;850566;38891.80554097211;39044;39184.80407597944;39481.2103757929;39550;43880.34179487374;44447.33329000132;44681.32978005268;44737;44899.877503062686;29742.025797420083;34088.48867266943;36983.8150809255;37994.620053800216;38416.80791596024;33492.66507334895;35641.46537801883;36508;36715.44926826153;36775;35343;36146.27707445784;36658.816705917365;36982.63017369792;36995.70515031961;29039;29906.252343691584;30534;30617.54073688852;30700.53949190719;19753.80246197577;19822.90088549548;19831.60336793285;19855.801441985972;19934 20:25:44 INFO - PROCESS | 1639 | |2;jquery.html;296.5137175032945;361.7323180846174;367.54608059047086;369.8502106646808;396.34602905206407;14362.196230410418;14608.050476719005;15637.687246255082;19852.40442786715;19932;18516.166772495235;18954;19159.61680766384;19369.806301936977;19469.513262168453;5654.547636189095;5888.175655408247;5890.3226128995075;5893.705314734268;5894.557908156906;4056.9391459128137;5593.440655934394;5709.286339207599;5754.683492407916;5800.100984347412;4271.6155546000855;4320.524742278347;6096.847578810521;6417.101605775172;6423.4861211103;6269.780557680459;6414.880615256186;6434.646094464802;6474.255460622042;6480.416762491398;5547.389787123413;5583.4137415571595;5587.916181257285;5589.916151257735;5593.133064375028;22789.886050569807;23856.76143238563;23870.403239918967;23983.52032959331;24310.635340469908;2312.6415405612156;2354.446705024318;2410.433548116191;2810.6486689163853;3091.520814273791;14508.202048887308;14792.852071479256;14804;14823.77764333536;14890.106593604418;1797.4068557376036;1812.392848395789;1917.4151883675474;1947.221111555375;1948.9475683131093;101632.47551286737;111603;112607.31089033671;113707;116955.83044169535;9498;9582.952085239529;9897;10085.546150423248;10146.289759716896;12932.288724120075;12956.546520871725;12967.157134786208;12983.285919274342;12983.805242921364;7855.253750893656;8112.391570632226;8147.918520814835;8239.134890836376;8290.585470726439;8141.552214628134;8167.714130005421;8221.753347399588;8303.04514980785;8338.498450464836;5132.384113906355;6145.692715364214;6271.78048768291;6313.3686631336495;6402.455791257702;1777.5911540345792;1817.3457555280088;1817.8636602254883;1818.2726909236412;1824.1153040775214;364.8668236093807;686.4028295383049;952.8665986761858;991.945443000642;1002.3334482569155;10744.356527231348;11032.172587056002;11164.274322169196;11510.654680359603;11773.293602383885;395.40688966550175;412.65955586641144;418.046853174762;421.044229598809;438.1368703653797;5817.3019237690905;5821.010428227211;5858.765649373977;5983.341832398432;6004.579679422486;473707;521610;551921;563734;574986;90999;129639;129888;133450;138586;437.72642098688317;442.5950255516231;447.54350562426794;447.7805875121167;448.19996306593225;9982.850257246002;10429.582816687247;10565;10712.73218169552;10764.138868890313;36549.45175822311;37092.629073708915;39250.80374598223;44774.552254477036;50036;71844.64077679579;73059;73375.63312183405;76306.61846690731;78197;7564.319211271012;7772.92227077722;7856.7250146244605;7891.053073631201;7929.801754956172;9999.450030248407;11227;11451.312921224753;12191.293218949531;12611.621651350475;9088.54557272147;10482.475876206312;10707.89292107069;10772.461376931278;10942.45287735626;8830.91169088301;10149.898501014895;10477.68566942993;10711.678649640524;10772.838407423738;10330.793384132125;10625.468726563486;10776;10800.189985750943;11142.83285750698;7688.11586667518;7716.344110750649;7747.3802095833325;7944.6822127114265;8020.95989520072;9446.716598502057;10310.896891030994;10645.361278323326;10696.251262411557;10715.839262411226 20:25:44 INFO - PROCESS | 1639 | |3;mootools.html;1484.5843163914105;1512.1456377146912;1685.8229885861983;1825.8082901295372;1867.7291792690053;7938.642761075751;8337.082920878698;8357.28963038141;8362.163783621634;8366.498010119398;7274.163471200814;7585.469017168786;7600.847983040336;7848.332891704198;8111.553864537448;2270.7842754938256;2302.792748652621;2306.4925716342377;2307.9960217305525;2308.5267520158327;2292.4154340643113;2311.7572654871165;2329.557384097016;2341.6838726771925;2344.284993077111;2281.1559722902466;2287.736910255317;2311.711036120485;2312.9653055204185;2313.063209400187;2270.3075561953597;2283.5889539882814;2293.415179129311;2296.3225848374605;2302.6776251324827;2212.281008672172;2311.133325003124;2313.5719891820067;2316.027268547214;2316.6177580699164;8225.547594882279;8267.545285009322;8288.129746376664;8290.170982901662;8294.294984926288;4903.754812259373;5072.315237442935;5075.5939524838295;5082;5088.7964481420695;3232.143481977278;3268.150280926976;3454.3436747018236;3521.084518025332;3527.770694904823;1035.6271742172812;1061.888501707325;1072.072657151566;1075.3440401355167;1077.5797438998798;8857.468551886908;10609.416482093482;10770.353778773298;10774.838377424267;10800.5679772809;4377.9781101094295;4495.797689103998;4609.723416595015;4618.0994706032;4619.307103934437;9212.309076819265;9232.815343693088;9236.676716314896;9241.768955776159;9242.630294788134;5145.974270128625;5148.099082660519;5149.510796474329;5149.665271757323;5151.098557752378;4184.378848675077;4268.189044081614;4723.055388922229;4728.05438912219;4742.715437073786;3620.728445366608;3664.4320130379833;3710.703143748494;3740.551133863954;3770.170562476251;1071;1222.3032871263295;1252.1798222164498;1263.0842639086773;1268.492602958824;765.8008917681332;845.1675100026468;902.1880307722971;920.3373571028849;933.4679232837353;4214.557471465513;5462.644928079662;5567.387587365387;5670.886582268332;5694.743736531866;853.7097386888364;917.27535247154;936.2743873497957;961.423146112327;985.2413641496008;3136.5765621641244;3516.7362447816517;3734.2158146788934;3738.925221495555;3787.9242415151543;9507.762305942406;10026.147777438853;10028.899711002943;10032.69901902944;10033.046860548237;9329.16037556623;9859.30984831055;9959.352642078242;9974.202063834875;9979.301448898508;7567.583782891994;7661.540307581563;7662.885056724153;7806.414518911104;7817;4638.234691275901;5556.527695145796;5598.944010559842;5813.854653633693;5926.140709597171;8535.487870727777;8910.242629376575;9269.67556135532;9353.625854965725;9444.763880903032;9285;9389.859152112587;9426.62293508252;9470.526473676151;9533.618655253713;5958.851028724316;6469.5794773339585;6578.309277525982;6911.688973996082;7089.61007144612;7747.651355688895;7847.568383738949;7924.247196516321;7932.960335198287;7936.007999000125;6910.343517365842;6999;7002.614856182959;7038.718451261892;7128.8217794553475;6951.75668851608;6985.476089293425;6992.720291188295;7047.048648432396;7057.188423331178;5503.862403439946;6426.646534440651;6484.1246431731115;6556.18047744032;6557.114789503356;4586.65600080002;4605.378273932976;4624.838130665411;4668.089722504079;4797.832075877328;4757.976210118927;4785.59322457595;4813.927791083207;4855.781489833037;4988.4762099980435 20:25:44 INFO - PROCESS | 1639 | |4;prototype.html;297.1486690631341;302.23232988209935;306.20234289675386;313.3200953929973;314.16275625458155;4566.383538222343;5037.874053148673;5127.948770502047;5156.664816786906;5171.482851714832;3973.562908080109;4107.835686572534;4732.526747325274;4769.642276829243;5041.495850414956;3388.103171788123;3795.335816232155;3934.3114954882926;3947.9143235610295;3963.1875465529497;3891.747036442622;3907.089218532183;3919.6668283195963;3947.802609869495;3975.0658595230097;3435.896923092311;3589.8025608591515;3672.5042119313953;3899.25914076326;3924.8037598120122;3250.30118524516;3291.897214433168;3823.866164684223;3964.1873415949663;3967.563568007517;2831.490331740286;3020.320427903704;3375.1055970167927;3410.4031794436123;3424.630147940819;4071.7760523171214;4377.9343309850055;4874.707517548923;4928.802847886081;4989.276554899556;3459.913502162441;3814.80925953704;4134.4831896013;4265.125649241898;4456.910861782779;4612.423447069116;4796.424429068499;5306.97346513265;5308;5331.786728530854;3663.249033948034;3667.449882517644;3671.8714844980564;3675.0628589709722;3675.4303083022173;4442.9777851111185;4805.486271824399;5320.563447869054;5490.6431081979545;5547.72261386929;3030.787844850883;3628.927421451609;3698.3712768829364;3698.890332900119;3737.3272810893754;3749.7375183736876;3755.2301778135416;3793.8292776824555;3804.896579991827;3812.2375524895133;3617.5839778425816;4373.956260437419;4379.627731642846;4380.386745855582;4396.3185706214945;4620.636912110936;4631.3516107744945;4841.564259216688;5194.506521880416;5333.946660533423;1045.4145678419957;1206.6440400081997;1207.8671346151916;1210.3766560221493;1213.2720367779261;724.5652608435003;775.7284950267361;814.9511029338258;832.4381042796089;843.4264700004056;4275.593818587229;4730.847464403688;4867.6836005660225;5004;5097.643164978416;5481.698506582176;5505.504504594605;5506.174073888868;5525.4474552545225;5538.670719027485;4470.619997300266;4818.542238487338;5041.966396888703;5050.747462626854;5076.644634875597;2305.5388922215625;2765.2948498132846;2768.529350010503;2775.4032882929864;2783.2346104821336;4912.975435122801;5029.673071250357;5466.617336786387;5472.808451704251;5501.689290498;4590.8163673453355;5233.4243233244315;5426.294581704353;5427.348718153847;5444.428335024844;4179.582041795857;4404.9119017620105;4471.776411179493;5047.369078865142;5320;4456.866294011184;4579.450465944108;4862.440819305825;5272.868178295574;5295.391030031596;4627.745473998963;4700.952990470051;5029.622778291569;5072.365954255718;5397.652021370716;4775.594074503706;4957.851264462072;5414.485623865727;5779.422057794187;5780.7398667060925;3138.5762922005238;3701.3707669695677;3754.849806007729;3770.472133901311;3775.4525593789294;4299.9355009674255;5512.448755124456;5591.524720398812;5627;5628.437156284339;5164.896702065863;5430.99053350263;5438.646487978269;5445.292112025411;5498.5876059294915;4856.854294371175;5098.439171691185;5410.322799932033;5426.2674538936735;5435.945640543702;5116.74416279192;5217.852072544034;5273.815416460406;5315.973420132875;5327.547158491571;4227.027783609726;5267.89464210706;5319.734013299242;5367.731613419235;5506.301912063141;4417.359482875029;5347.62030896263;5368.516833485005;5385.73071346439;5397.649152805055 20:25:44 INFO - PROCESS | 1639 | |5;yui.html;639.8432384065904;646.3762469217204;679.633935789064;710.6375748368331;772.4476998945753;14220.217888016168;14713.48502802402;15002.099874007567;15028.774568381483;15606.765898511532;13812.861871381283;14137;14341.06783059103;14356.99501034928;14409.423623055065;811.9188081191893;828.9792755181138;834.4826207751172;837.9203975622337;840.7183593496186;649.1074772188241;664.1996394344827;670.299536983853;818.9017317921857;825.9669613215464;871.7994861181932;887.4497811356936;887.8890138732659;888.9599968001455;892.1168043636785;879.463527248378;880.0539420123393;880.75779160731;881.1144799476549;881.8060026794095;507.2340765444206;520.1158031346725;627.8179327994876;653.085680047932;654.1594051643615;14291.928540357336;14782;14812.925935370362;14834.184119873402;14838.109713417229;12400.7336538938;12580.937095314557;12624.368781560977;12635;13193.670158246025;11883.58407455735;12048.277103373826;12123.696907577292;12657.746845063139;12684.746305073846;4363.214621368153;4392.780360981938;4437.667174961891;4471.28459446487;4614.492405835355;89211;91069.54465227698;91633.54183229042;91644.54177729135;92239;7646.35006024483;10197.643082492226;10538.631147909786;10549.402237176677;10810.675679729464;20476.795232047785;20486.487837804176;20526.589468210554;20533.897330513253;20540.281090161774;7341.926580734124;7493.550386976799;7516.774496765106;7520.924790752022;7593.544387336778;4002.15954649521;4130.896727581774;4154.459920210354;4191.350340697197;4207.705460617789;3144.5754823099046;3264.183954011497;3265.7713960023048;3267.101547074526;3274.2141885947676;612.5528364294001;612.7579606055672;630.3129588748286;640.1613885809604;640.478010421505;497.7361998140991;589.3487696095838;609.8048624440225;610.8228613702065;621.254494606465;8416.621252043551;8417.28453081495;8428.4942903426;8505.02192247887;8687.695930642398;521.6281180495273;525.4456548341536;583;590.9143174239712;599.4604855629881;4021.6983726220064;4128.566500517462;4184.058586818002;4228.386883901817;4231.746095234295;76017;107982;115302;117739.8226017746;121664;100452.49773751084;101196;101423;101758.49120754497;103717;92288;93546.59680104667;93613.59579606312;94196;95425.045749543;7854;7931.249221571802;8017.6770832811935;8182.7954301142945;8203.958980205061;56294.71852640711;57256.86131640203;57385;57506.84986300167;58986;50526.747366262935;52985.94028119493;68561;70063;76952.61523692346;11925.522979080739;12127.151099422956;12128.757424851277;12431.378431078228;12463.376831158586;12822.358882056047;13366.198028118344;13507;13912.373943172784;14313.57059288223;12868.099233053596;12984;13004;13083.41124649412;13157.27634980047;10648.627298044532;12723.363831808558;12765.680857978254;12812.679683008;12893.097483176087;12062.638120856389;12326.81509777372;12510.812337814757;12544.811827822772;12842.807357889826;8665.566721664018;10188.898111018794;10765.40790256512;11109.888901110886;11590.768184636428;8445.652227913153;10782.137429005817;10976.725581860517;11034;11325.263857849213 20:25:44 INFO - PROCESS | 1639 | __end_tp_report 20:25:44 INFO - PROCESS | 1639 | __start_cc_report 20:25:44 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1602 20:25:44 INFO - PROCESS | 1639 | __end_cc_report 20:25:44 INFO - PROCESS | 1639 | __startTimestamp1479788744155__endTimestamp 20:25:44 INFO - PROCESS | 1639 | 20:25:44 INFO - PROCESS | 1639 | ------- Summary: start ------- 20:25:44 INFO - PROCESS | 1639 | Number of tests: 6 20:25:44 INFO - PROCESS | 1639 | 20:25:44 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5562.50 Median:5705.71 stddev:634.05 (11.1%) stddev-sans-first:608.87 20:25:44 INFO - PROCESS | 1639 | Values: 3223.7 3263.3 3275.8 3314.7 3317.6 5387.9 5475.5 5479.8 5595.9 5597.3 5500.2 5517.0 5590.7 5594.7 5623.3 5014.4 5034.9 5035.8 5083.7 5104.3 5089.8 5172.5 5192.0 5218.5 5241.0 4971.7 5097.4 5109.2 5134.2 5197.0 5018.2 5076.6 5100.1 5106.3 5109.9 4992.9 5051.8 5070.7 5071.6 5071.6 5445.6 5471.2 5478.4 5501.8 5506.7 6070.8 6089.8 6093.3 6103.4 6120.8 5017.3 6167.5 6168.9 6170.0 6172.7 5529.5 5535.7 5582.6 5597.2 5681.4 6161.7 6221.4 6247.0 6265.8 6295.0 5975.1 6005.0 6006.0 6020.2 6033.5 5941.6 6124.8 6144.7 6155.7 6155.9 5150.9 5872.1 5917.9 5956.6 6032.0 6034.4 6057.5 6102.0 6121.7 6140.7 4300.7 4842.3 4842.3 4863.3 4905.9 4246.7 4286.3 4315.2 4322.8 4359.4 5517.2 5568.2 5575.6 5588.9 5600.5 6025.5 6059.2 6060.8 6063.3 6064.5 5563.7 5581.7 5597.7 5600.9 5611.0 5237.3 5246.2 5267.1 5274.4 5275.1 6239.9 6263.7 6271.6 6273.5 6278.4 4623.3 6020.6 6064.1 6079.9 6082.3 6221.5 6314.7 6316.9 6330.4 6334.7 5748.5 5836.6 5968.9 6007.7 6021.4 5783.5 5937.9 5970.0 5972.4 5977.6 5757.5 5789.2 5799.9 5810.2 5815.9 5160.5 5705.7 5771.7 5791.6 5896.9 5794.8 5801.9 5833.2 5837.5 5842.4 5824.5 5917.2 5928.4 5934.1 5942.3 4739.5 5574.2 5633.4 5749.7 5788.8 20:25:44 INFO - PROCESS | 1639 | 20:25:44 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:71590.09 Median:19073.01 stddev:166557.53 (873.3%) stddev-sans-first:166939.14 20:25:44 INFO - PROCESS | 1639 | Values: 456.0 481.6 518.0 530.5 550.3 29763.4 38487.8 39781.6 39866.0 39911.8 40538.6 41083.0 41137.6 41142.0 41167.4 8371.5 9190.3 9369.4 9377.9 9383.0 8383.4 8548.3 8550.0 8554.7 10978.7 11057.2 11243.6 11278.4 11288.8 11309.8 11177.8 11226.8 11239.2 11257.2 11279.8 11032.3 11118.4 11122.4 11125.8 11131.3 38036.6 38390.8 38406.2 38441.8 38515.4 2937.1 3032.7 3347.4 3492.9 3504.7 23585.0 28796.9 29668.9 29987.4 30843.0 2884.3 3181.1 3181.3 3199.6 3296.5 486618.0 486784.0 489746.0 490482.0 491106.0 32453.8 59898.5 60515.0 60524.4 60525.5 32836.0 33542.0 34424.8 34642.0 34653.1 14123.9 14261.6 14287.2 14305.6 14313.1 12080.2 12139.6 12139.9 12147.7 12149.5 7138.6 7319.1 7333.4 7681.4 7742.6 3089.9 3125.4 3182.2 3271.4 3290.3 909.9 939.4 943.8 1019.8 1038.6 27954.0 28629.9 29044.6 29225.3 29381.4 1042.3 1043.4 1051.6 1072.4 1079.9 12694.4 14504.9 14839.0 15069.1 15298.9 652267.0 654999.0 655736.0 656196.0 656934.0 50598.7 51770.5 51892.2 55001.4 55506.0 1319.3 1350.5 1360.1 1372.8 1374.4 29646.9 30146.8 30468.5 30726.0 30852.5 48927.5 49385.0 49414.5 49491.0 49519.0 572401.0 574771.0 578686.0 834862.0 850566.0 38891.8 39044.0 39184.8 39481.2 39550.0 43880.3 44447.3 44681.3 44737.0 44899.9 29742.0 34088.5 36983.8 37994.6 38416.8 33492.7 35641.5 36508.0 36715.4 36775.0 35343.0 36146.3 36658.8 36982.6 36995.7 29039.0 29906.3 30534.0 30617.5 30700.5 19753.8 19822.9 19831.6 19855.8 19934.0 20:25:44 INFO - PROCESS | 1639 | 20:25:44 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:31730.68 Median:395.88 stddev:90343.50 (22821.1%) stddev-sans-first:90566.10 20:25:44 INFO - PROCESS | 1639 | Values: 296.5 361.7 367.5 369.9 396.3 14362.2 14608.1 15637.7 19852.4 19932.0 18516.2 18954.0 19159.6 19369.8 19469.5 5654.5 5888.2 5890.3 5893.7 5894.6 4056.9 5593.4 5709.3 5754.7 5800.1 4271.6 4320.5 6096.8 6417.1 6423.5 6269.8 6414.9 6434.6 6474.3 6480.4 5547.4 5583.4 5587.9 5589.9 5593.1 22789.9 23856.8 23870.4 23983.5 24310.6 2312.6 2354.4 2410.4 2810.6 3091.5 14508.2 14792.9 14804.0 14823.8 14890.1 1797.4 1812.4 1917.4 1947.2 1948.9 101632.5 111603.0 112607.3 113707.0 116955.8 9498.0 9583.0 9897.0 10085.5 10146.3 12932.3 12956.5 12967.2 12983.3 12983.8 7855.3 8112.4 8147.9 8239.1 8290.6 8141.6 8167.7 8221.8 8303.0 8338.5 5132.4 6145.7 6271.8 6313.4 6402.5 1777.6 1817.3 1817.9 1818.3 1824.1 364.9 686.4 952.9 991.9 1002.3 10744.4 11032.2 11164.3 11510.7 11773.3 395.4 412.7 418.0 421.0 438.1 5817.3 5821.0 5858.8 5983.3 6004.6 473707.0 521610.0 551921.0 563734.0 574986.0 90999.0 129639.0 129888.0 133450.0 138586.0 437.7 442.6 447.5 447.8 448.2 9982.9 10429.6 10565.0 10712.7 10764.1 36549.5 37092.6 39250.8 44774.6 50036.0 71844.6 73059.0 73375.6 76306.6 78197.0 7564.3 7772.9 7856.7 7891.1 7929.8 9999.5 11227.0 11451.3 12191.3 12611.6 9088.5 10482.5 10707.9 10772.5 10942.5 8830.9 10149.9 10477.7 10711.7 10772.8 10330.8 10625.5 10776.0 10800.2 11142.8 7688.1 7716.3 7747.4 7944.7 8021.0 9446.7 10310.9 10645.4 10696.3 10715.8 20:25:44 INFO - PROCESS | 1639 | 20:25:44 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5337.51 Median:5147.04 stddev:2909.56 (56.5%) stddev-sans-first:2903.31 20:25:44 INFO - PROCESS | 1639 | Values: 1484.6 1512.1 1685.8 1825.8 1867.7 7938.6 8337.1 8357.3 8362.2 8366.5 7274.2 7585.5 7600.8 7848.3 8111.6 2270.8 2302.8 2306.5 2308.0 2308.5 2292.4 2311.8 2329.6 2341.7 2344.3 2281.2 2287.7 2311.7 2313.0 2313.1 2270.3 2283.6 2293.4 2296.3 2302.7 2212.3 2311.1 2313.6 2316.0 2316.6 8225.5 8267.5 8288.1 8290.2 8294.3 4903.8 5072.3 5075.6 5082.0 5088.8 3232.1 3268.2 3454.3 3521.1 3527.8 1035.6 1061.9 1072.1 1075.3 1077.6 8857.5 10609.4 10770.4 10774.8 10800.6 4378.0 4495.8 4609.7 4618.1 4619.3 9212.3 9232.8 9236.7 9241.8 9242.6 5146.0 5148.1 5149.5 5149.7 5151.1 4184.4 4268.2 4723.1 4728.1 4742.7 3620.7 3664.4 3710.7 3740.6 3770.2 1071.0 1222.3 1252.2 1263.1 1268.5 765.8 845.2 902.2 920.3 933.5 4214.6 5462.6 5567.4 5670.9 5694.7 853.7 917.3 936.3 961.4 985.2 3136.6 3516.7 3734.2 3738.9 3787.9 9507.8 10026.1 10028.9 10032.7 10033.0 9329.2 9859.3 9959.4 9974.2 9979.3 7567.6 7661.5 7662.9 7806.4 7817.0 4638.2 5556.5 5598.9 5813.9 5926.1 8535.5 8910.2 9269.7 9353.6 9444.8 9285.0 9389.9 9426.6 9470.5 9533.6 5958.9 6469.6 6578.3 6911.7 7089.6 7747.7 7847.6 7924.2 7933.0 7936.0 6910.3 6999.0 7002.6 7038.7 7128.8 6951.8 6985.5 6992.7 7047.0 7057.2 5503.9 6426.6 6484.1 6556.2 6557.1 4586.7 4605.4 4624.8 4668.1 4797.8 4758.0 4785.6 4813.9 4855.8 4988.5 20:25:44 INFO - PROCESS | 1639 | 20:25:44 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4238.90 Median:4666.15 stddev:1307.71 (28.0%) stddev-sans-first:1277.47 20:25:44 INFO - PROCESS | 1639 | Values: 297.1 302.2 306.2 313.3 314.2 4566.4 5037.9 5127.9 5156.7 5171.5 3973.6 4107.8 4732.5 4769.6 5041.5 3388.1 3795.3 3934.3 3947.9 3963.2 3891.7 3907.1 3919.7 3947.8 3975.1 3435.9 3589.8 3672.5 3899.3 3924.8 3250.3 3291.9 3823.9 3964.2 3967.6 2831.5 3020.3 3375.1 3410.4 3424.6 4071.8 4377.9 4874.7 4928.8 4989.3 3459.9 3814.8 4134.5 4265.1 4456.9 4612.4 4796.4 5307.0 5308.0 5331.8 3663.2 3667.4 3671.9 3675.1 3675.4 4443.0 4805.5 5320.6 5490.6 5547.7 3030.8 3628.9 3698.4 3698.9 3737.3 3749.7 3755.2 3793.8 3804.9 3812.2 3617.6 4374.0 4379.6 4380.4 4396.3 4620.6 4631.4 4841.6 5194.5 5333.9 1045.4 1206.6 1207.9 1210.4 1213.3 724.6 775.7 815.0 832.4 843.4 4275.6 4730.8 4867.7 5004.0 5097.6 5481.7 5505.5 5506.2 5525.4 5538.7 4470.6 4818.5 5042.0 5050.7 5076.6 2305.5 2765.3 2768.5 2775.4 2783.2 4913.0 5029.7 5466.6 5472.8 5501.7 4590.8 5233.4 5426.3 5427.3 5444.4 4179.6 4404.9 4471.8 5047.4 5320.0 4456.9 4579.5 4862.4 5272.9 5295.4 4627.7 4701.0 5029.6 5072.4 5397.7 4775.6 4957.9 5414.5 5779.4 5780.7 3138.6 3701.4 3754.8 3770.5 3775.5 4299.9 5512.4 5591.5 5627.0 5628.4 5164.9 5431.0 5438.6 5445.3 5498.6 4856.9 5098.4 5410.3 5426.3 5435.9 5116.7 5217.9 5273.8 5316.0 5327.5 4227.0 5267.9 5319.7 5367.7 5506.3 4417.4 5347.6 5368.5 5385.7 5397.6 20:25:44 INFO - PROCESS | 1639 | 20:25:44 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20722.63 Median:4297.48 stddev:30878.37 (718.5%) stddev-sans-first:30928.17 20:25:44 INFO - PROCESS | 1639 | Values: 639.8 646.4 679.6 710.6 772.4 14220.2 14713.5 15002.1 15028.8 15606.8 13812.9 14137.0 14341.1 14357.0 14409.4 811.9 829.0 834.5 837.9 840.7 649.1 664.2 670.3 818.9 826.0 871.8 887.4 887.9 889.0 892.1 879.5 880.1 880.8 881.1 881.8 507.2 520.1 627.8 653.1 654.2 14291.9 14782.0 14812.9 14834.2 14838.1 12400.7 12580.9 12624.4 12635.0 13193.7 11883.6 12048.3 12123.7 12657.7 12684.7 4363.2 4392.8 4437.7 4471.3 4614.5 89211.0 91069.5 91633.5 91644.5 92239.0 7646.4 10197.6 10538.6 10549.4 10810.7 20476.8 20486.5 20526.6 20533.9 20540.3 7341.9 7493.6 7516.8 7520.9 7593.5 4002.2 4130.9 4154.5 4191.4 4207.7 3144.6 3264.2 3265.8 3267.1 3274.2 612.6 612.8 630.3 640.2 640.5 497.7 589.3 609.8 610.8 621.3 8416.6 8417.3 8428.5 8505.0 8687.7 521.6 525.4 583.0 590.9 599.5 4021.7 4128.6 4184.1 4228.4 4231.7 76017.0 107982.0 115302.0 117739.8 121664.0 100452.5 101196.0 101423.0 101758.5 103717.0 92288.0 93546.6 93613.6 94196.0 95425.0 7854.0 7931.2 8017.7 8182.8 8204.0 56294.7 57256.9 57385.0 57506.8 58986.0 50526.7 52985.9 68561.0 70063.0 76952.6 11925.5 12127.2 12128.8 12431.4 12463.4 12822.4 13366.2 13507.0 13912.4 14313.6 12868.1 12984.0 13004.0 13083.4 13157.3 10648.6 12723.4 12765.7 12812.7 12893.1 12062.6 12326.8 12510.8 12544.8 12842.8 8665.6 10188.9 10765.4 11109.9 11590.8 8445.7 10782.1 10976.7 11034.0 11325.3 20:25:44 INFO - PROCESS | 1639 | -------- Summary: end -------- 20:25:44 INFO - PROCESS | 1639 | 20:25:44 INFO - TEST-INFO | 1639: exit 0 20:25:44 INFO - TEST-OK | dromaeo_css | took 1120663ms 20:25:44 INFO - TEST-START | kraken 20:25:44 INFO - operating with platform_type : mac_ 20:25:44 INFO - Initialising browser for kraken test... 20:25:44 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpfJcyjX/profile http://localhost:49239/getInfo.html) 20:25:47 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 20:25:47 INFO - PROCESS | 1649 | colorDepth:24 20:25:47 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 20:25:47 INFO - PROCESS | 1649 | __metrics 20:25:47 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:25:47 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:25:48 INFO - TEST-INFO | 1649: exit 0 20:25:48 INFO - Browser initialized. 20:25:48 INFO - Running cycle 1/1 for kraken test... 20:25:48 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpfJcyjX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:01 INFO - PROCESS | 1650 | RSS: Main: 236498944 20:26:01 INFO - PROCESS | 1650 | 20:26:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:04 INFO - PROCESS | 1650 | RSS: Main: 294309888 20:26:04 INFO - PROCESS | 1650 | 20:26:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 20:26:08 INFO - PROCESS | 1650 | RSS: Main: 296636416 20:26:08 INFO - PROCESS | 1650 | 20:26:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 20:26:12 INFO - PROCESS | 1650 | RSS: Main: 383102976 20:26:12 INFO - PROCESS | 1650 | 20:26:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 20:26:14 INFO - PROCESS | 1650 | RSS: Main: 288038912 20:26:14 INFO - PROCESS | 1650 | 20:26:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:17 INFO - PROCESS | 1650 | RSS: Main: 292724736 20:26:17 INFO - PROCESS | 1650 | 20:26:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:21 INFO - PROCESS | 1650 | RSS: Main: 335417344 20:26:21 INFO - PROCESS | 1650 | 20:26:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:24 INFO - PROCESS | 1650 | RSS: Main: 335745024 20:26:24 INFO - PROCESS | 1650 | 20:26:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 20:26:28 INFO - PROCESS | 1650 | RSS: Main: 332488704 20:26:28 INFO - PROCESS | 1650 | 20:26:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:30 INFO - PROCESS | 1650 | RSS: Main: 309252096 20:26:30 INFO - PROCESS | 1650 | 20:26:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:32 INFO - PROCESS | 1650 | RSS: Main: 311934976 20:26:32 INFO - PROCESS | 1650 | 20:26:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:35 INFO - PROCESS | 1650 | RSS: Main: 314294272 20:26:35 INFO - PROCESS | 1650 | 20:26:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:39 INFO - PROCESS | 1650 | RSS: Main: 330125312 20:26:39 INFO - PROCESS | 1650 | 20:26:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:43 INFO - PROCESS | 1650 | RSS: Main: 324112384 20:26:43 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 20:26:45 INFO - PROCESS | 1650 | RSS: Main: 367288320 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | __start_tp_report 20:26:45 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 20:26:45 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 20:26:45 INFO - PROCESS | 1650 | |i|pagename|runs| 20:26:45 INFO - PROCESS | 1650 | |0;ai-astar;104;114;116;114;114;115;114;114;114;115 20:26:45 INFO - PROCESS | 1650 | |1;audio-beat-detection;147;113;116;152;121;118;112;113;143;111 20:26:45 INFO - PROCESS | 1650 | |2;audio-dft;183;180;182;199;264;184;181;184;201;203 20:26:45 INFO - PROCESS | 1650 | |3;audio-fft;82;58;59;87;60;60;59;58;83;58 20:26:45 INFO - PROCESS | 1650 | |4;audio-oscillator;88;70;91;70;66;68;93;98;82;92 20:26:45 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;87;84;86;84;86;83;86;83;86;83 20:26:45 INFO - PROCESS | 1650 | |6;imaging-darkroom;93;92;93;92;103;93;93;93;93;92 20:26:45 INFO - PROCESS | 1650 | |7;imaging-desaturate;139;84;88;84;83;114;85;86;87;85 20:26:45 INFO - PROCESS | 1650 | |8;json-parse-financial;54;53;54;52;54;55;55;55;55;54 20:26:45 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;66;77;65;75;74;69;71;71;70;71 20:26:45 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;92;102;89;91;91;100;113;113;91;89 20:26:45 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;150;150;147;149;145;142;184;159;218;163 20:26:45 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;173;175;171;172;172;174;174;173;172;172 20:26:45 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;68;70;79;93;92;90;90;66;67 20:26:45 INFO - PROCESS | 1650 | __end_tp_report 20:26:45 INFO - PROCESS | 1650 | __start_cc_report 20:26:45 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2066 20:26:45 INFO - PROCESS | 1650 | __end_cc_report 20:26:45 INFO - PROCESS | 1650 | __startTimestamp1479788805418__endTimestamp 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | ------- Summary: start ------- 20:26:45 INFO - PROCESS | 1650 | Number of tests: 14 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:3.37 (3.0%) stddev-sans-first:0.73 20:26:45 INFO - PROCESS | 1650 | Values: 104.0 114.0 116.0 114.0 114.0 115.0 114.0 114.0 114.0 115.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:119.50 stddev:16.11 (13.5%) stddev-sans-first:14.90 20:26:45 INFO - PROCESS | 1650 | Values: 147.0 113.0 116.0 152.0 121.0 118.0 112.0 113.0 143.0 111.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:196.10 Median:191.50 stddev:25.48 (13.3%) stddev-sans-first:26.58 20:26:45 INFO - PROCESS | 1650 | Values: 183.0 180.0 182.0 199.0 264.0 184.0 181.0 184.0 201.0 203.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:66.40 Median:60.00 stddev:12.23 (20.4%) stddev-sans-first:11.60 20:26:45 INFO - PROCESS | 1650 | Values: 82.0 58.0 59.0 87.0 60.0 60.0 59.0 58.0 83.0 58.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:89.50 stddev:12.17 (13.6%) stddev-sans-first:12.70 20:26:45 INFO - PROCESS | 1650 | Values: 88.0 70.0 91.0 70.0 66.0 68.0 93.0 98.0 82.0 92.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:84.80 Median:86.00 stddev:1.55 (1.8%) stddev-sans-first:1.42 20:26:45 INFO - PROCESS | 1650 | Values: 87.0 84.0 86.0 84.0 86.0 83.0 86.0 83.0 86.0 83.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:93.00 stddev:3.30 (3.6%) stddev-sans-first:3.49 20:26:45 INFO - PROCESS | 1650 | Values: 93.0 92.0 93.0 92.0 103.0 93.0 93.0 93.0 93.0 92.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:85.00 stddev:18.42 (21.7%) stddev-sans-first:9.71 20:26:45 INFO - PROCESS | 1650 | Values: 139.0 84.0 88.0 84.0 83.0 114.0 85.0 86.0 87.0 85.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:0.99 (1.8%) stddev-sans-first:1.05 20:26:45 INFO - PROCESS | 1650 | Values: 54.0 53.0 54.0 52.0 54.0 55.0 55.0 55.0 55.0 54.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:3.75 (5.3%) stddev-sans-first:3.54 20:26:45 INFO - PROCESS | 1650 | Values: 66.0 77.0 65.0 75.0 74.0 69.0 71.0 71.0 70.0 71.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:97.10 Median:90.00 stddev:9.47 (10.5%) stddev-sans-first:9.86 20:26:45 INFO - PROCESS | 1650 | Values: 92.0 102.0 89.0 91.0 91.0 100.0 113.0 113.0 91.0 89.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:160.70 Median:154.50 stddev:23.53 (15.2%) stddev-sans-first:24.64 20:26:45 INFO - PROCESS | 1650 | Values: 150.0 150.0 147.0 149.0 145.0 142.0 184.0 159.0 218.0 163.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.00 stddev:1.23 (0.7%) stddev-sans-first:1.30 20:26:45 INFO - PROCESS | 1650 | Values: 173.0 175.0 171.0 172.0 172.0 174.0 174.0 173.0 172.0 172.0 20:26:45 INFO - PROCESS | 1650 | 20:26:45 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:84.50 stddev:11.83 (14.0%) stddev-sans-first:11.83 20:26:45 INFO - PROCESS | 1650 | Values: 67.0 68.0 70.0 79.0 93.0 92.0 90.0 90.0 66.0 67.0 20:26:45 INFO - PROCESS | 1650 | -------- Summary: end -------- 20:26:45 INFO - PROCESS | 1650 | 20:26:46 INFO - TEST-INFO | 1650: exit 0 20:26:46 INFO - TEST-OK | kraken | took 61857ms 20:26:46 INFO - SUITE-END | took 1182s 20:26:47 INFO - Completed test suite (00:19:42) 20:26:47 INFO - javascript benchmark 20:26:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3223.661515540868, 3263.314703912178, 3275.7706960512774, 3314.651961544038, 3317.5521304623867, 5387.919181212285, 5475.4524547545225, 5479.835604931854, 5595.944040559598, 5597.2723545939025, 5500.22996780451, 5517.006938751023, 5590.720463976805, 5594.664320140794, 5623.297087864017, 5014.398272207322, 5034.949650503503, 5035.84892453227, 5083.745812709368, 5104.285400043997, 5089.84730458085, 5172.456892026339, 5192.0, 5218.530332270095, 5241.0, 4971.726555039471, 5097.388313402378, 5109.156989096795, 5134.229865520183, 5197.0, 5018.197088465864, 5076.568491678212, 5100.107481190814, 5106.285120083191, 5109.948900511022, 4992.87517812054, 5051.772670229849, 5070.69575825448, 5071.594272458231, 5071.619628527875, 5445.591580631429, 5471.151971444432, 5478.424765399655, 5501.779928802843, 5506.669599824023, 6070.817875463743, 6089.847753806191, 6093.299270583895, 6103.398280005542, 6120.816375508742, 5017.322661440695, 6167.537434692371, 6168.87662246757, 6170.043643235305, 6172.660503672296, 5529.529989950819, 5535.6955367454375, 5582.581306402036, 5597.160425936101, 5681.375048744635, 6161.7227224775, 6221.440070393686, 6246.968765156145, 6265.780697675651, 6294.968525157345, 5975.133605627159, 6004.969975150097, 6005.961028651938, 6020.187274717857, 6033.547483938634, 5941.554383421174, 6124.816255512342, 6144.692765361714, 6155.72299246526, 6155.938440615626, 5150.896982060338, 5872.148538461899, 5917.940820591825, 5956.583039187302, 6032.0, 6034.366391528826, 6057.545684073624, 6101.969490152521, 6121.696863452088, 6140.6929653517145, 4300.741955482618, 4842.322074909515, 4842.322074909515, 4863.294822250754, 4905.9018819624125, 4246.681498887596, 4286.292761694348, 4315.244832154361, 4322.783860806947, 4359.411479450297, 5517.172424136332, 5568.192612071308, 5575.581831362664, 5588.86027849307, 5600.4959553639555, 6025.487833534111, 6059.1820104286235, 6060.787872424532, 6063.333033366326, 6064.4845188158615, 5563.749631266603, 5581.720913954286, 5597.74810133545, 5600.859978500489, 5611.046122159243, 5237.319148510745, 5246.23929530216, 5267.051930652443, 5274.3670759509105, 5275.050490911673, 6239.906401403982, 6263.655498947511, 6271.560990730787, 6273.498120150468, 6278.372162783777, 4623.283391074388, 6020.578559500793, 6064.090386441892, 6079.939200607937, 6082.300535438304, 6221.502279817694, 6314.684265786784, 6316.936830631635, 6330.430261276507, 6334.651594162181, 5748.45389687979, 5836.591438599257, 5968.880622387441, 6007.729652165575, 6021.42796434338, 5783.537317014713, 5937.851553711192, 5969.970150149222, 5972.402759723993, 5977.551683623658, 5757.5393968481585, 5789.247397838254, 5799.94200057994, 5810.215620891126, 5815.883682326245, 5160.458151893997, 5705.714714264187, 5771.7402716877, 5791.623544469765, 5896.852578685567, 5794.797182098607, 5801.94198058014, 5833.212516310244, 5837.474627283565, 5842.357340692435, 5824.5340372770925, 5917.230760001345, 5928.436798504135, 5934.109883517507, 5942.286925568959, 4739.454962679336, 5574.247476590608, 5633.4084921082695, 5749.655020698771, 5788.82633520995], "value": 5523.124427986464, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.9772011399429, 481.566590068938, 518.0157700369298, 530.4827792901918, 550.2846299810245, 29763.40473190535, 38487.84536463907, 39781.60218397815, 39866.0, 39911.802645920594, 40538.59461405385, 41082.97292567687, 41137.58862411375, 41141.97145071375, 41167.38248926269, 8371.539565323936, 9190.31072669549, 9369.390989585689, 9377.859332110023, 9382.953085234565, 8383.413161078726, 8548.316134709208, 8549.95725021374, 8554.657813687445, 10978.670639880816, 11057.225994180411, 11243.60647377342, 11278.379689117095, 11288.774224515504, 11309.830352544719, 11177.776444471107, 11226.775464490745, 11239.157063220291, 11257.211995160342, 11279.830802537968, 11032.28290161137, 11118.444077796159, 11122.388268645222, 11125.833112503238, 11131.276467029616, 38036.61963380359, 38390.80804595987, 38406.23187536262, 38441.80779096087, 38515.42226866599, 2937.074821431264, 3032.7270545651, 3347.364000839857, 3492.8952131435844, 3504.667056629616, 23585.0, 28796.856015719786, 29668.8516557418, 29987.400251995055, 30843.0, 2884.2500949753007, 3181.125190572588, 3181.2683082891062, 3199.6480387157394, 3296.456084746014, 486618.0, 486784.0, 489746.0, 490482.0, 491106.0, 32453.837730811196, 59898.50253743604, 60515.0, 60524.39475605276, 60525.48686282878, 32836.0, 33542.0, 34424.82787586096, 34642.0, 34653.13367165841, 14123.858761412459, 14261.572152835432, 14287.214203218922, 14305.64235894111, 14313.069650472895, 12080.154389192672, 12139.635810925687, 12139.939300303442, 12147.696307592381, 12149.453274602663, 7138.571685698875, 7319.085114360705, 7333.376662983599, 7681.3854891608535, 7742.61286935651, 3089.938201235963, 3125.4374212641487, 3182.2362632968384, 3271.4275001874576, 3290.2596915693775, 909.9272058235325, 939.3800091939287, 943.7546237978175, 1019.8062368150028, 1038.6053299746047, 27954.0, 28629.856850715612, 29044.596151257087, 29225.269368265963, 29381.412371752445, 1042.259995403257, 1043.4261156363968, 1051.6476980211562, 1072.3940973350032, 1079.9028087472166, 12694.42875070624, 14504.85495145035, 14838.961272710807, 15069.09585424878, 15298.923505382625, 652267.0, 654999.0, 655736.0, 656196.0, 656934.0, 50598.74700626473, 51770.48229517732, 51892.22161667578, 55001.44998550043, 55506.0, 1319.2743990805018, 1350.4868150103096, 1360.1091285208204, 1372.835259768834, 1374.415873253883, 29646.851765741034, 30146.84926575353, 30468.542971854997, 30726.0, 30852.53721194139, 48927.51072489372, 49385.0, 49414.50585494099, 49491.0, 49519.0, 572401.0, 574771.0, 578686.0, 834862.0, 850566.0, 38891.80554097211, 39044.0, 39184.80407597944, 39481.2103757929, 39550.0, 43880.34179487374, 44447.33329000132, 44681.32978005268, 44737.0, 44899.877503062686, 29742.025797420083, 34088.48867266943, 36983.8150809255, 37994.620053800216, 38416.80791596024, 33492.66507334895, 35641.46537801883, 36508.0, 36715.44926826153, 36775.0, 35343.0, 36146.27707445784, 36658.816705917365, 36982.63017369792, 36995.70515031961, 29039.0, 29906.252343691584, 30534.0, 30617.54073688852, 30700.53949190719, 19753.80246197577, 19822.90088549548, 19831.60336793285, 19855.801441985972, 19934.0], "value": 18455.769143250527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.5137175032945, 361.7323180846174, 367.54608059047086, 369.8502106646808, 396.34602905206407, 14362.196230410418, 14608.050476719005, 15637.687246255082, 19852.40442786715, 19932.0, 18516.166772495235, 18954.0, 19159.61680766384, 19369.806301936977, 19469.513262168453, 5654.547636189095, 5888.175655408247, 5890.3226128995075, 5893.705314734268, 5894.557908156906, 4056.9391459128137, 5593.440655934394, 5709.286339207599, 5754.683492407916, 5800.100984347412, 4271.6155546000855, 4320.524742278347, 6096.847578810521, 6417.101605775172, 6423.4861211103, 6269.780557680459, 6414.880615256186, 6434.646094464802, 6474.255460622042, 6480.416762491398, 5547.389787123413, 5583.4137415571595, 5587.916181257285, 5589.916151257735, 5593.133064375028, 22789.886050569807, 23856.76143238563, 23870.403239918967, 23983.52032959331, 24310.635340469908, 2312.6415405612156, 2354.446705024318, 2410.433548116191, 2810.6486689163853, 3091.520814273791, 14508.202048887308, 14792.852071479256, 14804.0, 14823.77764333536, 14890.106593604418, 1797.4068557376036, 1812.392848395789, 1917.4151883675474, 1947.221111555375, 1948.9475683131093, 101632.47551286737, 111603.0, 112607.31089033671, 113707.0, 116955.83044169535, 9498.0, 9582.952085239529, 9897.0, 10085.546150423248, 10146.289759716896, 12932.288724120075, 12956.546520871725, 12967.157134786208, 12983.285919274342, 12983.805242921364, 7855.253750893656, 8112.391570632226, 8147.918520814835, 8239.134890836376, 8290.585470726439, 8141.552214628134, 8167.714130005421, 8221.753347399588, 8303.04514980785, 8338.498450464836, 5132.384113906355, 6145.692715364214, 6271.78048768291, 6313.3686631336495, 6402.455791257702, 1777.5911540345792, 1817.3457555280088, 1817.8636602254883, 1818.2726909236412, 1824.1153040775214, 364.8668236093807, 686.4028295383049, 952.8665986761858, 991.945443000642, 1002.3334482569155, 10744.356527231348, 11032.172587056002, 11164.274322169196, 11510.654680359603, 11773.293602383885, 395.40688966550175, 412.65955586641144, 418.046853174762, 421.044229598809, 438.1368703653797, 5817.3019237690905, 5821.010428227211, 5858.765649373977, 5983.341832398432, 6004.579679422486, 473707.0, 521610.0, 551921.0, 563734.0, 574986.0, 90999.0, 129639.0, 129888.0, 133450.0, 138586.0, 437.72642098688317, 442.5950255516231, 447.54350562426794, 447.7805875121167, 448.19996306593225, 9982.850257246002, 10429.582816687247, 10565.0, 10712.73218169552, 10764.138868890313, 36549.45175822311, 37092.629073708915, 39250.80374598223, 44774.552254477036, 50036.0, 71844.64077679579, 73059.0, 73375.63312183405, 76306.61846690731, 78197.0, 7564.319211271012, 7772.92227077722, 7856.7250146244605, 7891.053073631201, 7929.801754956172, 9999.450030248407, 11227.0, 11451.312921224753, 12191.293218949531, 12611.621651350475, 9088.54557272147, 10482.475876206312, 10707.89292107069, 10772.461376931278, 10942.45287735626, 8830.91169088301, 10149.898501014895, 10477.68566942993, 10711.678649640524, 10772.838407423738, 10330.793384132125, 10625.468726563486, 10776.0, 10800.189985750943, 11142.83285750698, 7688.11586667518, 7716.344110750649, 7747.3802095833325, 7944.6822127114265, 8020.95989520072, 9446.716598502057, 10310.896891030994, 10645.361278323326, 10696.251262411557, 10715.839262411226], "value": 8445.699868175256, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.5843163914105, 1512.1456377146912, 1685.8229885861983, 1825.8082901295372, 1867.7291792690053, 7938.642761075751, 8337.082920878698, 8357.28963038141, 8362.163783621634, 8366.498010119398, 7274.163471200814, 7585.469017168786, 7600.847983040336, 7848.332891704198, 8111.553864537448, 2270.7842754938256, 2302.792748652621, 2306.4925716342377, 2307.9960217305525, 2308.5267520158327, 2292.4154340643113, 2311.7572654871165, 2329.557384097016, 2341.6838726771925, 2344.284993077111, 2281.1559722902466, 2287.736910255317, 2311.711036120485, 2312.9653055204185, 2313.063209400187, 2270.3075561953597, 2283.5889539882814, 2293.415179129311, 2296.3225848374605, 2302.6776251324827, 2212.281008672172, 2311.133325003124, 2313.5719891820067, 2316.027268547214, 2316.6177580699164, 8225.547594882279, 8267.545285009322, 8288.129746376664, 8290.170982901662, 8294.294984926288, 4903.754812259373, 5072.315237442935, 5075.5939524838295, 5082.0, 5088.7964481420695, 3232.143481977278, 3268.150280926976, 3454.3436747018236, 3521.084518025332, 3527.770694904823, 1035.6271742172812, 1061.888501707325, 1072.072657151566, 1075.3440401355167, 1077.5797438998798, 8857.468551886908, 10609.416482093482, 10770.353778773298, 10774.838377424267, 10800.5679772809, 4377.9781101094295, 4495.797689103998, 4609.723416595015, 4618.0994706032, 4619.307103934437, 9212.309076819265, 9232.815343693088, 9236.676716314896, 9241.768955776159, 9242.630294788134, 5145.974270128625, 5148.099082660519, 5149.510796474329, 5149.665271757323, 5151.098557752378, 4184.378848675077, 4268.189044081614, 4723.055388922229, 4728.05438912219, 4742.715437073786, 3620.728445366608, 3664.4320130379833, 3710.703143748494, 3740.551133863954, 3770.170562476251, 1071.0, 1222.3032871263295, 1252.1798222164498, 1263.0842639086773, 1268.492602958824, 765.8008917681332, 845.1675100026468, 902.1880307722971, 920.3373571028849, 933.4679232837353, 4214.557471465513, 5462.644928079662, 5567.387587365387, 5670.886582268332, 5694.743736531866, 853.7097386888364, 917.27535247154, 936.2743873497957, 961.423146112327, 985.2413641496008, 3136.5765621641244, 3516.7362447816517, 3734.2158146788934, 3738.925221495555, 3787.9242415151543, 9507.762305942406, 10026.147777438853, 10028.899711002943, 10032.69901902944, 10033.046860548237, 9329.16037556623, 9859.30984831055, 9959.352642078242, 9974.202063834875, 9979.301448898508, 7567.583782891994, 7661.540307581563, 7662.885056724153, 7806.414518911104, 7817.0, 4638.234691275901, 5556.527695145796, 5598.944010559842, 5813.854653633693, 5926.140709597171, 8535.487870727777, 8910.242629376575, 9269.67556135532, 9353.625854965725, 9444.763880903032, 9285.0, 9389.859152112587, 9426.62293508252, 9470.526473676151, 9533.618655253713, 5958.851028724316, 6469.5794773339585, 6578.309277525982, 6911.688973996082, 7089.61007144612, 7747.651355688895, 7847.568383738949, 7924.247196516321, 7932.960335198287, 7936.007999000125, 6910.343517365842, 6999.0, 7002.614856182959, 7038.718451261892, 7128.8217794553475, 6951.75668851608, 6985.476089293425, 6992.720291188295, 7047.048648432396, 7057.188423331178, 5503.862403439946, 6426.646534440651, 6484.1246431731115, 6556.18047744032, 6557.114789503356, 4586.65600080002, 4605.378273932976, 4624.838130665411, 4668.089722504079, 4797.832075877328, 4757.976210118927, 4785.59322457595, 4813.927791083207, 4855.781489833037, 4988.4762099980435], "value": 4347.683712827032, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.1486690631341, 302.23232988209935, 306.20234289675386, 313.3200953929973, 314.16275625458155, 4566.383538222343, 5037.874053148673, 5127.948770502047, 5156.664816786906, 5171.482851714832, 3973.562908080109, 4107.835686572534, 4732.526747325274, 4769.642276829243, 5041.495850414956, 3388.103171788123, 3795.335816232155, 3934.3114954882926, 3947.9143235610295, 3963.1875465529497, 3891.747036442622, 3907.089218532183, 3919.6668283195963, 3947.802609869495, 3975.0658595230097, 3435.896923092311, 3589.8025608591515, 3672.5042119313953, 3899.25914076326, 3924.8037598120122, 3250.30118524516, 3291.897214433168, 3823.866164684223, 3964.1873415949663, 3967.563568007517, 2831.490331740286, 3020.320427903704, 3375.1055970167927, 3410.4031794436123, 3424.630147940819, 4071.7760523171214, 4377.9343309850055, 4874.707517548923, 4928.802847886081, 4989.276554899556, 3459.913502162441, 3814.80925953704, 4134.4831896013, 4265.125649241898, 4456.910861782779, 4612.423447069116, 4796.424429068499, 5306.97346513265, 5308.0, 5331.786728530854, 3663.249033948034, 3667.449882517644, 3671.8714844980564, 3675.0628589709722, 3675.4303083022173, 4442.9777851111185, 4805.486271824399, 5320.563447869054, 5490.6431081979545, 5547.72261386929, 3030.787844850883, 3628.927421451609, 3698.3712768829364, 3698.890332900119, 3737.3272810893754, 3749.7375183736876, 3755.2301778135416, 3793.8292776824555, 3804.896579991827, 3812.2375524895133, 3617.5839778425816, 4373.956260437419, 4379.627731642846, 4380.386745855582, 4396.3185706214945, 4620.636912110936, 4631.3516107744945, 4841.564259216688, 5194.506521880416, 5333.946660533423, 1045.4145678419957, 1206.6440400081997, 1207.8671346151916, 1210.3766560221493, 1213.2720367779261, 724.5652608435003, 775.7284950267361, 814.9511029338258, 832.4381042796089, 843.4264700004056, 4275.593818587229, 4730.847464403688, 4867.6836005660225, 5004.0, 5097.643164978416, 5481.698506582176, 5505.504504594605, 5506.174073888868, 5525.4474552545225, 5538.670719027485, 4470.619997300266, 4818.542238487338, 5041.966396888703, 5050.747462626854, 5076.644634875597, 2305.5388922215625, 2765.2948498132846, 2768.529350010503, 2775.4032882929864, 2783.2346104821336, 4912.975435122801, 5029.673071250357, 5466.617336786387, 5472.808451704251, 5501.689290498, 4590.8163673453355, 5233.4243233244315, 5426.294581704353, 5427.348718153847, 5444.428335024844, 4179.582041795857, 4404.9119017620105, 4471.776411179493, 5047.369078865142, 5320.0, 4456.866294011184, 4579.450465944108, 4862.440819305825, 5272.868178295574, 5295.391030031596, 4627.745473998963, 4700.952990470051, 5029.622778291569, 5072.365954255718, 5397.652021370716, 4775.594074503706, 4957.851264462072, 5414.485623865727, 5779.422057794187, 5780.7398667060925, 3138.5762922005238, 3701.3707669695677, 3754.849806007729, 3770.472133901311, 3775.4525593789294, 4299.9355009674255, 5512.448755124456, 5591.524720398812, 5627.0, 5628.437156284339, 5164.896702065863, 5430.99053350263, 5438.646487978269, 5445.292112025411, 5498.5876059294915, 4856.854294371175, 5098.439171691185, 5410.322799932033, 5426.2674538936735, 5435.945640543702, 5116.74416279192, 5217.852072544034, 5273.815416460406, 5315.973420132875, 5327.547158491571, 4227.027783609726, 5267.89464210706, 5319.734013299242, 5367.731613419235, 5506.301912063141, 4417.359482875029, 5347.62030896263, 5368.516833485005, 5385.73071346439, 5397.649152805055], "value": 3825.6386280757824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.8432384065904, 646.3762469217204, 679.633935789064, 710.6375748368331, 772.4476998945753, 14220.217888016168, 14713.48502802402, 15002.099874007567, 15028.774568381483, 15606.765898511532, 13812.861871381283, 14137.0, 14341.06783059103, 14356.99501034928, 14409.423623055065, 811.9188081191893, 828.9792755181138, 834.4826207751172, 837.9203975622337, 840.7183593496186, 649.1074772188241, 664.1996394344827, 670.299536983853, 818.9017317921857, 825.9669613215464, 871.7994861181932, 887.4497811356936, 887.8890138732659, 888.9599968001455, 892.1168043636785, 879.463527248378, 880.0539420123393, 880.75779160731, 881.1144799476549, 881.8060026794095, 507.2340765444206, 520.1158031346725, 627.8179327994876, 653.085680047932, 654.1594051643615, 14291.928540357336, 14782.0, 14812.925935370362, 14834.184119873402, 14838.109713417229, 12400.7336538938, 12580.937095314557, 12624.368781560977, 12635.0, 13193.670158246025, 11883.58407455735, 12048.277103373826, 12123.696907577292, 12657.746845063139, 12684.746305073846, 4363.214621368153, 4392.780360981938, 4437.667174961891, 4471.28459446487, 4614.492405835355, 89211.0, 91069.54465227698, 91633.54183229042, 91644.54177729135, 92239.0, 7646.35006024483, 10197.643082492226, 10538.631147909786, 10549.402237176677, 10810.675679729464, 20476.795232047785, 20486.487837804176, 20526.589468210554, 20533.897330513253, 20540.281090161774, 7341.926580734124, 7493.550386976799, 7516.774496765106, 7520.924790752022, 7593.544387336778, 4002.15954649521, 4130.896727581774, 4154.459920210354, 4191.350340697197, 4207.705460617789, 3144.5754823099046, 3264.183954011497, 3265.7713960023048, 3267.101547074526, 3274.2141885947676, 612.5528364294001, 612.7579606055672, 630.3129588748286, 640.1613885809604, 640.478010421505, 497.7361998140991, 589.3487696095838, 609.8048624440225, 610.8228613702065, 621.254494606465, 8416.621252043551, 8417.28453081495, 8428.4942903426, 8505.02192247887, 8687.695930642398, 521.6281180495273, 525.4456548341536, 583.0, 590.9143174239712, 599.4604855629881, 4021.6983726220064, 4128.566500517462, 4184.058586818002, 4228.386883901817, 4231.746095234295, 76017.0, 107982.0, 115302.0, 117739.8226017746, 121664.0, 100452.49773751084, 101196.0, 101423.0, 101758.49120754497, 103717.0, 92288.0, 93546.59680104667, 93613.59579606312, 94196.0, 95425.045749543, 7854.0, 7931.249221571802, 8017.6770832811935, 8182.7954301142945, 8203.958980205061, 56294.71852640711, 57256.86131640203, 57385.0, 57506.84986300167, 58986.0, 50526.747366262935, 52985.94028119493, 68561.0, 70063.0, 76952.61523692346, 11925.522979080739, 12127.151099422956, 12128.757424851277, 12431.378431078228, 12463.376831158586, 12822.358882056047, 13366.198028118344, 13507.0, 13912.373943172784, 14313.57059288223, 12868.099233053596, 12984.0, 13004.0, 13083.41124649412, 13157.27634980047, 10648.627298044532, 12723.363831808558, 12765.680857978254, 12812.679683008, 12893.097483176087, 12062.638120856389, 12326.81509777372, 12510.812337814757, 12544.811827822772, 12842.807357889826, 8665.566721664018, 10188.898111018794, 10765.40790256512, 11109.888901110886, 11590.768184636428, 8445.652227913153, 10782.137429005817, 10976.725581860517, 11034.0, 11325.263857849213], "value": 7173.109774873467, "unit": "score"}], "name": "dromaeo_css", "value": 6843.497686193676, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 116.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 113.0, 116.0, 152.0, 121.0, 118.0, 112.0, 113.0, 143.0, 111.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 182.0, 199.0, 264.0, 184.0, 181.0, 184.0, 201.0, 203.0], "value": 196.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 87.0, 60.0, 60.0, 59.0, 58.0, 83.0, 58.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 91.0, 70.0, 66.0, 68.0, 93.0, 98.0, 82.0, 92.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 84.0, 86.0, 83.0, 86.0, 83.0, 86.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 92.0, 103.0, 93.0, 93.0, 93.0, 93.0, 92.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 84.0, 88.0, 84.0, 83.0, 114.0, 85.0, 86.0, 87.0, 85.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 52.0, 54.0, 55.0, 55.0, 55.0, 55.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 65.0, 75.0, 74.0, 69.0, 71.0, 71.0, 70.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 102.0, 89.0, 91.0, 91.0, 100.0, 113.0, 113.0, 91.0, 89.0], "value": 97.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 147.0, 149.0, 145.0, 142.0, 184.0, 159.0, 218.0, 163.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 171.0, 172.0, 172.0, 174.0, 174.0, 173.0, 172.0, 172.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 79.0, 93.0, 92.0, 90.0, 90.0, 66.0, 67.0], "value": 78.2, "unit": "score"}], "name": "kraken", "value": 1488.1, "alertThreshold": 2.0}]} 20:26:47 INFO - Return code: 0 20:26:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:47 INFO - # TBPL SUCCESS # 20:26:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:26:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:26:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:26:47 INFO - 2016-11-21 20:26:47.274 screenresolution[1654:9751] starting screenresolution argv=screenresolution get 20:26:47 INFO - 2016-11-21 20:26:47.276 screenresolution[1654:9751] Display 0: 1600x1200x32@60 20:26:47 INFO - 2016-11-21 20:26:47.282 screenresolution[1655:9754] starting screenresolution argv=screenresolution list 20:26:47 INFO - Available Modes on Display 0 20:26:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:26:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:26:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:26:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:26:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:26:47 INFO - Intel Iris: 20:26:47 INFO - Chipset Model: Intel Iris 20:26:47 INFO - Type: GPU 20:26:47 INFO - Bus: Built-In 20:26:47 INFO - VRAM (Dynamic, Max): 1536 MB 20:26:47 INFO - Vendor: Intel (0x8086) 20:26:47 INFO - Device ID: 0x0a2e 20:26:47 INFO - Revision ID: 0x0009 20:26:47 INFO - Displays: 20:26:47 INFO - Display: 20:26:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:26:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:26:47 INFO - Display Serial Number: 1600x1200 60 20:26:47 INFO - Main Display: Yes 20:26:47 INFO - Mirror: Off 20:26:47 INFO - Online: Yes 20:26:47 INFO - Rotation: Supported 20:26:47 INFO - Return code: 0 20:26:47 INFO - Running post-action listener: _resource_record_post_action 20:26:47 INFO - [mozharness: 2016-11-22 04:26:47.520237Z] Finished run-tests step (success) 20:26:47 INFO - Running post-run listener: _resource_record_post_run 20:26:47 INFO - Total resource usage - Wall time: 1216s; CPU: 53.0%; Read bytes: 36672512; Write bytes: 694738944; Read time: 239; Write time: 1971 20:26:47 INFO - TinderboxPrint: CPU usage
53.4% 20:26:47 INFO - TinderboxPrint: I/O read bytes / time
36,672,512 / 239 20:26:47 INFO - TinderboxPrint: I/O write bytes / time
694,738,944 / 1,971 20:26:47 INFO - TinderboxPrint: CPU idle
2,266.4 (46.6%) 20:26:47 INFO - TinderboxPrint: CPU system
969.0 (19.9%) 20:26:47 INFO - TinderboxPrint: CPU user
1,630.3 (33.5%) 20:26:47 INFO - TinderboxPrint: Swap in / out
419,733,504 / 0 20:26:47 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 367821312; Write bytes: 366732800; Read time: 27664; Write time: 751 20:26:47 INFO - run-tests - Wall time: 1184s; CPU: 53.0%; Read bytes: 35709952; Write bytes: 309426688; Read time: 223; Write time: 1167 20:26:48 INFO - Running post-run listener: _upload_blobber_files 20:26:48 INFO - Blob upload gear active. 20:26:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:26:48 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'] 20:26:48 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 20:26:48 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:26:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:26:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:49 INFO - (blobuploader) - INFO - Done attempting. 20:26:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:26:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:26:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:52 INFO - (blobuploader) - INFO - Done attempting. 20:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:54 INFO - (blobuploader) - INFO - Done attempting. 20:26:54 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:54 INFO - Return code: 0 20:26:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8f71711d1ad352ce8b2291139bb102a73dd3b93353a08c812a6fe5f599442072fe7be9df8953effc80d57e6aed20fae209e3bae4c89e5105a6239342a56aed3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fa835ff19a291a31805d7fc7d0e73d19a6e0f9d16b95abb179472fd2cc81157f3a3172c08f6c7991384db4bd00fd36ea1ff5639341053ac5e66ab6e326e265ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e89b7edf63680f3ec271c8426bb242b48e1f58f8c4685b70ba6369da74f7046e91859c88c7b16532baa050a19e8332f3688464f1380c40add07ed642c1513c8c"} 20:26:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:54 INFO - Contents: 20:26:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8f71711d1ad352ce8b2291139bb102a73dd3b93353a08c812a6fe5f599442072fe7be9df8953effc80d57e6aed20fae209e3bae4c89e5105a6239342a56aed3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fa835ff19a291a31805d7fc7d0e73d19a6e0f9d16b95abb179472fd2cc81157f3a3172c08f6c7991384db4bd00fd36ea1ff5639341053ac5e66ab6e326e265ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e89b7edf63680f3ec271c8426bb242b48e1f58f8c4685b70ba6369da74f7046e91859c88c7b16532baa050a19e8332f3688464f1380c40add07ed642c1513c8c"} 20:26:54 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:54 INFO - Copying logs to upload dir... 20:26:54 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.801195 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-21 20:26:54.268908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 20:26:54.272425) ========= 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.PhaVQ1QyiM/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.JeUndm27ev/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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/8f71711d1ad352ce8b2291139bb102a73dd3b93353a08c812a6fe5f599442072fe7be9df8953effc80d57e6aed20fae209e3bae4c89e5105a6239342a56aed3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fa835ff19a291a31805d7fc7d0e73d19a6e0f9d16b95abb179472fd2cc81157f3a3172c08f6c7991384db4bd00fd36ea1ff5639341053ac5e66ab6e326e265ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e89b7edf63680f3ec271c8426bb242b48e1f58f8c4685b70ba6369da74f7046e91859c88c7b16532baa050a19e8332f3688464f1380c40add07ed642c1513c8c"} build_url:https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011008 build_url: 'https://queue.taskcluster.net/v1/task/TlErQtRHS5Cdjdqn8esb5Q/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/8f71711d1ad352ce8b2291139bb102a73dd3b93353a08c812a6fe5f599442072fe7be9df8953effc80d57e6aed20fae209e3bae4c89e5105a6239342a56aed3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fa835ff19a291a31805d7fc7d0e73d19a6e0f9d16b95abb179472fd2cc81157f3a3172c08f6c7991384db4bd00fd36ea1ff5639341053ac5e66ab6e326e265ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e89b7edf63680f3ec271c8426bb242b48e1f58f8c4685b70ba6369da74f7046e91859c88c7b16532baa050a19e8332f3688464f1380c40add07ed642c1513c8c"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 20:26:54.373540) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:26:54.373869) ========= 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.PhaVQ1QyiM/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.JeUndm27ev/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.004902 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:26:54.400164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 20:26:54.400470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 20:26:54.400777) ========= ========= Total master_lag: 0.22 =========