builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0130 starttime: 1480340207.64 results: success (0) buildid: 20161128030212 builduid: 2fe0ce39798d48a8bbc3b670de3bb3be revision: 05328d3102efd4d5fc0696489734d7771d24459f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:47.640346) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:47.640770) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:47.641037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:47.665770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:47.666072) ========= 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.7ijlRxfpP8/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.dAlxlspE0q/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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-28 05:36:47-- 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% 19.9M=0.001s 2016-11-28 05:36:47 (19.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137033 ========= master_lag: 0.79 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:48.594582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:48.594870) ========= 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.7ijlRxfpP8/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.dAlxlspE0q/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.019295 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:48.656138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-28 05:36:48.656475) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05328d3102efd4d5fc0696489734d7771d24459f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 05328d3102efd4d5fc0696489734d7771d24459f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7ijlRxfpP8/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.dAlxlspE0q/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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-28 05:36:48,734 truncating revision to first 12 chars 2016-11-28 05:36:48,734 Setting DEBUG logging. 2016-11-28 05:36:48,734 attempt 1/10 2016-11-28 05:36:48,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05328d3102ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-28 05:36:50,116 unpacking tar archive at: mozilla-central-05328d3102ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.639294 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-28 05:36:50.318712) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:50.318988) ========= script_repo_revision: 05328d3102efd4d5fc0696489734d7771d24459f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:50.319341) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:50.319618) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 05:36:50.339656) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-28 05:36:50.339924) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7ijlRxfpP8/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.dAlxlspE0q/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 05:36:50 INFO - MultiFileLogger online at 20161128 05:36:50 in /builds/slave/test 05:36:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:36:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:36:50 INFO - {'append_to_log': False, 05:36:50 INFO - 'base_work_dir': '/builds/slave/test', 05:36:50 INFO - 'blob_upload_branch': 'Firefox', 05:36:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:36:50 INFO - 'branch': 'Firefox', 05:36:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:36:50 INFO - 'config_files': ('talos/mac_config.py',), 05:36:50 INFO - 'default_actions': ('clobber', 05:36:50 INFO - 'read-buildbot-config', 05:36:50 INFO - 'download-and-extract', 05:36:50 INFO - 'populate-webroot', 05:36:50 INFO - 'create-virtualenv', 05:36:50 INFO - 'install', 05:36:50 INFO - 'run-tests'), 05:36:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:36:50 INFO - 'download_minidump_stackwalk': True, 05:36:50 INFO - 'download_symbols': 'ondemand', 05:36:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:36:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:36:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:36:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:36:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:36:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:36:50 INFO - 'installer_path': 'installer.exe', 05:36:50 INFO - 'log_level': 'info', 05:36:50 INFO - 'log_name': 'talos', 05:36:50 INFO - 'log_to_console': True, 05:36:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:36:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:36:50 INFO - 'opt_config_files': (), 05:36:50 INFO - 'pip_index': False, 05:36:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:36:50 INFO - 'cmd': ('bash', 05:36:50 INFO - '-c', 05:36:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:36:50 INFO - 'enabled': True, 05:36:50 INFO - 'halt_on_failure': False, 05:36:50 INFO - 'name': 'check_screen_resolution'},), 05:36:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:36:50 INFO - 'cmd': ('bash', 05:36:50 INFO - '-c', 05:36:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:36:50 INFO - 'enabled': True, 05:36:50 INFO - 'halt_on_failure': False, 05:36:50 INFO - 'name': 'check_screen_resolution'},), 05:36:50 INFO - 'run_cmd_checks_enabled': True, 05:36:50 INFO - 'sps_profile': False, 05:36:50 INFO - 'sps_profile_interval': 0, 05:36:50 INFO - 'suite': 'dromaeojs', 05:36:50 INFO - 'system_bits': '32', 05:36:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:36:50 INFO - 'title': 't-yosemite-r7-0130', 05:36:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:36:50 INFO - 'use_talos_json': True, 05:36:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:36:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:36:50 INFO - 'work_dir': 'build'} 05:36:50 INFO - [mozharness: 2016-11-28 13:36:50.542906Z] Running clobber step. 05:36:50 INFO - Running pre-action listener: _resource_record_pre_action 05:36:50 INFO - Running main action method: clobber 05:36:50 INFO - rmtree: /builds/slave/test/build 05:36:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:36:52 INFO - Running post-action listener: _resource_record_post_action 05:36:52 INFO - [mozharness: 2016-11-28 13:36:52.028826Z] Finished clobber step (success) 05:36:52 INFO - [mozharness: 2016-11-28 13:36:52.028986Z] Running read-buildbot-config step. 05:36:52 INFO - Running pre-action listener: _resource_record_pre_action 05:36:52 INFO - Running main action method: read_buildbot_config 05:36:52 INFO - Using buildbot properties: 05:36:52 INFO - { 05:36:52 INFO - "project": "", 05:36:52 INFO - "product": "firefox", 05:36:52 INFO - "script_repo_revision": "production", 05:36:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:36:52 INFO - "repository": "", 05:36:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:36:52 INFO - "buildid": "20161128030212", 05:36:52 INFO - "stage_platform": "macosx64", 05:36:52 INFO - "basedir": "/builds/slave/test", 05:36:52 INFO - "nightly_build": "True", 05:36:52 INFO - "buildnumber": 0, 05:36:52 INFO - "slavename": "t-yosemite-r7-0130", 05:36:52 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:36:52 INFO - "platform": "yosemite_r7", 05:36:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:36:52 INFO - "branch": "mozilla-central", 05:36:52 INFO - "repo_path": "mozilla-central", 05:36:52 INFO - "revision": "05328d3102efd4d5fc0696489734d7771d24459f", 05:36:52 INFO - "pgo_build": "False", 05:36:52 INFO - "builduid": "2fe0ce39798d48a8bbc3b670de3bb3be", 05:36:52 INFO - "slavebuilddir": "test" 05:36:52 INFO - } 05:36:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 05:36:52 INFO - Running post-action listener: _resource_record_post_action 05:36:52 INFO - [mozharness: 2016-11-28 13:36:52.033311Z] Finished read-buildbot-config step (success) 05:36:52 INFO - [mozharness: 2016-11-28 13:36:52.033490Z] Running download-and-extract step. 05:36:52 INFO - Running pre-action listener: _resource_record_pre_action 05:36:52 INFO - Running main action method: download_and_extract 05:36:52 INFO - mkdir: /builds/slave/test/build/tests 05:36:52 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')]} 05:36:52 INFO - trying https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 05:36:52 INFO - Downloading https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/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 05:36:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/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 05:36:53 INFO - Downloaded 1199 bytes. 05:36:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:36:53 INFO - Using the following test package requirements: 05:36:53 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:36:53 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:36:53 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 05:36:53 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:36:53 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 05:36:53 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:36:53 INFO - u'jsshell-mac.zip'], 05:36:53 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:36:53 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 05:36:53 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:36:53 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:36:53 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 05:36:53 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:36:53 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 05:36:53 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:36:53 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 05:36:53 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:36:53 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 05:36:53 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:36:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:36:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:36:53 INFO - Fetch https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:36:54 INFO - Http code: 200 05:36:54 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 05:36:54 INFO - x-amz-cf-id: xmYrt14K9FkAVlb64lzqC414U8dxEBd5s8wxgt9M2ebVzH5KXLFKjA== 05:36:54 INFO - x-amz-version-id: RunkRo2L6JtB2j.LFzvYdjXnzT8aEEAs 05:36:54 INFO - Expected file size: 16282790 05:36:54 INFO - Obtained file size: 16282790 05:37:01 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 05:37:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:37:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:37:01 INFO - Fetch https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:37:01 INFO - Http code: 200 05:37:01 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 05:37:01 INFO - x-amz-cf-id: twpY5ibVDEi-SqQ7vtBAwsiTcTcP3FqZ87xXbS_aUXCxBvL0lAlIAA== 05:37:01 INFO - x-amz-version-id: RunkRo2L6JtB2j.LFzvYdjXnzT8aEEAs 05:37:01 INFO - Expected file size: 16282790 05:37:01 INFO - Obtained file size: 16282790 05:37:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 05:37:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:37:08 INFO - Fetch https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 05:37:08 INFO - Http code: 200 05:37:08 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 05:37:08 INFO - x-amz-cf-id: GeqvVEZAeDRdaWY_VAzv2oTwxfoXNb8fC4oEpry3cee5UdYszJcbig== 05:37:08 INFO - x-amz-version-id: warGttQYHCl2_hBzlgS_ljbsc3cjqrdI 05:37:09 INFO - Expected file size: 14409702 05:37:09 INFO - Obtained file size: 14409702 05:37:09 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')]} 05:37:09 INFO - trying https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:37:09 INFO - Downloading https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 05:37:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/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 05:37:12 INFO - Downloaded 107719928 bytes. 05:37:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:37:12 INFO - mkdir: /builds/slave/test/properties 05:37:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:37:12 INFO - Writing to file /builds/slave/test/properties/build_url 05:37:12 INFO - Contents: 05:37:12 INFO - build_url:https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:37:12 INFO - Running post-action listener: _resource_record_post_action 05:37:12 INFO - Running post-action listener: set_extra_try_arguments 05:37:12 INFO - [mozharness: 2016-11-28 13:37:12.941477Z] Finished download-and-extract step (success) 05:37:12 INFO - [mozharness: 2016-11-28 13:37:12.941597Z] Running populate-webroot step. 05:37:12 INFO - Running pre-action listener: _resource_record_pre_action 05:37:12 INFO - Running main action method: populate_webroot 05:37:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:12 INFO - '--tppagecycles', 05:37:12 INFO - '7'], 05:37:12 INFO - 'tests': ['tsvgm']}}, 05:37:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:37:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:37:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:37:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:37:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:37:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:37:12 INFO - 'talos_options': ['--disable-e10s'], 05:37:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:37:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:37:12 INFO - 'talos_options': ['--disable-e10s'], 05:37:12 INFO - 'tests': ['damp', 'tps']}, 05:37:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:37:12 INFO - 'tests': ['damp', 'tps']}, 05:37:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:37:12 INFO - 'tests': ['dromaeo_dom']}, 05:37:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:37:12 INFO - 'tests': ['basic_compositor_video']}, 05:37:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:37:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:37:12 INFO - 'tests': ['a11yr', 05:37:12 INFO - 'ts_paint', 05:37:12 INFO - 'tpaint', 05:37:12 INFO - 'sessionrestore', 05:37:12 INFO - 'sessionrestore_no_auto_restore', 05:37:12 INFO - 'tabpaint']}, 05:37:12 INFO - 'other-e10s': {'tests': ['a11yr', 05:37:12 INFO - 'ts_paint', 05:37:12 INFO - 'tpaint', 05:37:12 INFO - 'sessionrestore', 05:37:12 INFO - 'sessionrestore_no_auto_restore', 05:37:12 INFO - 'tabpaint']}, 05:37:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:37:12 INFO - 'ts_paint', 05:37:12 INFO - 'tpaint', 05:37:12 INFO - 'sessionrestore', 05:37:12 INFO - 'sessionrestore_no_auto_restore', 05:37:12 INFO - 'tabpaint']}, 05:37:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:37:12 INFO - 'ts_paint', 05:37:12 INFO - 'tpaint', 05:37:12 INFO - 'sessionrestore', 05:37:12 INFO - 'sessionrestore_no_auto_restore', 05:37:12 INFO - 'tabpaint']}, 05:37:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:37:12 INFO - 'tests': ['a11yr', 05:37:12 INFO - 'ts_paint', 05:37:12 INFO - 'tpaint', 05:37:12 INFO - 'sessionrestore', 05:37:12 INFO - 'sessionrestore_no_auto_restore', 05:37:12 INFO - 'tabpaint']}, 05:37:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:37:12 INFO - 'tests': ['a11yr', 05:37:12 INFO - 'ts_paint', 05:37:12 INFO - 'tpaint', 05:37:12 INFO - 'sessionrestore', 05:37:12 INFO - 'sessionrestore_no_auto_restore', 05:37:12 INFO - 'tabpaint']}, 05:37:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:37:12 INFO - 'tests': ['tsvgx', 05:37:12 INFO - 'tsvgr_opacity', 05:37:12 INFO - 'tart', 05:37:12 INFO - 'tscrollx', 05:37:12 INFO - 'cart', 05:37:12 INFO - 'tsvg_static']}, 05:37:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:37:12 INFO - 'tsvgr_opacity', 05:37:12 INFO - 'tart', 05:37:12 INFO - 'tscrollx', 05:37:12 INFO - 'cart', 05:37:12 INFO - 'tsvg_static']}, 05:37:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:37:12 INFO - 'talos_options': ['--disable-e10s'], 05:37:12 INFO - 'tests': ['tp5o']}, 05:37:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:37:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:37:12 INFO - 'talos_options': ['--disable-e10s', 05:37:12 INFO - '--xperf_path', 05:37:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:12 INFO - 'tests': ['tp5n']}, 05:37:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:37:12 INFO - 'talos_options': ['--xperf_path', 05:37:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:12 INFO - 'tests': ['tp5n']}}, 05:37:12 INFO - 'talos.zip': {'path': '', 05:37:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:12 INFO - Running post-action listener: _resource_record_post_action 05:37:12 INFO - [mozharness: 2016-11-28 13:37:12.960095Z] Finished populate-webroot step (success) 05:37:12 INFO - [mozharness: 2016-11-28 13:37:12.960207Z] Running create-virtualenv step. 05:37:12 INFO - Running pre-action listener: _resource_record_pre_action 05:37:12 INFO - Running main action method: create_virtualenv 05:37:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:37:12 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 05:37:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:37:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:13 INFO - Using real prefix '/tools/python27' 05:37:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:37:13 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:16 INFO - Installing pip.................done. 05:37:16 INFO - Return code: 0 05:37:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:37:16 INFO - Reading from file tmpfile_stdout 05:37:16 INFO - Output received: 05:37:16 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) 05:37:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:16 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 0x10376f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e2d76900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103585d30>, '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 0x1033ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10357db20>, '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.7ijlRxfpP8/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.dAlxlspE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 05:37:16 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 05:37:16 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 05:37:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ijlRxfpP8/Render', 05:37:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:16 INFO - 'HOME': '/Users/cltbld', 05:37:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:16 INFO - 'LOGNAME': 'cltbld', 05:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:16 INFO - 'MOZ_NO_REMOTE': '1', 05:37:16 INFO - 'NO_EM_RESTART': '1', 05:37:16 INFO - 'PAGER': '/bin/cat', 05:37:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:16 INFO - 'PWD': '/builds/slave/test', 05:37:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:16 INFO - 'SHELL': '/bin/bash', 05:37:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dAlxlspE0q/Listeners', 05:37:16 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 05:37:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:16 INFO - 'USER': 'cltbld', 05:37:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:16 INFO - 'XPC_FLAGS': '0x0', 05:37:16 INFO - 'XPC_SERVICE_NAME': '0', 05:37:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:17 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 05:37:17 INFO - Cleaning up... 05:37:17 INFO - Return code: 0 05:37:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:17 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 0x10376f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e2d76900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103585d30>, '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 0x1033ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10357db20>, '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.7ijlRxfpP8/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.dAlxlspE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 05:37:17 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 05:37:17 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 05:37:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ijlRxfpP8/Render', 05:37:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:17 INFO - 'HOME': '/Users/cltbld', 05:37:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:17 INFO - 'LOGNAME': 'cltbld', 05:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:17 INFO - 'MOZ_NO_REMOTE': '1', 05:37:17 INFO - 'NO_EM_RESTART': '1', 05:37:17 INFO - 'PAGER': '/bin/cat', 05:37:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:17 INFO - 'PWD': '/builds/slave/test', 05:37:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:17 INFO - 'SHELL': '/bin/bash', 05:37:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dAlxlspE0q/Listeners', 05:37:17 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 05:37:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:17 INFO - 'USER': 'cltbld', 05:37:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:17 INFO - 'XPC_FLAGS': '0x0', 05:37:17 INFO - 'XPC_SERVICE_NAME': '0', 05:37:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:17 INFO - Downloading/unpacking psutil>=3.1.1 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:21 INFO - Installing collected packages: psutil 05:37:21 INFO - Running setup.py install for psutil 05:37:21 INFO - building 'psutil._psutil_osx' extension 05:37:21 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 05:37:21 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 05:37:21 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 05:37:21 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 05:37:21 INFO - building 'psutil._psutil_posix' extension 05:37:21 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 05:37:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:37:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:37:22 INFO - ^ 05:37:22 INFO - 1 warning generated. 05:37:22 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 05:37:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:22 INFO - Successfully installed psutil 05:37:22 INFO - Cleaning up... 05:37:22 INFO - Return code: 0 05:37:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10376f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e2d76900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103585d30>, '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 0x1033ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10357db20>, '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.7ijlRxfpP8/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.dAlxlspE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 05:37:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:37:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:37:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ijlRxfpP8/Render', 05:37:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:22 INFO - 'HOME': '/Users/cltbld', 05:37:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:22 INFO - 'LOGNAME': 'cltbld', 05:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:22 INFO - 'MOZ_NO_REMOTE': '1', 05:37:22 INFO - 'NO_EM_RESTART': '1', 05:37:22 INFO - 'PAGER': '/bin/cat', 05:37:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:22 INFO - 'PWD': '/builds/slave/test', 05:37:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:22 INFO - 'SHELL': '/bin/bash', 05:37:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dAlxlspE0q/Listeners', 05:37:22 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 05:37:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:22 INFO - 'USER': 'cltbld', 05:37:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:22 INFO - 'XPC_FLAGS': '0x0', 05:37:22 INFO - 'XPC_SERVICE_NAME': '0', 05:37:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:37:22 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 05:37:22 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 05:37:22 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 05:37:22 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 05:37:22 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 05:37:22 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 05:37:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:37:25 INFO - Installing collected packages: mozsystemmonitor 05:37:25 INFO - Running setup.py install for mozsystemmonitor 05:37:25 INFO - Successfully installed mozsystemmonitor 05:37:25 INFO - Cleaning up... 05:37:25 INFO - Return code: 0 05:37:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10376f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e2d76900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103585d30>, '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 0x1033ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10357db20>, '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.7ijlRxfpP8/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.dAlxlspE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 05:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:37:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ijlRxfpP8/Render', 05:37:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:25 INFO - 'HOME': '/Users/cltbld', 05:37:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:25 INFO - 'LOGNAME': 'cltbld', 05:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:25 INFO - 'MOZ_NO_REMOTE': '1', 05:37:25 INFO - 'NO_EM_RESTART': '1', 05:37:25 INFO - 'PAGER': '/bin/cat', 05:37:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:25 INFO - 'PWD': '/builds/slave/test', 05:37:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:25 INFO - 'SHELL': '/bin/bash', 05:37:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dAlxlspE0q/Listeners', 05:37:25 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 05:37:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:25 INFO - 'USER': 'cltbld', 05:37:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:25 INFO - 'XPC_FLAGS': '0x0', 05:37:25 INFO - 'XPC_SERVICE_NAME': '0', 05:37:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:25 INFO - Downloading/unpacking jsonschema==2.5.1 05:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:37:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:37:28 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 05:37:28 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 05:37:28 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 05:37:28 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 05:37:28 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 05:37:28 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 05:37:28 INFO - Downloading functools32-3.2.3-2.tar.gz 05:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:37:28 INFO - warning: no files found matching '*.txt' 05:37:28 INFO - no previously-included directories found matching 'build' 05:37:28 INFO - no previously-included directories found matching 'dist' 05:37:28 INFO - no previously-included directories found matching '.git*' 05:37:28 INFO - Installing collected packages: jsonschema, functools32 05:37:28 INFO - Running setup.py install for functools32 05:37:28 INFO - warning: no files found matching '*.txt' 05:37:28 INFO - no previously-included directories found matching 'build' 05:37:28 INFO - no previously-included directories found matching 'dist' 05:37:28 INFO - no previously-included directories found matching '.git*' 05:37:28 INFO - Successfully installed jsonschema functools32 05:37:28 INFO - Cleaning up... 05:37:29 INFO - Return code: 0 05:37:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:29 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 0x10376f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e2d76900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103585d30>, '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 0x1033ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10357db20>, '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.7ijlRxfpP8/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.dAlxlspE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 05:37:29 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 05:37:29 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 05:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ijlRxfpP8/Render', 05:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:29 INFO - 'HOME': '/Users/cltbld', 05:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:29 INFO - 'LOGNAME': 'cltbld', 05:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:29 INFO - 'MOZ_NO_REMOTE': '1', 05:37:29 INFO - 'NO_EM_RESTART': '1', 05:37:29 INFO - 'PAGER': '/bin/cat', 05:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:29 INFO - 'PWD': '/builds/slave/test', 05:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:29 INFO - 'SHELL': '/bin/bash', 05:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dAlxlspE0q/Listeners', 05:37:29 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 05:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:29 INFO - 'USER': 'cltbld', 05:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:29 INFO - 'XPC_FLAGS': '0x0', 05:37:29 INFO - 'XPC_SERVICE_NAME': '0', 05:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:37:29 INFO - Cleaning up... 05:37:29 INFO - Return code: 0 05:37:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:29 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 0x10376f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e2d76900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103585d30>, '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 0x1033ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10357db20>, '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.7ijlRxfpP8/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.dAlxlspE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 05:37:29 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 05:37:29 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 05:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ijlRxfpP8/Render', 05:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:29 INFO - 'HOME': '/Users/cltbld', 05:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:29 INFO - 'LOGNAME': 'cltbld', 05:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:29 INFO - 'MOZ_NO_REMOTE': '1', 05:37:29 INFO - 'NO_EM_RESTART': '1', 05:37:29 INFO - 'PAGER': '/bin/cat', 05:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:29 INFO - 'PWD': '/builds/slave/test', 05:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:29 INFO - 'SHELL': '/bin/bash', 05:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dAlxlspE0q/Listeners', 05:37:29 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 05:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:29 INFO - 'USER': 'cltbld', 05:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:29 INFO - 'XPC_FLAGS': '0x0', 05:37:29 INFO - 'XPC_SERVICE_NAME': '0', 05:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:29 INFO - Downloading/unpacking blobuploader==1.2.4 05:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:32 INFO - Downloading blobuploader-1.2.4.tar.gz 05:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:37:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:37:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:33 INFO - Downloading docopt-0.6.1.tar.gz 05:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:37:33 INFO - Installing collected packages: blobuploader, requests, docopt 05:37:33 INFO - Running setup.py install for blobuploader 05:37:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:37:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:37:33 INFO - Running setup.py install for requests 05:37:34 INFO - Running setup.py install for docopt 05:37:34 INFO - Successfully installed blobuploader requests docopt 05:37:34 INFO - Cleaning up... 05:37:34 INFO - Return code: 0 05:37:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:34 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 0x10376f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e2d76900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103585d30>, '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 0x1033ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10357db20>, '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.7ijlRxfpP8/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.dAlxlspE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 05:37:34 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 05:37:34 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 05:37:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ijlRxfpP8/Render', 05:37:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:34 INFO - 'HOME': '/Users/cltbld', 05:37:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:34 INFO - 'LOGNAME': 'cltbld', 05:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:34 INFO - 'MOZ_NO_REMOTE': '1', 05:37:34 INFO - 'NO_EM_RESTART': '1', 05:37:34 INFO - 'PAGER': '/bin/cat', 05:37:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:34 INFO - 'PWD': '/builds/slave/test', 05:37:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:34 INFO - 'SHELL': '/bin/bash', 05:37:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dAlxlspE0q/Listeners', 05:37:34 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 05:37:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:34 INFO - 'USER': 'cltbld', 05:37:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:34 INFO - 'XPC_FLAGS': '0x0', 05:37:34 INFO - 'XPC_SERVICE_NAME': '0', 05:37:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-EjyRmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-48xNik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-FX7Z6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-WM11mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-U9cWZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-3BQ1bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Jx2eKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-fikGQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-5FqC3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-mhwXiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-gd6a5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-F3hq3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-NDF5PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-iIa7RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:36 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-_wp8Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:36 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-7KmVpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:36 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-OunjRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:37:36 INFO - Running setup.py install for manifestparser 05:37:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:37:36 INFO - Running setup.py install for mozcrash 05:37:36 INFO - Running setup.py install for mozdebug 05:37:36 INFO - Running setup.py install for mozdevice 05:37:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:37:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:37:37 INFO - Running setup.py install for mozfile 05:37:37 INFO - Running setup.py install for mozhttpd 05:37:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:37:37 INFO - Running setup.py install for mozinfo 05:37:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:37:37 INFO - Running setup.py install for mozInstall 05:37:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:37:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:37:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:37:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:37:37 INFO - Running setup.py install for mozleak 05:37:37 INFO - Running setup.py install for mozlog 05:37:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:37:37 INFO - Running setup.py install for moznetwork 05:37:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:37:38 INFO - Running setup.py install for mozprocess 05:37:38 INFO - Running setup.py install for mozprofile 05:37:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:37:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:37:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:37:38 INFO - Running setup.py install for mozrunner 05:37:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:37:38 INFO - Running setup.py install for mozscreenshot 05:37:38 INFO - Running setup.py install for moztest 05:37:38 INFO - Running setup.py install for mozversion 05:37:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:37:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:37:38 INFO - Cleaning up... 05:37:38 INFO - Return code: 0 05:37:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:38 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')]} 05:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:38 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')]} 05:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:38 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 0x10376f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e2d76900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103585d30>, '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 0x1033ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10357db20>, '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.7ijlRxfpP8/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.dAlxlspE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 05:37:38 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 05:37:38 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 05:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ijlRxfpP8/Render', 05:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:38 INFO - 'HOME': '/Users/cltbld', 05:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:38 INFO - 'LOGNAME': 'cltbld', 05:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:38 INFO - 'MOZ_NO_REMOTE': '1', 05:37:38 INFO - 'NO_EM_RESTART': '1', 05:37:38 INFO - 'PAGER': '/bin/cat', 05:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:38 INFO - 'PWD': '/builds/slave/test', 05:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:38 INFO - 'SHELL': '/bin/bash', 05:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dAlxlspE0q/Listeners', 05:37:38 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 05:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:38 INFO - 'USER': 'cltbld', 05:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:38 INFO - 'XPC_FLAGS': '0x0', 05:37:38 INFO - 'XPC_SERVICE_NAME': '0', 05:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-jBldtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:39 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)) 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-KO3vwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:39 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)) 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-d_LbUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:39 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)) 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-1OteD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:39 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)) 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-88vO7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:39 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)) 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-FTWXCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:39 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)) 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-9qKwC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:39 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)) 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-oWqo41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:40 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)) 05:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:40 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-0MiJVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:40 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)) 05:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:40 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-c2lY19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:40 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)) 05:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:40 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-S0roeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:40 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)) 05:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:40 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-bJeZOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:40 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)) 05:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:40 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-2rGxnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:40 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)) 05:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:40 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-RFRGaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:40 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)) 05:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:40 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-J8wR2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:40 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)) 05:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:40 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-DpbFwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:40 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)) 05:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:40 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-EZEvlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:41 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)) 05:37:41 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)) 05:37:41 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)) 05:37:41 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)) 05:37:41 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)) 05:37:41 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)) 05:37:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:43 INFO - Downloading blessings-1.6.tar.gz 05:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:37:43 INFO - Installing collected packages: blessings 05:37:43 INFO - Running setup.py install for blessings 05:37:43 INFO - Successfully installed blessings 05:37:43 INFO - Cleaning up... 05:37:43 INFO - Return code: 0 05:37:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:37:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:44 INFO - Reading from file tmpfile_stdout 05:37:44 INFO - Current package versions: 05:37:44 INFO - blessings == 1.6 05:37:44 INFO - blobuploader == 1.2.4 05:37:44 INFO - docopt == 0.6.1 05:37:44 INFO - functools32 == 3.2.3-2 05:37:44 INFO - jsonschema == 2.5.1 05:37:44 INFO - manifestparser == 1.1 05:37:44 INFO - mozInstall == 1.12 05:37:44 INFO - mozcrash == 1.0 05:37:44 INFO - mozdebug == 0.1 05:37:44 INFO - mozdevice == 0.49 05:37:44 INFO - mozfile == 1.2 05:37:44 INFO - mozhttpd == 0.7 05:37:44 INFO - mozinfo == 0.9 05:37:44 INFO - mozleak == 0.1 05:37:44 INFO - mozlog == 3.4 05:37:44 INFO - moznetwork == 0.27 05:37:44 INFO - mozprocess == 0.23 05:37:44 INFO - mozprofile == 0.28 05:37:44 INFO - mozrunner == 6.13 05:37:44 INFO - mozscreenshot == 0.1 05:37:44 INFO - mozsystemmonitor == 0.3 05:37:44 INFO - moztest == 0.7 05:37:44 INFO - mozversion == 1.4 05:37:44 INFO - psutil == 3.1.1 05:37:44 INFO - requests == 1.2.3 05:37:44 INFO - wsgiref == 0.1.2 05:37:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:44 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')]} 05:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:44 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')]} 05:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:44 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 0x10376f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e2d76900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103585d30>, '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 0x1033ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10357db20>, '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.7ijlRxfpP8/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.dAlxlspE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 05:37:44 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 05:37:44 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 05:37:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ijlRxfpP8/Render', 05:37:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:44 INFO - 'HOME': '/Users/cltbld', 05:37:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:44 INFO - 'LOGNAME': 'cltbld', 05:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:44 INFO - 'MOZ_NO_REMOTE': '1', 05:37:44 INFO - 'NO_EM_RESTART': '1', 05:37:44 INFO - 'PAGER': '/bin/cat', 05:37:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:44 INFO - 'PWD': '/builds/slave/test', 05:37:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:44 INFO - 'SHELL': '/bin/bash', 05:37:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dAlxlspE0q/Listeners', 05:37:44 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 05:37:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:44 INFO - 'USER': 'cltbld', 05:37:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:44 INFO - 'XPC_FLAGS': '0x0', 05:37:44 INFO - 'XPC_SERVICE_NAME': '0', 05:37:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 INFO - Cleaning up... 05:37:44 INFO - Return code: 0 05:37:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:37:44 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')]} 05:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:44 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')]} 05:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:44 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 0x10376f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e2d76900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103585d30>, '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 0x1033ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10357db20>, '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.7ijlRxfpP8/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.dAlxlspE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 05:37:44 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 05:37:44 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 05:37:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ijlRxfpP8/Render', 05:37:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:44 INFO - 'HOME': '/Users/cltbld', 05:37:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:44 INFO - 'LOGNAME': 'cltbld', 05:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:44 INFO - 'MOZ_NO_REMOTE': '1', 05:37:44 INFO - 'NO_EM_RESTART': '1', 05:37:44 INFO - 'PAGER': '/bin/cat', 05:37:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:44 INFO - 'PWD': '/builds/slave/test', 05:37:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:44 INFO - 'SHELL': '/bin/bash', 05:37:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dAlxlspE0q/Listeners', 05:37:44 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 05:37:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:44 INFO - 'USER': 'cltbld', 05:37:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:44 INFO - 'XPC_FLAGS': '0x0', 05:37:44 INFO - 'XPC_SERVICE_NAME': '0', 05:37:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:37:44 INFO - Cleaning up... 05:37:44 INFO - Return code: 0 05:37:44 INFO - Running post-action listener: _resource_record_post_action 05:37:44 INFO - Running post-action listener: _start_resource_monitoring 05:37:44 INFO - Starting resource monitoring. 05:37:44 INFO - [mozharness: 2016-11-28 13:37:44.819193Z] Finished create-virtualenv step (success) 05:37:44 INFO - [mozharness: 2016-11-28 13:37:44.820190Z] Running install step. 05:37:44 INFO - Running pre-action listener: _resource_record_pre_action 05:37:44 INFO - Running main action method: install 05:37:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:45 INFO - Reading from file tmpfile_stdout 05:37:45 INFO - Detecting whether we're running mozinstall >=1.0... 05:37:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:37:45 INFO - Reading from file tmpfile_stdout 05:37:45 INFO - Output received: 05:37:45 INFO - Usage: mozinstall [options] installer 05:37:45 INFO - Options: 05:37:45 INFO - -h, --help show this help message and exit 05:37:45 INFO - -d DEST, --destination=DEST 05:37:45 INFO - Directory to install application into. [default: 05:37:45 INFO - "/builds/slave/test"] 05:37:45 INFO - --app=APP Application being installed. [default: firefox] 05:37:45 INFO - mkdir: /builds/slave/test/build/application 05:37:45 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'] 05:37:45 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 05:38:18 INFO - Reading from file tmpfile_stdout 05:38:18 INFO - Output received: 05:38:18 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:38:18 INFO - Running post-action listener: _resource_record_post_action 05:38:18 INFO - [mozharness: 2016-11-28 13:38:18.148153Z] Finished install step (success) 05:38:18 INFO - [mozharness: 2016-11-28 13:38:18.148289Z] Running run-tests step. 05:38:18 INFO - Running pre-action listener: _resource_record_pre_action 05:38:18 INFO - Running main action method: run_tests 05:38:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:38:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:38:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:38:18 INFO - 2016-11-28 05:38:18.162 screenresolution[1915:18995] starting screenresolution argv=screenresolution get 05:38:18 INFO - 2016-11-28 05:38:18.165 screenresolution[1915:18995] Display 0: 1600x1200x32@60 05:38:18 INFO - 2016-11-28 05:38:18.172 screenresolution[1916:18997] starting screenresolution argv=screenresolution list 05:38:18 INFO - Available Modes on Display 0 05:38:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:38:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:38:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:38:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:38:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:38:18 INFO - Intel Iris: 05:38:18 INFO - Chipset Model: Intel Iris 05:38:18 INFO - Type: GPU 05:38:18 INFO - Bus: Built-In 05:38:18 INFO - VRAM (Dynamic, Max): 1536 MB 05:38:18 INFO - Vendor: Intel (0x8086) 05:38:18 INFO - Device ID: 0x0a2e 05:38:18 INFO - Revision ID: 0x0009 05:38:18 INFO - Displays: 05:38:18 INFO - Display: 05:38:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:38:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:38:18 INFO - Display Serial Number: 1600x1200 60 05:38:18 INFO - Main Display: Yes 05:38:18 INFO - Mirror: Off 05:38:18 INFO - Online: Yes 05:38:18 INFO - Rotation: Supported 05:38:18 INFO - Return code: 0 05:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:38:18 INFO - Python 2.7.3 05:38:18 INFO - Return code: 0 05:38:18 INFO - grabbing minidump binary from tooltool 05:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:18 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 0x103585d30>, '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 0x1033ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10357db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:38:18 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 05:38:18 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 05:38:18 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 05:38:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:38:18 INFO - Return code: 0 05:38:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:38:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:38:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:38:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:38:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 05:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0130 --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 05:38:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ijlRxfpP8/Render', 05:38:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:18 INFO - 'HOME': '/Users/cltbld', 05:38:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:18 INFO - 'LOGNAME': 'cltbld', 05:38:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:38:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:18 INFO - 'MOZ_NO_REMOTE': '1', 05:38:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:38:18 INFO - 'NO_EM_RESTART': '1', 05:38:18 INFO - 'PAGER': '/bin/cat', 05:38:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:18 INFO - 'PWD': '/builds/slave/test', 05:38:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:38:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:18 INFO - 'SHELL': '/bin/bash', 05:38:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dAlxlspE0q/Listeners', 05:38:18 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 05:38:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:18 INFO - 'USER': 'cltbld', 05:38:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:18 INFO - 'XPC_FLAGS': '0x0', 05:38:18 INFO - 'XPC_SERVICE_NAME': '0', 05:38:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 05:38:18 INFO - mozversion application_buildid: 20161128030212 05:38:18 INFO - mozversion application_changeset: 05328d3102efd4d5fc0696489734d7771d24459f 05:38:18 INFO - mozversion application_display_name: Nightly 05:38:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:38:18 INFO - mozversion application_name: Firefox 05:38:18 INFO - mozversion application_remotingname: firefox 05:38:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:38:18 INFO - mozversion application_vendor: Mozilla 05:38:18 INFO - mozversion application_version: 53.0a1 05:38:18 INFO - mozversion platform_buildid: 20161128030212 05:38:18 INFO - mozversion platform_changeset: 05328d3102efd4d5fc0696489734d7771d24459f 05:38:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:38:18 INFO - mozversion platform_version: 53.0a1 05:38:18 INFO - using testdate: 1480340298 05:38:18 INFO - actual date: 1480340298 05:38:18 INFO - starting webserver on 'localhost:54514' 05:38:18 INFO - SUITE-START | Running 2 tests 05:38:18 INFO - TEST-START | dromaeo_css 05:38:18 INFO - operating with platform_type : mac_ 05:38:18 INFO - Initialising browser for dromaeo_css test... 05:38:18 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmp9EiuGO/profile http://localhost:54514/getInfo.html) 05:38:21 INFO - PROCESS | 1926 | __metrics Screen width/height:1600/1200 05:38:21 INFO - PROCESS | 1926 | colorDepth:24 05:38:21 INFO - PROCESS | 1926 | Browser inner width/height: 1024/689 05:38:21 INFO - PROCESS | 1926 | __metrics 05:38:21 INFO - PROCESS | 1926 | 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" 05:38:21 INFO - PROCESS | 1926 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:38:22 INFO - TEST-INFO | 1926: exit 0 05:38:22 INFO - Browser initialized. 05:38:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:38:22 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmp9EiuGO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:35 INFO - PROCESS | 1929 | RSS: Main: 244953088 05:38:35 INFO - PROCESS | 1929 | 05:39:26 INFO - PROCESS | 1929 | 1480340366635 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] 05:41:39 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:54514/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54514/tests/dromaeo/cssquery-ext.html) 05:41:41 INFO - PROCESS | 1929 | RSS: Main: 408891392 05:41:41 INFO - PROCESS | 1929 | 05:44:44 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:54514/tests/dromaeo/cssquery-ext.html (next: http://localhost:54514/tests/dromaeo/cssquery-jquery.html) 05:44:45 INFO - PROCESS | 1929 | RSS: Main: 374272000 05:44:45 INFO - PROCESS | 1929 | 05:47:47 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:54514/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54514/tests/dromaeo/cssquery-mootools.html) 05:47:48 INFO - PROCESS | 1929 | RSS: Main: 334749696 05:47:48 INFO - PROCESS | 1929 | 05:50:50 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:54514/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54514/tests/dromaeo/cssquery-prototype.html) 05:50:51 INFO - PROCESS | 1929 | RSS: Main: 341106688 05:50:51 INFO - PROCESS | 1929 | 05:53:54 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:54514/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54514/tests/dromaeo/cssquery-yui.html) 05:53:55 INFO - PROCESS | 1929 | RSS: Main: 330928128 05:53:55 INFO - PROCESS | 1929 | 05:56:58 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:54514/tests/dromaeo/cssquery-yui.html (next: http://localhost:54514/tests/dromaeo/cssquery-dojo.html) 05:56:58 INFO - PROCESS | 1929 | RSS: Main: 432852992 05:56:58 INFO - PROCESS | 1929 | 05:56:58 INFO - PROCESS | 1929 | __start_tp_report 05:56:58 INFO - PROCESS | 1929 | _x_x_mozilla_page_load 05:56:58 INFO - PROCESS | 1929 | _x_x_mozilla_page_load_details 05:56:58 INFO - PROCESS | 1929 | |i|pagename|runs| 05:56:58 INFO - PROCESS | 1929 | |0;dojo.html;3254.934901301974;3290.9177270568234;3295.8846440374577;3310.817905015223;3342.629521896023;5509.47659972302;5566.081596536572;5609.719514024303;5623.0721930881355;5665.745041473133;5596.468335508121;5598.608097433182;5611.046122159232;5619;5624.550035997121;5105.642605017651;5136.922946155811;5144.56271216947;5175.8188463403785;5195.090859099642;5170.1986192140275;5217.713025783581;5221.112410890158;5226.55574276187;5247.947520524784;4363.192809330269;5129.615278854082;5169.508896654812;5174.172132458807;5198.558122559587;5178.300929374543;5216.713080780555;5222.738863056832;5229.450907654717;5283.55089817366;5008.774605142741;5042.571381432583;5152.845414637567;5154.92267615986;5159.58723302135;5523.392426833086;5568.49883510486;5573.164025396182;5578.414266501999;5585.1063829787445;6146.78486252979;6151.692415379258;6155.169052177988;6158.9692051539905;6159.3224745277985;5995.640261584275;6203.596766210182;6211.09939058834;6223.222097237845;6226.688665566749;5612.0459521881785;5645.322561292671;5652.63257888236;5697.601167918206;5711.428857114339;6293.433590976834;6309.684515774193;6309.779157729549;6310.1796766420075;6319.747210111636;5885.676287804212;6007.978643630593;6030.155778191057;6030.728617212236;6048.455638992512;5978.013627751372;6026.246719160105;6030.517558595302;6087.54343424245;6177.413145751147;6068.939310606837;6094.061814318811;6103.701349646989;6124.326324104345;6162.784302549389;6148.4159004895355;6157.692115394212;6165;6167.938320616737;6175.536834737323;4783.569478746929;4814.15752243356;4822.132016237041;4841.661083724105;4881.023795240966;4331.696781225284;4353.238183317907;4360.847370342023;4361.498427680857;4413.6248418884115;5688.431156884279;5688.857778555569;5689.829305120853;5690.118031705092;5694.117411801178;6177.505799536027;6188.659623720739;6190.659513726699;6192.040233763774;6194.287656919422;5486.643368181056;5603.719814009283;5618.971905140448;5633.549316054706;5677.659340439587;5354.732263386815;5361.115415956401;5367.838964831061;5389.595780316492;5393.838184854382;6306.873862522632;6307.905381419282;6320.462760665395;6328.746850126127;6332.715027823667;5872.442117998783;5970.223870896755;6198.132261483306;6204.751809927552;6220.7511699531515;5231.29377534028;6232.875342493216;6295.527835412271;6305.432511074026;6314.368563143649;6053.364396738455;6053.727582258897;6063.696815159313;6087.969560152171;6126.295476020315;5979.850503737442;6106.870229007669;6115.661454455199;6150.600210986271;6166.229221347332;5834.066549352084;5906.911396329145;5911.615744976735;5915.08316210988;6023.698815059317;5974.910376344272;5985.40145985398;5987.760489580368;5989.221401217814;6010.87978240424;4382.342648602735;5829.15477255804;5840.94159058404;5854.795082172103;5855.151003104611;5782.5952183348445;5786.103154011135;5853.560982926212;5871.559633027455;5900.881982360243;5545.722713864371;5793.391693872083;5802.506786923159;5804.01331773591;5863.530917526502 05:56:58 INFO - PROCESS | 1929 | |1;ext.html;464.32904453065333;502.2065137083409;512.5463964391515;519.7868873761759;523.5968304405608;25444.600546969934;31065.68934310659;31066.2233444164;31095.06714798554;31114.91097811577;31352.529712054336;32048.038558843215;33178.8341058295;39007.024824379405;40212.798936005354;9177.265818734486;9322.161005509503;9334;9347.018563050884;9348.906510934872;9132.817343653123;9177.541122943827;9229.261659067259;9260.305477089212;9273.489958052305;8400.41197116202;8594.957025214866;9271.629134834599;10889.564417423293;11138.220324577283;10959.123270138409;11029.283096598696;11034.889651103467;11069.446527673585;11086.279391839505;10990.615328463466;11018.44907754609;11060.889391106148;11062.944685276603;11081.72295692606;30360.240993975105;30910.53634195489;37518;38175;38205.61794382076;3212.261179928606;3277.246233366315;3359.10983589349;3502.4221003534385;3905.0627849316243;28616.570751438747;28704.851805927738;28899.56650650242;28919.277018074506;29672.25819354512;3119.251379668886;3140.3876244132402;3155.3373791503814;3232.8545215465124;3235.304409551934;363149;470304;472555;473829;474707.62646186893;56722.43277567172;56959.43040569624;57005.57486062882;57155;57338.42661573414;59871.40128598658;60114.39885601088;60232.09651855226;60362;60374;15041.473548425753;15506.5348039559;15533.378664853506;15540.300686469136;15547.455839045579;12123.757524849454;12135.817962730565;12159.270443773403;12166.75666486683;12172.330521821208;12924.418401171783;15191.088534687955;15736.60658483547;15804.209789510478;16038.957467764558;5097.311862898536;6073.51411887048;6154.5076393888385;6184.443400094013;6208.844778880564;707.9221285658573;955.0640372435053;985.2413641496008;986.9309148359689;1001.369137443406;22847.428814279778;28806.85596572004;29084.73051647902;29193.56209656857;29257.707422925923;965.2374624046925;976.511744127936;1018.9286749927434;1054.8660190295464;1060.7666313411037;14638.48765293231;14908.925455372653;14965.92517037408;15302.617434564225;15432.691346173013;595683;596257;597085;602062;603243;44184.558154418046;46633.76683116562;48548.51451485511;52865.735671321396;54782.45217547853;1329.820474235985;1344.9125806822526;1372.2658377768046;1373.0525937103366;1376.7865980773197;28717.425651486436;28848.85575572193;29012.564811527423;29757.851210743807;29908;47991.520084800104;48209.5179048205;48243.75878120587;48302.27546586734;48350;582401;601187;601603;744713;744985;24468.51062978766;24602.50794984126;24636.688579498874;24644.01423943022;24759.25722228336;41953;42053.36919946142;42587.5741242596;42945.785271073444;43321.78339108284;35544.93365199048;35876.82061589675;35999.64000359963;36494.4525832118;36779.63220367762;29087.12738617845;35484.64515354813;35743.28513429769;36034.27931441409;36645.816770915975;28433.857830711542;35288.29423411466;35758.10604734902;36078.09804754902;36598.08504787295;30578;31748.36503269968;31863.84068079645;32074.19814504656;32118.67881321157;23683.763162368155;23995.186641936794;23997.640035399832;24096.397590060387;24289.149879754124 05:56:58 INFO - PROCESS | 1929 | |2;jquery.html;347.3313870798712;361.6148801526374;369.56022333423243;373.1641123882503;396.14630471334266;14936.327865246063;15305.081695098303;15890.602734931632;19377.80622193781;20633.071511781967;16598.253078611462;18935;19444.902775486138;19993.900030499863;20190.697139542917;5586.10622300431;5875.7062146892695;5880.882382352372;5886.852828679296;5891.941080589182;5273.866118784461;5600.327960644729;5785.884282314351;5829.562782791287;5830.21292125564;5781.421857814227;5783.450572195635;5783.826485205451;5786.305643322808;5787.074068149097;5542.972285138569;5747.166660834177;5835.5915085944;5839.211706419664;5841.766329346821;4950.801967921278;5099.898002039939;5110.386753589556;5112.10538155825;5119.820806271762;12334.5066197352;12836.999885446136;12996.935015324958;13002.609921702364;13021.348932553334;2110.7150534677776;2277.202978957368;2374.536965291769;2554.731753165928;2606.0845278720126;9161.496117713523;9663.516824158763;9677.854832177523;9791.564712814758;10091.848622270672;1709.8204688507776;1793.506785633948;1804.7292906064195;1805.3951926104771;1805.6840052990674;100654;115549;126143.21570352904;129351.70648293584;130226;9435.150836424755;10589.788204235872;11260;11303.208775385809;11508.88491115078;14338.641533961734;14415.567532974028;14416.279186040656;14442.783358249635;14469.638259043608;7271.781846544613;8004.719834805754;8049.879251811228;8363.498190108612;8486.108958559385;8172.264496195371;8181.713640022571;8183.427160098855;8349.290310323691;8355.248027677539;3692.316921369555;4406.49325327585;4412.470503539532;4454.665900057444;4500.662450316174;1688.7044767165696;1806.4851517317502;1825.9135814190536;1877.192807092936;1882.6234753049446;604.3141034925303;817.284875733733;834.2616784145953;838.3251482556478;847.6905929335747;13245.470181192837;17014.236013915877;17022.404215852384;17360.95834249949;17822.821771782375;695.9408450281682;801.1867954026668;822.2147848804497;841.4026041510596;843.0852525010432;8432.831343373098;8679.392442528962;8923.063078376677;9082.228010619172;9166.587503562356;515729.42135289835;549407.6447358554;553518;558564;559270;94794.52602736941;102379.48810255901;118721;124659.75340246482;131217.34391327982;858.1590041758986;902.801383695586;907.3693782821008;981.8969008254173;984.1487113646645;12949.352532373532;16078;16213.918930405272;16457.177141142656;16649.50051498457;53217.20174197468;54862;55055.44944550503;55960.44039559552;56666.43333566777;74066.62966685132;76364;82485;86867;87172.44796828543;6338.524610654312;7067.116610423697;7379.741709040158;7972.601369931596;8337.749867503984;12024.458899349374;12865.678358041125;12979.221246725227;13322.866771332163;13347.399367028313;7709.498882572839;8677.566121694017;9678.128968392879;10906.127509799355;11193.832092518456;10784;10924.235303528676;11222.943885280521;11250.774984500427;11409.60066397672;11088.611898583511;11252.66242012741;11455;11508.654740357802;11705.473253703774;6929.792106236821;7297.963510182628;7972.711587133529;7980.521168729895;8369.707060252862;10271.537780799732;10774.892251077703;11179.66461006171;11194.66416007521;11301.491432885705 05:56:58 INFO - PROCESS | 1929 | |3;mootools.html;1358.1918758338788;1461.269365317341;1616.975745363819;1816.4096668582713;1843.235057451158;7823.178566250547;8256.545889976056;8257.917420825797;8263.710770123047;8264.793380165484;7203.207647158822;7448.292412220831;7454.254574542557;7712.383009359251;8033.758987230378;2215.5901158285687;2268.9773102269014;2272.170657709932;2280.521090570982;2282.7032485776826;2274.7725227477204;2292.862428254302;2318.860868347896;2321.6401457773986;2326.325365643961;2264.4225722440838;2268.3081660093667;2291.117919600949;2294.300238427279;2297.7127859017623;1881.5860510687626;2170.8914554272224;2204.151401710337;2226.25420484138;2232.6092933736613;2251.6284813005836;2276.863388196697;2277.430642339415;2277.6014197515533;2279.099755596547;7919.010123734533;8069.152738962442;8069.475484093515;8076.353891688651;8135.918640813576;4892.266160075981;5086.669366491204;5087;5089.821856235014;5092.719900405476;3113.237256872058;3201.599800024997;3434.1414646338417;3450.189205536697;3455.3089382123676;883.5273128876021;1055.883852776194;1071.7320669832543;1074.0923919288189;1084.430673896203;10121.443320617363;10345.793084138275;10354.741131471697;10360.171186305077;10538;4377.606015458624;4394.209042372339;4565.703229290086;4582.335561343587;4586.243269860435;9124.270058395312;9220.815583688289;9230.861537076815;9233.353665243369;9251.629934802668;5104.770285337168;5114.514121158484;5115.820946266863;5118.309028281209;5126.564242039469;4172.979135104305;4204.936925946114;4292.763897985641;4570.702904311209;4679.298105284234;3650.0509867434125;3681.7238707097076;3761.1725420407465;3796.1458671798623;3804.524434445694;1213.3387303919208;1241.596481143632;1246.8628450870397;1261.2684642907093;1263.406199086428;855.8758979947872;871.1288711288711;872.1322284327135;895.785011597212;911.0889110889111;5444.673319600836;5550.500454958992;5587.664740115606;5804.4775970162045;5862.618929769551;881.1496905486237;897.2463130970017;898.8606765951288;906.6464079009191;986.7024862306044;3080.3069309405205;3742.139307959185;3745.6441638044344;3794.962050379461;3845.2309538092495;9411.764705882408;9750.804983900282;9875.358101723365;9876.555555000043;9909.355891867006;9828.967958364412;9842;9844.50777461124;9846.261530385107;9856.063673951106;7203.927960720431;7514.47398682087;7549.773506794915;7661.770146895602;7690.038745156856;5315.946840531546;5462.6995515247045;5486.6982315973;5501.724913754377;5697.145428185805;8875.423097498642;8937.508437036025;9222.216111630318;9272.258219342571;9284.72145835626;8496.192861678132;8724.476531408136;9109.635614575607;9260.49067301305;9384.061593840834;6398.48812095022;6602.372774586406;6609.372109649576;6777.93222067773;7011.614361210182;7445.7766267012075;7680.654370553227;7687;7799.844003120019;7819.452638315263;6833.3166683331265;6940.722371105099;6949.30506949301;7010.158780946319;7071.611061391467;6825.761098361732;6850.4862135341045;6855.314468553105;6892.069570608104;6931.133608298963;6301.117843501822;6415.582987105823;6509.576877502947;6516.706748196438;6522.412982831568;4737.218358970731;4761.571458568746;4789.928151077806;4826.396700412449;4894.535019173173;4641.419822522184;4688.835890743808;4820.758962051813;4871.318015477765;4995.750212489288 05:56:58 INFO - PROCESS | 1929 | |4;prototype.html;300.1849977311599;303.3826163756755;308.2970826515545;313.75997362018046;317.5538368592129;5276.551493123079;5292.497212764786;5346.732663366831;5352.7883270037955;5359.678419294835;4929.926051109236;5034.924476132861;5053.5451809337155;5066.493350664931;5298.7350632468315;4009.138035322405;4037.6769858411403;4061.964199129218;4075.1442197138635;4092.608513105551;3602.8198590070524;4032.2943484890175;4052.8986775330704;4067.4305597216267;4091.3862920562005;3344.331133773243;3920.4511368408444;4011.7392369496033;4051.5745846686114;4131.223573863238;3986.521617405901;3997.020729921159;4005.8798236052967;4011.4699064822917;4049.858254961077;3071.832703572628;3477.4957631143598;3487.2676737885076;3500.2299494111508;3510.1926556891804;4710.222813235812;4753.025629745894;4801.207800712878;5015.749212539395;5103.617228707824;3988.202359528106;4333.180064372939;4532.501424843297;4545.227311357077;4550.544945505456;4874.951250487486;5063.860631357952;5421.918671219935;5443.700596467193;5448.972755136199;3226.5805445291962;3848.3073046851555;3857.3442514772555;3861.343571592836;3871.9612803871883;4670.416197975253;4789.664723469358;5131.717755523445;5246;5659.688717120557;3896.883093507199;3905.511811023622;3922.9215415692097;3924;3942.842286308573;3736.7384283100464;3920.5491368492417;3934.8426062957733;3944.684425245973;3954.6638535724787;3634;4028.6633752423522;4525.321201819687;4541.977290113595;4543.522930092358;4802.471728109905;5419.891602168013;5433.782648694087;5448.101063324507;5570.100929349472;1096.9633696157055;1187.9961432589448;1226.0926914083514;1244.147758785235;1259.6472987563498;680.0581195044898;704.651197657163;808.8422757562337;849.6941101203562;857.7812657772229;4892.82269390118;4944.381952255968;4947.802087916443;5007.718400767364;5055.823046193439;4383.254846676073;4644.349791029259;4951.603871690256;4954.925676114861;5329.8934021319355;4617.275807273724;4691.756684478616;4695.5253112696355;4736.1055577768475;4978.7929199826085;2350.200931683236;2456.005317846275;2473.7649923257263;2663.654854298567;2802.285417218596;4827.324174615556;5041.924371134436;5123.538881500683;5482.451754824486;5602.971985140048;4484.69038445201;4549.363089167519;4654.813807447664;4992.875178120504;5486.91769623448;5511.2364043506495;5560.944390556205;5572.442755724395;5579.8884022320135;5593.664380137205;4415.867523974286;4894.82868099629;4927.260910863399;5118.488151184852;5221.947780522146;4516.367708520876;4875;5086.694798312114;5650.689212093374;5654.321481422256;5443.700596467233;5630.5214056805635;5880.558958078076;5890.617109887844;5905.232319798399;3327.650596687313;3512.016635342108;3557.8043207623828;3768.9246215074995;3821.8662346817728;4390.165868484977;4682.859514214579;5453.727313634382;5693.345265294544;5732.7706891723865;4637.353739422457;5074.441811400669;5451.863703407288;5479.890402191854;5504.834854954358;4882.511748825089;5306.97346513265;5428.538574221236;5471.863203419946;5480.506754392124;4663.11143986686;4913.968066706032;5281.762320695655;5345.278387417648;5374.865628359323;4325.697201195886;4658.324542941323;4695.5539223773685;5254.65844720092;5317.776911310498;5269.920951185812;5284.9471505284455;5350.652207606493;5387.299651045339;5470.507654310972 05:56:58 INFO - PROCESS | 1929 | |5;yui.html;644.4908522267409;674.6154691825658;700.6916956539119;759.5556599389357;759.8404335089631;14677.77983330251;15495;15525.456609018687;16746.24641891115;17530.386436474724;15809.525714228563;16352.22012257916;16355.34578616857;16358.263878125483;16400.179991000463;659.3670076726348;821.322409012564;846.9703560375389;848.9235968762811;850.2093053460279;668.4919461209491;808.4260175275562;831.8003679116998;837.3217693668117;844.9986765682655;885.0220506340497;887.2103827593447;888.2716172738357;889.4529864133576;889.7864512516982;883.0198479687542;884.0231544143693;884.1026358246385;884.4118661090367;884.6372987075332;504.23104765232944;521.0542864700557;634.5209366927986;649.4998850884839;656.4256275758711;15192.848071519364;15242.466513671969;15248.618784530365;15255.923720381437;15279.923600381928;11128.49921753523;11300.265482743678;13683.452661893512;13688.589342319747;13796.965227607969;10875.401852898087;11671.766564668744;12151.635450936486;12318.753624927542;12814;4253.851115210984;4302.956970430287;4407.537208593116;4476.932846007313;4520.819167233307;89290;96232;110953;115385;116073;8976.237019853386;10353.378797272188;10392.272540922215;10435.94782026085;10560.630377936735;21531.461713457287;21856.125754969624;21869.67195492069;21897.671534926987;21904.78095219059;7341.375983041501;7469.813254668677;7572;7574.469787114849;7663.271989161132;3958.0302825807285;4048.1220129743588;4082.22437736835;4105.753654780723;4129.6489798367475;3310.0400883743446;3396.9150771230916;3435.879744208941;3437.862485500602;3439.724822014233;600.67263341479;608.5831205624162;621.9346968568326;626.996865015672;628.3025841316136;434.83476279013775;501.64383287866025;589.908564172554;593.403629352498;692.1797669761248;8095.190480951976;8440.915590844135;8737.259202033518;8752.562371881508;8899.15458031486;515.6132900324757;532.8481382805882;557.2115456628906;563.3605857351853;631.4159402552621;4138.468766556393;4182.749035057906;4412.139632771578;4447.073561138554;4544.568266014723;109571.45214273878;113540.43229783798;115194.63248307693;115590;116747;94736;99546;101137.98862011285;102132.48933755283;104407.95592044134;69392;88769.11230887608;89324;89726.65410018855;91902;8581.227689507974;8585.313174945864;8588.914110858812;8699.521526316114;8805.559722013746;49565.50434495609;53621.92756144933;55490;55525;58037.77660010619;55573.38772979743;64006.07981760555;69037.65481172562;70982;74697.6265118671;11804.763904721685;12277.815832762695;12292.631221063382;12576.371181441074;13235.80146297787;13835.377408016462;14137.081089729134;14248.497690090097;14432.42270309176;14443.422263109358;13466.326683665973;13497.39261733244;13663.521776737767;14102;14197.645058873612;13427.395767190696;13431.529896453578;13663.863361366657;13745.38145783422;13878.930605346908;13124.409401577142;13211.603651890458;13389.330533473481;13456.663583410493;13471;9184.954075229582;10981.231313807957;11003.119750419786;11246.268992515788;11667.066634669036;11278.661640150809;11360.659180224606;11378.772424551627;11519.769604607693;11559.07527397823 05:56:58 INFO - PROCESS | 1929 | __end_tp_report 05:56:58 INFO - PROCESS | 1929 | __start_cc_report 05:56:58 INFO - PROCESS | 1929 | _x_x_mozilla_cycle_collect,1912 05:56:58 INFO - PROCESS | 1929 | __end_cc_report 05:56:58 INFO - PROCESS | 1929 | __startTimestamp1480341418890__endTimestamp 05:56:58 INFO - PROCESS | 1929 | 05:56:58 INFO - PROCESS | 1929 | ------- Summary: start ------- 05:56:58 INFO - PROCESS | 1929 | Number of tests: 6 05:56:58 INFO - PROCESS | 1929 | 05:56:58 INFO - PROCESS | 1929 | [#0] dojo.html Cycles:165 Average:5642.04 Median:5804.01 stddev:640.48 (11.0%) stddev-sans-first:614.46 05:56:58 INFO - PROCESS | 1929 | Values: 3254.9 3290.9 3295.9 3310.8 3342.6 5509.5 5566.1 5609.7 5623.1 5665.7 5596.5 5598.6 5611.0 5619.0 5624.6 5105.6 5136.9 5144.6 5175.8 5195.1 5170.2 5217.7 5221.1 5226.6 5247.9 4363.2 5129.6 5169.5 5174.2 5198.6 5178.3 5216.7 5222.7 5229.5 5283.6 5008.8 5042.6 5152.8 5154.9 5159.6 5523.4 5568.5 5573.2 5578.4 5585.1 6146.8 6151.7 6155.2 6159.0 6159.3 5995.6 6203.6 6211.1 6223.2 6226.7 5612.0 5645.3 5652.6 5697.6 5711.4 6293.4 6309.7 6309.8 6310.2 6319.7 5885.7 6008.0 6030.2 6030.7 6048.5 5978.0 6026.2 6030.5 6087.5 6177.4 6068.9 6094.1 6103.7 6124.3 6162.8 6148.4 6157.7 6165.0 6167.9 6175.5 4783.6 4814.2 4822.1 4841.7 4881.0 4331.7 4353.2 4360.8 4361.5 4413.6 5688.4 5688.9 5689.8 5690.1 5694.1 6177.5 6188.7 6190.7 6192.0 6194.3 5486.6 5603.7 5619.0 5633.5 5677.7 5354.7 5361.1 5367.8 5389.6 5393.8 6306.9 6307.9 6320.5 6328.7 6332.7 5872.4 5970.2 6198.1 6204.8 6220.8 5231.3 6232.9 6295.5 6305.4 6314.4 6053.4 6053.7 6063.7 6088.0 6126.3 5979.9 6106.9 6115.7 6150.6 6166.2 5834.1 5906.9 5911.6 5915.1 6023.7 5974.9 5985.4 5987.8 5989.2 6010.9 4382.3 5829.2 5840.9 5854.8 5855.2 5782.6 5786.1 5853.6 5871.6 5900.9 5545.7 5793.4 5802.5 5804.0 5863.5 05:56:58 INFO - PROCESS | 1929 | 05:56:58 INFO - PROCESS | 1929 | [#1] ext.html Cycles:180 Average:68285.17 Median:3430.77 stddev:154730.60 (4510.1%) stddev-sans-first:155080.87 05:56:58 INFO - PROCESS | 1929 | Values: 464.3 502.2 512.5 519.8 523.6 25444.6 31065.7 31066.2 31095.1 31114.9 31352.5 32048.0 33178.8 39007.0 40212.8 9177.3 9322.2 9334.0 9347.0 9348.9 9132.8 9177.5 9229.3 9260.3 9273.5 8400.4 8595.0 9271.6 10889.6 11138.2 10959.1 11029.3 11034.9 11069.4 11086.3 10990.6 11018.4 11060.9 11062.9 11081.7 30360.2 30910.5 37518.0 38175.0 38205.6 3212.3 3277.2 3359.1 3502.4 3905.1 28616.6 28704.9 28899.6 28919.3 29672.3 3119.3 3140.4 3155.3 3232.9 3235.3 363149.0 470304.0 472555.0 473829.0 474707.6 56722.4 56959.4 57005.6 57155.0 57338.4 59871.4 60114.4 60232.1 60362.0 60374.0 15041.5 15506.5 15533.4 15540.3 15547.5 12123.8 12135.8 12159.3 12166.8 12172.3 12924.4 15191.1 15736.6 15804.2 16039.0 5097.3 6073.5 6154.5 6184.4 6208.8 707.9 955.1 985.2 986.9 1001.4 22847.4 28806.9 29084.7 29193.6 29257.7 965.2 976.5 1018.9 1054.9 1060.8 14638.5 14908.9 14965.9 15302.6 15432.7 595683.0 596257.0 597085.0 602062.0 603243.0 44184.6 46633.8 48548.5 52865.7 54782.5 1329.8 1344.9 1372.3 1373.1 1376.8 28717.4 28848.9 29012.6 29757.9 29908.0 47991.5 48209.5 48243.8 48302.3 48350.0 582401.0 601187.0 601603.0 744713.0 744985.0 24468.5 24602.5 24636.7 24644.0 24759.3 41953.0 42053.4 42587.6 42945.8 43321.8 35544.9 35876.8 35999.6 36494.5 36779.6 29087.1 35484.6 35743.3 36034.3 36645.8 28433.9 35288.3 35758.1 36078.1 36598.1 30578.0 31748.4 31863.8 32074.2 32118.7 23683.8 23995.2 23997.6 24096.4 24289.1 05:56:58 INFO - PROCESS | 1929 | 05:56:58 INFO - PROCESS | 1929 | [#2] jquery.html Cycles:180 Average:32564.10 Median:4725.73 stddev:91865.33 (1943.9%) stddev-sans-first:92091.19 05:56:58 INFO - PROCESS | 1929 | Values: 347.3 361.6 369.6 373.2 396.1 14936.3 15305.1 15890.6 19377.8 20633.1 16598.3 18935.0 19444.9 19993.9 20190.7 5586.1 5875.7 5880.9 5886.9 5891.9 5273.9 5600.3 5785.9 5829.6 5830.2 5781.4 5783.5 5783.8 5786.3 5787.1 5543.0 5747.2 5835.6 5839.2 5841.8 4950.8 5099.9 5110.4 5112.1 5119.8 12334.5 12837.0 12996.9 13002.6 13021.3 2110.7 2277.2 2374.5 2554.7 2606.1 9161.5 9663.5 9677.9 9791.6 10091.8 1709.8 1793.5 1804.7 1805.4 1805.7 100654.0 115549.0 126143.2 129351.7 130226.0 9435.2 10589.8 11260.0 11303.2 11508.9 14338.6 14415.6 14416.3 14442.8 14469.6 7271.8 8004.7 8049.9 8363.5 8486.1 8172.3 8181.7 8183.4 8349.3 8355.2 3692.3 4406.5 4412.5 4454.7 4500.7 1688.7 1806.5 1825.9 1877.2 1882.6 604.3 817.3 834.3 838.3 847.7 13245.5 17014.2 17022.4 17361.0 17822.8 695.9 801.2 822.2 841.4 843.1 8432.8 8679.4 8923.1 9082.2 9166.6 515729.4 549407.6 553518.0 558564.0 559270.0 94794.5 102379.5 118721.0 124659.8 131217.3 858.2 902.8 907.4 981.9 984.1 12949.4 16078.0 16213.9 16457.2 16649.5 53217.2 54862.0 55055.4 55960.4 56666.4 74066.6 76364.0 82485.0 86867.0 87172.4 6338.5 7067.1 7379.7 7972.6 8337.7 12024.5 12865.7 12979.2 13322.9 13347.4 7709.5 8677.6 9678.1 10906.1 11193.8 10784.0 10924.2 11222.9 11250.8 11409.6 11088.6 11252.7 11455.0 11508.7 11705.5 6929.8 7298.0 7972.7 7980.5 8369.7 10271.5 10774.9 11179.7 11194.7 11301.5 05:56:58 INFO - PROCESS | 1929 | 05:56:58 INFO - PROCESS | 1929 | [#3] mootools.html Cycles:180 Average:5297.92 Median:5453.69 stddev:2870.61 (52.6%) stddev-sans-first:2863.39 05:56:58 INFO - PROCESS | 1929 | Values: 1358.2 1461.3 1617.0 1816.4 1843.2 7823.2 8256.5 8257.9 8263.7 8264.8 7203.2 7448.3 7454.3 7712.4 8033.8 2215.6 2269.0 2272.2 2280.5 2282.7 2274.8 2292.9 2318.9 2321.6 2326.3 2264.4 2268.3 2291.1 2294.3 2297.7 1881.6 2170.9 2204.2 2226.3 2232.6 2251.6 2276.9 2277.4 2277.6 2279.1 7919.0 8069.2 8069.5 8076.4 8135.9 4892.3 5086.7 5087.0 5089.8 5092.7 3113.2 3201.6 3434.1 3450.2 3455.3 883.5 1055.9 1071.7 1074.1 1084.4 10121.4 10345.8 10354.7 10360.2 10538.0 4377.6 4394.2 4565.7 4582.3 4586.2 9124.3 9220.8 9230.9 9233.4 9251.6 5104.8 5114.5 5115.8 5118.3 5126.6 4173.0 4204.9 4292.8 4570.7 4679.3 3650.1 3681.7 3761.2 3796.1 3804.5 1213.3 1241.6 1246.9 1261.3 1263.4 855.9 871.1 872.1 895.8 911.1 5444.7 5550.5 5587.7 5804.5 5862.6 881.1 897.2 898.9 906.6 986.7 3080.3 3742.1 3745.6 3795.0 3845.2 9411.8 9750.8 9875.4 9876.6 9909.4 9829.0 9842.0 9844.5 9846.3 9856.1 7203.9 7514.5 7549.8 7661.8 7690.0 5315.9 5462.7 5486.7 5501.7 5697.1 8875.4 8937.5 9222.2 9272.3 9284.7 8496.2 8724.5 9109.6 9260.5 9384.1 6398.5 6602.4 6609.4 6777.9 7011.6 7445.8 7680.7 7687.0 7799.8 7819.5 6833.3 6940.7 6949.3 7010.2 7071.6 6825.8 6850.5 6855.3 6892.1 6931.1 6301.1 6415.6 6509.6 6516.7 6522.4 4737.2 4761.6 4789.9 4826.4 4894.5 4641.4 4688.8 4820.8 4871.3 4995.8 05:56:58 INFO - PROCESS | 1929 | 05:56:58 INFO - PROCESS | 1929 | [#4] prototype.html Cycles:180 Average:4333.01 Median:4771.35 stddev:1312.10 (27.5%) stddev-sans-first:1280.39 05:56:58 INFO - PROCESS | 1929 | Values: 300.2 303.4 308.3 313.8 317.6 5276.6 5292.5 5346.7 5352.8 5359.7 4929.9 5034.9 5053.5 5066.5 5298.7 4009.1 4037.7 4062.0 4075.1 4092.6 3602.8 4032.3 4052.9 4067.4 4091.4 3344.3 3920.5 4011.7 4051.6 4131.2 3986.5 3997.0 4005.9 4011.5 4049.9 3071.8 3477.5 3487.3 3500.2 3510.2 4710.2 4753.0 4801.2 5015.7 5103.6 3988.2 4333.2 4532.5 4545.2 4550.5 4875.0 5063.9 5421.9 5443.7 5449.0 3226.6 3848.3 3857.3 3861.3 3872.0 4670.4 4789.7 5131.7 5246.0 5659.7 3896.9 3905.5 3922.9 3924.0 3942.8 3736.7 3920.5 3934.8 3944.7 3954.7 3634.0 4028.7 4525.3 4542.0 4543.5 4802.5 5419.9 5433.8 5448.1 5570.1 1097.0 1188.0 1226.1 1244.1 1259.6 680.1 704.7 808.8 849.7 857.8 4892.8 4944.4 4947.8 5007.7 5055.8 4383.3 4644.3 4951.6 4954.9 5329.9 4617.3 4691.8 4695.5 4736.1 4978.8 2350.2 2456.0 2473.8 2663.7 2802.3 4827.3 5041.9 5123.5 5482.5 5603.0 4484.7 4549.4 4654.8 4992.9 5486.9 5511.2 5560.9 5572.4 5579.9 5593.7 4415.9 4894.8 4927.3 5118.5 5221.9 4516.4 4875.0 5086.7 5650.7 5654.3 5443.7 5630.5 5880.6 5890.6 5905.2 3327.7 3512.0 3557.8 3768.9 3821.9 4390.2 4682.9 5453.7 5693.3 5732.8 4637.4 5074.4 5451.9 5479.9 5504.8 4882.5 5307.0 5428.5 5471.9 5480.5 4663.1 4914.0 5281.8 5345.3 5374.9 4325.7 4658.3 4695.6 5254.7 5317.8 5269.9 5284.9 5350.7 5387.3 5470.5 05:56:58 INFO - PROCESS | 1929 | 05:56:58 INFO - PROCESS | 1929 | [#5] yui.html Cycles:180 Average:21344.31 Median:4218.30 stddev:31702.73 (751.6%) stddev-sans-first:31753.56 05:56:58 INFO - PROCESS | 1929 | Values: 644.5 674.6 700.7 759.6 759.8 14677.8 15495.0 15525.5 16746.2 17530.4 15809.5 16352.2 16355.3 16358.3 16400.2 659.4 821.3 847.0 848.9 850.2 668.5 808.4 831.8 837.3 845.0 885.0 887.2 888.3 889.5 889.8 883.0 884.0 884.1 884.4 884.6 504.2 521.1 634.5 649.5 656.4 15192.8 15242.5 15248.6 15255.9 15279.9 11128.5 11300.3 13683.5 13688.6 13797.0 10875.4 11671.8 12151.6 12318.8 12814.0 4253.9 4303.0 4407.5 4476.9 4520.8 89290.0 96232.0 110953.0 115385.0 116073.0 8976.2 10353.4 10392.3 10435.9 10560.6 21531.5 21856.1 21869.7 21897.7 21904.8 7341.4 7469.8 7572.0 7574.5 7663.3 3958.0 4048.1 4082.2 4105.8 4129.6 3310.0 3396.9 3435.9 3437.9 3439.7 600.7 608.6 621.9 627.0 628.3 434.8 501.6 589.9 593.4 692.2 8095.2 8440.9 8737.3 8752.6 8899.2 515.6 532.8 557.2 563.4 631.4 4138.5 4182.7 4412.1 4447.1 4544.6 109571.5 113540.4 115194.6 115590.0 116747.0 94736.0 99546.0 101138.0 102132.5 104408.0 69392.0 88769.1 89324.0 89726.7 91902.0 8581.2 8585.3 8588.9 8699.5 8805.6 49565.5 53621.9 55490.0 55525.0 58037.8 55573.4 64006.1 69037.7 70982.0 74697.6 11804.8 12277.8 12292.6 12576.4 13235.8 13835.4 14137.1 14248.5 14432.4 14443.4 13466.3 13497.4 13663.5 14102.0 14197.6 13427.4 13431.5 13663.9 13745.4 13878.9 13124.4 13211.6 13389.3 13456.7 13471.0 9185.0 10981.2 11003.1 11246.3 11667.1 11278.7 11360.7 11378.8 11519.8 11559.1 05:56:58 INFO - PROCESS | 1929 | -------- Summary: end -------- 05:56:58 INFO - PROCESS | 1929 | 05:56:59 INFO - TEST-INFO | 1929: exit 0 05:56:59 INFO - TEST-OK | dromaeo_css | took 1120838ms 05:56:59 INFO - TEST-START | kraken 05:56:59 INFO - operating with platform_type : mac_ 05:56:59 INFO - Initialising browser for kraken test... 05:56:59 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpgO8qVX/profile http://localhost:54514/getInfo.html) 05:57:02 INFO - PROCESS | 1933 | __metrics Screen width/height:1600/1200 05:57:02 INFO - PROCESS | 1933 | colorDepth:24 05:57:02 INFO - PROCESS | 1933 | Browser inner width/height: 1024/689 05:57:02 INFO - PROCESS | 1933 | __metrics 05:57:02 INFO - PROCESS | 1933 | 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" 05:57:02 INFO - PROCESS | 1933 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:57:03 INFO - TEST-INFO | 1933: exit 0 05:57:03 INFO - Browser initialized. 05:57:03 INFO - Running cycle 1/1 for kraken test... 05:57:03 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpgO8qVX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:15 INFO - PROCESS | 1935 | RSS: Main: 237043712 05:57:15 INFO - PROCESS | 1935 | 05:57:18 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54514/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:19 INFO - PROCESS | 1935 | RSS: Main: 295194624 05:57:19 INFO - PROCESS | 1935 | 05:57:22 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54514/tests/kraken/driver.html?testName=audio-dft) 05:57:22 INFO - PROCESS | 1935 | RSS: Main: 297111552 05:57:22 INFO - PROCESS | 1935 | 05:57:25 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54514/tests/kraken/driver.html?testName=audio-fft) 05:57:26 INFO - PROCESS | 1935 | RSS: Main: 389447680 05:57:26 INFO - PROCESS | 1935 | 05:57:28 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54514/tests/kraken/driver.html?testName=audio-oscillator) 05:57:29 INFO - PROCESS | 1935 | RSS: Main: 291491840 05:57:29 INFO - PROCESS | 1935 | 05:57:31 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54514/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:57:31 INFO - PROCESS | 1935 | RSS: Main: 295424000 05:57:31 INFO - PROCESS | 1935 | 05:57:34 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54514/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:35 INFO - PROCESS | 1935 | RSS: Main: 337293312 05:57:35 INFO - PROCESS | 1935 | 05:57:38 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54514/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:38 INFO - PROCESS | 1935 | RSS: Main: 338501632 05:57:38 INFO - PROCESS | 1935 | 05:57:41 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54514/tests/kraken/driver.html?testName=json-parse-financial) 05:57:42 INFO - PROCESS | 1935 | RSS: Main: 335556608 05:57:42 INFO - PROCESS | 1935 | 05:57:43 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54514/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:44 INFO - PROCESS | 1935 | RSS: Main: 310648832 05:57:44 INFO - PROCESS | 1935 | 05:57:46 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54514/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:47 INFO - PROCESS | 1935 | RSS: Main: 315301888 05:57:47 INFO - PROCESS | 1935 | 05:57:49 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54514/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:57:50 INFO - PROCESS | 1935 | RSS: Main: 317739008 05:57:50 INFO - PROCESS | 1935 | 05:57:53 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54514/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:57:53 INFO - PROCESS | 1935 | RSS: Main: 333991936 05:57:53 INFO - PROCESS | 1935 | 05:57:56 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54514/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:57:57 INFO - PROCESS | 1935 | RSS: Main: 327180288 05:57:57 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:54514/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54514/tests/kraken/driver.html?testName=ai-astar) 05:57:59 INFO - PROCESS | 1935 | RSS: Main: 370806784 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | __start_tp_report 05:57:59 INFO - PROCESS | 1935 | _x_x_mozilla_page_load 05:57:59 INFO - PROCESS | 1935 | _x_x_mozilla_page_load_details 05:57:59 INFO - PROCESS | 1935 | |i|pagename|runs| 05:57:59 INFO - PROCESS | 1935 | |0;ai-astar;102;112;117;163;140;115;114;114;113;114 05:57:59 INFO - PROCESS | 1935 | |1;audio-beat-detection;169;143;118;176;147;112;115;119;166;142 05:57:59 INFO - PROCESS | 1935 | |2;audio-dft;184;185;184;179;181;184;183;184;187;185 05:57:59 INFO - PROCESS | 1935 | |3;audio-fft;80;59;58;88;64;61;60;59;74;59 05:57:59 INFO - PROCESS | 1935 | |4;audio-oscillator;89;70;85;70;68;68;82;68;91;112 05:57:59 INFO - PROCESS | 1935 | |5;imaging-gaussian-blur;90;87;91;87;90;88;91;88;90;86 05:57:59 INFO - PROCESS | 1935 | |6;imaging-darkroom;99;99;99;99;99;100;99;99;99;100 05:57:59 INFO - PROCESS | 1935 | |7;imaging-desaturate;87;91;87;85;88;85;87;88;86;86 05:57:59 INFO - PROCESS | 1935 | |8;json-parse-financial;56;55;55;56;57;57;57;55;55;57 05:57:59 INFO - PROCESS | 1935 | |9;json-stringify-tinderbox;68;69;95;115;110;71;72;74;74;75 05:57:59 INFO - PROCESS | 1935 | |10;stanford-crypto-aes;89;86;87;85;78;88;102;106;105;109 05:57:59 INFO - PROCESS | 1935 | |11;stanford-crypto-ccm;151;146;142;148;149;152;162;151;219;162 05:57:59 INFO - PROCESS | 1935 | |12;stanford-crypto-pbkdf2;178;174;176;175;175;174;172;175;173;171 05:57:59 INFO - PROCESS | 1935 | |13;stanford-crypto-sha256-iterative;68;69;70;69;70;71;71;84;85;89 05:57:59 INFO - PROCESS | 1935 | __end_tp_report 05:57:59 INFO - PROCESS | 1935 | __start_cc_report 05:57:59 INFO - PROCESS | 1935 | _x_x_mozilla_cycle_collect,1978 05:57:59 INFO - PROCESS | 1935 | __end_cc_report 05:57:59 INFO - PROCESS | 1935 | __startTimestamp1480341479440__endTimestamp 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | ------- Summary: start ------- 05:57:59 INFO - PROCESS | 1935 | Number of tests: 14 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#0] ai-astar Cycles:10 Average:120.40 Median:114.50 stddev:17.72 (15.5%) stddev-sans-first:17.50 05:57:59 INFO - PROCESS | 1935 | Values: 102.0 112.0 117.0 163.0 140.0 115.0 114.0 114.0 113.0 114.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:145.00 stddev:24.05 (16.6%) stddev-sans-first:23.22 05:57:59 INFO - PROCESS | 1935 | Values: 169.0 143.0 118.0 176.0 147.0 112.0 115.0 119.0 166.0 142.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:2.22 (1.2%) stddev-sans-first:2.35 05:57:59 INFO - PROCESS | 1935 | Values: 184.0 185.0 184.0 179.0 181.0 184.0 183.0 184.0 187.0 185.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#3] audio-fft Cycles:10 Average:66.20 Median:62.50 stddev:10.64 (17.0%) stddev-sans-first:10.05 05:57:59 INFO - PROCESS | 1935 | Values: 80.0 59.0 58.0 88.0 64.0 61.0 60.0 59.0 74.0 59.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#4] audio-oscillator Cycles:10 Average:80.30 Median:76.00 stddev:14.48 (19.0%) stddev-sans-first:15.01 05:57:59 INFO - PROCESS | 1935 | Values: 89.0 70.0 85.0 70.0 68.0 68.0 82.0 68.0 91.0 112.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:90.00 stddev:1.81 (2.0%) stddev-sans-first:1.87 05:57:59 INFO - PROCESS | 1935 | Values: 90.0 87.0 91.0 87.0 90.0 88.0 91.0 88.0 90.0 86.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:99.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:57:59 INFO - PROCESS | 1935 | Values: 99.0 99.0 99.0 99.0 99.0 100.0 99.0 99.0 99.0 100.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#7] imaging-desaturate Cycles:10 Average:87.00 Median:87.00 stddev:1.76 (2.0%) stddev-sans-first:1.87 05:57:59 INFO - PROCESS | 1935 | Values: 87.0 91.0 87.0 85.0 88.0 85.0 87.0 88.0 86.0 86.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:0.94 (1.7%) stddev-sans-first:1.00 05:57:59 INFO - PROCESS | 1935 | Values: 56.0 55.0 55.0 56.0 57.0 57.0 57.0 55.0 55.0 57.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#9] json-stringify-tinderbox Cycles:10 Average:82.30 Median:73.00 stddev:17.65 (24.2%) stddev-sans-first:17.95 05:57:59 INFO - PROCESS | 1935 | Values: 68.0 69.0 95.0 115.0 110.0 71.0 72.0 74.0 74.0 75.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#10] stanford-crypto-aes Cycles:10 Average:93.50 Median:85.50 stddev:10.87 (12.7%) stddev-sans-first:11.40 05:57:59 INFO - PROCESS | 1935 | Values: 89.0 86.0 87.0 85.0 78.0 88.0 102.0 106.0 105.0 109.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#11] stanford-crypto-ccm Cycles:10 Average:158.20 Median:151.50 stddev:22.28 (14.7%) stddev-sans-first:23.48 05:57:59 INFO - PROCESS | 1935 | Values: 151.0 146.0 142.0 148.0 149.0 152.0 162.0 151.0 219.0 162.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:175.00 stddev:2.00 (1.1%) stddev-sans-first:1.62 05:57:59 INFO - PROCESS | 1935 | Values: 178.0 174.0 176.0 175.0 175.0 174.0 172.0 175.0 173.0 171.0 05:57:59 INFO - PROCESS | 1935 | 05:57:59 INFO - PROCESS | 1935 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:71.00 stddev:8.02 (11.3%) stddev-sans-first:8.14 05:57:59 INFO - PROCESS | 1935 | Values: 68.0 69.0 70.0 69.0 70.0 71.0 71.0 84.0 85.0 89.0 05:57:59 INFO - PROCESS | 1935 | -------- Summary: end -------- 05:57:59 INFO - PROCESS | 1935 | 05:58:00 INFO - TEST-INFO | 1935: exit 0 05:58:00 INFO - TEST-OK | kraken | took 60951ms 05:58:00 INFO - SUITE-END | took 1181s 05:58:00 INFO - Completed test suite (00:19:41) 05:58:00 INFO - javascript benchmark 05:58:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.934901301974, 3290.9177270568234, 3295.8846440374577, 3310.817905015223, 3342.629521896023, 5509.47659972302, 5566.081596536572, 5609.719514024303, 5623.0721930881355, 5665.745041473133, 5596.468335508121, 5598.608097433182, 5611.046122159232, 5619.0, 5624.550035997121, 5105.642605017651, 5136.922946155811, 5144.56271216947, 5175.8188463403785, 5195.090859099642, 5170.1986192140275, 5217.713025783581, 5221.112410890158, 5226.55574276187, 5247.947520524784, 4363.192809330269, 5129.615278854082, 5169.508896654812, 5174.172132458807, 5198.558122559587, 5178.300929374543, 5216.713080780555, 5222.738863056832, 5229.450907654717, 5283.55089817366, 5008.774605142741, 5042.571381432583, 5152.845414637567, 5154.92267615986, 5159.58723302135, 5523.392426833086, 5568.49883510486, 5573.164025396182, 5578.414266501999, 5585.1063829787445, 6146.78486252979, 6151.692415379258, 6155.169052177988, 6158.9692051539905, 6159.3224745277985, 5995.640261584275, 6203.596766210182, 6211.09939058834, 6223.222097237845, 6226.688665566749, 5612.0459521881785, 5645.322561292671, 5652.63257888236, 5697.601167918206, 5711.428857114339, 6293.433590976834, 6309.684515774193, 6309.779157729549, 6310.1796766420075, 6319.747210111636, 5885.676287804212, 6007.978643630593, 6030.155778191057, 6030.728617212236, 6048.455638992512, 5978.013627751372, 6026.246719160105, 6030.517558595302, 6087.54343424245, 6177.413145751147, 6068.939310606837, 6094.061814318811, 6103.701349646989, 6124.326324104345, 6162.784302549389, 6148.4159004895355, 6157.692115394212, 6165.0, 6167.938320616737, 6175.536834737323, 4783.569478746929, 4814.15752243356, 4822.132016237041, 4841.661083724105, 4881.023795240966, 4331.696781225284, 4353.238183317907, 4360.847370342023, 4361.498427680857, 4413.6248418884115, 5688.431156884279, 5688.857778555569, 5689.829305120853, 5690.118031705092, 5694.117411801178, 6177.505799536027, 6188.659623720739, 6190.659513726699, 6192.040233763774, 6194.287656919422, 5486.643368181056, 5603.719814009283, 5618.971905140448, 5633.549316054706, 5677.659340439587, 5354.732263386815, 5361.115415956401, 5367.838964831061, 5389.595780316492, 5393.838184854382, 6306.873862522632, 6307.905381419282, 6320.462760665395, 6328.746850126127, 6332.715027823667, 5872.442117998783, 5970.223870896755, 6198.132261483306, 6204.751809927552, 6220.7511699531515, 5231.29377534028, 6232.875342493216, 6295.527835412271, 6305.432511074026, 6314.368563143649, 6053.364396738455, 6053.727582258897, 6063.696815159313, 6087.969560152171, 6126.295476020315, 5979.850503737442, 6106.870229007669, 6115.661454455199, 6150.600210986271, 6166.229221347332, 5834.066549352084, 5906.911396329145, 5911.615744976735, 5915.08316210988, 6023.698815059317, 5974.910376344272, 5985.40145985398, 5987.760489580368, 5989.221401217814, 6010.87978240424, 4382.342648602735, 5829.15477255804, 5840.94159058404, 5854.795082172103, 5855.151003104611, 5782.5952183348445, 5786.103154011135, 5853.560982926212, 5871.559633027455, 5900.881982360243, 5545.722713864371, 5793.391693872083, 5802.506786923159, 5804.01331773591, 5863.530917526502], "value": 5601.273787562639, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.32904453065333, 502.2065137083409, 512.5463964391515, 519.7868873761759, 523.5968304405608, 25444.600546969934, 31065.68934310659, 31066.2233444164, 31095.06714798554, 31114.91097811577, 31352.529712054336, 32048.038558843215, 33178.8341058295, 39007.024824379405, 40212.798936005354, 9177.265818734486, 9322.161005509503, 9334.0, 9347.018563050884, 9348.906510934872, 9132.817343653123, 9177.541122943827, 9229.261659067259, 9260.305477089212, 9273.489958052305, 8400.41197116202, 8594.957025214866, 9271.629134834599, 10889.564417423293, 11138.220324577283, 10959.123270138409, 11029.283096598696, 11034.889651103467, 11069.446527673585, 11086.279391839505, 10990.615328463466, 11018.44907754609, 11060.889391106148, 11062.944685276603, 11081.72295692606, 30360.240993975105, 30910.53634195489, 37518.0, 38175.0, 38205.61794382076, 3212.261179928606, 3277.246233366315, 3359.10983589349, 3502.4221003534385, 3905.0627849316243, 28616.570751438747, 28704.851805927738, 28899.56650650242, 28919.277018074506, 29672.25819354512, 3119.251379668886, 3140.3876244132402, 3155.3373791503814, 3232.8545215465124, 3235.304409551934, 363149.0, 470304.0, 472555.0, 473829.0, 474707.62646186893, 56722.43277567172, 56959.43040569624, 57005.57486062882, 57155.0, 57338.42661573414, 59871.40128598658, 60114.39885601088, 60232.09651855226, 60362.0, 60374.0, 15041.473548425753, 15506.5348039559, 15533.378664853506, 15540.300686469136, 15547.455839045579, 12123.757524849454, 12135.817962730565, 12159.270443773403, 12166.75666486683, 12172.330521821208, 12924.418401171783, 15191.088534687955, 15736.60658483547, 15804.209789510478, 16038.957467764558, 5097.311862898536, 6073.51411887048, 6154.5076393888385, 6184.443400094013, 6208.844778880564, 707.9221285658573, 955.0640372435053, 985.2413641496008, 986.9309148359689, 1001.369137443406, 22847.428814279778, 28806.85596572004, 29084.73051647902, 29193.56209656857, 29257.707422925923, 965.2374624046925, 976.511744127936, 1018.9286749927434, 1054.8660190295464, 1060.7666313411037, 14638.48765293231, 14908.925455372653, 14965.92517037408, 15302.617434564225, 15432.691346173013, 595683.0, 596257.0, 597085.0, 602062.0, 603243.0, 44184.558154418046, 46633.76683116562, 48548.51451485511, 52865.735671321396, 54782.45217547853, 1329.820474235985, 1344.9125806822526, 1372.2658377768046, 1373.0525937103366, 1376.7865980773197, 28717.425651486436, 28848.85575572193, 29012.564811527423, 29757.851210743807, 29908.0, 47991.520084800104, 48209.5179048205, 48243.75878120587, 48302.27546586734, 48350.0, 582401.0, 601187.0, 601603.0, 744713.0, 744985.0, 24468.51062978766, 24602.50794984126, 24636.688579498874, 24644.01423943022, 24759.25722228336, 41953.0, 42053.36919946142, 42587.5741242596, 42945.785271073444, 43321.78339108284, 35544.93365199048, 35876.82061589675, 35999.64000359963, 36494.4525832118, 36779.63220367762, 29087.12738617845, 35484.64515354813, 35743.28513429769, 36034.27931441409, 36645.816770915975, 28433.857830711542, 35288.29423411466, 35758.10604734902, 36078.09804754902, 36598.08504787295, 30578.0, 31748.36503269968, 31863.84068079645, 32074.19814504656, 32118.67881321157, 23683.763162368155, 23995.186641936794, 23997.640035399832, 24096.397590060387, 24289.149879754124], "value": 18832.230438048817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.3313870798712, 361.6148801526374, 369.56022333423243, 373.1641123882503, 396.14630471334266, 14936.327865246063, 15305.081695098303, 15890.602734931632, 19377.80622193781, 20633.071511781967, 16598.253078611462, 18935.0, 19444.902775486138, 19993.900030499863, 20190.697139542917, 5586.10622300431, 5875.7062146892695, 5880.882382352372, 5886.852828679296, 5891.941080589182, 5273.866118784461, 5600.327960644729, 5785.884282314351, 5829.562782791287, 5830.21292125564, 5781.421857814227, 5783.450572195635, 5783.826485205451, 5786.305643322808, 5787.074068149097, 5542.972285138569, 5747.166660834177, 5835.5915085944, 5839.211706419664, 5841.766329346821, 4950.801967921278, 5099.898002039939, 5110.386753589556, 5112.10538155825, 5119.820806271762, 12334.5066197352, 12836.999885446136, 12996.935015324958, 13002.609921702364, 13021.348932553334, 2110.7150534677776, 2277.202978957368, 2374.536965291769, 2554.731753165928, 2606.0845278720126, 9161.496117713523, 9663.516824158763, 9677.854832177523, 9791.564712814758, 10091.848622270672, 1709.8204688507776, 1793.506785633948, 1804.7292906064195, 1805.3951926104771, 1805.6840052990674, 100654.0, 115549.0, 126143.21570352904, 129351.70648293584, 130226.0, 9435.150836424755, 10589.788204235872, 11260.0, 11303.208775385809, 11508.88491115078, 14338.641533961734, 14415.567532974028, 14416.279186040656, 14442.783358249635, 14469.638259043608, 7271.781846544613, 8004.719834805754, 8049.879251811228, 8363.498190108612, 8486.108958559385, 8172.264496195371, 8181.713640022571, 8183.427160098855, 8349.290310323691, 8355.248027677539, 3692.316921369555, 4406.49325327585, 4412.470503539532, 4454.665900057444, 4500.662450316174, 1688.7044767165696, 1806.4851517317502, 1825.9135814190536, 1877.192807092936, 1882.6234753049446, 604.3141034925303, 817.284875733733, 834.2616784145953, 838.3251482556478, 847.6905929335747, 13245.470181192837, 17014.236013915877, 17022.404215852384, 17360.95834249949, 17822.821771782375, 695.9408450281682, 801.1867954026668, 822.2147848804497, 841.4026041510596, 843.0852525010432, 8432.831343373098, 8679.392442528962, 8923.063078376677, 9082.228010619172, 9166.587503562356, 515729.42135289835, 549407.6447358554, 553518.0, 558564.0, 559270.0, 94794.52602736941, 102379.48810255901, 118721.0, 124659.75340246482, 131217.34391327982, 858.1590041758986, 902.801383695586, 907.3693782821008, 981.8969008254173, 984.1487113646645, 12949.352532373532, 16078.0, 16213.918930405272, 16457.177141142656, 16649.50051498457, 53217.20174197468, 54862.0, 55055.44944550503, 55960.44039559552, 56666.43333566777, 74066.62966685132, 76364.0, 82485.0, 86867.0, 87172.44796828543, 6338.524610654312, 7067.116610423697, 7379.741709040158, 7972.601369931596, 8337.749867503984, 12024.458899349374, 12865.678358041125, 12979.221246725227, 13322.866771332163, 13347.399367028313, 7709.498882572839, 8677.566121694017, 9678.128968392879, 10906.127509799355, 11193.832092518456, 10784.0, 10924.235303528676, 11222.943885280521, 11250.774984500427, 11409.60066397672, 11088.611898583511, 11252.66242012741, 11455.0, 11508.654740357802, 11705.473253703774, 6929.792106236821, 7297.963510182628, 7972.711587133529, 7980.521168729895, 8369.707060252862, 10271.537780799732, 10774.892251077703, 11179.66461006171, 11194.66416007521, 11301.491432885705], "value": 8863.029184711047, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.1918758338788, 1461.269365317341, 1616.975745363819, 1816.4096668582713, 1843.235057451158, 7823.178566250547, 8256.545889976056, 8257.917420825797, 8263.710770123047, 8264.793380165484, 7203.207647158822, 7448.292412220831, 7454.254574542557, 7712.383009359251, 8033.758987230378, 2215.5901158285687, 2268.9773102269014, 2272.170657709932, 2280.521090570982, 2282.7032485776826, 2274.7725227477204, 2292.862428254302, 2318.860868347896, 2321.6401457773986, 2326.325365643961, 2264.4225722440838, 2268.3081660093667, 2291.117919600949, 2294.300238427279, 2297.7127859017623, 1881.5860510687626, 2170.8914554272224, 2204.151401710337, 2226.25420484138, 2232.6092933736613, 2251.6284813005836, 2276.863388196697, 2277.430642339415, 2277.6014197515533, 2279.099755596547, 7919.010123734533, 8069.152738962442, 8069.475484093515, 8076.353891688651, 8135.918640813576, 4892.266160075981, 5086.669366491204, 5087.0, 5089.821856235014, 5092.719900405476, 3113.237256872058, 3201.599800024997, 3434.1414646338417, 3450.189205536697, 3455.3089382123676, 883.5273128876021, 1055.883852776194, 1071.7320669832543, 1074.0923919288189, 1084.430673896203, 10121.443320617363, 10345.793084138275, 10354.741131471697, 10360.171186305077, 10538.0, 4377.606015458624, 4394.209042372339, 4565.703229290086, 4582.335561343587, 4586.243269860435, 9124.270058395312, 9220.815583688289, 9230.861537076815, 9233.353665243369, 9251.629934802668, 5104.770285337168, 5114.514121158484, 5115.820946266863, 5118.309028281209, 5126.564242039469, 4172.979135104305, 4204.936925946114, 4292.763897985641, 4570.702904311209, 4679.298105284234, 3650.0509867434125, 3681.7238707097076, 3761.1725420407465, 3796.1458671798623, 3804.524434445694, 1213.3387303919208, 1241.596481143632, 1246.8628450870397, 1261.2684642907093, 1263.406199086428, 855.8758979947872, 871.1288711288711, 872.1322284327135, 895.785011597212, 911.0889110889111, 5444.673319600836, 5550.500454958992, 5587.664740115606, 5804.4775970162045, 5862.618929769551, 881.1496905486237, 897.2463130970017, 898.8606765951288, 906.6464079009191, 986.7024862306044, 3080.3069309405205, 3742.139307959185, 3745.6441638044344, 3794.962050379461, 3845.2309538092495, 9411.764705882408, 9750.804983900282, 9875.358101723365, 9876.555555000043, 9909.355891867006, 9828.967958364412, 9842.0, 9844.50777461124, 9846.261530385107, 9856.063673951106, 7203.927960720431, 7514.47398682087, 7549.773506794915, 7661.770146895602, 7690.038745156856, 5315.946840531546, 5462.6995515247045, 5486.6982315973, 5501.724913754377, 5697.145428185805, 8875.423097498642, 8937.508437036025, 9222.216111630318, 9272.258219342571, 9284.72145835626, 8496.192861678132, 8724.476531408136, 9109.635614575607, 9260.49067301305, 9384.061593840834, 6398.48812095022, 6602.372774586406, 6609.372109649576, 6777.93222067773, 7011.614361210182, 7445.7766267012075, 7680.654370553227, 7687.0, 7799.844003120019, 7819.452638315263, 6833.3166683331265, 6940.722371105099, 6949.30506949301, 7010.158780946319, 7071.611061391467, 6825.761098361732, 6850.4862135341045, 6855.314468553105, 6892.069570608104, 6931.133608298963, 6301.117843501822, 6415.582987105823, 6509.576877502947, 6516.706748196438, 6522.412982831568, 4737.218358970731, 4761.571458568746, 4789.928151077806, 4826.396700412449, 4894.535019173173, 4641.419822522184, 4688.835890743808, 4820.758962051813, 4871.318015477765, 4995.750212489288], "value": 4314.888490312669, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.1849977311599, 303.3826163756755, 308.2970826515545, 313.75997362018046, 317.5538368592129, 5276.551493123079, 5292.497212764786, 5346.732663366831, 5352.7883270037955, 5359.678419294835, 4929.926051109236, 5034.924476132861, 5053.5451809337155, 5066.493350664931, 5298.7350632468315, 4009.138035322405, 4037.6769858411403, 4061.964199129218, 4075.1442197138635, 4092.608513105551, 3602.8198590070524, 4032.2943484890175, 4052.8986775330704, 4067.4305597216267, 4091.3862920562005, 3344.331133773243, 3920.4511368408444, 4011.7392369496033, 4051.5745846686114, 4131.223573863238, 3986.521617405901, 3997.020729921159, 4005.8798236052967, 4011.4699064822917, 4049.858254961077, 3071.832703572628, 3477.4957631143598, 3487.2676737885076, 3500.2299494111508, 3510.1926556891804, 4710.222813235812, 4753.025629745894, 4801.207800712878, 5015.749212539395, 5103.617228707824, 3988.202359528106, 4333.180064372939, 4532.501424843297, 4545.227311357077, 4550.544945505456, 4874.951250487486, 5063.860631357952, 5421.918671219935, 5443.700596467193, 5448.972755136199, 3226.5805445291962, 3848.3073046851555, 3857.3442514772555, 3861.343571592836, 3871.9612803871883, 4670.416197975253, 4789.664723469358, 5131.717755523445, 5246.0, 5659.688717120557, 3896.883093507199, 3905.511811023622, 3922.9215415692097, 3924.0, 3942.842286308573, 3736.7384283100464, 3920.5491368492417, 3934.8426062957733, 3944.684425245973, 3954.6638535724787, 3634.0, 4028.6633752423522, 4525.321201819687, 4541.977290113595, 4543.522930092358, 4802.471728109905, 5419.891602168013, 5433.782648694087, 5448.101063324507, 5570.100929349472, 1096.9633696157055, 1187.9961432589448, 1226.0926914083514, 1244.147758785235, 1259.6472987563498, 680.0581195044898, 704.651197657163, 808.8422757562337, 849.6941101203562, 857.7812657772229, 4892.82269390118, 4944.381952255968, 4947.802087916443, 5007.718400767364, 5055.823046193439, 4383.254846676073, 4644.349791029259, 4951.603871690256, 4954.925676114861, 5329.8934021319355, 4617.275807273724, 4691.756684478616, 4695.5253112696355, 4736.1055577768475, 4978.7929199826085, 2350.200931683236, 2456.005317846275, 2473.7649923257263, 2663.654854298567, 2802.285417218596, 4827.324174615556, 5041.924371134436, 5123.538881500683, 5482.451754824486, 5602.971985140048, 4484.69038445201, 4549.363089167519, 4654.813807447664, 4992.875178120504, 5486.91769623448, 5511.2364043506495, 5560.944390556205, 5572.442755724395, 5579.8884022320135, 5593.664380137205, 4415.867523974286, 4894.82868099629, 4927.260910863399, 5118.488151184852, 5221.947780522146, 4516.367708520876, 4875.0, 5086.694798312114, 5650.689212093374, 5654.321481422256, 5443.700596467233, 5630.5214056805635, 5880.558958078076, 5890.617109887844, 5905.232319798399, 3327.650596687313, 3512.016635342108, 3557.8043207623828, 3768.9246215074995, 3821.8662346817728, 4390.165868484977, 4682.859514214579, 5453.727313634382, 5693.345265294544, 5732.7706891723865, 4637.353739422457, 5074.441811400669, 5451.863703407288, 5479.890402191854, 5504.834854954358, 4882.511748825089, 5306.97346513265, 5428.538574221236, 5471.863203419946, 5480.506754392124, 4663.11143986686, 4913.968066706032, 5281.762320695655, 5345.278387417648, 5374.865628359323, 4325.697201195886, 4658.324542941323, 4695.5539223773685, 5254.65844720092, 5317.776911310498, 5269.920951185812, 5284.9471505284455, 5350.652207606493, 5387.299651045339, 5470.507654310972], "value": 3908.4879953935615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.4908522267409, 674.6154691825658, 700.6916956539119, 759.5556599389357, 759.8404335089631, 14677.77983330251, 15495.0, 15525.456609018687, 16746.24641891115, 17530.386436474724, 15809.525714228563, 16352.22012257916, 16355.34578616857, 16358.263878125483, 16400.179991000463, 659.3670076726348, 821.322409012564, 846.9703560375389, 848.9235968762811, 850.2093053460279, 668.4919461209491, 808.4260175275562, 831.8003679116998, 837.3217693668117, 844.9986765682655, 885.0220506340497, 887.2103827593447, 888.2716172738357, 889.4529864133576, 889.7864512516982, 883.0198479687542, 884.0231544143693, 884.1026358246385, 884.4118661090367, 884.6372987075332, 504.23104765232944, 521.0542864700557, 634.5209366927986, 649.4998850884839, 656.4256275758711, 15192.848071519364, 15242.466513671969, 15248.618784530365, 15255.923720381437, 15279.923600381928, 11128.49921753523, 11300.265482743678, 13683.452661893512, 13688.589342319747, 13796.965227607969, 10875.401852898087, 11671.766564668744, 12151.635450936486, 12318.753624927542, 12814.0, 4253.851115210984, 4302.956970430287, 4407.537208593116, 4476.932846007313, 4520.819167233307, 89290.0, 96232.0, 110953.0, 115385.0, 116073.0, 8976.237019853386, 10353.378797272188, 10392.272540922215, 10435.94782026085, 10560.630377936735, 21531.461713457287, 21856.125754969624, 21869.67195492069, 21897.671534926987, 21904.78095219059, 7341.375983041501, 7469.813254668677, 7572.0, 7574.469787114849, 7663.271989161132, 3958.0302825807285, 4048.1220129743588, 4082.22437736835, 4105.753654780723, 4129.6489798367475, 3310.0400883743446, 3396.9150771230916, 3435.879744208941, 3437.862485500602, 3439.724822014233, 600.67263341479, 608.5831205624162, 621.9346968568326, 626.996865015672, 628.3025841316136, 434.83476279013775, 501.64383287866025, 589.908564172554, 593.403629352498, 692.1797669761248, 8095.190480951976, 8440.915590844135, 8737.259202033518, 8752.562371881508, 8899.15458031486, 515.6132900324757, 532.8481382805882, 557.2115456628906, 563.3605857351853, 631.4159402552621, 4138.468766556393, 4182.749035057906, 4412.139632771578, 4447.073561138554, 4544.568266014723, 109571.45214273878, 113540.43229783798, 115194.63248307693, 115590.0, 116747.0, 94736.0, 99546.0, 101137.98862011285, 102132.48933755283, 104407.95592044134, 69392.0, 88769.11230887608, 89324.0, 89726.65410018855, 91902.0, 8581.227689507974, 8585.313174945864, 8588.914110858812, 8699.521526316114, 8805.559722013746, 49565.50434495609, 53621.92756144933, 55490.0, 55525.0, 58037.77660010619, 55573.38772979743, 64006.07981760555, 69037.65481172562, 70982.0, 74697.6265118671, 11804.763904721685, 12277.815832762695, 12292.631221063382, 12576.371181441074, 13235.80146297787, 13835.377408016462, 14137.081089729134, 14248.497690090097, 14432.42270309176, 14443.422263109358, 13466.326683665973, 13497.39261733244, 13663.521776737767, 14102.0, 14197.645058873612, 13427.395767190696, 13431.529896453578, 13663.863361366657, 13745.38145783422, 13878.930605346908, 13124.409401577142, 13211.603651890458, 13389.330533473481, 13456.663583410493, 13471.0, 9184.954075229582, 10981.231313807957, 11003.119750419786, 11246.268992515788, 11667.066634669036, 11278.661640150809, 11360.659180224606, 11378.772424551627, 11519.769604607693, 11559.07527397823], "value": 7370.293116979586, "unit": "score"}], "name": "dromaeo_css", "value": 6985.757737229605, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 117.0, 163.0, 140.0, 115.0, 114.0, 114.0, 113.0, 114.0], "value": 120.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 143.0, 118.0, 176.0, 147.0, 112.0, 115.0, 119.0, 166.0, 142.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 179.0, 181.0, 184.0, 183.0, 184.0, 187.0, 185.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 88.0, 64.0, 61.0, 60.0, 59.0, 74.0, 59.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 85.0, 70.0, 68.0, 68.0, 82.0, 68.0, 91.0, 112.0], "value": 80.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 87.0, 90.0, 88.0, 91.0, 88.0, 90.0, 86.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 99.0, 99.0, 99.0, 100.0, 99.0, 99.0, 99.0, 100.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 87.0, 85.0, 88.0, 85.0, 87.0, 88.0, 86.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 57.0, 57.0, 57.0, 55.0, 55.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 95.0, 115.0, 110.0, 71.0, 72.0, 74.0, 74.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 87.0, 85.0, 78.0, 88.0, 102.0, 106.0, 105.0, 109.0], "value": 93.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 146.0, 142.0, 148.0, 149.0, 152.0, 162.0, 151.0, 219.0, 162.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 174.0, 176.0, 175.0, 175.0, 174.0, 172.0, 175.0, 173.0, 171.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 69.0, 70.0, 71.0, 71.0, 84.0, 85.0, 89.0], "value": 74.6, "unit": "score"}], "name": "kraken", "value": 1505.1, "alertThreshold": 2.0}]} 05:58:00 INFO - Return code: 0 05:58:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:58:00 INFO - # TBPL SUCCESS # 05:58:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:58:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:58:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:58:00 INFO - 2016-11-28 05:58:00.717 screenresolution[1939:21206] starting screenresolution argv=screenresolution get 05:58:00 INFO - 2016-11-28 05:58:00.720 screenresolution[1939:21206] Display 0: 1600x1200x32@60 05:58:00 INFO - 2016-11-28 05:58:00.726 screenresolution[1940:21209] starting screenresolution argv=screenresolution list 05:58:00 INFO - Available Modes on Display 0 05:58:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:58:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:58:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:58:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:58:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:58:00 INFO - Intel Iris: 05:58:00 INFO - Chipset Model: Intel Iris 05:58:00 INFO - Type: GPU 05:58:00 INFO - Bus: Built-In 05:58:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:58:00 INFO - Vendor: Intel (0x8086) 05:58:00 INFO - Device ID: 0x0a2e 05:58:00 INFO - Revision ID: 0x0009 05:58:00 INFO - Displays: 05:58:00 INFO - Display: 05:58:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:58:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:58:00 INFO - Display Serial Number: 1600x1200 60 05:58:00 INFO - Main Display: Yes 05:58:00 INFO - Mirror: Off 05:58:00 INFO - Online: Yes 05:58:00 INFO - Rotation: Supported 05:58:00 INFO - Return code: 0 05:58:00 INFO - Running post-action listener: _resource_record_post_action 05:58:00 INFO - [mozharness: 2016-11-28 13:58:00.972884Z] Finished run-tests step (success) 05:58:00 INFO - Running post-run listener: _resource_record_post_run 05:58:01 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 630784; Write bytes: 691725312; Read time: 8; Write time: 2129 05:58:01 INFO - TinderboxPrint: CPU usage
53.5% 05:58:01 INFO - TinderboxPrint: I/O read bytes / time
630,784 / 8 05:58:01 INFO - TinderboxPrint: I/O write bytes / time
691,725,312 / 2,129 05:58:01 INFO - TinderboxPrint: CPU idle
2,258.5 (46.5%) 05:58:01 INFO - TinderboxPrint: CPU system
973.6 (20.0%) 05:58:01 INFO - TinderboxPrint: CPU user
1,629.5 (33.5%) 05:58:01 INFO - TinderboxPrint: Swap in / out
383,721,472 / 0 05:58:01 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 378393088; Write bytes: 373831680; Read time: 28919; Write time: 706 05:58:01 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 581632; Write bytes: 303393792; Read time: 7; Write time: 1376 05:58:01 INFO - Running post-run listener: _upload_blobber_files 05:58:01 INFO - Blob upload gear active. 05:58:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:58:01 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 05:58:01 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:58:01 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:58:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:58:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:58:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:02 INFO - (blobuploader) - INFO - Done attempting. 05:58:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:58:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:03 INFO - (blobuploader) - INFO - Done attempting. 05:58:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:58:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:58:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:06 INFO - (blobuploader) - INFO - Done attempting. 05:58:06 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:06 INFO - Return code: 0 05:58:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:58:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d29e8110431a643c983538da2ba847c9095912141dadd7e673ff82799d207cce32da7a27027a460b49d202fafe51489d4643b33eda4db90cc41bd6aa4578ecdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7adf682497b2cc7ea0d0b8135c84571951cd89e35846443d07742a720ce369f5baf93260f0a90c367db0c984a6185c9e0f995abd080e5d2738ba97300839c174", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdf4e35305c1aabcb085e0a46d18c8ab51df3dbb27288f32857dc7b1849d1a8c6634d5e44e7f1f3041edfa787adb37ca50999ef94afe756490220b19e6455ab0"} 05:58:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:58:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:58:06 INFO - Contents: 05:58:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d29e8110431a643c983538da2ba847c9095912141dadd7e673ff82799d207cce32da7a27027a460b49d202fafe51489d4643b33eda4db90cc41bd6aa4578ecdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7adf682497b2cc7ea0d0b8135c84571951cd89e35846443d07742a720ce369f5baf93260f0a90c367db0c984a6185c9e0f995abd080e5d2738ba97300839c174", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdf4e35305c1aabcb085e0a46d18c8ab51df3dbb27288f32857dc7b1849d1a8c6634d5e44e7f1f3041edfa787adb37ca50999ef94afe756490220b19e6455ab0"} 05:58:06 INFO - Running post-run listener: copy_logs_to_upload_dir 05:58:06 INFO - Copying logs to upload dir... 05:58:06 INFO - mkdir: /builds/slave/test/build/upload/logs 05:58:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.812203 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-28 05:58:06.189732) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 05:58:06.192888) ========= 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.7ijlRxfpP8/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.dAlxlspE0q/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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/Firefox/sha512/d29e8110431a643c983538da2ba847c9095912141dadd7e673ff82799d207cce32da7a27027a460b49d202fafe51489d4643b33eda4db90cc41bd6aa4578ecdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7adf682497b2cc7ea0d0b8135c84571951cd89e35846443d07742a720ce369f5baf93260f0a90c367db0c984a6185c9e0f995abd080e5d2738ba97300839c174", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdf4e35305c1aabcb085e0a46d18c8ab51df3dbb27288f32857dc7b1849d1a8c6634d5e44e7f1f3041edfa787adb37ca50999ef94afe756490220b19e6455ab0"} build_url:https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011675 build_url: 'https://queue.taskcluster.net/v1/task/XJHeMfYcSDC4ls6WdvTRsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d29e8110431a643c983538da2ba847c9095912141dadd7e673ff82799d207cce32da7a27027a460b49d202fafe51489d4643b33eda4db90cc41bd6aa4578ecdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7adf682497b2cc7ea0d0b8135c84571951cd89e35846443d07742a720ce369f5baf93260f0a90c367db0c984a6185c9e0f995abd080e5d2738ba97300839c174", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdf4e35305c1aabcb085e0a46d18c8ab51df3dbb27288f32857dc7b1849d1a8c6634d5e44e7f1f3041edfa787adb37ca50999ef94afe756490220b19e6455ab0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 05:58:06.227427) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:58:06.227727) ========= 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.7ijlRxfpP8/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.dAlxlspE0q/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.004549 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:58:06.275838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 05:58:06.276134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 05:58:06.276431) ========= ========= Total master_lag: 0.96 =========