builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0353 starttime: 1477330137.9 results: success (0) buildid: 20161024075623 builduid: 97b197ede2464edb9231fa49c27e2fdd revision: c845bfd0accb7e0c29b41713255963b08006e701 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 10:28:57.900997) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 10:28:57.901463) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 10:28:57.901753) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 10:28:57.925658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:28:57.925937) ========= 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.HPhvvNsB3d/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.xP5ftxAp58/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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-10-24 10:28:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.2M=0.001s 2016-10-24 10:28:58 (19.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104855 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:28:58.052839) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:28:58.053153) ========= 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.HPhvvNsB3d/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.xP5ftxAp58/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.024955 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:28:58.101650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 10:28:58.102022) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c845bfd0accb7e0c29b41713255963b08006e701 --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 c845bfd0accb7e0c29b41713255963b08006e701 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HPhvvNsB3d/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.xP5ftxAp58/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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-10-24 10:28:58,187 truncating revision to first 12 chars 2016-10-24 10:28:58,187 Setting DEBUG logging. 2016-10-24 10:28:58,187 attempt 1/10 2016-10-24 10:28:58,187 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c845bfd0accb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 10:28:59,805 unpacking tar archive at: mozilla-central-c845bfd0accb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.883693 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 10:29:00.008122) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 10:29:00.008448) ========= script_repo_revision: c845bfd0accb7e0c29b41713255963b08006e701 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 10:29:00.008892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 10:29:00.009167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 10:29:00.027713) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-24 10:29:00.028108) ========= /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.HPhvvNsB3d/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.xP5ftxAp58/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 10:29:00 INFO - MultiFileLogger online at 20161024 10:29:00 in /builds/slave/test 10:29:00 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 10:29:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:29:00 INFO - {'append_to_log': False, 10:29:00 INFO - 'base_work_dir': '/builds/slave/test', 10:29:00 INFO - 'blob_upload_branch': 'Firefox', 10:29:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:29:00 INFO - 'branch': 'Firefox', 10:29:00 INFO - 'buildbot_json_path': 'buildprops.json', 10:29:00 INFO - 'config_files': ('talos/mac_config.py',), 10:29:00 INFO - 'default_actions': ('clobber', 10:29:00 INFO - 'read-buildbot-config', 10:29:00 INFO - 'download-and-extract', 10:29:00 INFO - 'populate-webroot', 10:29:00 INFO - 'create-virtualenv', 10:29:00 INFO - 'install', 10:29:00 INFO - 'run-tests'), 10:29:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:29:00 INFO - 'download_minidump_stackwalk': True, 10:29:00 INFO - 'download_symbols': 'ondemand', 10:29:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:29:00 INFO - 'tooltool.py': '/tools/tooltool.py', 10:29:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:29:00 INFO - '/tools/misc-python/virtualenv.py')}, 10:29:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:29:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:29:00 INFO - 'installer_path': 'installer.exe', 10:29:00 INFO - 'log_level': 'info', 10:29:00 INFO - 'log_name': 'talos', 10:29:00 INFO - 'log_to_console': True, 10:29:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:29:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:29:00 INFO - 'opt_config_files': (), 10:29:00 INFO - 'pip_index': False, 10:29:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:29:00 INFO - 'cmd': ('bash', 10:29:00 INFO - '-c', 10:29:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:29:00 INFO - 'enabled': True, 10:29:00 INFO - 'halt_on_failure': False, 10:29:00 INFO - 'name': 'check_screen_resolution'},), 10:29:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:29:00 INFO - 'cmd': ('bash', 10:29:00 INFO - '-c', 10:29:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:29:00 INFO - 'enabled': True, 10:29:00 INFO - 'halt_on_failure': False, 10:29:00 INFO - 'name': 'check_screen_resolution'},), 10:29:00 INFO - 'run_cmd_checks_enabled': True, 10:29:00 INFO - 'sps_profile': False, 10:29:00 INFO - 'sps_profile_interval': 0, 10:29:00 INFO - 'suite': 'dromaeojs', 10:29:00 INFO - 'system_bits': '32', 10:29:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:29:00 INFO - 'title': 't-yosemite-r7-0353', 10:29:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:29:00 INFO - 'use_talos_json': True, 10:29:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:29:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:29:00 INFO - 'work_dir': 'build'} 10:29:00 INFO - [mozharness: 2016-10-24 17:29:00.234969Z] Running clobber step. 10:29:00 INFO - Running pre-action listener: _resource_record_pre_action 10:29:00 INFO - Running main action method: clobber 10:29:00 INFO - rmtree: /builds/slave/test/build 10:29:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:29:02 INFO - Running post-action listener: _resource_record_post_action 10:29:02 INFO - [mozharness: 2016-10-24 17:29:02.281612Z] Finished clobber step (success) 10:29:02 INFO - [mozharness: 2016-10-24 17:29:02.281776Z] Running read-buildbot-config step. 10:29:02 INFO - Running pre-action listener: _resource_record_pre_action 10:29:02 INFO - Running main action method: read_buildbot_config 10:29:02 INFO - Using buildbot properties: 10:29:02 INFO - { 10:29:02 INFO - "project": "", 10:29:02 INFO - "product": "firefox", 10:29:02 INFO - "script_repo_revision": "production", 10:29:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:29:02 INFO - "repository": "", 10:29:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:29:02 INFO - "buildid": "20161024075623", 10:29:02 INFO - "pgo_build": "False", 10:29:02 INFO - "basedir": "/builds/slave/test", 10:29:02 INFO - "buildnumber": 59, 10:29:02 INFO - "slavename": "t-yosemite-r7-0353", 10:29:02 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:29:02 INFO - "platform": "yosemite_r7", 10:29:02 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:29:02 INFO - "branch": "mozilla-central", 10:29:02 INFO - "repo_path": "mozilla-central", 10:29:02 INFO - "revision": "c845bfd0accb7e0c29b41713255963b08006e701", 10:29:02 INFO - "stage_platform": "macosx64", 10:29:02 INFO - "builduid": "97b197ede2464edb9231fa49c27e2fdd", 10:29:02 INFO - "slavebuilddir": "test" 10:29:02 INFO - } 10:29:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:29:02 INFO - Running post-action listener: _resource_record_post_action 10:29:02 INFO - [mozharness: 2016-10-24 17:29:02.285015Z] Finished read-buildbot-config step (success) 10:29:02 INFO - [mozharness: 2016-10-24 17:29:02.285153Z] Running download-and-extract step. 10:29:02 INFO - Running pre-action listener: _resource_record_pre_action 10:29:02 INFO - Running main action method: download_and_extract 10:29:02 INFO - mkdir: /builds/slave/test/build/tests 10:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:02 INFO - trying https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:29:02 INFO - Downloading https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 10:29:03 INFO - Downloaded 1199 bytes. 10:29:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:29:03 INFO - Using the following test package requirements: 10:29:03 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:29:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:29:03 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:29:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:29:03 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:29:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:29:03 INFO - u'jsshell-mac.zip'], 10:29:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:29:03 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:29:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:29:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:29:03 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:29:03 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:29:03 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:29:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:29:03 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 10:29:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:29:03 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:29:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:29:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:29:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:29:03 INFO - Fetch https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:29:04 INFO - Http code: 200 10:29:04 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 10:29:04 INFO - x-amz-cf-id: J0NmLhE_UWGGhWBP4HvtKj9VNn6zdvAqPYMITRcPDHshiNOCHk9_Mg== 10:29:04 INFO - x-amz-version-id: ZsKtRJZQ1aw3ASxh1Ds6twhUPVrNY_VX 10:29:04 INFO - Expected file size: 16409408 10:29:04 INFO - Obtained file size: 16409408 10:29:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:29:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:29:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:29:11 INFO - Fetch https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:29:11 INFO - Http code: 200 10:29:11 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 10:29:11 INFO - x-amz-cf-id: a6D_1w27ICuTz_p6EOKFW9n-5ilY-xpOMbL3kRL1lwcQZu-2JQNi7A== 10:29:11 INFO - x-amz-version-id: ZsKtRJZQ1aw3ASxh1Ds6twhUPVrNY_VX 10:29:11 INFO - Expected file size: 16409408 10:29:11 INFO - Obtained file size: 16409408 10:29:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:29:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:29:18 INFO - Fetch https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:29:18 INFO - Http code: 200 10:29:18 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 10:29:18 INFO - x-amz-cf-id: 4L5sSngq8pqlWoH8EfYWSp5upVjX7hbOr0z8auJ8_gJ1lUCcO5QHFg== 10:29:18 INFO - x-amz-version-id: ZZVx5bpq6cWx9TCR3r0pt1jr0alDtQZU 10:29:19 INFO - Expected file size: 14409028 10:29:19 INFO - Obtained file size: 14409028 10:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:19 INFO - trying https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:29:19 INFO - Downloading https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 10:29:22 INFO - Downloaded 111235715 bytes. 10:29:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:29:22 INFO - mkdir: /builds/slave/test/properties 10:29:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:29:22 INFO - Writing to file /builds/slave/test/properties/build_url 10:29:22 INFO - Contents: 10:29:22 INFO - build_url:https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:29:23 INFO - Running post-action listener: _resource_record_post_action 10:29:23 INFO - Running post-action listener: set_extra_try_arguments 10:29:23 INFO - [mozharness: 2016-10-24 17:29:23.008354Z] Finished download-and-extract step (success) 10:29:23 INFO - [mozharness: 2016-10-24 17:29:23.008508Z] Running populate-webroot step. 10:29:23 INFO - Running pre-action listener: _resource_record_pre_action 10:29:23 INFO - Running main action method: populate_webroot 10:29:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:29:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:29:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:29:23 INFO - '--tppagecycles', 10:29:23 INFO - '7'], 10:29:23 INFO - 'tests': ['tsvgm']}}, 10:29:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:29:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:29:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:29:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:29:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:29:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:29:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:23 INFO - 'talos_options': ['--disable-e10s'], 10:29:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:23 INFO - 'talos_options': ['--disable-e10s'], 10:29:23 INFO - 'tests': ['damp', 'tps']}, 10:29:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:23 INFO - 'tests': ['damp', 'tps']}, 10:29:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:29:23 INFO - 'tests': ['dromaeo_dom']}, 10:29:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:29:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:29:23 INFO - 'tests': ['basic_compositor_video']}, 10:29:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:29:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:29:23 INFO - 'tests': ['a11yr', 10:29:23 INFO - 'ts_paint', 10:29:23 INFO - 'tpaint', 10:29:23 INFO - 'sessionrestore', 10:29:23 INFO - 'sessionrestore_no_auto_restore', 10:29:23 INFO - 'tabpaint']}, 10:29:23 INFO - 'other-e10s': {'tests': ['a11yr', 10:29:23 INFO - 'ts_paint', 10:29:23 INFO - 'tpaint', 10:29:23 INFO - 'sessionrestore', 10:29:23 INFO - 'sessionrestore_no_auto_restore', 10:29:23 INFO - 'tabpaint']}, 10:29:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:29:23 INFO - 'ts_paint', 10:29:23 INFO - 'tpaint', 10:29:23 INFO - 'sessionrestore', 10:29:23 INFO - 'sessionrestore_no_auto_restore', 10:29:23 INFO - 'tabpaint']}, 10:29:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:29:23 INFO - 'ts_paint', 10:29:23 INFO - 'tpaint', 10:29:23 INFO - 'sessionrestore', 10:29:23 INFO - 'sessionrestore_no_auto_restore', 10:29:23 INFO - 'tabpaint']}, 10:29:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:29:23 INFO - 'tests': ['a11yr', 10:29:23 INFO - 'ts_paint', 10:29:23 INFO - 'tpaint', 10:29:23 INFO - 'sessionrestore', 10:29:23 INFO - 'sessionrestore_no_auto_restore', 10:29:23 INFO - 'tabpaint']}, 10:29:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:29:23 INFO - 'tests': ['a11yr', 10:29:23 INFO - 'ts_paint', 10:29:23 INFO - 'tpaint', 10:29:23 INFO - 'sessionrestore', 10:29:23 INFO - 'sessionrestore_no_auto_restore', 10:29:23 INFO - 'tabpaint']}, 10:29:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:29:23 INFO - 'tests': ['tsvgx', 10:29:23 INFO - 'tsvgr_opacity', 10:29:23 INFO - 'tart', 10:29:23 INFO - 'tscrollx', 10:29:23 INFO - 'cart']}, 10:29:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:29:23 INFO - 'tsvgr_opacity', 10:29:23 INFO - 'tart', 10:29:23 INFO - 'tscrollx', 10:29:23 INFO - 'cart']}, 10:29:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:23 INFO - 'talos_options': ['--disable-e10s'], 10:29:23 INFO - 'tests': ['tp5o']}, 10:29:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:23 INFO - 'tests': ['tp5o']}, 10:29:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:23 INFO - 'talos_options': ['--disable-e10s', 10:29:23 INFO - '--xperf_path', 10:29:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:23 INFO - 'tests': ['tp5n']}, 10:29:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:23 INFO - 'talos_options': ['--xperf_path', 10:29:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:23 INFO - 'tests': ['tp5n']}}, 10:29:23 INFO - 'talos.zip': {'path': '', 10:29:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:29:23 INFO - Running post-action listener: _resource_record_post_action 10:29:23 INFO - [mozharness: 2016-10-24 17:29:23.028015Z] Finished populate-webroot step (success) 10:29:23 INFO - [mozharness: 2016-10-24 17:29:23.028150Z] Running create-virtualenv step. 10:29:23 INFO - Running pre-action listener: _resource_record_pre_action 10:29:23 INFO - Running main action method: create_virtualenv 10:29:23 INFO - Creating virtualenv /builds/slave/test/build/venv 10:29:23 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 10:29:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:29:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:29:23 INFO - Using real prefix '/tools/python27' 10:29:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:29:23 INFO - Installing distribute.............................................................................................................................................................................................done. 10:29:26 INFO - Installing pip.................done. 10:29:26 INFO - Return code: 0 10:29:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:29:27 INFO - Reading from file tmpfile_stdout 10:29:27 INFO - Output received: 10:29:27 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) 10:29:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:29:27 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')]} 10:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:27 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')]} 10:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:27 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 0x105886490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f809856a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569ad30>, '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 0x1054c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105692b20>, '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.HPhvvNsB3d/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.xP5ftxAp58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 10:29:27 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 10:29:27 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 10:29:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPhvvNsB3d/Render', 10:29:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:27 INFO - 'HOME': '/Users/cltbld', 10:29:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:27 INFO - 'LOGNAME': 'cltbld', 10:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:27 INFO - 'MOZ_NO_REMOTE': '1', 10:29:27 INFO - 'NO_EM_RESTART': '1', 10:29:27 INFO - 'PAGER': '/bin/cat', 10:29:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:27 INFO - 'PWD': '/builds/slave/test', 10:29:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:27 INFO - 'SHELL': '/bin/bash', 10:29:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP5ftxAp58/Listeners', 10:29:27 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 10:29:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:27 INFO - 'USER': 'cltbld', 10:29:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:27 INFO - 'XPC_FLAGS': '0x0', 10:29:27 INFO - 'XPC_SERVICE_NAME': '0', 10:29:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:27 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 10:29:27 INFO - Cleaning up... 10:29:27 INFO - Return code: 0 10:29:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:29:27 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')]} 10:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:27 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')]} 10:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:27 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 0x105886490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f809856a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569ad30>, '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 0x1054c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105692b20>, '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.HPhvvNsB3d/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.xP5ftxAp58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 10:29:27 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 10:29:27 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 10:29:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPhvvNsB3d/Render', 10:29:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:27 INFO - 'HOME': '/Users/cltbld', 10:29:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:27 INFO - 'LOGNAME': 'cltbld', 10:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:27 INFO - 'MOZ_NO_REMOTE': '1', 10:29:27 INFO - 'NO_EM_RESTART': '1', 10:29:27 INFO - 'PAGER': '/bin/cat', 10:29:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:27 INFO - 'PWD': '/builds/slave/test', 10:29:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:27 INFO - 'SHELL': '/bin/bash', 10:29:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP5ftxAp58/Listeners', 10:29:27 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 10:29:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:27 INFO - 'USER': 'cltbld', 10:29:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:27 INFO - 'XPC_FLAGS': '0x0', 10:29:27 INFO - 'XPC_SERVICE_NAME': '0', 10:29:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:27 INFO - Downloading/unpacking psutil>=3.1.1 10:29:27 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 10:29:27 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 10:29:27 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 10:29:27 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 10:29:27 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 10:29:27 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 10:29:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:29:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:29:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:29:31 INFO - Installing collected packages: psutil 10:29:31 INFO - Running setup.py install for psutil 10:29:31 INFO - building 'psutil._psutil_osx' extension 10:29:31 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 10:29:31 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 10:29:31 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 10:29:31 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 10:29:31 INFO - building 'psutil._psutil_posix' extension 10:29:31 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 10:29:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:29:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:29:31 INFO - ^ 10:29:31 INFO - 1 warning generated. 10:29:31 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 10:29:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:29:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:29:32 INFO - Successfully installed psutil 10:29:32 INFO - Cleaning up... 10:29:32 INFO - Return code: 0 10:29:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105886490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f809856a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569ad30>, '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 0x1054c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105692b20>, '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.HPhvvNsB3d/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.xP5ftxAp58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 10:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:29:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPhvvNsB3d/Render', 10:29:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:32 INFO - 'HOME': '/Users/cltbld', 10:29:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:32 INFO - 'LOGNAME': 'cltbld', 10:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:32 INFO - 'MOZ_NO_REMOTE': '1', 10:29:32 INFO - 'NO_EM_RESTART': '1', 10:29:32 INFO - 'PAGER': '/bin/cat', 10:29:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:32 INFO - 'PWD': '/builds/slave/test', 10:29:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:32 INFO - 'SHELL': '/bin/bash', 10:29:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP5ftxAp58/Listeners', 10:29:32 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 10:29:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:32 INFO - 'USER': 'cltbld', 10:29:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:32 INFO - 'XPC_FLAGS': '0x0', 10:29:32 INFO - 'XPC_SERVICE_NAME': '0', 10:29:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:29:35 INFO - Installing collected packages: mozsystemmonitor 10:29:35 INFO - Running setup.py install for mozsystemmonitor 10:29:35 INFO - Successfully installed mozsystemmonitor 10:29:35 INFO - Cleaning up... 10:29:35 INFO - Return code: 0 10:29:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:29:35 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')]} 10:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:35 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')]} 10:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:35 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 0x105886490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f809856a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569ad30>, '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 0x1054c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105692b20>, '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.HPhvvNsB3d/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.xP5ftxAp58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 10:29:35 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 10:29:35 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 10:29:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPhvvNsB3d/Render', 10:29:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:35 INFO - 'HOME': '/Users/cltbld', 10:29:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:35 INFO - 'LOGNAME': 'cltbld', 10:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:35 INFO - 'MOZ_NO_REMOTE': '1', 10:29:35 INFO - 'NO_EM_RESTART': '1', 10:29:35 INFO - 'PAGER': '/bin/cat', 10:29:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:35 INFO - 'PWD': '/builds/slave/test', 10:29:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:35 INFO - 'SHELL': '/bin/bash', 10:29:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP5ftxAp58/Listeners', 10:29:35 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 10:29:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:35 INFO - 'USER': 'cltbld', 10:29:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:35 INFO - 'XPC_FLAGS': '0x0', 10:29:35 INFO - 'XPC_SERVICE_NAME': '0', 10:29:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:35 INFO - Downloading/unpacking jsonschema==2.5.1 10:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:29:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:29:38 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 10:29:38 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 10:29:38 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 10:29:38 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 10:29:38 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 10:29:38 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 10:29:38 INFO - Downloading functools32-3.2.3-2.tar.gz 10:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:29:38 INFO - warning: no files found matching '*.txt' 10:29:38 INFO - no previously-included directories found matching 'build' 10:29:38 INFO - no previously-included directories found matching 'dist' 10:29:38 INFO - no previously-included directories found matching '.git*' 10:29:38 INFO - Installing collected packages: jsonschema, functools32 10:29:38 INFO - Running setup.py install for functools32 10:29:38 INFO - warning: no files found matching '*.txt' 10:29:38 INFO - no previously-included directories found matching 'build' 10:29:38 INFO - no previously-included directories found matching 'dist' 10:29:38 INFO - no previously-included directories found matching '.git*' 10:29:38 INFO - Successfully installed jsonschema functools32 10:29:38 INFO - Cleaning up... 10:29:38 INFO - Return code: 0 10:29:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:29: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')]} 10:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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')]} 10:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:38 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 0x105886490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f809856a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569ad30>, '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 0x1054c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105692b20>, '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.HPhvvNsB3d/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.xP5ftxAp58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 10:29:38 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 10:29:38 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 10:29:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPhvvNsB3d/Render', 10:29:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:38 INFO - 'HOME': '/Users/cltbld', 10:29:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:38 INFO - 'LOGNAME': 'cltbld', 10:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:38 INFO - 'MOZ_NO_REMOTE': '1', 10:29:38 INFO - 'NO_EM_RESTART': '1', 10:29:38 INFO - 'PAGER': '/bin/cat', 10:29:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:38 INFO - 'PWD': '/builds/slave/test', 10:29:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:38 INFO - 'SHELL': '/bin/bash', 10:29:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP5ftxAp58/Listeners', 10:29:38 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 10:29:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:38 INFO - 'USER': 'cltbld', 10:29:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:38 INFO - 'XPC_FLAGS': '0x0', 10:29:38 INFO - 'XPC_SERVICE_NAME': '0', 10:29:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:29:39 INFO - Cleaning up... 10:29:39 INFO - Return code: 0 10:29:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:29:39 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')]} 10:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:39 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')]} 10:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:39 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 0x105886490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f809856a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569ad30>, '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 0x1054c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105692b20>, '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.HPhvvNsB3d/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.xP5ftxAp58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 10:29:39 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 10:29:39 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 10:29:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPhvvNsB3d/Render', 10:29:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:39 INFO - 'HOME': '/Users/cltbld', 10:29:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:39 INFO - 'LOGNAME': 'cltbld', 10:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:39 INFO - 'MOZ_NO_REMOTE': '1', 10:29:39 INFO - 'NO_EM_RESTART': '1', 10:29:39 INFO - 'PAGER': '/bin/cat', 10:29:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:39 INFO - 'PWD': '/builds/slave/test', 10:29:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:39 INFO - 'SHELL': '/bin/bash', 10:29:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP5ftxAp58/Listeners', 10:29:39 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 10:29:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:39 INFO - 'USER': 'cltbld', 10:29:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:39 INFO - 'XPC_FLAGS': '0x0', 10:29:39 INFO - 'XPC_SERVICE_NAME': '0', 10:29:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:39 INFO - Downloading/unpacking blobuploader==1.2.4 10:29:39 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 10:29:39 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 10:29:39 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 10:29:39 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 10:29:39 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 10:29:39 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 10:29:42 INFO - Downloading blobuploader-1.2.4.tar.gz 10:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:29:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:29:42 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 10:29:42 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 10:29:42 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 10:29:42 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 10:29:42 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 10:29:42 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 10:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:29:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:29:42 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 10:29:42 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 10:29:42 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 10:29:42 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 10:29:42 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 10:29:42 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 10:29:43 INFO - Downloading docopt-0.6.1.tar.gz 10:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:29:43 INFO - Installing collected packages: blobuploader, requests, docopt 10:29:43 INFO - Running setup.py install for blobuploader 10:29:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:29:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:29:43 INFO - Running setup.py install for requests 10:29:44 INFO - Running setup.py install for docopt 10:29:44 INFO - Successfully installed blobuploader requests docopt 10:29:44 INFO - Cleaning up... 10:29:44 INFO - Return code: 0 10:29:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29: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')]} 10:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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')]} 10:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:44 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 0x105886490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f809856a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569ad30>, '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 0x1054c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105692b20>, '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.HPhvvNsB3d/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.xP5ftxAp58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 10:29:44 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 10:29:44 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 10:29:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPhvvNsB3d/Render', 10:29:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:44 INFO - 'HOME': '/Users/cltbld', 10:29:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:44 INFO - 'LOGNAME': 'cltbld', 10:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:44 INFO - 'MOZ_NO_REMOTE': '1', 10:29:44 INFO - 'NO_EM_RESTART': '1', 10:29:44 INFO - 'PAGER': '/bin/cat', 10:29:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:44 INFO - 'PWD': '/builds/slave/test', 10:29:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:44 INFO - 'SHELL': '/bin/bash', 10:29:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP5ftxAp58/Listeners', 10:29:44 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 10:29:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:44 INFO - 'USER': 'cltbld', 10:29:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:44 INFO - 'XPC_FLAGS': '0x0', 10:29:44 INFO - 'XPC_SERVICE_NAME': '0', 10:29:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:44 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-AefIln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:44 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-W1CZaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:44 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-JKFJTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:44 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-oPUUI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:44 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-rL6Xjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:45 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-bwhiDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:45 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-xAIeX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:45 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Qjxhbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:45 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-_VEObx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:45 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-y0t8Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:45 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-6pRCAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:45 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-FcTsbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:45 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-NeECVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:45 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-j7pww4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:45 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-re9hcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:46 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-cOiZZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:46 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-w77QYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:29:46 INFO - Running setup.py install for manifestparser 10:29:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:29:46 INFO - Running setup.py install for mozcrash 10:29:46 INFO - Running setup.py install for mozdebug 10:29:46 INFO - Running setup.py install for mozdevice 10:29:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:29:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:29:46 INFO - Running setup.py install for mozfile 10:29:47 INFO - Running setup.py install for mozhttpd 10:29:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozinfo 10:29:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozInstall 10:29:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozleak 10:29:47 INFO - Running setup.py install for mozlog 10:29:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for moznetwork 10:29:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozprocess 10:29:48 INFO - Running setup.py install for mozprofile 10:29:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Running setup.py install for mozrunner 10:29:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Running setup.py install for mozscreenshot 10:29:48 INFO - Running setup.py install for moztest 10:29:48 INFO - Running setup.py install for mozversion 10:29:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:29:48 INFO - Cleaning up... 10:29:48 INFO - Return code: 0 10:29:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:48 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 0x105886490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f809856a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569ad30>, '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 0x1054c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105692b20>, '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.HPhvvNsB3d/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.xP5ftxAp58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 10:29:48 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 10:29:48 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 10:29:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPhvvNsB3d/Render', 10:29:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:48 INFO - 'HOME': '/Users/cltbld', 10:29:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:48 INFO - 'LOGNAME': 'cltbld', 10:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:48 INFO - 'MOZ_NO_REMOTE': '1', 10:29:48 INFO - 'NO_EM_RESTART': '1', 10:29:48 INFO - 'PAGER': '/bin/cat', 10:29:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:48 INFO - 'PWD': '/builds/slave/test', 10:29:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:48 INFO - 'SHELL': '/bin/bash', 10:29:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP5ftxAp58/Listeners', 10:29:48 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 10:29:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:48 INFO - 'USER': 'cltbld', 10:29:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:48 INFO - 'XPC_FLAGS': '0x0', 10:29:48 INFO - 'XPC_SERVICE_NAME': '0', 10:29:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-ZHlmkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-8JM6Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-W6DLBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-UoHXcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-1GqgvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-KbjHHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-tqeRRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-xA9wC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29:50 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)) 10:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:50 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-gT_00t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29:50 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)) 10:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:50 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-bCrbGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:50 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)) 10:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:50 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-eJlO1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:50 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)) 10:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:50 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-vjMgOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:50 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)) 10:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:50 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-2TorVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29:50 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)) 10:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:50 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-eoK_bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 10:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:50 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-YaMUI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:50 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)) 10:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:50 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-ZRN4u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29:50 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)) 10:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:50 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-VlIf6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29:50 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)) 10:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:29:50 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)) 10:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:29:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:29:50 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 10:29:50 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 10:29:50 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 10:29:50 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 10:29:50 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 10:29:50 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 10:29:53 INFO - Downloading blessings-1.6.tar.gz 10:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:29:53 INFO - Installing collected packages: blessings 10:29:53 INFO - Running setup.py install for blessings 10:29:53 INFO - Successfully installed blessings 10:29:53 INFO - Cleaning up... 10:29:53 INFO - Return code: 0 10:29:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:54 INFO - Reading from file tmpfile_stdout 10:29:54 INFO - Current package versions: 10:29:54 INFO - blessings == 1.6 10:29:54 INFO - blobuploader == 1.2.4 10:29:54 INFO - docopt == 0.6.1 10:29:54 INFO - functools32 == 3.2.3-2 10:29:54 INFO - jsonschema == 2.5.1 10:29:54 INFO - manifestparser == 1.1 10:29:54 INFO - mozInstall == 1.12 10:29:54 INFO - mozcrash == 0.17 10:29:54 INFO - mozdebug == 0.1 10:29:54 INFO - mozdevice == 0.48 10:29:54 INFO - mozfile == 1.2 10:29:54 INFO - mozhttpd == 0.7 10:29:54 INFO - mozinfo == 0.9 10:29:54 INFO - mozleak == 0.1 10:29:54 INFO - mozlog == 3.4 10:29:54 INFO - moznetwork == 0.27 10:29:54 INFO - mozprocess == 0.23 10:29:54 INFO - mozprofile == 0.28 10:29:54 INFO - mozrunner == 6.12 10:29:54 INFO - mozscreenshot == 0.1 10:29:54 INFO - mozsystemmonitor == 0.3 10:29:54 INFO - moztest == 0.7 10:29:54 INFO - mozversion == 1.4 10:29:54 INFO - psutil == 3.1.1 10:29:54 INFO - requests == 1.2.3 10:29:54 INFO - wsgiref == 0.1.2 10:29:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:55 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 0x105886490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f809856a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569ad30>, '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 0x1054c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105692b20>, '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.HPhvvNsB3d/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.xP5ftxAp58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 10:29:55 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 10:29:55 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 10:29:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPhvvNsB3d/Render', 10:29:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:55 INFO - 'HOME': '/Users/cltbld', 10:29:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:55 INFO - 'LOGNAME': 'cltbld', 10:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:55 INFO - 'MOZ_NO_REMOTE': '1', 10:29:55 INFO - 'NO_EM_RESTART': '1', 10:29:55 INFO - 'PAGER': '/bin/cat', 10:29:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:55 INFO - 'PWD': '/builds/slave/test', 10:29:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:55 INFO - 'SHELL': '/bin/bash', 10:29:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP5ftxAp58/Listeners', 10:29:55 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 10:29:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:55 INFO - 'USER': 'cltbld', 10:29:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:55 INFO - 'XPC_FLAGS': '0x0', 10:29:55 INFO - 'XPC_SERVICE_NAME': '0', 10:29:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:55 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)) 10:29:55 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)) 10:29:55 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)) 10:29:55 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)) 10:29:55 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)) 10:29:55 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)) 10:29:55 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)) 10:29:55 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)) 10:29:55 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)) 10:29:55 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)) 10:29:55 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)) 10:29:55 INFO - Cleaning up... 10:29:55 INFO - Return code: 0 10:29:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:55 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 0x105886490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f809856a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569ad30>, '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 0x1054c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105692b20>, '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.HPhvvNsB3d/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.xP5ftxAp58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 10:29:55 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 10:29:55 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 10:29:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPhvvNsB3d/Render', 10:29:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:55 INFO - 'HOME': '/Users/cltbld', 10:29:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:55 INFO - 'LOGNAME': 'cltbld', 10:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:55 INFO - 'MOZ_NO_REMOTE': '1', 10:29:55 INFO - 'NO_EM_RESTART': '1', 10:29:55 INFO - 'PAGER': '/bin/cat', 10:29:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:55 INFO - 'PWD': '/builds/slave/test', 10:29:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:55 INFO - 'SHELL': '/bin/bash', 10:29:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP5ftxAp58/Listeners', 10:29:55 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 10:29:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:55 INFO - 'USER': 'cltbld', 10:29:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:55 INFO - 'XPC_FLAGS': '0x0', 10:29:55 INFO - 'XPC_SERVICE_NAME': '0', 10:29:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:29:56 INFO - Cleaning up... 10:29:56 INFO - Return code: 0 10:29:56 INFO - Running post-action listener: _resource_record_post_action 10:29:56 INFO - Running post-action listener: _start_resource_monitoring 10:29:56 INFO - Starting resource monitoring. 10:29:56 INFO - [mozharness: 2016-10-24 17:29:56.193240Z] Finished create-virtualenv step (success) 10:29:56 INFO - [mozharness: 2016-10-24 17:29:56.194131Z] Running install step. 10:29:56 INFO - Running pre-action listener: _resource_record_pre_action 10:29:56 INFO - Running main action method: install 10:29:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:56 INFO - Reading from file tmpfile_stdout 10:29:56 INFO - Detecting whether we're running mozinstall >=1.0... 10:29:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:29:56 INFO - Reading from file tmpfile_stdout 10:29:56 INFO - Output received: 10:29:56 INFO - Usage: mozinstall [options] installer 10:29:56 INFO - Options: 10:29:56 INFO - -h, --help show this help message and exit 10:29:56 INFO - -d DEST, --destination=DEST 10:29:56 INFO - Directory to install application into. [default: 10:29:56 INFO - "/builds/slave/test"] 10:29:56 INFO - --app=APP Application being installed. [default: firefox] 10:29:56 INFO - mkdir: /builds/slave/test/build/application 10:29:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:30:30 INFO - Reading from file tmpfile_stdout 10:30:30 INFO - Output received: 10:30:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:30:30 INFO - Running post-action listener: _resource_record_post_action 10:30:30 INFO - [mozharness: 2016-10-24 17:30:30.834782Z] Finished install step (success) 10:30:30 INFO - [mozharness: 2016-10-24 17:30:30.834936Z] Running run-tests step. 10:30:30 INFO - Running pre-action listener: _resource_record_pre_action 10:30:30 INFO - Running main action method: run_tests 10:30:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:30:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:30:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:30:30 INFO - 2016-10-24 10:30:30.849 screenresolution[1640:7663] starting screenresolution argv=screenresolution get 10:30:30 INFO - 2016-10-24 10:30:30.852 screenresolution[1640:7663] Display 0: 1600x1200x32@60 10:30:30 INFO - 2016-10-24 10:30:30.857 screenresolution[1641:7665] starting screenresolution argv=screenresolution list 10:30:30 INFO - Available Modes on Display 0 10:30:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:30:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:30:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:30:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:30:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:30:31 INFO - Intel Iris: 10:30:31 INFO - Chipset Model: Intel Iris 10:30:31 INFO - Type: GPU 10:30:31 INFO - Bus: Built-In 10:30:31 INFO - VRAM (Dynamic, Max): 1536 MB 10:30:31 INFO - Vendor: Intel (0x8086) 10:30:31 INFO - Device ID: 0x0a2e 10:30:31 INFO - Revision ID: 0x0009 10:30:31 INFO - Displays: 10:30:31 INFO - Display: 10:30:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:30:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:30:31 INFO - Display Serial Number: 1600x1200 60 10:30:31 INFO - Main Display: Yes 10:30:31 INFO - Mirror: Off 10:30:31 INFO - Online: Yes 10:30:31 INFO - Rotation: Supported 10:30:31 INFO - Return code: 0 10:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:30:31 INFO - Python 2.7.3 10:30:31 INFO - Return code: 0 10:30:31 INFO - grabbing minidump binary from tooltool 10:30:31 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')]} 10:30:31 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 0x10569ad30>, '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 0x1054c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105692b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:30:31 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 10:30:31 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 10:30:31 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 10:30:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:30:31 INFO - Return code: 0 10:30:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:30:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:30:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:30:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:30:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:30:31 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 10:30:31 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0353 --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 10:30:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPhvvNsB3d/Render', 10:30:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:30:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:30:31 INFO - 'HOME': '/Users/cltbld', 10:30:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:30:31 INFO - 'LOGNAME': 'cltbld', 10:30:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:30:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:31 INFO - 'MOZ_NO_REMOTE': '1', 10:30:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:30:31 INFO - 'NO_EM_RESTART': '1', 10:30:31 INFO - 'PAGER': '/bin/cat', 10:30:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:31 INFO - 'PWD': '/builds/slave/test', 10:30:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:30:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:30:31 INFO - 'SHELL': '/bin/bash', 10:30:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP5ftxAp58/Listeners', 10:30:31 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 10:30:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:30:31 INFO - 'USER': 'cltbld', 10:30:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:30:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:31 INFO - 'XPC_FLAGS': '0x0', 10:30:31 INFO - 'XPC_SERVICE_NAME': '0', 10:30:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:30:31 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 10:30:31 INFO - mozversion application_buildid: 20161024075623 10:30:31 INFO - mozversion application_changeset: c845bfd0accb7e0c29b41713255963b08006e701 10:30:31 INFO - mozversion application_display_name: Nightly 10:30:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:30:31 INFO - mozversion application_name: Firefox 10:30:31 INFO - mozversion application_remotingname: firefox 10:30:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:30:31 INFO - mozversion application_vendor: Mozilla 10:30:31 INFO - mozversion application_version: 52.0a1 10:30:31 INFO - mozversion platform_buildid: 20161024075623 10:30:31 INFO - mozversion platform_changeset: c845bfd0accb7e0c29b41713255963b08006e701 10:30:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:30:31 INFO - mozversion platform_version: 52.0a1 10:30:31 INFO - using testdate: 1477330231 10:30:31 INFO - actual date: 1477330231 10:30:31 INFO - starting webserver on 'localhost:49273' 10:30:31 INFO - SUITE-START | Running 2 tests 10:30:31 INFO - TEST-START | dromaeo_css 10:30:31 INFO - operating with platform_type : mac_ 10:30:31 INFO - Initialising browser for dromaeo_css test... 10:30:31 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpJVJBWN/profile http://localhost:49273/getInfo.html) 10:30:33 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 10:30:33 INFO - PROCESS | 1651 | colorDepth:24 10:30:33 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 10:30:33 INFO - PROCESS | 1651 | __metrics 10:30:33 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:30:33 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:30:34 INFO - TEST-INFO | 1651: exit 0 10:30:34 INFO - Browser initialized. 10:30:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:30:34 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpJVJBWN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:46 INFO - PROCESS | 1653 | RSS: Main: 230760448 10:30:46 INFO - PROCESS | 1653 | 10:31:37 INFO - PROCESS | 1653 | 1477330297634 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] 10:33:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 10:33:53 INFO - PROCESS | 1653 | RSS: Main: 406560768 10:33:53 INFO - PROCESS | 1653 | 10:36:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 10:36:56 INFO - PROCESS | 1653 | RSS: Main: 371609600 10:36:56 INFO - PROCESS | 1653 | 10:39:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 10:39:59 INFO - PROCESS | 1653 | RSS: Main: 337707008 10:39:59 INFO - PROCESS | 1653 | 10:43:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 10:43:02 INFO - PROCESS | 1653 | RSS: Main: 332664832 10:43:02 INFO - PROCESS | 1653 | 10:46:06 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 10:46:06 INFO - PROCESS | 1653 | RSS: Main: 332935168 10:46:06 INFO - PROCESS | 1653 | 10:49:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 10:49:10 INFO - PROCESS | 1653 | RSS: Main: 376795136 10:49:10 INFO - PROCESS | 1653 | 10:49:10 INFO - PROCESS | 1653 | __start_tp_report 10:49:10 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 10:49:10 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 10:49:10 INFO - PROCESS | 1653 | |i|pagename|runs| 10:49:10 INFO - PROCESS | 1653 | |0;dojo.html;2799.8040137190396;3330.4171769940253;3342.8634264350117;3348.882789102382;3379.7127244184244;5546.4453554644515;5623.959567480019;5654.632448890819;5676.602637815349;5688.857778555538;5613.410591887854;5632.098864181732;5692.288463942007;5695.231143795586;5698.145278208261;5050.419201791804;5112.846614601568;5125.487451254863;5156.561692256144;5183.844484665447;5236.476352364771;5236.973815130919;5249.212618107295;5261.789528418859;5278.9208161877605;5210.322658054429;5214.895702085937;5220.556252718524;5228.241904923784;5283.498067683583;5073.162928116856;5120.667156634844;5145.511176438233;5153.6392452528335;5173.042987047408;5082.745862706887;5093.516115968977;5133.101707201262;5167.870803229912;5168.5089916458255;5609.691466969315;5619.775208991636;5631.206309820983;5632.211490391349;5706.28671416073;6044.184035155242;6122.602030867979;6130.295016073164;6183.350748171422;6229.439350458435;6118;6130.279669685376;6157.107219453199;6250;6304.842378940517;5701.087825947829;5757.625754325955;5766.740496677659;5778.5377169826315;5795.043817770063;6268;6299.4330510253385;6327.620342779448;6332.841678958063;6362.172917520693;5405.459454054641;5787.5080618147085;5945.881082378328;6009.128676341993;6019.879602407927;6216.844578885564;6238.095476155932;6240.219972503437;6245.968770156211;6248;6100.298465676416;6146.078088286703;6179.907301390483;6183.474404675653;6217.844553886189;6002.039673652194;6046.486048685911;6058.303295121029;6185.474234690012;6258.3741625837965;4858.854234372904;4879.463259041502;4880.121578115903;4880.365552478155;4889.633277504201;4321.78391080451;4336.067745434747;4426.933595996063;4452.621527170162;4457.286834106592;5591.273134492571;5636.379998200195;5652.265205523256;5655.773769049274;5656.85857853557;6174.104754810617;6189.257289125334;6194.163787888578;6202.503799696014;6205.503559715212;5613.242212301287;5639.125935480007;5642.576806739511;5643.5203007743985;5645.379008309083;5346.97326513365;5350;5352.2506849041165;5354.9464505354445;5359.651622644516;6006.579539432198;6305.653189074645;6308.84227894288;6317.936820631827;6323.620582765049;6112.685862051747;6297.622142671455;6313.08460273267;6316.557840951089;6329.082283068838;6187.381261873777;6275.6862156892885;6289.245290565162;6306.400891915261;6331.240251169889;6100.581173165915;6119.959572021022;6134.650895842656;6138.1738283688655;6144.95535758931;6206.875862482815;6206.937930620636;6214.564980451325;6215.34738852414;6220.657863817533;5847.239858818326;5918.526517878473;5923.289205295392;5942.584019118794;5962.940370596239;4919.385076865392;5890.7054647266605;6001.459868611846;6035.4266344698935;6066.423689749467;5844.532437405082;5874.206982057368;5880.794172203952;5881.794137205177;5882.264716910387;5835.8832823342445;5922.318933322723;5951.345352011362;5967.194428752063;6019;4905.5094490550655;5803.129530570448;5824.534037276923;5870.882582348244;5892.941070589411 10:49:10 INFO - PROCESS | 1653 | |1;ext.html;433.4235466829117;480.83891896214766;501.47595762428284;540.4379445376811;547.87125025619;30855.845720771395;41435.17129657405;42504.14991700164;42594;44686.32970505437;43819;44162.55837441624;44169;44267.77866110665;44305.556944430544;9642.084002019832;9799.314048016642;9804.362716423446;9807.31348805584;9827.115559599635;9674.564644590975;9792.755181120458;9793.363431376973;9795.510224488782;9802.950985245065;9774.853377199348;9813.705588832347;9836.31145819793;9845.65540206093;9856.112949834513;9741.415515069084;9792.314537982344;9792.804143917081;9800.264980126483;9803.705888823346;8679.566021698889;9322.555003974394;9622.278329125274;9687.806243875153;9704.805903881954;41005.384919226235;41157;41376;41456.963575910544;41492.37761433581;3301.7853839500353;3348.28011977426;3866.2654095721723;4069.4709687740406;4082.040720430726;30198;31162.532562011587;31540.526892096637;31624;32099.6790032099;2659.8271112377633;3244;3287.424700677396;3298.6371499135075;3356.345512625039;479635;480927.59536202444;481378;481468;490831;61302.38697613056;61685.69157154275;61841.072383914274;61861.813818617775;61862.69068654628;64951;65084.349156508775;65138;65235;65939.34060659428;12200.572979945659;16216.918915405584;16232;16243.837561624232;16249.918750406172;12532.99736021116;12591.181573197713;12600.991920646326;12603.306818124907;12607.621771346874;14102.897362580421;17323.4802955909;17493;17543.561410964827;17748.935063896206;6707.228668703162;6723.697433615499;6732.629705366154;6784.525083244125;6824.7952561423235;890.9331800115017;954.5275088830934;966.2415004221652;976.8339382305026;1026.8511065895402;29627.851860740557;31158;31482.37035259282;32225.51661725029;32369.51445728316;1000.7147962830559;1015.5277795824977;1065.1319174872453;1097.8243481042996;1156.7108222944264;14944.459441894904;15185.088894666356;15354;15778.368865245491;15979.600509987344;589028;592132;593393;594114;595055;58471.41528584745;58479.41520584825;58499.4150058494;58658;58695.70652146712;1267.5056727876135;1307.1307580459268;1366.2417358365806;1403.1300593632013;1424.173979092124;30081;31117.68882311148;31467.527987079753;32420.513692295106;32572;56783;57171.71414142902;57179.42820571741;57313;57360.42639573551;560528;564363;565219;565834;566007;23700.288991330286;24229.75770242275;26397.34006649849;27197.04810331629;27245.72754272511;47747.52252477431;47891.52108478871;47961;49205.75397122991;49274;39106.82679519619;39611;40256;40825;41582;39639;39654.40518392284;40862.760373750156;41315.96710082272;41455.58544414638;31286.843565782936;38397.424038638885;39185.41221881617;39188.6081139185;39219.80390098031;28094.85952570224;31443.213919652193;34143.4878476828;34314.656853431145;35046.82476587601;19524.902375488033;25393.619095713948;25774.613380799678;25798.87100564485;25966.870165649052 10:49:10 INFO - PROCESS | 1653 | |2;jquery.html;363.329656783235;367.6342039670527;372.17006076449525;383.4976181202623;390.37929691790066;16231.83768162318;20334.18663253472;20416;21328.680069798964;21540.03069861856;20079;20367.083481243342;20521.871297078655;20739;21175.364739057815;5627.943720562783;5778.566607504423;5876.29484461863;5884.941150588482;5905.704714764266;4107.322291821846;5865.413458654122;5978.461938425541;5980.192673989;5982.401759824026;4321.697481176319;4364.803583838735;6169.136320915076;6462.579932304408;6504.967475162617;5561.332640083216;6278.152449419315;6545.934540654604;6562.671866406685;6613.603183808938;5698.629589076697;5708.058170401879;5712.771489140429;5716.657000579979;5721.284839395075;25865.353366165808;26164.73835261642;26232.0818771344;26270.817813198453;26537.867310663518;2134.7725058091505;2174.195547647365;2230.0410823345956;2482.8137889658346;2693.9191824245304;14663;15480.071195728293;15836.841631583651;15838;16484.258208380652;1827.4700336902283;1832.4685841106063;1927.9807201927943;1945.7762357328947;1956.4815323939167;124754;129429;129658;130175;154378.87779538753;17236.741448878278;19432.70850937237;20785.64645909347;21144.471388215417;21489.46276343104;35897.102572435375;36032.91901242914;36058.819705901304;36086.819565902006;36101.638983610355;10461.84307235392;10656.413897235572;10827.458627068616;10855;11029.338239705643;8780.824383512294;8790.033096359395;8816.515091669891;8990.190882820578;9000.729978100668;9683.854742178732;9695.466749328714;9784.55969481375;9894.901050989542;9904.504774761233;2902.796804223684;3353.859687706192;3693.242885208526;3702.6667599916136;3709.4621279914263;843.7890527368158;876.2157868707471;889.9466032038099;938.3572253006712;993.1310103659298;21169.470763230733;21338.93305334758;21648.134074637153;21651.891740541512;21651.891740541512;868.3357231717741;868.5092922498768;921.2721949659693;1007.5919252702668;1056.57736905237;10284.177265818716;11234.49444774987;11312.264702794291;11342.149338799458;11363.488643011084;518432;530563;534003;589520;589839;126726.73273267334;132707;132881.00678489832;133637.3318133403;134332.32833835768;950.3062764182185;979.5934687104914;996.7607774134301;998.276249718948;1002.0530598584413;18067.638647227246;18607.627847442705;18789.530261743566;18818.964956926953;18849.528761781065;53474.197887032504;53545;54668.17997729958;55632;55969.72015140061;78346;78649.60675196587;81744.59127704323;82863.17136828796;87196;7262.946872703534;7360.705571777069;7436.219196984239;8077.555734434663;8114.675412983414;9149.77125571866;11983.28100313984;12741.745165096832;13223.140495867738;13232.404541795835;9082.727518174466;11082.556697732;11131.592319878788;11490.540378385105;11558.537658493902;10943.507542160463;11179.441027948407;11323.263987840764;11346.319220846446;11506.94246528762;10239.539220734936;10268.332558383681;10681.626143085266;11634.88365116338;11732.296062236293;7172.533785303938;7265.600391978492;7362.7423040193335;7448.925510744823;7543;10446.947765261126;11197.272177308449;11465.770684586429;11480.598179063692;11531.019863311712 10:49:10 INFO - PROCESS | 1653 | |3;mootools.html;1509.8414666460021;1512.6520900192954;1548.3729089718665;1639.221369849321;1942.65032294187;8368.665253389865;8916.821663566732;8922.821543569125;8925.866112008325;8934.91065089349;7814.609269536529;8148.95925520373;8149.348052155829;8347.457415268018;8750.91249087509;2321.570509455756;2384.499255156419;2384.8092152627746;2385.8449200801892;2388.1163969331283;2328.39461739948;2335.789778919897;2383.7377888432256;2384.1893756122913;2395.1138078910826;2342.590046741822;2363.7399886012527;2371.9169829055986;2375.8574485530835;2378.4291769975166;2314.0396735354807;2324.244620498336;2331.347222777625;2335.065973610552;2354.8233882458885;2330.079618550663;2346.21401830387;2354.976450235493;2355.3993731598334;2355.7762012608773;8697.173768491983;8749.212570868653;8795.736127916172;8801.031886492545;8807.955960220223;5147.819826306099;5294.49702278283;5295.761690723926;5297.761600727977;5313.07021271276;3489.476578513218;3542.6457354264367;3586.8565257389673;3603.459481077833;3616.5117709109195;1046.3303485769113;1056.5192837259106;1059.7456610413522;1076.5424694504882;1078.358376765823;10626.787464250749;10661.893381066167;10795.5681772729;10804.78390432187;10807.297525660806;4303.591158839905;4485.75328356937;4531.048479819275;4684.414448193976;4689.531046895351;9460.101290377403;9467.053294670477;9468.431894086378;9483;9487.146156845916;5049.091163590589;5060.01329740697;5065.341505604248;5065.645404821701;5069.290299358093;3685.9631403686158;4475.955240447619;4522.796474158671;4596.931046034312;4603.815847366068;3897.2205558888336;3906.1797022625;4042.939355909664;4044.757314561136;4065.4308396824467;1245.1221888568537;1277.565627686591;1281.653953432568;1293.4179619171223;1298.4157129291857;809.2595275323014;907.5416914458157;917.7659696777279;936.2463217110292;982.8673129127476;5311.760970756325;5668.234788303526;6040.607360521552;6097.634141951497;6170.321264660884;426.94449721536625;430.08821298846647;435.6449493662655;444.61540767236755;458.2393227242761;3948.861789837342;3955.5055618047745;4000.1599664070873;4041.939370909439;4070.4504891839224;9617.903820961841;9933.50332483373;10006.649767258257;10019.749506262402;10025.699229023141;9954.751131221778;9964.601415943282;9973.102420782165;9987.201023918069;10011.549480273405;7649.273319034683;7693.769186924401;7767.72812951544;7767.990161278997;7778;5914.319853216935;6079.787207447718;6105.45050945417;6160.969195153995;6180.381961803783;9317.11487408695;9548.570314335733;9839.409635421898;9859.704208873745;9914.256430767577;9606.903930960601;9900.356476828983;9932.205423565953;10006.549705263134;10165.237607179342;6893.75871844483;7157.534760240567;7352.669129889275;7411.370033546993;7468;7810.179931107379;8129.146439623754;8407.831843362976;8423.578821059045;8457.57712114404;7365.300296471826;7474;7496.962515187389;7528.322450979438;7646.350060244719;7266.564006159648;7339.669714862951;7350.071614290996;7363.2268611797135;7451.739189128354;6894.448444124559;6915.170179578483;6990.965045174945;6992.475564332797;7002.649867506706;4986.15235409974;5014.297998280316;5060.49395060491;5061.367329083864;5137.92293115611;4784.378030855966;4965.8013679452415;5021.899562008666;5231.346081739783;5259.47405259471 10:49:10 INFO - PROCESS | 1653 | |4;prototype.html;297.9731824135828;305.0406471646671;307.59551190184914;312.0606973011237;312.56865525574705;5080.503754177552;5167.6641018333785;5172.922406163911;5194.688318700871;5198.116320225561;5024.497550244973;5061.39263288405;5066.695998240109;5083.5933125349975;5118.897622047557;3674.4855720199125;3756.1548651553453;3839.884803455901;3843.885862775476;3947.427622994664;3939.98030009851;3946.6645335146545;3952.9802350988207;3970.2655008823317;3999.860004899829;3243.594550681165;3942.152437225996;3946.8026598670094;3946.9013274668077;3947.276379298289;3025.803322784012;3506.7720598161036;3649.8905032849057;3944.073142811437;3947.585503522132;3393.6606339366112;3411.368896754084;3421.4354631485776;3422.469517224834;3445.207602251496;4076.286649836267;4878.585320247783;4882.047181127542;4900.779464924087;4905.056965820515;4269.014908067764;4317.589828966243;4506.842260520899;4521.660875434322;4530.70550414222;3918.5689574146822;4357.302831546969;4487.640988720895;5220.451852555503;5335.493128152819;3768.2840260350445;3795.6394142556414;3797.3354662933875;3801.4107813288983;3823.617638236182;5664.348599910981;5679.829605111853;5705.516565692908;5728.742206600713;5736.762662561604;3466.1681196512654;3720.6837418819705;3774.339290712078;3775.716821238418;3789.3936970084656;3834.4631751554803;3834.8466061357235;3840.5967373425947;3852.5954774748807;3858.2090671412852;3864.9227015459533;4259.2759230930815;4267.97866010668;4487.394201782783;4495.955040449554;4250.681198910094;5073.416557095908;5297.231901374356;5534;5564.554835613141;1152.9250598711058;1299.876511731384;1306.764782339169;1308.738252349534;1314.8750868667462;679.1103654212997;680.7821497120973;684.9999001457927;793.6031984007996;802.1617409806765;4264.315595339824;4270.850520231777;4801.663883528119;4859.489753575824;4860.635452341088;4654.255319148988;5329.440408757102;5349.170878513836;5362.731863406814;5412.269343638637;4834.299026641188;5046.62150338726;5055.345943379682;5089.236614507853;5102.4897510248675;2624.8556329402068;2708.593710943335;2852.6719427265716;2863.2984918694638;2866.312085099561;4552.749598772033;5510.504054635102;5605.215269862222;5605.635633683797;5660.009498337775;4937.814924418186;5006.274090256892;5529.695866727368;5658.660480371191;5686.687232202268;4641.398717442477;5566.604371333564;5580.804671836466;5626.2967129108865;5639.295088113986;4948.307236986897;5388.892222155613;5391.568674505952;5409.702466364388;5550.278463799842;5212.1163746657685;5318.574514038945;5385.353757549119;5387.138057910715;5486.341639003345;5544.613846538366;5619.269494965792;5639.548836093185;5653.717314134359;5655.915161272502;3237.9800362885617;3658.2866341063236;3676.3933950898872;3677.8528858846416;3684.8710295140613;4415.779211039499;4594.5864872161665;4832.855014349575;5053.065182941167;5329.467053294639;4918;5412.728008917822;5473.579013116802;5497.615166938276;5500.4499550044675;4077.7553346799286;5434.701091440009;5451.6370907273185;5472.91790623133;5475.616706830484;3818.995027610527;5211.478852114758;5232.319798426332;5352.678839269656;5379.488948549882;5077.365329333833;5226.608004399762;5329.813456529003;5331.546818520314;5344.919826202532;5105.668131571436;5154.366171848913;5158.587313015025;5158.793648254028;5167.379914410295 10:49:10 INFO - PROCESS | 1653 | |5;yui.html;712.4620911212035;760.1562265884867;774.5352788327001;809.6845005376425;867.9132086791319;11965.880341196596;15579.688406231868;15611.609709757233;15625.296861641225;15646.765298520517;14086;14116;14134.858651413482;14138.787918181235;14452.710945781078;676.8037269191929;698.1761521404741;780.4185881518248;798.1619299735283;873.2315562305195;839.3914412051245;866.6403442571325;869.1352104655845;869.1569177897461;870.2515836380708;889.1730690457872;914.9039350868163;930.2743859789341;930.8184903943734;933.883264591926;733.4169335378386;752.868248056588;904.6517090919978;914.446759710379;926.5552534783308;686.7287421468542;686.7699320727562;687.9312068793131;688.1432616392573;689.3657834792003;14651.63370915725;14693.118412895261;14693.338799754038;14709.411623535047;14728.18994955277;12484.625461236177;13652.658683532893;13758.65603359914;13758.793618095737;14010.22943738094;12229;12423.813642795365;12634.873651263462;12966.80549791754;13130.671733206651;4414.4040554525045;4439.977800111011;4475.261581838992;4646.233371493733;4662.930056049162;109556;110435.79128417387;111351;111420.44289778499;113504;10361.274710770325;10657.360558366523;10870.728231794268;10922.344659320466;11138.665840024812;20987.950602469817;21269.255576054762;21306.147754089663;21320.78679213188;21381;7053.682584283617;7142.642867856586;7468.477206595486;7726.18875018115;7788.065432148179;4007.579204183577;4190.28765109932;4250.064985703202;4276.679249056333;4288.485381754147;3628.5827129880404;3776.263628592398;3782.6406491383273;3782.924341513154;3788.45067465216;688.769262297126;701.5194591704699;713.1477883928759;714.8463080437731;714.907062081926;513.5401427163844;568.3009897825698;622.8349487385847;646.6249575246346;672.7880717573948;8078.474899131537;8896.043378801958;9384.436933783994;9488.351665901419;9679.177269931994;581.2480438767744;598.9251343582052;664.8005598320484;680.4655501843312;695.3116414749362;4363.93986665736;4614.7461889595725;4662.277347011219;4690.882727931761;4797.352357431771;137885;150990;153181;158318;162593;110765;113150;113782;134567.32716336354;141621;106978.46510767397;109850;110374.44812775885;112075;114292.28561571582;9634.662786802428;9690.46702431373;9852.868078337864;9934.105930466292;9957.551910163915;60648.696756515936;61264;61941;63360.68319658372;65842;48671.75664121657;49730;56028;63125;86717.13282867344;12902.935485322889;12995.480180792661;13130.474781008652;13288.534901278408;13497.932510337385;14358.425662973365;14753.852461475248;14776.408943642135;14935.775963360775;15462.226888655747;13109.592578613763;13392.799108013192;13541.661458463617;13559.45762169502;13761.243131627856;13324.93778297504;13770.862291376958;13779.655508612364;13911;13992;13233.206007639572;13524.661883452993;13712.382942767399;13736.65658358549;14019.369128389451;9351.48566828831;11293.841081372124;11313.264637798517;11611;11663.59177428786;11326.603568875049;11377.601783937522;11589.188756786943;11652.30086194831;11711.472983715583 10:49:10 INFO - PROCESS | 1653 | __end_tp_report 10:49:10 INFO - PROCESS | 1653 | __start_cc_report 10:49:10 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1745 10:49:10 INFO - PROCESS | 1653 | __end_cc_report 10:49:10 INFO - PROCESS | 1653 | __startTimestamp1477331350435__endTimestamp 10:49:10 INFO - PROCESS | 1653 | 10:49:10 INFO - PROCESS | 1653 | ------- Summary: start ------- 10:49:10 INFO - PROCESS | 1653 | Number of tests: 6 10:49:10 INFO - PROCESS | 1653 | 10:49:10 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5673.67 Median:5844.53 stddev:647.39 (11.1%) stddev-sans-first:608.85 10:49:10 INFO - PROCESS | 1653 | Values: 2799.8 3330.4 3342.9 3348.9 3379.7 5546.4 5624.0 5654.6 5676.6 5688.9 5613.4 5632.1 5692.3 5695.2 5698.1 5050.4 5112.8 5125.5 5156.6 5183.8 5236.5 5237.0 5249.2 5261.8 5278.9 5210.3 5214.9 5220.6 5228.2 5283.5 5073.2 5120.7 5145.5 5153.6 5173.0 5082.7 5093.5 5133.1 5167.9 5168.5 5609.7 5619.8 5631.2 5632.2 5706.3 6044.2 6122.6 6130.3 6183.4 6229.4 6118.0 6130.3 6157.1 6250.0 6304.8 5701.1 5757.6 5766.7 5778.5 5795.0 6268.0 6299.4 6327.6 6332.8 6362.2 5405.5 5787.5 5945.9 6009.1 6019.9 6216.8 6238.1 6240.2 6246.0 6248.0 6100.3 6146.1 6179.9 6183.5 6217.8 6002.0 6046.5 6058.3 6185.5 6258.4 4858.9 4879.5 4880.1 4880.4 4889.6 4321.8 4336.1 4426.9 4452.6 4457.3 5591.3 5636.4 5652.3 5655.8 5656.9 6174.1 6189.3 6194.2 6202.5 6205.5 5613.2 5639.1 5642.6 5643.5 5645.4 5347.0 5350.0 5352.3 5354.9 5359.7 6006.6 6305.7 6308.8 6317.9 6323.6 6112.7 6297.6 6313.1 6316.6 6329.1 6187.4 6275.7 6289.2 6306.4 6331.2 6100.6 6120.0 6134.7 6138.2 6145.0 6206.9 6206.9 6214.6 6215.3 6220.7 5847.2 5918.5 5923.3 5942.6 5962.9 4919.4 5890.7 6001.5 6035.4 6066.4 5844.5 5874.2 5880.8 5881.8 5882.3 5835.9 5922.3 5951.3 5967.2 6019.0 4905.5 5803.1 5824.5 5870.9 5892.9 10:49:10 INFO - PROCESS | 1653 | 10:49:10 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:68854.75 Median:41474.67 stddev:146299.95 (352.7%) stddev-sans-first:146620.17 10:49:10 INFO - PROCESS | 1653 | Values: 433.4 480.8 501.5 540.4 547.9 30855.8 41435.2 42504.1 42594.0 44686.3 43819.0 44162.6 44169.0 44267.8 44305.6 9642.1 9799.3 9804.4 9807.3 9827.1 9674.6 9792.8 9793.4 9795.5 9803.0 9774.9 9813.7 9836.3 9845.7 9856.1 9741.4 9792.3 9792.8 9800.3 9803.7 8679.6 9322.6 9622.3 9687.8 9704.8 41005.4 41157.0 41376.0 41457.0 41492.4 3301.8 3348.3 3866.3 4069.5 4082.0 30198.0 31162.5 31540.5 31624.0 32099.7 2659.8 3244.0 3287.4 3298.6 3356.3 479635.0 480927.6 481378.0 481468.0 490831.0 61302.4 61685.7 61841.1 61861.8 61862.7 64951.0 65084.3 65138.0 65235.0 65939.3 12200.6 16216.9 16232.0 16243.8 16249.9 12533.0 12591.2 12601.0 12603.3 12607.6 14102.9 17323.5 17493.0 17543.6 17748.9 6707.2 6723.7 6732.6 6784.5 6824.8 890.9 954.5 966.2 976.8 1026.9 29627.9 31158.0 31482.4 32225.5 32369.5 1000.7 1015.5 1065.1 1097.8 1156.7 14944.5 15185.1 15354.0 15778.4 15979.6 589028.0 592132.0 593393.0 594114.0 595055.0 58471.4 58479.4 58499.4 58658.0 58695.7 1267.5 1307.1 1366.2 1403.1 1424.2 30081.0 31117.7 31467.5 32420.5 32572.0 56783.0 57171.7 57179.4 57313.0 57360.4 560528.0 564363.0 565219.0 565834.0 566007.0 23700.3 24229.8 26397.3 27197.0 27245.7 47747.5 47891.5 47961.0 49205.8 49274.0 39106.8 39611.0 40256.0 40825.0 41582.0 39639.0 39654.4 40862.8 41316.0 41455.6 31286.8 38397.4 39185.4 39188.6 39219.8 28094.9 31443.2 34143.5 34314.7 35046.8 19524.9 25393.6 25774.6 25798.9 25966.9 10:49:10 INFO - PROCESS | 1653 | 10:49:10 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35694.80 Median:2798.36 stddev:93211.99 (3331.0%) stddev-sans-first:93435.72 10:49:10 INFO - PROCESS | 1653 | Values: 363.3 367.6 372.2 383.5 390.4 16231.8 20334.2 20416.0 21328.7 21540.0 20079.0 20367.1 20521.9 20739.0 21175.4 5627.9 5778.6 5876.3 5884.9 5905.7 4107.3 5865.4 5978.5 5980.2 5982.4 4321.7 4364.8 6169.1 6462.6 6505.0 5561.3 6278.2 6545.9 6562.7 6613.6 5698.6 5708.1 5712.8 5716.7 5721.3 25865.4 26164.7 26232.1 26270.8 26537.9 2134.8 2174.2 2230.0 2482.8 2693.9 14663.0 15480.1 15836.8 15838.0 16484.3 1827.5 1832.5 1928.0 1945.8 1956.5 124754.0 129429.0 129658.0 130175.0 154378.9 17236.7 19432.7 20785.6 21144.5 21489.5 35897.1 36032.9 36058.8 36086.8 36101.6 10461.8 10656.4 10827.5 10855.0 11029.3 8780.8 8790.0 8816.5 8990.2 9000.7 9683.9 9695.5 9784.6 9894.9 9904.5 2902.8 3353.9 3693.2 3702.7 3709.5 843.8 876.2 889.9 938.4 993.1 21169.5 21338.9 21648.1 21651.9 21651.9 868.3 868.5 921.3 1007.6 1056.6 10284.2 11234.5 11312.3 11342.1 11363.5 518432.0 530563.0 534003.0 589520.0 589839.0 126726.7 132707.0 132881.0 133637.3 134332.3 950.3 979.6 996.8 998.3 1002.1 18067.6 18607.6 18789.5 18819.0 18849.5 53474.2 53545.0 54668.2 55632.0 55969.7 78346.0 78649.6 81744.6 82863.2 87196.0 7262.9 7360.7 7436.2 8077.6 8114.7 9149.8 11983.3 12741.7 13223.1 13232.4 9082.7 11082.6 11131.6 11490.5 11558.5 10943.5 11179.4 11323.3 11346.3 11506.9 10239.5 10268.3 10681.6 11634.9 11732.3 7172.5 7265.6 7362.7 7448.9 7543.0 10446.9 11197.3 11465.8 11480.6 11531.0 10:49:10 INFO - PROCESS | 1653 | 10:49:10 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5571.50 Median:5065.49 stddev:3058.98 (60.4%) stddev-sans-first:3052.33 10:49:10 INFO - PROCESS | 1653 | Values: 1509.8 1512.7 1548.4 1639.2 1942.7 8368.7 8916.8 8922.8 8925.9 8934.9 7814.6 8149.0 8149.3 8347.5 8750.9 2321.6 2384.5 2384.8 2385.8 2388.1 2328.4 2335.8 2383.7 2384.2 2395.1 2342.6 2363.7 2371.9 2375.9 2378.4 2314.0 2324.2 2331.3 2335.1 2354.8 2330.1 2346.2 2355.0 2355.4 2355.8 8697.2 8749.2 8795.7 8801.0 8808.0 5147.8 5294.5 5295.8 5297.8 5313.1 3489.5 3542.6 3586.9 3603.5 3616.5 1046.3 1056.5 1059.7 1076.5 1078.4 10626.8 10661.9 10795.6 10804.8 10807.3 4303.6 4485.8 4531.0 4684.4 4689.5 9460.1 9467.1 9468.4 9483.0 9487.1 5049.1 5060.0 5065.3 5065.6 5069.3 3686.0 4476.0 4522.8 4596.9 4603.8 3897.2 3906.2 4042.9 4044.8 4065.4 1245.1 1277.6 1281.7 1293.4 1298.4 809.3 907.5 917.8 936.2 982.9 5311.8 5668.2 6040.6 6097.6 6170.3 426.9 430.1 435.6 444.6 458.2 3948.9 3955.5 4000.2 4041.9 4070.5 9617.9 9933.5 10006.6 10019.7 10025.7 9954.8 9964.6 9973.1 9987.2 10011.5 7649.3 7693.8 7767.7 7768.0 7778.0 5914.3 6079.8 6105.5 6161.0 6180.4 9317.1 9548.6 9839.4 9859.7 9914.3 9606.9 9900.4 9932.2 10006.5 10165.2 6893.8 7157.5 7352.7 7411.4 7468.0 7810.2 8129.1 8407.8 8423.6 8457.6 7365.3 7474.0 7497.0 7528.3 7646.4 7266.6 7339.7 7350.1 7363.2 7451.7 6894.4 6915.2 6991.0 6992.5 7002.6 4986.2 5014.3 5060.5 5061.4 5137.9 4784.4 4965.8 5021.9 5231.3 5259.5 10:49:10 INFO - PROCESS | 1653 | 10:49:10 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4332.11 Median:4891.41 stddev:1330.37 (27.2%) stddev-sans-first:1299.19 10:49:10 INFO - PROCESS | 1653 | Values: 298.0 305.0 307.6 312.1 312.6 5080.5 5167.7 5172.9 5194.7 5198.1 5024.5 5061.4 5066.7 5083.6 5118.9 3674.5 3756.2 3839.9 3843.9 3947.4 3940.0 3946.7 3953.0 3970.3 3999.9 3243.6 3942.2 3946.8 3946.9 3947.3 3025.8 3506.8 3649.9 3944.1 3947.6 3393.7 3411.4 3421.4 3422.5 3445.2 4076.3 4878.6 4882.0 4900.8 4905.1 4269.0 4317.6 4506.8 4521.7 4530.7 3918.6 4357.3 4487.6 5220.5 5335.5 3768.3 3795.6 3797.3 3801.4 3823.6 5664.3 5679.8 5705.5 5728.7 5736.8 3466.2 3720.7 3774.3 3775.7 3789.4 3834.5 3834.8 3840.6 3852.6 3858.2 3864.9 4259.3 4268.0 4487.4 4496.0 4250.7 5073.4 5297.2 5534.0 5564.6 1152.9 1299.9 1306.8 1308.7 1314.9 679.1 680.8 685.0 793.6 802.2 4264.3 4270.9 4801.7 4859.5 4860.6 4654.3 5329.4 5349.2 5362.7 5412.3 4834.3 5046.6 5055.3 5089.2 5102.5 2624.9 2708.6 2852.7 2863.3 2866.3 4552.7 5510.5 5605.2 5605.6 5660.0 4937.8 5006.3 5529.7 5658.7 5686.7 4641.4 5566.6 5580.8 5626.3 5639.3 4948.3 5388.9 5391.6 5409.7 5550.3 5212.1 5318.6 5385.4 5387.1 5486.3 5544.6 5619.3 5639.5 5653.7 5655.9 3238.0 3658.3 3676.4 3677.9 3684.9 4415.8 4594.6 4832.9 5053.1 5329.5 4918.0 5412.7 5473.6 5497.6 5500.4 4077.8 5434.7 5451.6 5472.9 5475.6 3819.0 5211.5 5232.3 5352.7 5379.5 5077.4 5226.6 5329.8 5331.5 5344.9 5105.7 5154.4 5158.6 5158.8 5167.4 10:49:10 INFO - PROCESS | 1653 | 10:49:10 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:24016.16 Median:3779.45 stddev:38609.01 (1021.6%) stddev-sans-first:38677.67 10:49:10 INFO - PROCESS | 1653 | Values: 712.5 760.2 774.5 809.7 867.9 11965.9 15579.7 15611.6 15625.3 15646.8 14086.0 14116.0 14134.9 14138.8 14452.7 676.8 698.2 780.4 798.2 873.2 839.4 866.6 869.1 869.2 870.3 889.2 914.9 930.3 930.8 933.9 733.4 752.9 904.7 914.4 926.6 686.7 686.8 687.9 688.1 689.4 14651.6 14693.1 14693.3 14709.4 14728.2 12484.6 13652.7 13758.7 13758.8 14010.2 12229.0 12423.8 12634.9 12966.8 13130.7 4414.4 4440.0 4475.3 4646.2 4662.9 109556.0 110435.8 111351.0 111420.4 113504.0 10361.3 10657.4 10870.7 10922.3 11138.7 20988.0 21269.3 21306.1 21320.8 21381.0 7053.7 7142.6 7468.5 7726.2 7788.1 4007.6 4190.3 4250.1 4276.7 4288.5 3628.6 3776.3 3782.6 3782.9 3788.5 688.8 701.5 713.1 714.8 714.9 513.5 568.3 622.8 646.6 672.8 8078.5 8896.0 9384.4 9488.4 9679.2 581.2 598.9 664.8 680.5 695.3 4363.9 4614.7 4662.3 4690.9 4797.4 137885.0 150990.0 153181.0 158318.0 162593.0 110765.0 113150.0 113782.0 134567.3 141621.0 106978.5 109850.0 110374.4 112075.0 114292.3 9634.7 9690.5 9852.9 9934.1 9957.6 60648.7 61264.0 61941.0 63360.7 65842.0 48671.8 49730.0 56028.0 63125.0 86717.1 12902.9 12995.5 13130.5 13288.5 13497.9 14358.4 14753.9 14776.4 14935.8 15462.2 13109.6 13392.8 13541.7 13559.5 13761.2 13324.9 13770.9 13779.7 13911.0 13992.0 13233.2 13524.7 13712.4 13736.7 14019.4 9351.5 11293.8 11313.3 11611.0 11663.6 11326.6 11377.6 11589.2 11652.3 11711.5 10:49:10 INFO - PROCESS | 1653 | -------- Summary: end -------- 10:49:10 INFO - PROCESS | 1653 | 10:49:11 INFO - TEST-INFO | 1653: exit 0 10:49:11 INFO - TEST-OK | dromaeo_css | took 1119636ms 10:49:11 INFO - TEST-START | kraken 10:49:11 INFO - operating with platform_type : mac_ 10:49:11 INFO - Initialising browser for kraken test... 10:49:11 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpokJ_so/profile http://localhost:49273/getInfo.html) 10:49:13 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 10:49:13 INFO - PROCESS | 1662 | colorDepth:24 10:49:13 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 10:49:13 INFO - PROCESS | 1662 | __metrics 10:49:13 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:49:13 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:49:14 INFO - TEST-INFO | 1662: exit 0 10:49:14 INFO - Browser initialized. 10:49:14 INFO - Running cycle 1/1 for kraken test... 10:49:14 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpokJ_so/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:49:26 INFO - PROCESS | 1663 | RSS: Main: 230506496 10:49:26 INFO - PROCESS | 1663 | 10:49:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 10:49:29 INFO - PROCESS | 1663 | RSS: Main: 289857536 10:49:29 INFO - PROCESS | 1663 | 10:49:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 10:49:33 INFO - PROCESS | 1663 | RSS: Main: 291061760 10:49:33 INFO - PROCESS | 1663 | 10:49:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 10:49:37 INFO - PROCESS | 1663 | RSS: Main: 385904640 10:49:37 INFO - PROCESS | 1663 | 10:49:39 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 10:49:39 INFO - PROCESS | 1663 | RSS: Main: 286683136 10:49:39 INFO - PROCESS | 1663 | 10:49:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:49:42 INFO - PROCESS | 1663 | RSS: Main: 287817728 10:49:42 INFO - PROCESS | 1663 | 10:49:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 10:49:45 INFO - PROCESS | 1663 | RSS: Main: 325242880 10:49:45 INFO - PROCESS | 1663 | 10:49:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 10:49:49 INFO - PROCESS | 1663 | RSS: Main: 327286784 10:49:49 INFO - PROCESS | 1663 | 10:49:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 10:49:52 INFO - PROCESS | 1663 | RSS: Main: 326283264 10:49:52 INFO - PROCESS | 1663 | 10:49:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:49:54 INFO - PROCESS | 1663 | RSS: Main: 302477312 10:49:54 INFO - PROCESS | 1663 | 10:49:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:49:57 INFO - PROCESS | 1663 | RSS: Main: 304345088 10:49:57 INFO - PROCESS | 1663 | 10:49:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:49:59 INFO - PROCESS | 1663 | RSS: Main: 308224000 10:49:59 INFO - PROCESS | 1663 | 10:50:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:50:03 INFO - PROCESS | 1663 | RSS: Main: 317702144 10:50:03 INFO - PROCESS | 1663 | 10:50:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:50:07 INFO - PROCESS | 1663 | RSS: Main: 315957248 10:50:07 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 10:50:09 INFO - PROCESS | 1663 | RSS: Main: 360108032 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | __start_tp_report 10:50:09 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 10:50:09 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 10:50:09 INFO - PROCESS | 1663 | |i|pagename|runs| 10:50:09 INFO - PROCESS | 1663 | |0;ai-astar;111;113;114;113;112;114;113;112;112;112 10:50:09 INFO - PROCESS | 1663 | |1;audio-beat-detection;152;114;112;148;111;110;111;111;141;112 10:50:09 INFO - PROCESS | 1663 | |2;audio-dft;183;184;182;182;184;185;180;182;181;183 10:50:09 INFO - PROCESS | 1663 | |3;audio-fft;78;60;60;87;63;61;58;59;84;57 10:50:09 INFO - PROCESS | 1663 | |4;audio-oscillator;84;72;94;72;67;68;94;67;67;89 10:50:09 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;87;85;88;85;87;83;89;85;87;85 10:50:09 INFO - PROCESS | 1663 | |6;imaging-darkroom;94;93;94;93;93;93;95;94;93;93 10:50:09 INFO - PROCESS | 1663 | |7;imaging-desaturate;81;81;79;79;82;83;84;83;81;82 10:50:09 INFO - PROCESS | 1663 | |8;json-parse-financial;57;55;54;53;53;55;55;54;55;54 10:50:09 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;71;69;66;75;71;69;69;68;69;71 10:50:09 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;87;87;87;86;90;85;86;88;87;85 10:50:09 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;145;160;161;146;147;148;149;155;216;160 10:50:09 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;174;181;232;205;174;171;173;175;172;171 10:50:09 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;68;69;69;69;70;68;68;78;84;88 10:50:09 INFO - PROCESS | 1663 | __end_tp_report 10:50:09 INFO - PROCESS | 1663 | __start_cc_report 10:50:09 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1990 10:50:09 INFO - PROCESS | 1663 | __end_cc_report 10:50:09 INFO - PROCESS | 1663 | __startTimestamp1477331409435__endTimestamp 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | ------- Summary: start ------- 10:50:09 INFO - PROCESS | 1663 | Number of tests: 14 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:0.97 (0.9%) stddev-sans-first:0.83 10:50:09 INFO - PROCESS | 1663 | Values: 111.0 113.0 114.0 113.0 112.0 114.0 113.0 112.0 112.0 112.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:113.00 stddev:17.34 (15.3%) stddev-sans-first:14.67 10:50:09 INFO - PROCESS | 1663 | Values: 152.0 114.0 112.0 148.0 111.0 110.0 111.0 111.0 141.0 112.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.51 (0.8%) stddev-sans-first:1.59 10:50:09 INFO - PROCESS | 1663 | Values: 183.0 184.0 182.0 182.0 184.0 185.0 180.0 182.0 181.0 183.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:66.70 Median:62.00 stddev:11.57 (18.7%) stddev-sans-first:11.52 10:50:09 INFO - PROCESS | 1663 | Values: 78.0 60.0 60.0 87.0 63.0 61.0 58.0 59.0 84.0 57.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.00 stddev:11.55 (14.8%) stddev-sans-first:12.00 10:50:09 INFO - PROCESS | 1663 | Values: 84.0 72.0 94.0 72.0 67.0 68.0 94.0 67.0 67.0 89.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:87.00 stddev:1.79 (2.1%) stddev-sans-first:1.87 10:50:09 INFO - PROCESS | 1663 | Values: 87.0 85.0 88.0 85.0 87.0 83.0 89.0 85.0 87.0 85.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 10:50:09 INFO - PROCESS | 1663 | Values: 94.0 93.0 94.0 93.0 93.0 93.0 95.0 94.0 93.0 93.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:81.50 Median:82.00 stddev:1.65 (2.0%) stddev-sans-first:1.74 10:50:09 INFO - PROCESS | 1663 | Values: 81.0 81.0 79.0 79.0 82.0 83.0 84.0 83.0 81.0 82.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.18 (2.1%) stddev-sans-first:0.83 10:50:09 INFO - PROCESS | 1663 | Values: 57.0 55.0 54.0 53.0 53.0 55.0 55.0 54.0 55.0 54.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:2.39 (3.4%) stddev-sans-first:2.50 10:50:09 INFO - PROCESS | 1663 | Values: 71.0 69.0 66.0 75.0 71.0 69.0 69.0 68.0 69.0 71.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.00 stddev:1.48 (1.7%) stddev-sans-first:1.56 10:50:09 INFO - PROCESS | 1663 | Values: 87.0 87.0 87.0 86.0 90.0 85.0 86.0 88.0 87.0 85.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:158.70 Median:157.50 stddev:21.08 (13.4%) stddev-sans-first:21.77 10:50:09 INFO - PROCESS | 1663 | Values: 145.0 160.0 161.0 146.0 147.0 148.0 149.0 155.0 216.0 160.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.80 Median:174.50 stddev:20.07 (11.5%) stddev-sans-first:21.03 10:50:09 INFO - PROCESS | 1663 | Values: 174.0 181.0 232.0 205.0 174.0 171.0 173.0 175.0 172.0 171.0 10:50:09 INFO - PROCESS | 1663 | 10:50:09 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:69.50 stddev:7.48 (10.8%) stddev-sans-first:7.70 10:50:09 INFO - PROCESS | 1663 | Values: 68.0 69.0 69.0 69.0 70.0 68.0 68.0 78.0 84.0 88.0 10:50:09 INFO - PROCESS | 1663 | -------- Summary: end -------- 10:50:09 INFO - PROCESS | 1663 | 10:50:10 INFO - TEST-INFO | 1663: exit 0 10:50:10 INFO - TEST-OK | kraken | took 59247ms 10:50:10 INFO - SUITE-END | took 1178s 10:50:10 INFO - Completed test suite (00:19:39) 10:50:10 INFO - javascript benchmark 10:50:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2799.8040137190396, 3330.4171769940253, 3342.8634264350117, 3348.882789102382, 3379.7127244184244, 5546.4453554644515, 5623.959567480019, 5654.632448890819, 5676.602637815349, 5688.857778555538, 5613.410591887854, 5632.098864181732, 5692.288463942007, 5695.231143795586, 5698.145278208261, 5050.419201791804, 5112.846614601568, 5125.487451254863, 5156.561692256144, 5183.844484665447, 5236.476352364771, 5236.973815130919, 5249.212618107295, 5261.789528418859, 5278.9208161877605, 5210.322658054429, 5214.895702085937, 5220.556252718524, 5228.241904923784, 5283.498067683583, 5073.162928116856, 5120.667156634844, 5145.511176438233, 5153.6392452528335, 5173.042987047408, 5082.745862706887, 5093.516115968977, 5133.101707201262, 5167.870803229912, 5168.5089916458255, 5609.691466969315, 5619.775208991636, 5631.206309820983, 5632.211490391349, 5706.28671416073, 6044.184035155242, 6122.602030867979, 6130.295016073164, 6183.350748171422, 6229.439350458435, 6118.0, 6130.279669685376, 6157.107219453199, 6250.0, 6304.842378940517, 5701.087825947829, 5757.625754325955, 5766.740496677659, 5778.5377169826315, 5795.043817770063, 6268.0, 6299.4330510253385, 6327.620342779448, 6332.841678958063, 6362.172917520693, 5405.459454054641, 5787.5080618147085, 5945.881082378328, 6009.128676341993, 6019.879602407927, 6216.844578885564, 6238.095476155932, 6240.219972503437, 6245.968770156211, 6248.0, 6100.298465676416, 6146.078088286703, 6179.907301390483, 6183.474404675653, 6217.844553886189, 6002.039673652194, 6046.486048685911, 6058.303295121029, 6185.474234690012, 6258.3741625837965, 4858.854234372904, 4879.463259041502, 4880.121578115903, 4880.365552478155, 4889.633277504201, 4321.78391080451, 4336.067745434747, 4426.933595996063, 4452.621527170162, 4457.286834106592, 5591.273134492571, 5636.379998200195, 5652.265205523256, 5655.773769049274, 5656.85857853557, 6174.104754810617, 6189.257289125334, 6194.163787888578, 6202.503799696014, 6205.503559715212, 5613.242212301287, 5639.125935480007, 5642.576806739511, 5643.5203007743985, 5645.379008309083, 5346.97326513365, 5350.0, 5352.2506849041165, 5354.9464505354445, 5359.651622644516, 6006.579539432198, 6305.653189074645, 6308.84227894288, 6317.936820631827, 6323.620582765049, 6112.685862051747, 6297.622142671455, 6313.08460273267, 6316.557840951089, 6329.082283068838, 6187.381261873777, 6275.6862156892885, 6289.245290565162, 6306.400891915261, 6331.240251169889, 6100.581173165915, 6119.959572021022, 6134.650895842656, 6138.1738283688655, 6144.95535758931, 6206.875862482815, 6206.937930620636, 6214.564980451325, 6215.34738852414, 6220.657863817533, 5847.239858818326, 5918.526517878473, 5923.289205295392, 5942.584019118794, 5962.940370596239, 4919.385076865392, 5890.7054647266605, 6001.459868611846, 6035.4266344698935, 6066.423689749467, 5844.532437405082, 5874.206982057368, 5880.794172203952, 5881.794137205177, 5882.264716910387, 5835.8832823342445, 5922.318933322723, 5951.345352011362, 5967.194428752063, 6019.0, 4905.5094490550655, 5803.129530570448, 5824.534037276923, 5870.882582348244, 5892.941070589411], "value": 5631.099264598316, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.4235466829117, 480.83891896214766, 501.47595762428284, 540.4379445376811, 547.87125025619, 30855.845720771395, 41435.17129657405, 42504.14991700164, 42594.0, 44686.32970505437, 43819.0, 44162.55837441624, 44169.0, 44267.77866110665, 44305.556944430544, 9642.084002019832, 9799.314048016642, 9804.362716423446, 9807.31348805584, 9827.115559599635, 9674.564644590975, 9792.755181120458, 9793.363431376973, 9795.510224488782, 9802.950985245065, 9774.853377199348, 9813.705588832347, 9836.31145819793, 9845.65540206093, 9856.112949834513, 9741.415515069084, 9792.314537982344, 9792.804143917081, 9800.264980126483, 9803.705888823346, 8679.566021698889, 9322.555003974394, 9622.278329125274, 9687.806243875153, 9704.805903881954, 41005.384919226235, 41157.0, 41376.0, 41456.963575910544, 41492.37761433581, 3301.7853839500353, 3348.28011977426, 3866.2654095721723, 4069.4709687740406, 4082.040720430726, 30198.0, 31162.532562011587, 31540.526892096637, 31624.0, 32099.6790032099, 2659.8271112377633, 3244.0, 3287.424700677396, 3298.6371499135075, 3356.345512625039, 479635.0, 480927.59536202444, 481378.0, 481468.0, 490831.0, 61302.38697613056, 61685.69157154275, 61841.072383914274, 61861.813818617775, 61862.69068654628, 64951.0, 65084.349156508775, 65138.0, 65235.0, 65939.34060659428, 12200.572979945659, 16216.918915405584, 16232.0, 16243.837561624232, 16249.918750406172, 12532.99736021116, 12591.181573197713, 12600.991920646326, 12603.306818124907, 12607.621771346874, 14102.897362580421, 17323.4802955909, 17493.0, 17543.561410964827, 17748.935063896206, 6707.228668703162, 6723.697433615499, 6732.629705366154, 6784.525083244125, 6824.7952561423235, 890.9331800115017, 954.5275088830934, 966.2415004221652, 976.8339382305026, 1026.8511065895402, 29627.851860740557, 31158.0, 31482.37035259282, 32225.51661725029, 32369.51445728316, 1000.7147962830559, 1015.5277795824977, 1065.1319174872453, 1097.8243481042996, 1156.7108222944264, 14944.459441894904, 15185.088894666356, 15354.0, 15778.368865245491, 15979.600509987344, 589028.0, 592132.0, 593393.0, 594114.0, 595055.0, 58471.41528584745, 58479.41520584825, 58499.4150058494, 58658.0, 58695.70652146712, 1267.5056727876135, 1307.1307580459268, 1366.2417358365806, 1403.1300593632013, 1424.173979092124, 30081.0, 31117.68882311148, 31467.527987079753, 32420.513692295106, 32572.0, 56783.0, 57171.71414142902, 57179.42820571741, 57313.0, 57360.42639573551, 560528.0, 564363.0, 565219.0, 565834.0, 566007.0, 23700.288991330286, 24229.75770242275, 26397.34006649849, 27197.04810331629, 27245.72754272511, 47747.52252477431, 47891.52108478871, 47961.0, 49205.75397122991, 49274.0, 39106.82679519619, 39611.0, 40256.0, 40825.0, 41582.0, 39639.0, 39654.40518392284, 40862.760373750156, 41315.96710082272, 41455.58544414638, 31286.843565782936, 38397.424038638885, 39185.41221881617, 39188.6081139185, 39219.80390098031, 28094.85952570224, 31443.213919652193, 34143.4878476828, 34314.656853431145, 35046.82476587601, 19524.902375488033, 25393.619095713948, 25774.613380799678, 25798.87100564485, 25966.870165649052], "value": 20041.50187061981, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.329656783235, 367.6342039670527, 372.17006076449525, 383.4976181202623, 390.37929691790066, 16231.83768162318, 20334.18663253472, 20416.0, 21328.680069798964, 21540.03069861856, 20079.0, 20367.083481243342, 20521.871297078655, 20739.0, 21175.364739057815, 5627.943720562783, 5778.566607504423, 5876.29484461863, 5884.941150588482, 5905.704714764266, 4107.322291821846, 5865.413458654122, 5978.461938425541, 5980.192673989, 5982.401759824026, 4321.697481176319, 4364.803583838735, 6169.136320915076, 6462.579932304408, 6504.967475162617, 5561.332640083216, 6278.152449419315, 6545.934540654604, 6562.671866406685, 6613.603183808938, 5698.629589076697, 5708.058170401879, 5712.771489140429, 5716.657000579979, 5721.284839395075, 25865.353366165808, 26164.73835261642, 26232.0818771344, 26270.817813198453, 26537.867310663518, 2134.7725058091505, 2174.195547647365, 2230.0410823345956, 2482.8137889658346, 2693.9191824245304, 14663.0, 15480.071195728293, 15836.841631583651, 15838.0, 16484.258208380652, 1827.4700336902283, 1832.4685841106063, 1927.9807201927943, 1945.7762357328947, 1956.4815323939167, 124754.0, 129429.0, 129658.0, 130175.0, 154378.87779538753, 17236.741448878278, 19432.70850937237, 20785.64645909347, 21144.471388215417, 21489.46276343104, 35897.102572435375, 36032.91901242914, 36058.819705901304, 36086.819565902006, 36101.638983610355, 10461.84307235392, 10656.413897235572, 10827.458627068616, 10855.0, 11029.338239705643, 8780.824383512294, 8790.033096359395, 8816.515091669891, 8990.190882820578, 9000.729978100668, 9683.854742178732, 9695.466749328714, 9784.55969481375, 9894.901050989542, 9904.504774761233, 2902.796804223684, 3353.859687706192, 3693.242885208526, 3702.6667599916136, 3709.4621279914263, 843.7890527368158, 876.2157868707471, 889.9466032038099, 938.3572253006712, 993.1310103659298, 21169.470763230733, 21338.93305334758, 21648.134074637153, 21651.891740541512, 21651.891740541512, 868.3357231717741, 868.5092922498768, 921.2721949659693, 1007.5919252702668, 1056.57736905237, 10284.177265818716, 11234.49444774987, 11312.264702794291, 11342.149338799458, 11363.488643011084, 518432.0, 530563.0, 534003.0, 589520.0, 589839.0, 126726.73273267334, 132707.0, 132881.00678489832, 133637.3318133403, 134332.32833835768, 950.3062764182185, 979.5934687104914, 996.7607774134301, 998.276249718948, 1002.0530598584413, 18067.638647227246, 18607.627847442705, 18789.530261743566, 18818.964956926953, 18849.528761781065, 53474.197887032504, 53545.0, 54668.17997729958, 55632.0, 55969.72015140061, 78346.0, 78649.60675196587, 81744.59127704323, 82863.17136828796, 87196.0, 7262.946872703534, 7360.705571777069, 7436.219196984239, 8077.555734434663, 8114.675412983414, 9149.77125571866, 11983.28100313984, 12741.745165096832, 13223.140495867738, 13232.404541795835, 9082.727518174466, 11082.556697732, 11131.592319878788, 11490.540378385105, 11558.537658493902, 10943.507542160463, 11179.441027948407, 11323.263987840764, 11346.319220846446, 11506.94246528762, 10239.539220734936, 10268.332558383681, 10681.626143085266, 11634.88365116338, 11732.296062236293, 7172.533785303938, 7265.600391978492, 7362.7423040193335, 7448.925510744823, 7543.0, 10446.947765261126, 11197.272177308449, 11465.770684586429, 11480.598179063692, 11531.019863311712], "value": 10564.249301635258, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.8414666460021, 1512.6520900192954, 1548.3729089718665, 1639.221369849321, 1942.65032294187, 8368.665253389865, 8916.821663566732, 8922.821543569125, 8925.866112008325, 8934.91065089349, 7814.609269536529, 8148.95925520373, 8149.348052155829, 8347.457415268018, 8750.91249087509, 2321.570509455756, 2384.499255156419, 2384.8092152627746, 2385.8449200801892, 2388.1163969331283, 2328.39461739948, 2335.789778919897, 2383.7377888432256, 2384.1893756122913, 2395.1138078910826, 2342.590046741822, 2363.7399886012527, 2371.9169829055986, 2375.8574485530835, 2378.4291769975166, 2314.0396735354807, 2324.244620498336, 2331.347222777625, 2335.065973610552, 2354.8233882458885, 2330.079618550663, 2346.21401830387, 2354.976450235493, 2355.3993731598334, 2355.7762012608773, 8697.173768491983, 8749.212570868653, 8795.736127916172, 8801.031886492545, 8807.955960220223, 5147.819826306099, 5294.49702278283, 5295.761690723926, 5297.761600727977, 5313.07021271276, 3489.476578513218, 3542.6457354264367, 3586.8565257389673, 3603.459481077833, 3616.5117709109195, 1046.3303485769113, 1056.5192837259106, 1059.7456610413522, 1076.5424694504882, 1078.358376765823, 10626.787464250749, 10661.893381066167, 10795.5681772729, 10804.78390432187, 10807.297525660806, 4303.591158839905, 4485.75328356937, 4531.048479819275, 4684.414448193976, 4689.531046895351, 9460.101290377403, 9467.053294670477, 9468.431894086378, 9483.0, 9487.146156845916, 5049.091163590589, 5060.01329740697, 5065.341505604248, 5065.645404821701, 5069.290299358093, 3685.9631403686158, 4475.955240447619, 4522.796474158671, 4596.931046034312, 4603.815847366068, 3897.2205558888336, 3906.1797022625, 4042.939355909664, 4044.757314561136, 4065.4308396824467, 1245.1221888568537, 1277.565627686591, 1281.653953432568, 1293.4179619171223, 1298.4157129291857, 809.2595275323014, 907.5416914458157, 917.7659696777279, 936.2463217110292, 982.8673129127476, 5311.760970756325, 5668.234788303526, 6040.607360521552, 6097.634141951497, 6170.321264660884, 426.94449721536625, 430.08821298846647, 435.6449493662655, 444.61540767236755, 458.2393227242761, 3948.861789837342, 3955.5055618047745, 4000.1599664070873, 4041.939370909439, 4070.4504891839224, 9617.903820961841, 9933.50332483373, 10006.649767258257, 10019.749506262402, 10025.699229023141, 9954.751131221778, 9964.601415943282, 9973.102420782165, 9987.201023918069, 10011.549480273405, 7649.273319034683, 7693.769186924401, 7767.72812951544, 7767.990161278997, 7778.0, 5914.319853216935, 6079.787207447718, 6105.45050945417, 6160.969195153995, 6180.381961803783, 9317.11487408695, 9548.570314335733, 9839.409635421898, 9859.704208873745, 9914.256430767577, 9606.903930960601, 9900.356476828983, 9932.205423565953, 10006.549705263134, 10165.237607179342, 6893.75871844483, 7157.534760240567, 7352.669129889275, 7411.370033546993, 7468.0, 7810.179931107379, 8129.146439623754, 8407.831843362976, 8423.578821059045, 8457.57712114404, 7365.300296471826, 7474.0, 7496.962515187389, 7528.322450979438, 7646.350060244719, 7266.564006159648, 7339.669714862951, 7350.071614290996, 7363.2268611797135, 7451.739189128354, 6894.448444124559, 6915.170179578483, 6990.965045174945, 6992.475564332797, 7002.649867506706, 4986.15235409974, 5014.297998280316, 5060.49395060491, 5061.367329083864, 5137.92293115611, 4784.378030855966, 4965.8013679452415, 5021.899562008666, 5231.346081739783, 5259.47405259471], "value": 4435.748007006484, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.9731824135828, 305.0406471646671, 307.59551190184914, 312.0606973011237, 312.56865525574705, 5080.503754177552, 5167.6641018333785, 5172.922406163911, 5194.688318700871, 5198.116320225561, 5024.497550244973, 5061.39263288405, 5066.695998240109, 5083.5933125349975, 5118.897622047557, 3674.4855720199125, 3756.1548651553453, 3839.884803455901, 3843.885862775476, 3947.427622994664, 3939.98030009851, 3946.6645335146545, 3952.9802350988207, 3970.2655008823317, 3999.860004899829, 3243.594550681165, 3942.152437225996, 3946.8026598670094, 3946.9013274668077, 3947.276379298289, 3025.803322784012, 3506.7720598161036, 3649.8905032849057, 3944.073142811437, 3947.585503522132, 3393.6606339366112, 3411.368896754084, 3421.4354631485776, 3422.469517224834, 3445.207602251496, 4076.286649836267, 4878.585320247783, 4882.047181127542, 4900.779464924087, 4905.056965820515, 4269.014908067764, 4317.589828966243, 4506.842260520899, 4521.660875434322, 4530.70550414222, 3918.5689574146822, 4357.302831546969, 4487.640988720895, 5220.451852555503, 5335.493128152819, 3768.2840260350445, 3795.6394142556414, 3797.3354662933875, 3801.4107813288983, 3823.617638236182, 5664.348599910981, 5679.829605111853, 5705.516565692908, 5728.742206600713, 5736.762662561604, 3466.1681196512654, 3720.6837418819705, 3774.339290712078, 3775.716821238418, 3789.3936970084656, 3834.4631751554803, 3834.8466061357235, 3840.5967373425947, 3852.5954774748807, 3858.2090671412852, 3864.9227015459533, 4259.2759230930815, 4267.97866010668, 4487.394201782783, 4495.955040449554, 4250.681198910094, 5073.416557095908, 5297.231901374356, 5534.0, 5564.554835613141, 1152.9250598711058, 1299.876511731384, 1306.764782339169, 1308.738252349534, 1314.8750868667462, 679.1103654212997, 680.7821497120973, 684.9999001457927, 793.6031984007996, 802.1617409806765, 4264.315595339824, 4270.850520231777, 4801.663883528119, 4859.489753575824, 4860.635452341088, 4654.255319148988, 5329.440408757102, 5349.170878513836, 5362.731863406814, 5412.269343638637, 4834.299026641188, 5046.62150338726, 5055.345943379682, 5089.236614507853, 5102.4897510248675, 2624.8556329402068, 2708.593710943335, 2852.6719427265716, 2863.2984918694638, 2866.312085099561, 4552.749598772033, 5510.504054635102, 5605.215269862222, 5605.635633683797, 5660.009498337775, 4937.814924418186, 5006.274090256892, 5529.695866727368, 5658.660480371191, 5686.687232202268, 4641.398717442477, 5566.604371333564, 5580.804671836466, 5626.2967129108865, 5639.295088113986, 4948.307236986897, 5388.892222155613, 5391.568674505952, 5409.702466364388, 5550.278463799842, 5212.1163746657685, 5318.574514038945, 5385.353757549119, 5387.138057910715, 5486.341639003345, 5544.613846538366, 5619.269494965792, 5639.548836093185, 5653.717314134359, 5655.915161272502, 3237.9800362885617, 3658.2866341063236, 3676.3933950898872, 3677.8528858846416, 3684.8710295140613, 4415.779211039499, 4594.5864872161665, 4832.855014349575, 5053.065182941167, 5329.467053294639, 4918.0, 5412.728008917822, 5473.579013116802, 5497.615166938276, 5500.4499550044675, 4077.7553346799286, 5434.701091440009, 5451.6370907273185, 5472.91790623133, 5475.616706830484, 3818.995027610527, 5211.478852114758, 5232.319798426332, 5352.678839269656, 5379.488948549882, 5077.365329333833, 5226.608004399762, 5329.813456529003, 5331.546818520314, 5344.919826202532, 5105.668131571436, 5154.366171848913, 5158.587313015025, 5158.793648254028, 5167.379914410295], "value": 3903.1511861990616, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.4620911212035, 760.1562265884867, 774.5352788327001, 809.6845005376425, 867.9132086791319, 11965.880341196596, 15579.688406231868, 15611.609709757233, 15625.296861641225, 15646.765298520517, 14086.0, 14116.0, 14134.858651413482, 14138.787918181235, 14452.710945781078, 676.8037269191929, 698.1761521404741, 780.4185881518248, 798.1619299735283, 873.2315562305195, 839.3914412051245, 866.6403442571325, 869.1352104655845, 869.1569177897461, 870.2515836380708, 889.1730690457872, 914.9039350868163, 930.2743859789341, 930.8184903943734, 933.883264591926, 733.4169335378386, 752.868248056588, 904.6517090919978, 914.446759710379, 926.5552534783308, 686.7287421468542, 686.7699320727562, 687.9312068793131, 688.1432616392573, 689.3657834792003, 14651.63370915725, 14693.118412895261, 14693.338799754038, 14709.411623535047, 14728.18994955277, 12484.625461236177, 13652.658683532893, 13758.65603359914, 13758.793618095737, 14010.22943738094, 12229.0, 12423.813642795365, 12634.873651263462, 12966.80549791754, 13130.671733206651, 4414.4040554525045, 4439.977800111011, 4475.261581838992, 4646.233371493733, 4662.930056049162, 109556.0, 110435.79128417387, 111351.0, 111420.44289778499, 113504.0, 10361.274710770325, 10657.360558366523, 10870.728231794268, 10922.344659320466, 11138.665840024812, 20987.950602469817, 21269.255576054762, 21306.147754089663, 21320.78679213188, 21381.0, 7053.682584283617, 7142.642867856586, 7468.477206595486, 7726.18875018115, 7788.065432148179, 4007.579204183577, 4190.28765109932, 4250.064985703202, 4276.679249056333, 4288.485381754147, 3628.5827129880404, 3776.263628592398, 3782.6406491383273, 3782.924341513154, 3788.45067465216, 688.769262297126, 701.5194591704699, 713.1477883928759, 714.8463080437731, 714.907062081926, 513.5401427163844, 568.3009897825698, 622.8349487385847, 646.6249575246346, 672.7880717573948, 8078.474899131537, 8896.043378801958, 9384.436933783994, 9488.351665901419, 9679.177269931994, 581.2480438767744, 598.9251343582052, 664.8005598320484, 680.4655501843312, 695.3116414749362, 4363.93986665736, 4614.7461889595725, 4662.277347011219, 4690.882727931761, 4797.352357431771, 137885.0, 150990.0, 153181.0, 158318.0, 162593.0, 110765.0, 113150.0, 113782.0, 134567.32716336354, 141621.0, 106978.46510767397, 109850.0, 110374.44812775885, 112075.0, 114292.28561571582, 9634.662786802428, 9690.46702431373, 9852.868078337864, 9934.105930466292, 9957.551910163915, 60648.696756515936, 61264.0, 61941.0, 63360.68319658372, 65842.0, 48671.75664121657, 49730.0, 56028.0, 63125.0, 86717.13282867344, 12902.935485322889, 12995.480180792661, 13130.474781008652, 13288.534901278408, 13497.932510337385, 14358.425662973365, 14753.852461475248, 14776.408943642135, 14935.775963360775, 15462.226888655747, 13109.592578613763, 13392.799108013192, 13541.661458463617, 13559.45762169502, 13761.243131627856, 13324.93778297504, 13770.862291376958, 13779.655508612364, 13911.0, 13992.0, 13233.206007639572, 13524.661883452993, 13712.382942767399, 13736.65658358549, 14019.369128389451, 9351.48566828831, 11293.841081372124, 11313.264637798517, 11611.0, 11663.59177428786, 11326.603568875049, 11377.601783937522, 11589.188756786943, 11652.30086194831, 11711.472983715583], "value": 7771.850176049263, "unit": "score"}], "name": "dromaeo_css", "value": 7371.457509584623, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 114.0, 113.0, 112.0, 114.0, 113.0, 112.0, 112.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 114.0, 112.0, 148.0, 111.0, 110.0, 111.0, 111.0, 141.0, 112.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 182.0, 182.0, 184.0, 185.0, 180.0, 182.0, 181.0, 183.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 60.0, 87.0, 63.0, 61.0, 58.0, 59.0, 84.0, 57.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 94.0, 72.0, 67.0, 68.0, 94.0, 67.0, 67.0, 89.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 85.0, 87.0, 83.0, 89.0, 85.0, 87.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 95.0, 94.0, 93.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 79.0, 79.0, 82.0, 83.0, 84.0, 83.0, 81.0, 82.0], "value": 81.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 53.0, 53.0, 55.0, 55.0, 54.0, 55.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 66.0, 75.0, 71.0, 69.0, 69.0, 68.0, 69.0, 71.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 86.0, 90.0, 85.0, 86.0, 88.0, 87.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 160.0, 161.0, 146.0, 147.0, 148.0, 149.0, 155.0, 216.0, 160.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 181.0, 232.0, 205.0, 174.0, 171.0, 173.0, 175.0, 172.0, 171.0], "value": 182.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 70.0, 68.0, 68.0, 78.0, 84.0, 88.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1448.3, "alertThreshold": 2.0}]} 10:50:10 INFO - Return code: 0 10:50:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:50:10 INFO - # TBPL SUCCESS # 10:50:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:50:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:50:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:50:10 INFO - 2016-10-24 10:50:10.737 screenresolution[1667:10157] starting screenresolution argv=screenresolution get 10:50:10 INFO - 2016-10-24 10:50:10.740 screenresolution[1667:10157] Display 0: 1600x1200x32@60 10:50:10 INFO - 2016-10-24 10:50:10.746 screenresolution[1668:10160] starting screenresolution argv=screenresolution list 10:50:10 INFO - Available Modes on Display 0 10:50:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:50:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:50:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:50:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:50:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:50:10 INFO - Intel Iris: 10:50:10 INFO - Chipset Model: Intel Iris 10:50:10 INFO - Type: GPU 10:50:10 INFO - Bus: Built-In 10:50:10 INFO - VRAM (Dynamic, Max): 1536 MB 10:50:10 INFO - Vendor: Intel (0x8086) 10:50:10 INFO - Device ID: 0x0a2e 10:50:10 INFO - Revision ID: 0x0009 10:50:10 INFO - Displays: 10:50:10 INFO - Display: 10:50:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:50:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:50:10 INFO - Display Serial Number: 1600x1200 60 10:50:10 INFO - Main Display: Yes 10:50:10 INFO - Mirror: Off 10:50:10 INFO - Online: Yes 10:50:10 INFO - Rotation: Supported 10:50:10 INFO - Return code: 0 10:50:10 INFO - Running post-action listener: _resource_record_post_action 10:50:10 INFO - [mozharness: 2016-10-24 17:50:10.990907Z] Finished run-tests step (success) 10:50:10 INFO - Running post-run listener: _resource_record_post_run 10:50:11 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 37475328; Write bytes: 706344960; Read time: 237; Write time: 1995 10:50:11 INFO - TinderboxPrint: CPU usage
53.4% 10:50:11 INFO - TinderboxPrint: I/O read bytes / time
37,475,328 / 237 10:50:11 INFO - TinderboxPrint: I/O write bytes / time
706,344,960 / 1,995 10:50:11 INFO - TinderboxPrint: CPU idle
2,261.4 (46.6%) 10:50:11 INFO - TinderboxPrint: CPU system
971.1 (20.0%) 10:50:11 INFO - TinderboxPrint: CPU user
1,625.2 (33.5%) 10:50:11 INFO - TinderboxPrint: Swap in / out
442,187,776 / 0 10:50:11 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393572864; Write bytes: 387794944; Read time: 29550; Write time: 807 10:50:11 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 35660800; Write bytes: 298082304; Read time: 222; Write time: 1133 10:50:11 INFO - Running post-run listener: _upload_blobber_files 10:50:11 INFO - Blob upload gear active. 10:50:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:50:11 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 10:50:11 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'] 10:50:11 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 10:50:11 INFO - (blobuploader) - INFO - Open directory for files ... 10:50:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:50:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:50:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:50:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:50:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:50:12 INFO - (blobuploader) - INFO - Done attempting. 10:50:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:50:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:50:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:50:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:50:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:50:13 INFO - (blobuploader) - INFO - Done attempting. 10:50:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:50:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:50:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:50:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:50:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:50:16 INFO - (blobuploader) - INFO - Done attempting. 10:50:16 INFO - (blobuploader) - INFO - Iteration through files over. 10:50:16 INFO - Return code: 0 10:50:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:50:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:50:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9eb26292761d9e4c234f2fe14fb93b68206d15475e9d5954bca1b0b16bf2d635ab61fbbed37f8e6da38623adca7336fad6476ff8d4b77c3e1bfd74d63344f4de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6de68bc1b595dbb224346c822b83ec8f4550c50470dcf2da9898e5f0124a99b2df065df06ff056e91328b753cc69f625f8222bdd90c37788a09fe965397ce2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ddc709364708e8eceddfa8a8ddf1188abee79d72e314a8c910f44a169a1d8e2671d217ce007a440d0295619348062be01f81a6149e51f100504cd6c604c83df"} 10:50:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:50:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:50:16 INFO - Contents: 10:50:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9eb26292761d9e4c234f2fe14fb93b68206d15475e9d5954bca1b0b16bf2d635ab61fbbed37f8e6da38623adca7336fad6476ff8d4b77c3e1bfd74d63344f4de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6de68bc1b595dbb224346c822b83ec8f4550c50470dcf2da9898e5f0124a99b2df065df06ff056e91328b753cc69f625f8222bdd90c37788a09fe965397ce2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ddc709364708e8eceddfa8a8ddf1188abee79d72e314a8c910f44a169a1d8e2671d217ce007a440d0295619348062be01f81a6149e51f100504cd6c604c83df"} 10:50:16 INFO - Running post-run listener: copy_logs_to_upload_dir 10:50:16 INFO - Copying logs to upload dir... 10:50:16 INFO - mkdir: /builds/slave/test/build/upload/logs 10:50:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.033814 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-24 10:50:16.098036) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 10:50:16.102083) ========= 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.HPhvvNsB3d/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.xP5ftxAp58/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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/9eb26292761d9e4c234f2fe14fb93b68206d15475e9d5954bca1b0b16bf2d635ab61fbbed37f8e6da38623adca7336fad6476ff8d4b77c3e1bfd74d63344f4de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6de68bc1b595dbb224346c822b83ec8f4550c50470dcf2da9898e5f0124a99b2df065df06ff056e91328b753cc69f625f8222bdd90c37788a09fe965397ce2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ddc709364708e8eceddfa8a8ddf1188abee79d72e314a8c910f44a169a1d8e2671d217ce007a440d0295619348062be01f81a6149e51f100504cd6c604c83df"} build_url:https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/C38mb7ZeTK21VvE0ATjK2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9eb26292761d9e4c234f2fe14fb93b68206d15475e9d5954bca1b0b16bf2d635ab61fbbed37f8e6da38623adca7336fad6476ff8d4b77c3e1bfd74d63344f4de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6de68bc1b595dbb224346c822b83ec8f4550c50470dcf2da9898e5f0124a99b2df065df06ff056e91328b753cc69f625f8222bdd90c37788a09fe965397ce2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ddc709364708e8eceddfa8a8ddf1188abee79d72e314a8c910f44a169a1d8e2671d217ce007a440d0295619348062be01f81a6149e51f100504cd6c604c83df"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 10:50:16.135168) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:50:16.135531) ========= 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.HPhvvNsB3d/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.xP5ftxAp58/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.005105 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:50:16.184741) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 10:50:16.185049) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 10:50:16.185409) ========= ========= Total master_lag: 0.17 =========