builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0276 starttime: 1494523731.68 results: success (0) revision: 3b96f277325747fe668ca8cd896d2f581238e4ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:51.680103) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:51.680878) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:51.681282) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:52.532836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:52.533260) ========= 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.kjgiyPrDQg/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.scCSC0q2k9/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-11 10:28:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 75.9M=0s 2017-05-11 10:28:52 (75.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130774 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:52.687675) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:52.688112) ========= 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.kjgiyPrDQg/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.scCSC0q2k9/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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.032975 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:52.745507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 10:28:52.745983) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3b96f277325747fe668ca8cd896d2f581238e4ee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 3b96f277325747fe668ca8cd896d2f581238e4ee --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kjgiyPrDQg/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.scCSC0q2k9/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-11 10:28:52,850 truncating revision to first 12 chars 2017-05-11 10:28:52,851 Setting DEBUG logging. 2017-05-11 10:28:52,851 attempt 1/10 2017-05-11 10:28:52,851 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3b96f2773257?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 10:28:54,099 unpacking tar archive at: mozilla-central-3b96f2773257/testing/mozharness/ program finished with exit code 0 elapsedTime=1.542211 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 10:28:54.310817) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:54.311205) ========= script_repo_revision: 3b96f277325747fe668ca8cd896d2f581238e4ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:54.311613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:54.311898) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 10:28:54.330967) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 22 secs) (at 2017-05-11 10:28:54.331355) ========= /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.kjgiyPrDQg/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.scCSC0q2k9/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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:28:54 INFO - MultiFileLogger online at 20170511 10:28:54 in /builds/slave/test 10:28:54 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:28:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:28:54 INFO - {'append_to_log': False, 10:28:54 INFO - 'base_work_dir': '/builds/slave/test', 10:28:54 INFO - 'blob_upload_branch': 'Firefox', 10:28:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:28:54 INFO - 'branch': 'Firefox', 10:28:54 INFO - 'buildbot_json_path': 'buildprops.json', 10:28:54 INFO - 'config_files': ('talos/mac_config.py',), 10:28:54 INFO - 'default_actions': ('clobber', 10:28:54 INFO - 'read-buildbot-config', 10:28:54 INFO - 'download-and-extract', 10:28:54 INFO - 'populate-webroot', 10:28:54 INFO - 'create-virtualenv', 10:28:54 INFO - 'install', 10:28:54 INFO - 'run-tests'), 10:28:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:28:54 INFO - 'download_minidump_stackwalk': True, 10:28:54 INFO - 'download_symbols': 'ondemand', 10:28:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:28:54 INFO - 'tooltool.py': '/tools/tooltool.py', 10:28:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:28:54 INFO - '/tools/misc-python/virtualenv.py')}, 10:28:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:28:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:28:54 INFO - 'gecko_profile': False, 10:28:54 INFO - 'gecko_profile_interval': 0, 10:28:54 INFO - 'installer_path': 'installer.exe', 10:28:54 INFO - 'log_level': 'info', 10:28:54 INFO - 'log_name': 'talos', 10:28:54 INFO - 'log_to_console': True, 10:28:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:28:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:28:54 INFO - 'opt_config_files': (), 10:28:54 INFO - 'pip_index': False, 10:28:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:28:54 INFO - 'cmd': ('bash', 10:28:54 INFO - '-c', 10:28:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:28:54 INFO - 'enabled': True, 10:28:54 INFO - 'halt_on_failure': False, 10:28:54 INFO - 'name': 'check_screen_resolution'},), 10:28:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:28:54 INFO - 'cmd': ('bash', 10:28:54 INFO - '-c', 10:28:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:28:54 INFO - 'enabled': True, 10:28:54 INFO - 'halt_on_failure': False, 10:28:54 INFO - 'name': 'check_screen_resolution'},), 10:28:54 INFO - 'run_cmd_checks_enabled': True, 10:28:54 INFO - 'suite': 'dromaeojs', 10:28:54 INFO - 'system_bits': '32', 10:28:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:28:54 INFO - 'title': 't-yosemite-r7-0276', 10:28:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:28:54 INFO - 'use_talos_json': True, 10:28:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:28:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:28:54 INFO - 'work_dir': 'build'} 10:28:54 INFO - [mozharness: 2017-05-11 17:28:54.542797Z] Running clobber step. 10:28:54 INFO - Running pre-action listener: _resource_record_pre_action 10:28:54 INFO - Running main action method: clobber 10:28:54 INFO - rmtree: /builds/slave/test/build 10:28:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:28:56 INFO - Running post-action listener: _resource_record_post_action 10:28:56 INFO - [mozharness: 2017-05-11 17:28:56.815956Z] Finished clobber step (success) 10:28:56 INFO - [mozharness: 2017-05-11 17:28:56.816110Z] Running read-buildbot-config step. 10:28:56 INFO - Running pre-action listener: _resource_record_pre_action 10:28:56 INFO - Running main action method: read_buildbot_config 10:28:56 INFO - Using buildbot properties: 10:28:56 INFO - { 10:28:56 INFO - "project": "", 10:28:56 INFO - "product": "firefox", 10:28:56 INFO - "who": "ffxbld@noreply.mozilla.org", 10:28:56 INFO - "installer_path": "public/build/firefox-55.0a1.en-US.mac.dmg", 10:28:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:28:56 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:28:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:28:56 INFO - "stage_platform": "macosx64", 10:28:56 INFO - "basedir": "/builds/slave/test", 10:28:56 INFO - "buildnumber": 66, 10:28:56 INFO - "platform": "yosemite_r7", 10:28:56 INFO - "parent_task_id": "AcrmHGpHQDmj8gAyLuoYOg", 10:28:56 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:28:56 INFO - "slavebuilddir": "test", 10:28:56 INFO - "taskId": "McbXh2BFQta15USA8tsNsQ", 10:28:56 INFO - "branch": "mozilla-central", 10:28:56 INFO - "script_repo_revision": "production", 10:28:56 INFO - "revision": "3b96f277325747fe668ca8cd896d2f581238e4ee", 10:28:56 INFO - "slavename": "t-yosemite-r7-0276", 10:28:56 INFO - "repo_path": "mozilla-central" 10:28:56 INFO - } 10:28:56 INFO - Finding installer, test and symbols from parent task. 10:28:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/McbXh2BFQta15USA8tsNsQ'}, attempt #1 10:28:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/McbXh2BFQta15USA8tsNsQ'}, attempt #1 10:28:58 INFO - Task dependencies: cdC9z_BcS0W3tqQTWCg5Ww 10:28:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg'}, attempt #1 10:28:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:28:58 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/test_packages.json 10:28:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/target.crashreporter-symbols.zip 10:28:58 INFO - Running post-action listener: _resource_record_post_action 10:28:58 INFO - [mozharness: 2017-05-11 17:28:58.515659Z] Finished read-buildbot-config step (success) 10:28:58 INFO - [mozharness: 2017-05-11 17:28:58.515798Z] Running download-and-extract step. 10:28:58 INFO - Running pre-action listener: _resource_record_pre_action 10:28:58 INFO - Running main action method: download_and_extract 10:28:58 INFO - mkdir: /builds/slave/test/build/tests 10:28:58 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:28:58 INFO - trying https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:28:58 INFO - Downloading https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:28:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:28:59 INFO - Downloaded 1325 bytes. 10:28:59 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:28:59 INFO - Using the following test package requirements: 10:28:59 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:28:59 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:28:59 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:28:59 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:28:59 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:28:59 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:28:59 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:28:59 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:28:59 INFO - u'jsshell-mac.zip'], 10:28:59 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:28:59 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:28:59 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:28:59 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:28:59 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:28:59 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:28:59 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:28:59 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:28:59 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:28:59 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:28:59 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:28:59 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:28:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:28:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:28:59 INFO - Fetch https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:29:00 INFO - Content-Length response header: 52708090 10:29:00 INFO - Bytes received: 52708090 10:29:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:29:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:29:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:29:16 INFO - Fetch https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:29:18 INFO - Content-Length response header: 52708090 10:29:18 INFO - Bytes received: 52708090 10:29:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:29:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:29:33 INFO - Fetch https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:29:34 INFO - Content-Length response header: 14409411 10:29:34 INFO - Bytes received: 14409411 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 - trying https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:29:35 INFO - Downloading https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:29:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:29:37 INFO - Downloaded 75543569 bytes. 10:29:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:29:37 INFO - mkdir: /builds/slave/test/properties 10:29:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:29:37 INFO - Writing to file /builds/slave/test/properties/build_url 10:29:37 INFO - Contents: 10:29:37 INFO - build_url:https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:29:37 INFO - Running post-action listener: _resource_record_post_action 10:29:37 INFO - Running post-action listener: set_extra_try_arguments 10:29:37 INFO - [mozharness: 2017-05-11 17:29:37.313968Z] Finished download-and-extract step (success) 10:29:37 INFO - [mozharness: 2017-05-11 17:29:37.314126Z] Running populate-webroot step. 10:29:37 INFO - Running pre-action listener: _resource_record_pre_action 10:29:37 INFO - Running main action method: populate_webroot 10:29:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:29:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:29:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:29:37 INFO - '--tppagecycles', 10:29:37 INFO - '7'], 10:29:37 INFO - 'tests': ['tsvgm']}}, 10:29:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:29:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:29:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:29:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:29:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:29:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:29:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:29:37 INFO - 'talos_options': ['--disable-e10s'], 10:29:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:29:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:29:37 INFO - 'talos_options': ['--disable-e10s'], 10:29:37 INFO - 'tests': ['damp', 'tps']}, 10:29:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:29:37 INFO - 'tests': ['damp', 'tps']}, 10:29:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:29:37 INFO - 'tests': ['dromaeo_dom']}, 10:29:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:29:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:29:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:29:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:29:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:29:37 INFO - 'tests': ['a11yr', 10:29:37 INFO - 'ts_paint', 10:29:37 INFO - 'tpaint', 10:29:37 INFO - 'sessionrestore', 10:29:37 INFO - 'sessionrestore_no_auto_restore', 10:29:37 INFO - 'tabpaint']}, 10:29:37 INFO - 'other-e10s': {'tests': ['a11yr', 10:29:37 INFO - 'ts_paint', 10:29:37 INFO - 'tpaint', 10:29:37 INFO - 'sessionrestore', 10:29:37 INFO - 'sessionrestore_no_auto_restore', 10:29:37 INFO - 'tabpaint']}, 10:29:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:29:37 INFO - 'ts_paint', 10:29:37 INFO - 'tpaint', 10:29:37 INFO - 'sessionrestore', 10:29:37 INFO - 'sessionrestore_no_auto_restore', 10:29:37 INFO - 'tabpaint']}, 10:29:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:29:37 INFO - 'ts_paint', 10:29:37 INFO - 'tpaint', 10:29:37 INFO - 'sessionrestore', 10:29:37 INFO - 'sessionrestore_no_auto_restore', 10:29:37 INFO - 'tabpaint']}, 10:29:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:29:37 INFO - 'tests': ['a11yr', 10:29:37 INFO - 'ts_paint', 10:29:37 INFO - 'tpaint', 10:29:37 INFO - 'sessionrestore', 10:29:37 INFO - 'sessionrestore_no_auto_restore', 10:29:37 INFO - 'tabpaint']}, 10:29:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:29:37 INFO - 'tests': ['a11yr', 10:29:37 INFO - 'ts_paint', 10:29:37 INFO - 'tpaint', 10:29:37 INFO - 'sessionrestore', 10:29:37 INFO - 'sessionrestore_no_auto_restore', 10:29:37 INFO - 'tabpaint']}, 10:29:37 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:29:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:29:37 INFO - 'bloom_basic_ref']}, 10:29:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:29:37 INFO - 'tests': ['tsvgx', 10:29:37 INFO - 'tsvgr_opacity', 10:29:37 INFO - 'tart', 10:29:37 INFO - 'tscrollx', 10:29:37 INFO - 'cart', 10:29:37 INFO - 'tsvg_static']}, 10:29:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:29:37 INFO - 'tsvgr_opacity', 10:29:37 INFO - 'tart', 10:29:37 INFO - 'tscrollx', 10:29:37 INFO - 'cart', 10:29:37 INFO - 'tsvg_static']}, 10:29:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:29:37 INFO - 'talos_options': ['--disable-e10s'], 10:29:37 INFO - 'tests': ['tp5o']}, 10:29:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:29:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:29:37 INFO - 'talos_options': ['--disable-e10s', 10:29:37 INFO - '--xperf_path', 10:29:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:37 INFO - 'tests': ['tp5n']}, 10:29:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:29:37 INFO - 'talos_options': ['--xperf_path', 10:29:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:37 INFO - 'tests': ['tp5n']}}, 10:29:37 INFO - 'talos.zip': {'path': '', 10:29:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:29:37 INFO - Running post-action listener: _resource_record_post_action 10:29:37 INFO - [mozharness: 2017-05-11 17:29:37.335116Z] Finished populate-webroot step (success) 10:29:37 INFO - [mozharness: 2017-05-11 17:29:37.335256Z] Running create-virtualenv step. 10:29:37 INFO - Running pre-action listener: _resource_record_pre_action 10:29:37 INFO - Running main action method: create_virtualenv 10:29:37 INFO - Creating virtualenv /builds/slave/test/build/venv 10:29:37 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:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:29:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:29:37 INFO - Using real prefix '/tools/python27' 10:29:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:29:38 INFO - Installing distribute.............................................................................................................................................................................................done. 10:29:41 INFO - Installing pip.................done. 10:29:41 INFO - Return code: 0 10:29:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:29:41 INFO - Reading from file tmpfile_stdout 10:29:41 INFO - Output received: 10:29:41 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:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:29:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:41 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 0x101e7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7bb58b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8ed30>, '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 0x101b41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b82be8>, '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.kjgiyPrDQg/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.scCSC0q2k9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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:41 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:41 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:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjgiyPrDQg/Render', 10:29:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:41 INFO - 'HOME': '/Users/cltbld', 10:29:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:41 INFO - 'LOGNAME': 'cltbld', 10:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:41 INFO - 'MOZ_NO_REMOTE': '1', 10:29:41 INFO - 'NO_EM_RESTART': '1', 10:29:41 INFO - 'PAGER': '/bin/cat', 10:29:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:41 INFO - 'PWD': '/builds/slave/test', 10:29:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:41 INFO - 'SHELL': '/bin/bash', 10:29:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.scCSC0q2k9/Listeners', 10:29:41 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 10:29:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:41 INFO - 'USER': 'cltbld', 10:29:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:41 INFO - 'XPC_FLAGS': '0x0', 10:29:41 INFO - 'XPC_SERVICE_NAME': '0', 10:29:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:41 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:41 INFO - Cleaning up... 10:29:41 INFO - Return code: 0 10:29:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:29:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:41 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 0x101e7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7bb58b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8ed30>, '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 0x101b41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b82be8>, '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.kjgiyPrDQg/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.scCSC0q2k9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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:41 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:41 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:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjgiyPrDQg/Render', 10:29:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:41 INFO - 'HOME': '/Users/cltbld', 10:29:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:41 INFO - 'LOGNAME': 'cltbld', 10:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:41 INFO - 'MOZ_NO_REMOTE': '1', 10:29:41 INFO - 'NO_EM_RESTART': '1', 10:29:41 INFO - 'PAGER': '/bin/cat', 10:29:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:41 INFO - 'PWD': '/builds/slave/test', 10:29:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:41 INFO - 'SHELL': '/bin/bash', 10:29:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.scCSC0q2k9/Listeners', 10:29:41 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 10:29:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:41 INFO - 'USER': 'cltbld', 10:29:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:41 INFO - 'XPC_FLAGS': '0x0', 10:29:41 INFO - 'XPC_SERVICE_NAME': '0', 10:29:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:41 INFO - Downloading/unpacking psutil>=3.1.1 10:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:32:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:14 INFO - Installing collected packages: psutil 10:32:14 INFO - Running setup.py install for psutil 10:32:14 INFO - building 'psutil._psutil_osx' extension 10:32:14 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:32:15 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:32:15 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:32:15 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:32:15 INFO - building 'psutil._psutil_posix' extension 10:32:15 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:32:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:32:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:32:15 INFO - ^ 10:32:15 INFO - 1 warning generated. 10:32:15 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:32:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:15 INFO - Successfully installed psutil 10:32:15 INFO - Cleaning up... 10:32:15 INFO - Return code: 0 10:32:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:32:15 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:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:15 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:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:15 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 0x101e7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7bb58b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8ed30>, '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 0x101b41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b82be8>, '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.kjgiyPrDQg/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.scCSC0q2k9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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:32:15 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:32:15 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:32:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjgiyPrDQg/Render', 10:32:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:15 INFO - 'HOME': '/Users/cltbld', 10:32:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:15 INFO - 'LOGNAME': 'cltbld', 10:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:15 INFO - 'MOZ_NO_REMOTE': '1', 10:32:15 INFO - 'NO_EM_RESTART': '1', 10:32:15 INFO - 'PAGER': '/bin/cat', 10:32:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:15 INFO - 'PWD': '/builds/slave/test', 10:32:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:15 INFO - 'SHELL': '/bin/bash', 10:32:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.scCSC0q2k9/Listeners', 10:32:15 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 10:32:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:15 INFO - 'USER': 'cltbld', 10:32:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:15 INFO - 'XPC_FLAGS': '0x0', 10:32:15 INFO - 'XPC_SERVICE_NAME': '0', 10:32:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:32:16 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:32:16 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:32:16 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:32:16 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:32:16 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:32:16 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:34:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:34:48 INFO - Installing collected packages: mozsystemmonitor 10:34:48 INFO - Running setup.py install for mozsystemmonitor 10:34:48 INFO - Successfully installed mozsystemmonitor 10:34:48 INFO - Cleaning up... 10:34:48 INFO - Return code: 0 10:34:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:34: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:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34: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:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:50 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 0x101e7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7bb58b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8ed30>, '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 0x101b41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b82be8>, '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.kjgiyPrDQg/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.scCSC0q2k9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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:34:50 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:34:50 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:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjgiyPrDQg/Render', 10:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:50 INFO - 'HOME': '/Users/cltbld', 10:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:50 INFO - 'LOGNAME': 'cltbld', 10:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:50 INFO - 'MOZ_NO_REMOTE': '1', 10:34:50 INFO - 'NO_EM_RESTART': '1', 10:34:50 INFO - 'PAGER': '/bin/cat', 10:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:50 INFO - 'PWD': '/builds/slave/test', 10:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:50 INFO - 'SHELL': '/bin/bash', 10:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.scCSC0q2k9/Listeners', 10:34:50 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 10:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:50 INFO - 'USER': 'cltbld', 10:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:50 INFO - 'XPC_FLAGS': '0x0', 10:34:50 INFO - 'XPC_SERVICE_NAME': '0', 10:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:50 INFO - Downloading/unpacking jsonschema==2.5.1 10:34: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:34: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:34: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:34: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:34: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:34: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:37:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:37:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:39:53 INFO - Downloading functools32-3.2.3-2.tar.gz 10:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:39:53 INFO - warning: no files found matching '*.txt' 10:39:53 INFO - no previously-included directories found matching 'build' 10:39:53 INFO - no previously-included directories found matching 'dist' 10:39:53 INFO - no previously-included directories found matching '.git*' 10:39:53 INFO - Installing collected packages: jsonschema, functools32 10:39:53 INFO - Running setup.py install for functools32 10:39:54 INFO - warning: no files found matching '*.txt' 10:39:54 INFO - no previously-included directories found matching 'build' 10:39:54 INFO - no previously-included directories found matching 'dist' 10:39:54 INFO - no previously-included directories found matching '.git*' 10:39:54 INFO - Successfully installed jsonschema functools32 10:39:54 INFO - Cleaning up... 10:39:54 INFO - Return code: 0 10:39:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:39: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:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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', '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 0x101e7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7bb58b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8ed30>, '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 0x101b41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b82be8>, '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.kjgiyPrDQg/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.scCSC0q2k9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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:39: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:39: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 functools32==3.2.3-2 10:39:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjgiyPrDQg/Render', 10:39:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:55 INFO - 'HOME': '/Users/cltbld', 10:39:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:55 INFO - 'LOGNAME': 'cltbld', 10:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:55 INFO - 'MOZ_NO_REMOTE': '1', 10:39:55 INFO - 'NO_EM_RESTART': '1', 10:39:55 INFO - 'PAGER': '/bin/cat', 10:39:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:55 INFO - 'PWD': '/builds/slave/test', 10:39:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:55 INFO - 'SHELL': '/bin/bash', 10:39:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.scCSC0q2k9/Listeners', 10:39:55 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 10:39:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:55 INFO - 'USER': 'cltbld', 10:39:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:55 INFO - 'XPC_FLAGS': '0x0', 10:39:55 INFO - 'XPC_SERVICE_NAME': '0', 10:39:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:39:55 INFO - Cleaning up... 10:39:55 INFO - Return code: 0 10:39:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:39: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:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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', '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 0x101e7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7bb58b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8ed30>, '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 0x101b41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b82be8>, '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.kjgiyPrDQg/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.scCSC0q2k9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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:39: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:39: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 blobuploader==1.2.4 10:39:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjgiyPrDQg/Render', 10:39:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:55 INFO - 'HOME': '/Users/cltbld', 10:39:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:55 INFO - 'LOGNAME': 'cltbld', 10:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:55 INFO - 'MOZ_NO_REMOTE': '1', 10:39:55 INFO - 'NO_EM_RESTART': '1', 10:39:55 INFO - 'PAGER': '/bin/cat', 10:39:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:55 INFO - 'PWD': '/builds/slave/test', 10:39:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:55 INFO - 'SHELL': '/bin/bash', 10:39:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.scCSC0q2k9/Listeners', 10:39:55 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 10:39:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:55 INFO - 'USER': 'cltbld', 10:39:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:55 INFO - 'XPC_FLAGS': '0x0', 10:39:55 INFO - 'XPC_SERVICE_NAME': '0', 10:39:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:55 INFO - Downloading/unpacking blobuploader==1.2.4 10:39:55 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:39:55 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:39:55 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:39:55 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:39:55 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:39:55 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:42:28 INFO - Downloading blobuploader-1.2.4.tar.gz 10:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:42:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:44:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:44:59 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:44:59 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:44:59 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:44:59 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:44:59 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:44:59 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:47:30 INFO - Downloading docopt-0.6.1.tar.gz 10:47:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:47:30 INFO - Installing collected packages: blobuploader, requests, docopt 10:47:30 INFO - Running setup.py install for blobuploader 10:47:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:47:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:47:30 INFO - Running setup.py install for requests 10:47:30 INFO - Running setup.py install for docopt 10:47:31 INFO - Successfully installed blobuploader requests docopt 10:47:31 INFO - Cleaning up... 10:47:31 INFO - Return code: 0 10:47:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47: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:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:31 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 0x101e7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7bb58b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8ed30>, '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 0x101b41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b82be8>, '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.kjgiyPrDQg/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.scCSC0q2k9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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:47:31 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:47:31 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:47:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjgiyPrDQg/Render', 10:47:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:31 INFO - 'HOME': '/Users/cltbld', 10:47:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:31 INFO - 'LOGNAME': 'cltbld', 10:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:31 INFO - 'MOZ_NO_REMOTE': '1', 10:47:31 INFO - 'NO_EM_RESTART': '1', 10:47:31 INFO - 'PAGER': '/bin/cat', 10:47:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:31 INFO - 'PWD': '/builds/slave/test', 10:47:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:31 INFO - 'SHELL': '/bin/bash', 10:47:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.scCSC0q2k9/Listeners', 10:47:31 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 10:47:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:31 INFO - 'USER': 'cltbld', 10:47:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:31 INFO - 'XPC_FLAGS': '0x0', 10:47:31 INFO - 'XPC_SERVICE_NAME': '0', 10:47:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:32 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-CSmbDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:32 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-d3YpPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:32 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-Uxznqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:32 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-VRbW9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:32 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-_Zy3Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:32 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-VhQd6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:32 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-KLq0qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:32 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-ZoWTQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:32 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-vZ5RyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:32 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-46NjDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:33 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-zfVDjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:33 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-cFtk_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:33 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-umnuTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:33 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-NvjWIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:33 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-O7cUda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:33 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-klJqNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:33 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-Qb7MNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:47:33 INFO - Running setup.py install for manifestparser 10:47:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:47:33 INFO - Running setup.py install for mozcrash 10:47:34 INFO - Running setup.py install for mozdebug 10:47:34 INFO - Running setup.py install for mozdevice 10:47:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:47:34 INFO - Running setup.py install for mozfile 10:47:34 INFO - Running setup.py install for mozhttpd 10:47:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:47:34 INFO - Running setup.py install for mozinfo 10:47:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:47:34 INFO - Running setup.py install for mozInstall 10:47:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:47:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:47:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:47:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:47:34 INFO - Running setup.py install for mozleak 10:47:35 INFO - Running setup.py install for mozlog 10:47:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Running setup.py install for moznetwork 10:47:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Running setup.py install for mozprocess 10:47:35 INFO - Running setup.py install for mozprofile 10:47:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Running setup.py install for mozrunner 10:47:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Running setup.py install for mozscreenshot 10:47:36 INFO - Running setup.py install for moztest 10:47:36 INFO - Running setup.py install for mozversion 10:47:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:47:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:47:36 INFO - Cleaning up... 10:47:36 INFO - Return code: 0 10:47:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:36 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:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:36 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:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:36 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 0x101e7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7bb58b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8ed30>, '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 0x101b41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b82be8>, '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.kjgiyPrDQg/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.scCSC0q2k9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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:47:36 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:47:36 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:47:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjgiyPrDQg/Render', 10:47:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:36 INFO - 'HOME': '/Users/cltbld', 10:47:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:36 INFO - 'LOGNAME': 'cltbld', 10:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:36 INFO - 'MOZ_NO_REMOTE': '1', 10:47:36 INFO - 'NO_EM_RESTART': '1', 10:47:36 INFO - 'PAGER': '/bin/cat', 10:47:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:36 INFO - 'PWD': '/builds/slave/test', 10:47:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:36 INFO - 'SHELL': '/bin/bash', 10:47:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.scCSC0q2k9/Listeners', 10:47:36 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 10:47:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:36 INFO - 'USER': 'cltbld', 10:47:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:36 INFO - 'XPC_FLAGS': '0x0', 10:47:36 INFO - 'XPC_SERVICE_NAME': '0', 10:47:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:36 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-gSSC1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:36 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:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:36 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-e3MsgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:36 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-aqOa6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:36 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:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:36 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-ewHJcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:37 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-lAQc9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:37 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-5KUUD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:37 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-LtOdW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:37 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-uoKmuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:37 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-icE9qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:37 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-UmdgJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:37 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-IKxPJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:37 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-Gi13LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:37 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-j0M2Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:38 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:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:38 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-0iod67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:38 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-IqVqBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:38 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:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:38 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-yezb_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:38 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-MEMN3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:38 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:47:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:47:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:47:38 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:47:38 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:47:38 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:47:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:47: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:47: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:47: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:47: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:47: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:47: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:50:10 INFO - Downloading blessings-1.6.tar.gz 10:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:50:11 INFO - Installing collected packages: blessings 10:50:11 INFO - Running setup.py install for blessings 10:50:11 INFO - Successfully installed blessings 10:50:11 INFO - Cleaning up... 10:50:11 INFO - Return code: 0 10:50:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:11 INFO - Reading from file tmpfile_stdout 10:50:11 INFO - Current package versions: 10:50:11 INFO - blessings == 1.6 10:50:11 INFO - blobuploader == 1.2.4 10:50:11 INFO - docopt == 0.6.1 10:50:11 INFO - functools32 == 3.2.3-2 10:50:11 INFO - jsonschema == 2.5.1 10:50:11 INFO - manifestparser == 1.1 10:50:11 INFO - mozInstall == 1.12 10:50:11 INFO - mozcrash == 1.0 10:50:11 INFO - mozdebug == 0.1 10:50:11 INFO - mozdevice == 0.50 10:50:11 INFO - mozfile == 1.2 10:50:11 INFO - mozhttpd == 0.7 10:50:11 INFO - mozinfo == 0.9 10:50:11 INFO - mozleak == 0.1 10:50:11 INFO - mozlog == 3.4 10:50:11 INFO - moznetwork == 0.27 10:50:11 INFO - mozprocess == 0.25 10:50:11 INFO - mozprofile == 0.28 10:50:11 INFO - mozrunner == 6.13 10:50:11 INFO - mozscreenshot == 0.1 10:50:11 INFO - mozsystemmonitor == 0.3 10:50:11 INFO - moztest == 0.8 10:50:11 INFO - mozversion == 1.4 10:50:11 INFO - psutil == 3.1.1 10:50:11 INFO - requests == 1.2.3 10:50:11 INFO - wsgiref == 0.1.2 10:50:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:12 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 0x101e7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7bb58b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8ed30>, '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 0x101b41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b82be8>, '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.kjgiyPrDQg/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.scCSC0q2k9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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:50:12 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:50:12 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:50:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjgiyPrDQg/Render', 10:50:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:12 INFO - 'HOME': '/Users/cltbld', 10:50:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:12 INFO - 'LOGNAME': 'cltbld', 10:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:12 INFO - 'MOZ_NO_REMOTE': '1', 10:50:12 INFO - 'NO_EM_RESTART': '1', 10:50:12 INFO - 'PAGER': '/bin/cat', 10:50:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:12 INFO - 'PWD': '/builds/slave/test', 10:50:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:12 INFO - 'SHELL': '/bin/bash', 10:50:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.scCSC0q2k9/Listeners', 10:50:12 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 10:50:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:12 INFO - 'USER': 'cltbld', 10:50:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:12 INFO - 'XPC_FLAGS': '0x0', 10:50:12 INFO - 'XPC_SERVICE_NAME': '0', 10:50:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 INFO - Cleaning up... 10:50:12 INFO - Return code: 0 10:50:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:12 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 0x101e7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7bb58b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8ed30>, '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 0x101b41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b82be8>, '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.kjgiyPrDQg/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.scCSC0q2k9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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:50:12 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:50:12 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:50:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjgiyPrDQg/Render', 10:50:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:12 INFO - 'HOME': '/Users/cltbld', 10:50:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:12 INFO - 'LOGNAME': 'cltbld', 10:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:12 INFO - 'MOZ_NO_REMOTE': '1', 10:50:12 INFO - 'NO_EM_RESTART': '1', 10:50:12 INFO - 'PAGER': '/bin/cat', 10:50:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:12 INFO - 'PWD': '/builds/slave/test', 10:50:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:12 INFO - 'SHELL': '/bin/bash', 10:50:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.scCSC0q2k9/Listeners', 10:50:12 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 10:50:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:12 INFO - 'USER': 'cltbld', 10:50:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:12 INFO - 'XPC_FLAGS': '0x0', 10:50:12 INFO - 'XPC_SERVICE_NAME': '0', 10:50:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:50:13 INFO - Cleaning up... 10:50:13 INFO - Return code: 0 10:50:13 INFO - Running post-action listener: _resource_record_post_action 10:50:13 INFO - Running post-action listener: _start_resource_monitoring 10:50:13 INFO - Starting resource monitoring. 10:50:13 INFO - [mozharness: 2017-05-11 17:50:13.268173Z] Finished create-virtualenv step (success) 10:50:13 INFO - [mozharness: 2017-05-11 17:50:13.269126Z] Running install step. 10:50:13 INFO - Running pre-action listener: _resource_record_pre_action 10:50:13 INFO - Running main action method: install 10:50:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:13 INFO - Reading from file tmpfile_stdout 10:50:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:50:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:50:13 INFO - Reading from file tmpfile_stdout 10:50:13 INFO - Output received: 10:50:13 INFO - Usage: mozinstall [options] installer 10:50:13 INFO - Options: 10:50:13 INFO - -h, --help show this help message and exit 10:50:13 INFO - -d DEST, --destination=DEST 10:50:13 INFO - Directory to install application into. [default: 10:50:13 INFO - "/builds/slave/test"] 10:50:13 INFO - --app=APP Application being installed. [default: firefox] 10:50:13 INFO - mkdir: /builds/slave/test/build/application 10:50:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:50:34 INFO - Reading from file tmpfile_stdout 10:50:34 INFO - Output received: 10:50:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:50:34 INFO - Running post-action listener: _resource_record_post_action 10:50:34 INFO - [mozharness: 2017-05-11 17:50:34.327416Z] Finished install step (success) 10:50:34 INFO - [mozharness: 2017-05-11 17:50:34.327551Z] Running run-tests step. 10:50:34 INFO - Running pre-action listener: _resource_record_pre_action 10:50:34 INFO - Running main action method: run_tests 10:50:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:50:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:50:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:50:34 INFO - 2017-05-11 10:50:34.341 screenresolution[1631:9306] starting screenresolution argv=screenresolution get 10:50:34 INFO - 2017-05-11 10:50:34.344 screenresolution[1631:9306] Display 0: 1600x1200x32@60 10:50:34 INFO - 2017-05-11 10:50:34.351 screenresolution[1632:9308] starting screenresolution argv=screenresolution list 10:50:34 INFO - Available Modes on Display 0 10:50:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:50:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:50:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:50:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:50:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:50:34 INFO - Intel Iris: 10:50:34 INFO - Chipset Model: Intel Iris 10:50:34 INFO - Type: GPU 10:50:34 INFO - Bus: Built-In 10:50:34 INFO - VRAM (Dynamic, Max): 1536 MB 10:50:34 INFO - Vendor: Intel (0x8086) 10:50:34 INFO - Device ID: 0x0a2e 10:50:34 INFO - Revision ID: 0x0009 10:50:34 INFO - Displays: 10:50:34 INFO - Display: 10:50:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:50:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:50:34 INFO - Display Serial Number: 1600x1200 60 10:50:34 INFO - Main Display: Yes 10:50:34 INFO - Mirror: Off 10:50:34 INFO - Online: Yes 10:50:34 INFO - Rotation: Supported 10:50:34 INFO - Return code: 0 10:50:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:50:34 INFO - Python 2.7.3 10:50:34 INFO - Return code: 0 10:50:34 INFO - grabbing minidump binary from tooltool 10:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:34 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 0x101b8ed30>, '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 0x101b41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b82be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:50:34 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:50:34 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:50:34 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:50:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:50:34 INFO - Return code: 0 10:50:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:50:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:50:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:50:34 INFO - ENV: RUST_BACKTRACE is now 1 10:50:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:50:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:50:34 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/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0276', '--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:50:34 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/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0276 --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:50:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjgiyPrDQg/Render', 10:50:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:34 INFO - 'HOME': '/Users/cltbld', 10:50:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:34 INFO - 'LOGNAME': 'cltbld', 10:50:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:50:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:34 INFO - 'MOZ_NO_REMOTE': '1', 10:50:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:50:34 INFO - 'NO_EM_RESTART': '1', 10:50:34 INFO - 'PAGER': '/bin/cat', 10:50:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:34 INFO - 'PWD': '/builds/slave/test', 10:50:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:50:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:34 INFO - 'RUST_BACKTRACE': '1', 10:50:34 INFO - 'SHELL': '/bin/bash', 10:50:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.scCSC0q2k9/Listeners', 10:50:34 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 10:50:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:34 INFO - 'USER': 'cltbld', 10:50:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:34 INFO - 'XPC_FLAGS': '0x0', 10:50:34 INFO - 'XPC_SERVICE_NAME': '0', 10:50:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:34 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/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0276', '--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:50:34 INFO - mozversion application_buildid: 20170511081456 10:50:34 INFO - mozversion application_changeset: 3b96f277325747fe668ca8cd896d2f581238e4ee 10:50:34 INFO - mozversion application_display_name: Nightly 10:50:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:50:34 INFO - mozversion application_name: Firefox 10:50:34 INFO - mozversion application_remotingname: firefox 10:50:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:50:34 INFO - mozversion application_vendor: Mozilla 10:50:34 INFO - mozversion application_version: 55.0a1 10:50:34 INFO - mozversion platform_buildid: 20170511081456 10:50:34 INFO - mozversion platform_changeset: 3b96f277325747fe668ca8cd896d2f581238e4ee 10:50:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:50:34 INFO - mozversion platform_version: 55.0a1 10:50:34 INFO - using testdate: 1494525034 10:50:34 INFO - actual date: 1494525034 10:50:34 INFO - starting webserver on 'localhost:49250' 10:50:34 INFO - SUITE-START | Running 2 tests 10:50:34 INFO - TEST-START | dromaeo_css 10:50:34 INFO - operating with platform_type : mac_ 10:50:34 INFO - Initialising browser for dromaeo_css test... 10:50:34 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpUjVdt2/profile http://localhost:49250/getInfo.html) 10:50:37 INFO - PID 1642 | __metrics Screen width/height:1600/1200 10:50:37 INFO - PID 1642 | colorDepth:24 10:50:37 INFO - PID 1642 | Browser inner width/height: 1024/691 10:50:37 INFO - PID 1642 | __metrics 10:50:37 INFO - PID 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:50:37 INFO - PID 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:50:38 INFO - TEST-INFO | 1642: exit 0 10:50:38 INFO - Browser initialized. 10:50:38 INFO - Running cycle 1/1 for dromaeo_css test... 10:50:38 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpUjVdt2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:50 INFO - PID 1645 | RSS: Main: 235147264 10:50:50 INFO - PID 1645 | 10:53:53 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 10:53:55 INFO - PID 1645 | RSS: Main: 357806080 10:53:55 INFO - PID 1645 | 10:56:58 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 10:56:58 INFO - PID 1645 | RSS: Main: 367550464 10:56:58 INFO - PID 1645 | 11:00:00 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 11:00:01 INFO - PID 1645 | RSS: Main: 332341248 11:00:01 INFO - PID 1645 | 11:03:03 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 11:03:04 INFO - PID 1645 | RSS: Main: 336510976 11:03:04 INFO - PID 1645 | 11:06:07 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 11:06:08 INFO - PID 1645 | RSS: Main: 330088448 11:06:08 INFO - PID 1645 | 11:09:10 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 11:09:10 INFO - PID 1645 | RSS: Main: 368640000 11:09:10 INFO - PID 1645 | 11:09:10 INFO - PID 1645 | __start_tp_report 11:09:10 INFO - PID 1645 | _x_x_mozilla_page_load 11:09:10 INFO - PID 1645 | _x_x_mozilla_page_load_details 11:09:10 INFO - PID 1645 | |i|pagename|runs| 11:09:10 INFO - PID 1645 | |0;dojo.html;2944.2786517303252;3475.496053072303;3543.8936831895044;3550.3609350316947;3590.2460483298505;5628.746706398211;6137.101203255286;6207.193064901562;6227.190465239518;6227.470664993475;6162.969185154079;6209.782657606974;6239.407256310655;6241.781537646183;6248.37516248375;4935.185694360426;5211.504907033845;5329.2006199070065;5406.053940560406;5447.210154527611;5409.783608655649;5421.1326187809955;5460.699661518614;5494.532964698005;5521.889562208753;5321.920171197455;5384.3538775346815;5411;5433.1035379162395;5490.231367608538;5461.344638643349;5468.863278418032;5480.150576660624;5493.560515158818;5504.22940788286;5399.7030163341;5426.158945363475;5435.076037073707;5477.1510415885605;5491.2312276281355;6253.906191407133;6264.498840092827;6266.968665156645;6267.71795269214;6277.278113017016;6379.87240255197;6427.357264273582;6435.871282574369;6613.173353330833;6614.570052946543;6047.485963693091;6635.3032931541975;6651.102101216322;6721;6728.798136055926;6215.316315205324;6284.622922624657;6294.339094395068;6296.874062518724;6303.590266632654;6555.475561955032;6729.966350168218;6747.359000894907;6762.72949082041;6764.458843292623;6440.903386449207;6482.12491313676;6492.188476440445;6507.577007494498;6514.1531600891585;6620.238672552622;6629.502787290972;6631.10480085192;6646.401823835878;6664.466842652576;6395.968020159869;6520.706568204442;6533.41199292066;6573.408393244536;6577.408033277028;6452.483801295885;6510.18622672166;6599;6604.306547812411;6606.867862642816;5287.814926477555;5290.074237008508;5291.973540132351;5301;5313.0436521425745;4712.986707857827;4721;4743.335932969387;4762.3570817939135;4764.356811830427;6104.76233045773;6109.374301065143;6245.937540624535;6259.624422534663;6303.243610766737;6650.168728908887;6654.534182607268;6688.29772873851;6700.262971073178;6705.362990515893;5131.5638170755155;6255.311915689271;6269.7178626961895;6275.529335299871;6282.246130464374;5690.658560486384;5758.539316854642;5759.222504961776;5809.593328467051;5824.592278540546;6668.566543174678;6694.497912656473;6698.095757072733;6699.698513566804;6700.83247918806;6537.673116344069;6547.672616369257;6556.409923106943;6606.108175396452;6685.53201275906;5354.946450535601;6796.830079248059;6814.046033555207;6827.726890924506;6832.385085342343;6532.510061745483;6553.770618028346;6558.573692709959;6562.146920900253;6564.343565643398;6453.386928241997;6527.379898909596;6626;6665.500087493554;6678.833029174115;5285;6361.045843123384;6376.808695739135;6444.258910225384;6453.128827608213;6424.935750642434;6429.7749578764515;6433.228012638326;6440.25937017249;6446.323136070645;6240.375962403905;6273.153124328157;6342.52431067681;6353.809385718436;6362.936370636235;6374.07575901501;6374.776882809079;6383.840403989938;6404.743810247538;6439.098526206241;6303.149074874833;6307.432331090224;6308.148399965946;6310;6315.5894866833505 11:09:10 INFO - PID 1645 | |1;ext.html;786.4376970466117;793.3375631347824;1081.7890511350286;1112.5160555158511;1112.5716599109346;34619.65380346196;35178;35210;35230.64769352306;35240.471392929096;37070;37356.813215933886;37388;37411.25177496448;37454;4609.239475486541;4742.454617718955;7993.080795708495;8101.068377136646;8117.228863257981;5824.679642619654;5911.408859114075;5918.940810591904;7378.040854688909;8291.005079390481;8323.66705331789;8361.289290410323;8370.790730231762;8372.706955256568;8423.705170319041;8266.917330826705;8306.460080094836;8333;8334.70828521002;8379.162083791633;5768.567357448208;5844.941550584483;7993.480423772437;8141.307988820898;8189.426740128193;35402.5838966441;35674;35690.821545892104;35713.82143089294;35848.10379740501;3495.790252584853;3543.255916257589;3546.3616549021167;3547.6629720176543;3547.840347184383;29192;29256.561151582744;29291.70708292911;29357.559636605467;29388.70611293881;3043.5434684797237;3101.6122984626923;3127.46833038384;3132.9661211800053;3133.310671652233;289374;289389;290255;290441;290877;38665.680059195976;38685;38801.223975520894;48175;48489;48239;48550.75724621354;48556.62990330887;48611.27083093757;48876.7556162224;13238.470461181638;13373.331333433289;13386.531471398454;13390.656635089015;13441.663958401119;11001.339919604849;11006.944965275123;11009.119270458345;11022.063124634336;11033.448327583588;12371.13402061865;12384.876151238372;12413.255204687748;12429.192102513307;12534.81197782034;5215.843524694265;5218.712970786567;5221.190715439113;5233.1365324721755;5246.317978662826;868.2533021601417;971.4511301114848;978.7553111722069;1009.8994092288024;1023.3246057601947;24072.87963560171;24096.759032409802;24115.276541703777;24123.75876241215;24210.273691789276;1017.2675673515205;1071.4374953149502;1079.7084787107437;1115.6039605939936;1116.4919961417536;10945;11580.47887845049;12310.75378492425;12344.506219751289;12375.62873113808;312945;314317;314926;315617.42191288894;315642;50986;51046.234306485436;51156;51201.74399127981;51305.7434712824;1444.8627380398846;1481.7184734900334;1523.2992823301183;1523.7638166084053;1527.755559110537;23625.29124126279;23664.290071297888;23679.763202368445;23700;23975.28074157778;30608;37355.81322093372;37355.879323620335;37478.43782343213;37537;231278.8436057809;278274;279210;279431;280423;23328.883355583115;29581.40837183201;33124.834375827966;33163.83926562559;33551.83224083864;40707.389389159776;42179.789101054295;42204.57795422129;42268.788656056524;42279.812431886035;27877.909156812915;28709.674194483367;29219.831206751493;29603.407931841673;30134.19805437765;28911.42177156487;29126.7087329124;29381.38402387889;29653.962111326;29783.55324670175;35304.64695353014;35479.64520354763;35481.64518354784;35536;35607;27950.02174923868;28070;29480.55779163357;29923.95266165674;30023.394853132275;21534.67697984563;23382.53234935326;23417.882910585337;23465.88267058654;23515.52968940646 11:09:10 INFO - PID 1645 | |2;jquery.html;404.5267037566047;424.46767170514437;439.57361359481314;440.7179405180684;443.4766974969535;18092.185851636674;19775.802241977577;20277.69583456249;20518.794812051874;20545.897270513644;20738.859362735042;20976.790232097712;21145.048472818722;21180.8940955295;21241.044153013114;5921.289445266574;6088.573799834014;6170.876582468348;6191.907121393183;6199.44205021548;6019.21750172477;6072;6078.361772013919;6090.847728806793;6195.008798592204;6115.571909966282;6147.323794382614;6147.446729794317;6152.446279834814;6162.075688646694;5842.678652674102;6060.818175454766;6115.205023346981;6126.969365153146;6131.601445906046;5357.116075847481;5430.8099216527235;5433.538149257279;5437.700926449043;5438.428964958662;26928.326791830164;27570.17289481319;27633.86183069092;27791.74937127814;28050.158495245174;2161.232762369352;2217.3569664797187;2252.6057939860457;2255.7067581214337;2256.6163752162006;17145.571360716083;17504.299828006864;17558.03430811305;18016.36942707012;18273.725894111598;2117.851750377474;2203.768604296558;2302.82728795341;2348.612478940973;2353.5645905507536;145760;145867;152879;160801.19599402044;162585;21059.894700526398;21298.467538311666;21770.78229217719;22994.010778598677;23918.64122038171;42099.57900420957;42202.36696449556;42463.57536424658;42500.57499425028;42626.360604590955;8799.736007919773;8812.8678069829;8940.240079593177;9097.954510227539;9135.269178465707;8518.190771876662;8520.275776558938;8530.061693213742;8709.042005379402;8723.214910658071;7773.222677732295;7898.881516777253;7940.729483282647;7942.126366099725;7943.960280198562;1723.4398820383426;1795.5421367551191;1908.8165337490566;2044.7750747417772;2280.5210905709987;921.7142685767434;954.2461455450117;956.8277710012126;988.8417853143462;994.9054839790208;19775.901120494305;20630.381088567367;20678.896605517177;20767;21000.579988400146;870.9738707838775;915.7865827778221;999.6101520407047;999.6900960702205;1008.4503945349802;10421.322614030063;10632.78734425307;10742.73143171427;10753.247272690993;10831.025207731342;540176;544202;575292.3706144411;576433.0225062775;586853;130233;136356.31821840827;138957.3052134753;140311.29844350714;142870;1192.2548407245472;1203.9879601204052;1241.3979220078254;1242.2298175131295;1252.4990003998473;20771.376858694264;20938.685919711523;21036.47408814792;21238.89380553087;21288.467788304795;53725.462745372046;55362;56177.71911140418;56863.431365685814;57137.71431142984;72403.63798180975;72448;73468.89796652948;74977.25022749921;76792.2320776785;8459.196376344238;8615.22462978335;8687.39188256816;8739.431936924333;8898.976617689048;13141.474341026253;13539.98450116265;13608.863911361155;13960.650983725489;14274.357653905807;11044.33733975964;11261.831072533754;11759.88240117622;11917;12105.939470302592;10955.452227388758;11001.834972475579;11122.99893009633;11252.381119038531;11324;11770.88229117732;11783.821617838148;12099.697507562381;12143.392830358624;12203.511859525519;8704.56477176126;8732.738017859474;8734.301255899385;8835.160659737314;8838.823223535623;10673.733156671145;10974.945125274322;11477.713057173638;11927.60063381932;12086.033117350767 11:09:10 INFO - PID 1645 | |3;mootools.html;1195.497890885828;1421.331973972233;1458.0741229319378;1478.3199728125062;1482.5330021043371;9541.570629321679;10031.297809153362;10031.949840250807;10040.347377420463;10044.196464282859;10611.522481488333;11323.905077560636;11375.772484550303;11401.771964560703;11424.657260282183;2464.716557595877;2528.51958127956;2529.734377890323;2529.9747002529925;2534.3664083979006;2093.3719884034804;2360.5868972929757;2520.848749075052;2521.042004038472;2528.6459895614535;1998.6502362086649;2138.893055347234;2155.7844215578475;2480.7643273888953;2486.5026994601153;1798.9910050449664;2260.8130731366;2486.639437281602;2494.5135698538793;2494.8128890333296;2072.4197224777085;2433.3673244956262;2475.3811547113223;2475.7276699563035;2477.19491165372;9700.27247956399;9825.656102036395;9830.705078847646;9830.90169098307;9854.65508707199;6422.646754428504;6642.767503137416;6650.301718319555;6659.63372014539;6659.6670166491485;3942.1130245694776;4191.161767646483;4254.489461264637;4301.397804307399;4304.3113101903855;1207.7765613361555;1212.2241765270235;1243.6704273367566;1259.162656833205;1260.1116213069763;15711.978721383188;16007.679846403124;16036.118013509253;16039.438619648374;16061.875668703195;4764.475907650156;5800.796972105956;5843.503302219359;5951.791687290924;5953.940460595425;10596.523156457977;12819.871801282054;12845.743085138245;12869.163504372185;12881.162724422882;6582.769603063965;6586.901196482057;6593.076969224312;6606.900896486556;6696.029075784081;6020.548458865603;6156.476699480505;6166.845828854314;6174;6222.097795819581;4419.071994881111;4551.5676010778925;4579.084183163381;4628.814847406066;4629.930551041737;1415.688548519324;1463.3926920327945;1483.9851601484063;1485.225155938643;1489.7467430536835;766.5783818899583;768.1742127213156;790.4032455496178;792.9603519824101;795.4113955672876;6448.300953937818;6604.075429439882;6789.558678685869;6815.625140617214;6888.276730943279;793.5000949401955;833.4082801211086;893.6738090597015;898.7169041751828;930.6277489004452;3514.68367846895;3701.6783328030738;3736.402175651937;4030.1939612077704;4123.257813593582;14185.716285674229;14581.927090364481;14678.779818302733;14682.779758303634;14715.190664513555;13965.441382344796;14239.430422782973;14632.829373650082;14637.341319640642;14643.780343294859;8078.9192108080515;8347.332213422911;8502.787430314167;8534.146585341541;8551.358648101417;5372.946270537244;5531.834044978657;6779.796606101825;6853.348931851466;6859.17689877198;12159;12488.562900298446;12720.809187862003;12746.68133296675;12755.87244127547;9741.9025809741;12925.965922726347;13116.803247951479;13266.668333291746;13628;7466.178720340649;8152.225538573826;8781.604827782638;8848.247898928663;8949.910500894908;9229.123233292827;9936.155426788515;10048.799024019625;10052.296339256181;10076.596936122767;8585.944284188607;8681.6093275804;8812.427192232484;8948.821023579621;8957.193852553302;7234.638268086469;8595.914040859761;8752.737417877473;8754.25588824957;8826.42628229163;7860.9213907860185;7917.247861453153;8004.199580041949;8008.399370047153;8009.519428834288;5880.558958078076;5970.999715095491;6011.338752737282;6050.485708714808;6064.181335519648;5894.263217097863;5974.761009559569;6054.727537260922;6125.9693701531205;6246.406591373994 11:09:10 INFO - PID 1645 | |4;prototype.html;394.65467715748713;395.4562476594682;401.63651895034985;405.468835825069;407.47639283520664;5976.282846058473;6002.789902353418;6011.819645410639;6057.273127224728;6102.87794244116;4517.774111294439;5274.468255237488;5394.298741163653;5925.851853703649;5927.792527261547;3906.453096566469;3915;4512.413386259782;4533.410656614636;4535.954640453586;3711;4163.167366526707;4186.853460128896;4545.636269140045;4555.567221114005;4360.302351623741;4472.709273897202;4506.97746511267;4527.230370836965;4550.203714349992;4497.650704788551;4498.122866041123;4501.684882058257;4506.188886000518;4535.977320113411;3990.082281075369;4018.598140185958;4026.2752704513177;4037.555868854424;4039.2527382434346;4999.500049995007;5466.371367292772;5756.597038207286;5766.250387449647;5851.941480585182;4361.105973275471;4511.571400716926;4646.372739680134;4862.217206996221;5030.924536131961;5831;6053.4551890330085;6321.968390158066;6361.586496877688;6369.20384951881;4034.798260086984;4204.474440694913;4241.215375155575;4264.635316698657;4292.785360731951;5729.942700573024;6375.521835862282;6552.279249282575;6673.432758215557;6756.155480564929;4205.990562265034;4252.702310838212;4284.078923031563;4293.570642935744;4304.375865499485;4103.794810259535;4219.746815191037;4286.035641980529;4358.4769827620885;4363;4449.9777501112285;5097.974510127426;5127.923081153711;5130.33305670268;5138.58891288696;6413.262474815456;6425.614463132227;6436.3241859605005;6443.194600674916;6470.935290647128;1347.8719521645428;1360.2042804959012;1398.4895513137835;1478.911265324084;1485.094092603511;806.7055524733547;959.4051687953513;977.3793641037992;983.7245571240064;986.5363279258737;5287;5815.156802263733;6008.879822403527;6008.905413711942;6017.157597936292;6071.939280607226;6624.536282460278;6645.202575690948;6656.8668626627195;6676.899846502306;5918.674472904032;5930.614510056833;5935.347111817697;6040.818775436744;6084.969575152096;3382.458806590934;3448.5689288838894;3449.8615456899165;3451.516787649731;3464.185916309665;6018.879622407528;6410.743570257137;6453.999630057348;6789.592624442549;6819.659017049128;6643.335666433318;6715.824730672113;6812.591244525344;6826.146731658543;6850.143732033496;5637.661740295595;6646.567973081735;6750.561213521106;6860.3825655690225;6868.62222577753;6552.475801935929;6643.7674681385915;6648;6651.43462805667;6664.866702665822;5500.862478438071;6045.798170271795;6201.596896201732;6341.207349081365;6531.869362612816;6722.899156512558;6792.524523283323;6800.795976120724;6814.182298124257;6814.829629259309;3945.861894833667;4270.295401258758;4328.675349348874;4426.75652839097;4830.347903033045;5849.736761845642;6586.946088625797;6643.435307998874;6651.434628056476;6656.7004484797335;5205.505476979681;5372.62391632582;6383.904241436475;6394.680265986775;6468.514861385321;5203.427622961547;5871.1486834407915;6142;6415.454686351713;6431.324710905475;5738.110592858114;5739.569532285179;5766.855828604318;6224.751009959551;6313.96843015782;5832.416758324133;6230.6884655766125;6277.654728989949;6358.459530939737;6404.583702059351;5208.322918020633;5459.535939445032;6240.843978900382;6248.312685604671;6249.281332646622 11:09:10 INFO - PID 1645 | |5;yui.html;838.6058552480332;854.9145085491451;865.7965378136137;868.3617541107285;884.8893888263965;14483.203423811712;15087.09477431355;16526.008439493624;16584.58538536537;16915.15424228788;12068.51725930964;16045.438409655664;17947.9231246125;17957.91021044893;17971.910140449312;986.6842610364686;996.4718699089494;996.8405055191171;997.1723469520317;997.6358629100399;679.3104998426601;690.7444245629124;1009.4094954451655;1010.2524132142198;1014.0164040880335;1019.8572199891984;1042.5464922758586;1044.759705267785;1045.5451878432907;1050.2858056521563;1031.1905154453718;1034.9586016559367;1035.6996471023394;1035.9171266298715;1046.4715318764013;731.0277331149558;773.2769860180749;775;776.20051347112;780.9886197374357;14487.78268325976;16212.918935405247;16785.748213776802;16972.40596579114;17536.64926701459;16925.915370423194;16925.915370423194;17106.31574737009;17313.65372692539;17572.033538155396;14008.439662413492;14187.14877107377;14194.574162775134;14375;14386.928065359607;3403.3873902697505;3427.0746898337557;3430.3310854383403;3435.707964822993;3438.2263990602164;105987;125685;127750.36124819316;128308;129337.99999999905;11937.104717146249;12107.03143748498;12329.815052774216;12364.319962402154;12464.189827661354;21355.78644213569;21383.89308053481;21416.78583214148;24693.38266543315;24872.005119795005;6111.96944015277;6231.376862313732;6268.811935641938;7607.771766847003;7721.7683469496005;3867.555231148454;3932.193900250442;3933.0757272041046;3941.2117576484816;3943.38877473992;3463.8787642432394;3874.612538746103;4093.5906409359422;4170.061736109351;4183.247015537232;867.466508097528;898.0077014898574;898.5821592959305;900.2887718702283;902.3142411767104;641.4540956295306;644.5842431631665;650.5446187668651;654.5123882707413;682.2461180395592;10981.450927453756;11214.32714037144;11902.404879755977;12049.277043377426;12231.960283376013;641.5541198866742;648.5816648261939;650.6421468192475;656.9047488114197;675.1864003875319;5268.367795864444;5478.972605136949;5487.478689524569;5555.388907220203;5598.3282006159525;98106.50946745364;100460.4976975125;105527;106444.46777766217;107346;84044;85787;87913.12086879049;94204;97555;78189;80721.59639201884;81376;81570.59214703889;83476;11700.239484433485;12393.566225182436;12405.317707526172;12473.87526124727;12523.4364453598;39638.603613964646;40151;40349;40670.79664601658;41204.38193427161;51197;51248.23127653014;51551.484485154666;51686.966260675326;51883.22175167451;11714.70713232176;13740.519081832488;16003.439879604159;16299.837001629832;16513.752293715363;14771.187584682515;17764.28942842272;17986.5503362417;18177.909110454362;18468.538286542946;16435.506934791974;16516.091614961293;16586.25361858695;16767.24547395346;16960.830391695927;16269.67460650804;16541.917290413472;16625.91687041557;16654.583635409213;16717.164141793106;15707.450239241572;15956.521304360887;16412.507624771275;16541.586460338105;16611.169441527632;9486.95256523713;11466.885331146581;11701.707457313636;11806.82289765637;11827.935485806318;10302.845457317997;11303.028185185594;11801.704957376134;11823.46794394237;11952.940235298767 11:09:10 INFO - PID 1645 | __end_tp_report 11:09:10 INFO - PID 1645 | __start_cc_report 11:09:10 INFO - PID 1645 | _x_x_mozilla_cycle_collect,1860 11:09:10 INFO - PID 1645 | __end_cc_report 11:09:10 INFO - PID 1645 | __startTimestamp1494526150885__endTimestamp 11:09:10 INFO - PID 1645 | 11:09:10 INFO - PID 1645 | ------- Summary: start ------- 11:09:10 INFO - PID 1645 | Number of tests: 6 11:09:10 INFO - PID 1645 | 11:09:10 INFO - PID 1645 | [#0] dojo.html Cycles:165 Average:6079.33 Median:6308.15 stddev:713.09 (11.3%) stddev-sans-first:671.52 11:09:10 INFO - PID 1645 | Values: 2944.3 3475.5 3543.9 3550.4 3590.2 5628.7 6137.1 6207.2 6227.2 6227.5 6163.0 6209.8 6239.4 6241.8 6248.4 4935.2 5211.5 5329.2 5406.1 5447.2 5409.8 5421.1 5460.7 5494.5 5521.9 5321.9 5384.4 5411.0 5433.1 5490.2 5461.3 5468.9 5480.2 5493.6 5504.2 5399.7 5426.2 5435.1 5477.2 5491.2 6253.9 6264.5 6267.0 6267.7 6277.3 6379.9 6427.4 6435.9 6613.2 6614.6 6047.5 6635.3 6651.1 6721.0 6728.8 6215.3 6284.6 6294.3 6296.9 6303.6 6555.5 6730.0 6747.4 6762.7 6764.5 6440.9 6482.1 6492.2 6507.6 6514.2 6620.2 6629.5 6631.1 6646.4 6664.5 6396.0 6520.7 6533.4 6573.4 6577.4 6452.5 6510.2 6599.0 6604.3 6606.9 5287.8 5290.1 5292.0 5301.0 5313.0 4713.0 4721.0 4743.3 4762.4 4764.4 6104.8 6109.4 6245.9 6259.6 6303.2 6650.2 6654.5 6688.3 6700.3 6705.4 5131.6 6255.3 6269.7 6275.5 6282.2 5690.7 5758.5 5759.2 5809.6 5824.6 6668.6 6694.5 6698.1 6699.7 6700.8 6537.7 6547.7 6556.4 6606.1 6685.5 5354.9 6796.8 6814.0 6827.7 6832.4 6532.5 6553.8 6558.6 6562.1 6564.3 6453.4 6527.4 6626.0 6665.5 6678.8 5285.0 6361.0 6376.8 6444.3 6453.1 6424.9 6429.8 6433.2 6440.3 6446.3 6240.4 6273.2 6342.5 6353.8 6362.9 6374.1 6374.8 6383.8 6404.7 6439.1 6303.1 6307.4 6308.1 6310.0 6315.6 11:09:10 INFO - PID 1645 | 11:09:10 INFO - PID 1645 | [#1] ext.html Cycles:180 Average:43306.51 Median:315271.71 stddev:76732.21 (24.3%) stddev-sans-first:76881.05 11:09:10 INFO - PID 1645 | Values: 786.4 793.3 1081.8 1112.5 1112.6 34619.7 35178.0 35210.0 35230.6 35240.5 37070.0 37356.8 37388.0 37411.3 37454.0 4609.2 4742.5 7993.1 8101.1 8117.2 5824.7 5911.4 5918.9 7378.0 8291.0 8323.7 8361.3 8370.8 8372.7 8423.7 8266.9 8306.5 8333.0 8334.7 8379.2 5768.6 5844.9 7993.5 8141.3 8189.4 35402.6 35674.0 35690.8 35713.8 35848.1 3495.8 3543.3 3546.4 3547.7 3547.8 29192.0 29256.6 29291.7 29357.6 29388.7 3043.5 3101.6 3127.5 3133.0 3133.3 289374.0 289389.0 290255.0 290441.0 290877.0 38665.7 38685.0 38801.2 48175.0 48489.0 48239.0 48550.8 48556.6 48611.3 48876.8 13238.5 13373.3 13386.5 13390.7 13441.7 11001.3 11006.9 11009.1 11022.1 11033.4 12371.1 12384.9 12413.3 12429.2 12534.8 5215.8 5218.7 5221.2 5233.1 5246.3 868.3 971.5 978.8 1009.9 1023.3 24072.9 24096.8 24115.3 24123.8 24210.3 1017.3 1071.4 1079.7 1115.6 1116.5 10945.0 11580.5 12310.8 12344.5 12375.6 312945.0 314317.0 314926.0 315617.4 315642.0 50986.0 51046.2 51156.0 51201.7 51305.7 1444.9 1481.7 1523.3 1523.8 1527.8 23625.3 23664.3 23679.8 23700.0 23975.3 30608.0 37355.8 37355.9 37478.4 37537.0 231278.8 278274.0 279210.0 279431.0 280423.0 23328.9 29581.4 33124.8 33163.8 33551.8 40707.4 42179.8 42204.6 42268.8 42279.8 27877.9 28709.7 29219.8 29603.4 30134.2 28911.4 29126.7 29381.4 29654.0 29783.6 35304.6 35479.6 35481.6 35536.0 35607.0 27950.0 28070.0 29480.6 29924.0 30023.4 21534.7 23382.5 23417.9 23465.9 23515.5 11:09:10 INFO - PID 1645 | 11:09:10 INFO - PID 1645 | [#2] jquery.html Cycles:180 Average:36986.28 Median:25423.48 stddev:95655.80 (376.2%) stddev-sans-first:95884.70 11:09:10 INFO - PID 1645 | Values: 404.5 424.5 439.6 440.7 443.5 18092.2 19775.8 20277.7 20518.8 20545.9 20738.9 20976.8 21145.0 21180.9 21241.0 5921.3 6088.6 6170.9 6191.9 6199.4 6019.2 6072.0 6078.4 6090.8 6195.0 6115.6 6147.3 6147.4 6152.4 6162.1 5842.7 6060.8 6115.2 6127.0 6131.6 5357.1 5430.8 5433.5 5437.7 5438.4 26928.3 27570.2 27633.9 27791.7 28050.2 2161.2 2217.4 2252.6 2255.7 2256.6 17145.6 17504.3 17558.0 18016.4 18273.7 2117.9 2203.8 2302.8 2348.6 2353.6 145760.0 145867.0 152879.0 160801.2 162585.0 21059.9 21298.5 21770.8 22994.0 23918.6 42099.6 42202.4 42463.6 42500.6 42626.4 8799.7 8812.9 8940.2 9098.0 9135.3 8518.2 8520.3 8530.1 8709.0 8723.2 7773.2 7898.9 7940.7 7942.1 7944.0 1723.4 1795.5 1908.8 2044.8 2280.5 921.7 954.2 956.8 988.8 994.9 19775.9 20630.4 20678.9 20767.0 21000.6 871.0 915.8 999.6 999.7 1008.5 10421.3 10632.8 10742.7 10753.2 10831.0 540176.0 544202.0 575292.4 576433.0 586853.0 130233.0 136356.3 138957.3 140311.3 142870.0 1192.3 1204.0 1241.4 1242.2 1252.5 20771.4 20938.7 21036.5 21238.9 21288.5 53725.5 55362.0 56177.7 56863.4 57137.7 72403.6 72448.0 73468.9 74977.3 76792.2 8459.2 8615.2 8687.4 8739.4 8899.0 13141.5 13540.0 13608.9 13960.7 14274.4 11044.3 11261.8 11759.9 11917.0 12105.9 10955.5 11001.8 11123.0 11252.4 11324.0 11770.9 11783.8 12099.7 12143.4 12203.5 8704.6 8732.7 8734.3 8835.2 8838.8 10673.7 10974.9 11477.7 11927.6 12086.0 11:09:10 INFO - PID 1645 | 11:09:10 INFO - PID 1645 | [#3] mootools.html Cycles:180 Average:6823.34 Median:4361.69 stddev:4254.80 (97.5%) stddev-sans-first:4245.72 11:09:10 INFO - PID 1645 | Values: 1195.5 1421.3 1458.1 1478.3 1482.5 9541.6 10031.3 10031.9 10040.3 10044.2 10611.5 11323.9 11375.8 11401.8 11424.7 2464.7 2528.5 2529.7 2530.0 2534.4 2093.4 2360.6 2520.8 2521.0 2528.6 1998.7 2138.9 2155.8 2480.8 2486.5 1799.0 2260.8 2486.6 2494.5 2494.8 2072.4 2433.4 2475.4 2475.7 2477.2 9700.3 9825.7 9830.7 9830.9 9854.7 6422.6 6642.8 6650.3 6659.6 6659.7 3942.1 4191.2 4254.5 4301.4 4304.3 1207.8 1212.2 1243.7 1259.2 1260.1 15712.0 16007.7 16036.1 16039.4 16061.9 4764.5 5800.8 5843.5 5951.8 5953.9 10596.5 12819.9 12845.7 12869.2 12881.2 6582.8 6586.9 6593.1 6606.9 6696.0 6020.5 6156.5 6166.8 6174.0 6222.1 4419.1 4551.6 4579.1 4628.8 4629.9 1415.7 1463.4 1484.0 1485.2 1489.7 766.6 768.2 790.4 793.0 795.4 6448.3 6604.1 6789.6 6815.6 6888.3 793.5 833.4 893.7 898.7 930.6 3514.7 3701.7 3736.4 4030.2 4123.3 14185.7 14581.9 14678.8 14682.8 14715.2 13965.4 14239.4 14632.8 14637.3 14643.8 8078.9 8347.3 8502.8 8534.1 8551.4 5372.9 5531.8 6779.8 6853.3 6859.2 12159.0 12488.6 12720.8 12746.7 12755.9 9741.9 12926.0 13116.8 13266.7 13628.0 7466.2 8152.2 8781.6 8848.2 8949.9 9229.1 9936.2 10048.8 10052.3 10076.6 8585.9 8681.6 8812.4 8948.8 8957.2 7234.6 8595.9 8752.7 8754.3 8826.4 7860.9 7917.2 8004.2 8008.4 8009.5 5880.6 5971.0 6011.3 6050.5 6064.2 5894.3 5974.8 6054.7 6126.0 6246.4 11:09:10 INFO - PID 1645 | 11:09:10 INFO - PID 1645 | [#4] prototype.html Cycles:180 Average:5132.55 Median:5831.71 stddev:1610.19 (27.6%) stddev-sans-first:1574.95 11:09:10 INFO - PID 1645 | Values: 394.7 395.5 401.6 405.5 407.5 5976.3 6002.8 6011.8 6057.3 6102.9 4517.8 5274.5 5394.3 5925.9 5927.8 3906.5 3915.0 4512.4 4533.4 4536.0 3711.0 4163.2 4186.9 4545.6 4555.6 4360.3 4472.7 4507.0 4527.2 4550.2 4497.7 4498.1 4501.7 4506.2 4536.0 3990.1 4018.6 4026.3 4037.6 4039.3 4999.5 5466.4 5756.6 5766.3 5851.9 4361.1 4511.6 4646.4 4862.2 5030.9 5831.0 6053.5 6322.0 6361.6 6369.2 4034.8 4204.5 4241.2 4264.6 4292.8 5729.9 6375.5 6552.3 6673.4 6756.2 4206.0 4252.7 4284.1 4293.6 4304.4 4103.8 4219.7 4286.0 4358.5 4363.0 4450.0 5098.0 5127.9 5130.3 5138.6 6413.3 6425.6 6436.3 6443.2 6470.9 1347.9 1360.2 1398.5 1478.9 1485.1 806.7 959.4 977.4 983.7 986.5 5287.0 5815.2 6008.9 6008.9 6017.2 6071.9 6624.5 6645.2 6656.9 6676.9 5918.7 5930.6 5935.3 6040.8 6085.0 3382.5 3448.6 3449.9 3451.5 3464.2 6018.9 6410.7 6454.0 6789.6 6819.7 6643.3 6715.8 6812.6 6826.1 6850.1 5637.7 6646.6 6750.6 6860.4 6868.6 6552.5 6643.8 6648.0 6651.4 6664.9 5500.9 6045.8 6201.6 6341.2 6531.9 6722.9 6792.5 6800.8 6814.2 6814.8 3945.9 4270.3 4328.7 4426.8 4830.3 5849.7 6586.9 6643.4 6651.4 6656.7 5205.5 5372.6 6383.9 6394.7 6468.5 5203.4 5871.1 6142.0 6415.5 6431.3 5738.1 5739.6 5766.9 6224.8 6314.0 5832.4 6230.7 6277.7 6358.5 6404.6 5208.3 5459.5 6240.8 6248.3 6249.3 11:09:10 INFO - PID 1645 | 11:09:10 INFO - PID 1645 | [#5] yui.html Cycles:180 Average:21243.13 Median:17952.92 stddev:30249.42 (168.5%) stddev-sans-first:30295.48 11:09:10 INFO - PID 1645 | Values: 838.6 854.9 865.8 868.4 884.9 14483.2 15087.1 16526.0 16584.6 16915.2 12068.5 16045.4 17947.9 17957.9 17971.9 986.7 996.5 996.8 997.2 997.6 679.3 690.7 1009.4 1010.3 1014.0 1019.9 1042.5 1044.8 1045.5 1050.3 1031.2 1035.0 1035.7 1035.9 1046.5 731.0 773.3 775.0 776.2 781.0 14487.8 16212.9 16785.7 16972.4 17536.6 16925.9 16925.9 17106.3 17313.7 17572.0 14008.4 14187.1 14194.6 14375.0 14386.9 3403.4 3427.1 3430.3 3435.7 3438.2 105987.0 125685.0 127750.4 128308.0 129338.0 11937.1 12107.0 12329.8 12364.3 12464.2 21355.8 21383.9 21416.8 24693.4 24872.0 6112.0 6231.4 6268.8 7607.8 7721.8 3867.6 3932.2 3933.1 3941.2 3943.4 3463.9 3874.6 4093.6 4170.1 4183.2 867.5 898.0 898.6 900.3 902.3 641.5 644.6 650.5 654.5 682.2 10981.5 11214.3 11902.4 12049.3 12232.0 641.6 648.6 650.6 656.9 675.2 5268.4 5479.0 5487.5 5555.4 5598.3 98106.5 100460.5 105527.0 106444.5 107346.0 84044.0 85787.0 87913.1 94204.0 97555.0 78189.0 80721.6 81376.0 81570.6 83476.0 11700.2 12393.6 12405.3 12473.9 12523.4 39638.6 40151.0 40349.0 40670.8 41204.4 51197.0 51248.2 51551.5 51687.0 51883.2 11714.7 13740.5 16003.4 16299.8 16513.8 14771.2 17764.3 17986.6 18177.9 18468.5 16435.5 16516.1 16586.3 16767.2 16960.8 16269.7 16541.9 16625.9 16654.6 16717.2 15707.5 15956.5 16412.5 16541.6 16611.2 9487.0 11466.9 11701.7 11806.8 11827.9 10302.8 11303.0 11801.7 11823.5 11952.9 11:09:10 INFO - PID 1645 | -------- Summary: end -------- 11:09:10 INFO - PID 1645 | 11:09:11 INFO - TEST-INFO | 1645: exit 0 11:09:11 INFO - TEST-OK | dromaeo_css | took 1116667ms 11:09:11 INFO - TEST-START | kraken 11:09:11 INFO - operating with platform_type : mac_ 11:09:11 INFO - Initialising browser for kraken test... 11:09:11 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpf2NHYW/profile http://localhost:49250/getInfo.html) 11:09:13 INFO - PID 1654 | __metrics Screen width/height:1600/1200 11:09:13 INFO - PID 1654 | colorDepth:24 11:09:13 INFO - PID 1654 | Browser inner width/height: 1024/691 11:09:13 INFO - PID 1654 | __metrics 11:09:13 INFO - PID 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:09:13 INFO - PID 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:09:14 INFO - TEST-INFO | 1654: exit 0 11:09:14 INFO - Browser initialized. 11:09:14 INFO - Running cycle 1/1 for kraken test... 11:09:14 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpf2NHYW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:26 INFO - PID 1655 | RSS: Main: 235614208 11:09:26 INFO - PID 1655 | 11:09:29 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 11:09:30 INFO - PID 1655 | RSS: Main: 303710208 11:09:30 INFO - PID 1655 | 11:09:32 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 11:09:33 INFO - PID 1655 | RSS: Main: 288022528 11:09:33 INFO - PID 1655 | 11:09:36 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 11:09:37 INFO - PID 1655 | RSS: Main: 377372672 11:09:37 INFO - PID 1655 | 11:09:39 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 11:09:39 INFO - PID 1655 | RSS: Main: 280735744 11:09:39 INFO - PID 1655 | 11:09:41 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:09:42 INFO - PID 1655 | RSS: Main: 283226112 11:09:42 INFO - PID 1655 | 11:09:44 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 11:09:45 INFO - PID 1655 | RSS: Main: 345280512 11:09:45 INFO - PID 1655 | 11:09:48 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 11:09:49 INFO - PID 1655 | RSS: Main: 364191744 11:09:49 INFO - PID 1655 | 11:09:51 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 11:09:52 INFO - PID 1655 | RSS: Main: 371048448 11:09:52 INFO - PID 1655 | 11:09:53 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:09:54 INFO - PID 1655 | RSS: Main: 320241664 11:09:54 INFO - PID 1655 | 11:09:56 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:09:57 INFO - PID 1655 | RSS: Main: 322961408 11:09:57 INFO - PID 1655 | 11:09:59 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:09:59 INFO - PID 1655 | RSS: Main: 324743168 11:09:59 INFO - PID 1655 | 11:10:02 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:10:03 INFO - PID 1655 | RSS: Main: 347185152 11:10:03 INFO - PID 1655 | 11:10:06 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:10:06 INFO - PID 1655 | RSS: Main: 340324352 11:10:06 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 11:10:08 INFO - PID 1655 | RSS: Main: 383270912 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | __start_tp_report 11:10:08 INFO - PID 1655 | _x_x_mozilla_page_load 11:10:08 INFO - PID 1655 | _x_x_mozilla_page_load_details 11:10:08 INFO - PID 1655 | |i|pagename|runs| 11:10:08 INFO - PID 1655 | |0;ai-astar;111;111;111;111;112;112;111;111;111;111 11:10:08 INFO - PID 1655 | |1;audio-beat-detection;138;108;108;148;108;105;111;133;129;107 11:10:08 INFO - PID 1655 | |2;audio-dft;183;185;182;184;184;184;184;183;187;183 11:10:08 INFO - PID 1655 | |3;audio-fft;84;58;56;87;61;57;59;57;79;56 11:10:08 INFO - PID 1655 | |4;audio-oscillator;85;68;84;70;70;68;89;67;68;91 11:10:08 INFO - PID 1655 | |5;imaging-gaussian-blur;92;88;88;89;89;87;88;88;89;88 11:10:08 INFO - PID 1655 | |6;imaging-darkroom;95;96;96;95;96;96;96;96;96;96 11:10:08 INFO - PID 1655 | |7;imaging-desaturate;86;86;85;86;85;84;83;84;86;85 11:10:08 INFO - PID 1655 | |8;json-parse-financial;50;48;49;46;47;48;48;48;47;48 11:10:08 INFO - PID 1655 | |9;json-stringify-tinderbox;53;53;61;55;64;58;54;62;74;81 11:10:08 INFO - PID 1655 | |10;stanford-crypto-aes;83;82;83;82;82;81;83;81;80;81 11:10:08 INFO - PID 1655 | |11;stanford-crypto-ccm;140;135;135;140;156;150;134;135;173;151 11:10:08 INFO - PID 1655 | |12;stanford-crypto-pbkdf2;180;192;173;171;180;184;192;180;184;183 11:10:08 INFO - PID 1655 | |13;stanford-crypto-sha256-iterative;68;67;66;67;67;68;65;67;65;66 11:10:08 INFO - PID 1655 | __end_tp_report 11:10:08 INFO - PID 1655 | __start_cc_report 11:10:08 INFO - PID 1655 | _x_x_mozilla_cycle_collect,2116 11:10:08 INFO - PID 1655 | __end_cc_report 11:10:08 INFO - PID 1655 | __startTimestamp1494526208917__endTimestamp 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | ------- Summary: start ------- 11:10:08 INFO - PID 1655 | Number of tests: 14 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:10:08 INFO - PID 1655 | Values: 111.0 111.0 111.0 111.0 112.0 112.0 111.0 111.0 111.0 111.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:120.00 stddev:15.86 (13.2%) stddev-sans-first:15.34 11:10:08 INFO - PID 1655 | Values: 138.0 108.0 108.0 148.0 108.0 105.0 111.0 133.0 129.0 107.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.37 (0.7%) stddev-sans-first:1.41 11:10:08 INFO - PID 1655 | Values: 183.0 185.0 182.0 184.0 184.0 184.0 184.0 183.0 187.0 183.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#3] audio-fft Cycles:10 Average:65.40 Median:60.00 stddev:12.61 (21.0%) stddev-sans-first:11.43 11:10:08 INFO - PID 1655 | Values: 84.0 58.0 56.0 87.0 61.0 57.0 59.0 57.0 79.0 56.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:77.00 stddev:9.91 (12.9%) stddev-sans-first:9.96 11:10:08 INFO - PID 1655 | Values: 85.0 68.0 84.0 70.0 70.0 68.0 89.0 67.0 68.0 91.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:88.50 stddev:1.35 (1.5%) stddev-sans-first:0.67 11:10:08 INFO - PID 1655 | Values: 92.0 88.0 88.0 89.0 89.0 87.0 88.0 88.0 89.0 88.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:10:08 INFO - PID 1655 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.50 stddev:1.05 (1.2%) stddev-sans-first:1.05 11:10:08 INFO - PID 1655 | Values: 86.0 86.0 85.0 86.0 85.0 84.0 83.0 84.0 86.0 85.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#8] json-parse-financial Cycles:10 Average:47.90 Median:48.00 stddev:1.10 (2.3%) stddev-sans-first:0.87 11:10:08 INFO - PID 1655 | Values: 50.0 48.0 49.0 46.0 47.0 48.0 48.0 48.0 47.0 48.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:9.42 (15.3%) stddev-sans-first:9.48 11:10:08 INFO - PID 1655 | Values: 53.0 53.0 61.0 55.0 64.0 58.0 54.0 62.0 74.0 81.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.03 (1.3%) stddev-sans-first:1.00 11:10:08 INFO - PID 1655 | Values: 83.0 82.0 83.0 82.0 82.0 81.0 83.0 81.0 80.0 81.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:145.00 stddev:12.64 (8.7%) stddev-sans-first:13.28 11:10:08 INFO - PID 1655 | Values: 140.0 135.0 135.0 140.0 156.0 150.0 134.0 135.0 173.0 151.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:183.50 stddev:6.85 (3.7%) stddev-sans-first:7.24 11:10:08 INFO - PID 1655 | Values: 180.0 192.0 173.0 171.0 180.0 184.0 192.0 180.0 184.0 183.0 11:10:08 INFO - PID 1655 | 11:10:08 INFO - PID 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.01 11:10:08 INFO - PID 1655 | Values: 68.0 67.0 66.0 67.0 67.0 68.0 65.0 67.0 65.0 66.0 11:10:08 INFO - PID 1655 | -------- Summary: end -------- 11:10:08 INFO - PID 1655 | 11:10:09 INFO - TEST-INFO | 1655: exit 0 11:10:09 INFO - TEST-OK | kraken | took 58224ms 11:10:09 INFO - SUITE-END | took 1174s 11:10:10 INFO - Completed test suite (00:19:35) 11:10:10 INFO - javascript benchmark 11:10:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7726.837323587282, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2944.2786517303252, 3475.496053072303, 3543.8936831895044, 3550.3609350316947, 3590.2460483298505, 5628.746706398211, 6137.101203255286, 6207.193064901562, 6227.190465239518, 6227.470664993475, 6162.969185154079, 6209.782657606974, 6239.407256310655, 6241.781537646183, 6248.37516248375, 4935.185694360426, 5211.504907033845, 5329.2006199070065, 5406.053940560406, 5447.210154527611, 5409.783608655649, 5421.1326187809955, 5460.699661518614, 5494.532964698005, 5521.889562208753, 5321.920171197455, 5384.3538775346815, 5411.0, 5433.1035379162395, 5490.231367608538, 5461.344638643349, 5468.863278418032, 5480.150576660624, 5493.560515158818, 5504.22940788286, 5399.7030163341, 5426.158945363475, 5435.076037073707, 5477.1510415885605, 5491.2312276281355, 6253.906191407133, 6264.498840092827, 6266.968665156645, 6267.71795269214, 6277.278113017016, 6379.87240255197, 6427.357264273582, 6435.871282574369, 6613.173353330833, 6614.570052946543, 6047.485963693091, 6635.3032931541975, 6651.102101216322, 6721.0, 6728.798136055926, 6215.316315205324, 6284.622922624657, 6294.339094395068, 6296.874062518724, 6303.590266632654, 6555.475561955032, 6729.966350168218, 6747.359000894907, 6762.72949082041, 6764.458843292623, 6440.903386449207, 6482.12491313676, 6492.188476440445, 6507.577007494498, 6514.1531600891585, 6620.238672552622, 6629.502787290972, 6631.10480085192, 6646.401823835878, 6664.466842652576, 6395.968020159869, 6520.706568204442, 6533.41199292066, 6573.408393244536, 6577.408033277028, 6452.483801295885, 6510.18622672166, 6599.0, 6604.306547812411, 6606.867862642816, 5287.814926477555, 5290.074237008508, 5291.973540132351, 5301.0, 5313.0436521425745, 4712.986707857827, 4721.0, 4743.335932969387, 4762.3570817939135, 4764.356811830427, 6104.76233045773, 6109.374301065143, 6245.937540624535, 6259.624422534663, 6303.243610766737, 6650.168728908887, 6654.534182607268, 6688.29772873851, 6700.262971073178, 6705.362990515893, 5131.5638170755155, 6255.311915689271, 6269.7178626961895, 6275.529335299871, 6282.246130464374, 5690.658560486384, 5758.539316854642, 5759.222504961776, 5809.593328467051, 5824.592278540546, 6668.566543174678, 6694.497912656473, 6698.095757072733, 6699.698513566804, 6700.83247918806, 6537.673116344069, 6547.672616369257, 6556.409923106943, 6606.108175396452, 6685.53201275906, 5354.946450535601, 6796.830079248059, 6814.046033555207, 6827.726890924506, 6832.385085342343, 6532.510061745483, 6553.770618028346, 6558.573692709959, 6562.146920900253, 6564.343565643398, 6453.386928241997, 6527.379898909596, 6626.0, 6665.500087493554, 6678.833029174115, 5285.0, 6361.045843123384, 6376.808695739135, 6444.258910225384, 6453.128827608213, 6424.935750642434, 6429.7749578764515, 6433.228012638326, 6440.25937017249, 6446.323136070645, 6240.375962403905, 6273.153124328157, 6342.52431067681, 6353.809385718436, 6362.936370636235, 6374.07575901501, 6374.776882809079, 6383.840403989938, 6404.743810247538, 6439.098526206241, 6303.149074874833, 6307.432331090224, 6308.148399965946, 6310.0, 6315.5894866833505], "value": 6031.840717368538, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.4376970466117, 793.3375631347824, 1081.7890511350286, 1112.5160555158511, 1112.5716599109346, 34619.65380346196, 35178.0, 35210.0, 35230.64769352306, 35240.471392929096, 37070.0, 37356.813215933886, 37388.0, 37411.25177496448, 37454.0, 4609.239475486541, 4742.454617718955, 7993.080795708495, 8101.068377136646, 8117.228863257981, 5824.679642619654, 5911.408859114075, 5918.940810591904, 7378.040854688909, 8291.005079390481, 8323.66705331789, 8361.289290410323, 8370.790730231762, 8372.706955256568, 8423.705170319041, 8266.917330826705, 8306.460080094836, 8333.0, 8334.70828521002, 8379.162083791633, 5768.567357448208, 5844.941550584483, 7993.480423772437, 8141.307988820898, 8189.426740128193, 35402.5838966441, 35674.0, 35690.821545892104, 35713.82143089294, 35848.10379740501, 3495.790252584853, 3543.255916257589, 3546.3616549021167, 3547.6629720176543, 3547.840347184383, 29192.0, 29256.561151582744, 29291.70708292911, 29357.559636605467, 29388.70611293881, 3043.5434684797237, 3101.6122984626923, 3127.46833038384, 3132.9661211800053, 3133.310671652233, 289374.0, 289389.0, 290255.0, 290441.0, 290877.0, 38665.680059195976, 38685.0, 38801.223975520894, 48175.0, 48489.0, 48239.0, 48550.75724621354, 48556.62990330887, 48611.27083093757, 48876.7556162224, 13238.470461181638, 13373.331333433289, 13386.531471398454, 13390.656635089015, 13441.663958401119, 11001.339919604849, 11006.944965275123, 11009.119270458345, 11022.063124634336, 11033.448327583588, 12371.13402061865, 12384.876151238372, 12413.255204687748, 12429.192102513307, 12534.81197782034, 5215.843524694265, 5218.712970786567, 5221.190715439113, 5233.1365324721755, 5246.317978662826, 868.2533021601417, 971.4511301114848, 978.7553111722069, 1009.8994092288024, 1023.3246057601947, 24072.87963560171, 24096.759032409802, 24115.276541703777, 24123.75876241215, 24210.273691789276, 1017.2675673515205, 1071.4374953149502, 1079.7084787107437, 1115.6039605939936, 1116.4919961417536, 10945.0, 11580.47887845049, 12310.75378492425, 12344.506219751289, 12375.62873113808, 312945.0, 314317.0, 314926.0, 315617.42191288894, 315642.0, 50986.0, 51046.234306485436, 51156.0, 51201.74399127981, 51305.7434712824, 1444.8627380398846, 1481.7184734900334, 1523.2992823301183, 1523.7638166084053, 1527.755559110537, 23625.29124126279, 23664.290071297888, 23679.763202368445, 23700.0, 23975.28074157778, 30608.0, 37355.81322093372, 37355.879323620335, 37478.43782343213, 37537.0, 231278.8436057809, 278274.0, 279210.0, 279431.0, 280423.0, 23328.883355583115, 29581.40837183201, 33124.834375827966, 33163.83926562559, 33551.83224083864, 40707.389389159776, 42179.789101054295, 42204.57795422129, 42268.788656056524, 42279.812431886035, 27877.909156812915, 28709.674194483367, 29219.831206751493, 29603.407931841673, 30134.19805437765, 28911.42177156487, 29126.7087329124, 29381.38402387889, 29653.962111326, 29783.55324670175, 35304.64695353014, 35479.64520354763, 35481.64518354784, 35536.0, 35607.0, 27950.02174923868, 28070.0, 29480.55779163357, 29923.95266165674, 30023.394853132275, 21534.67697984563, 23382.53234935326, 23417.882910585337, 23465.88267058654, 23515.52968940646], "value": 16594.792216969738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.5267037566047, 424.46767170514437, 439.57361359481314, 440.7179405180684, 443.4766974969535, 18092.185851636674, 19775.802241977577, 20277.69583456249, 20518.794812051874, 20545.897270513644, 20738.859362735042, 20976.790232097712, 21145.048472818722, 21180.8940955295, 21241.044153013114, 5921.289445266574, 6088.573799834014, 6170.876582468348, 6191.907121393183, 6199.44205021548, 6019.21750172477, 6072.0, 6078.361772013919, 6090.847728806793, 6195.008798592204, 6115.571909966282, 6147.323794382614, 6147.446729794317, 6152.446279834814, 6162.075688646694, 5842.678652674102, 6060.818175454766, 6115.205023346981, 6126.969365153146, 6131.601445906046, 5357.116075847481, 5430.8099216527235, 5433.538149257279, 5437.700926449043, 5438.428964958662, 26928.326791830164, 27570.17289481319, 27633.86183069092, 27791.74937127814, 28050.158495245174, 2161.232762369352, 2217.3569664797187, 2252.6057939860457, 2255.7067581214337, 2256.6163752162006, 17145.571360716083, 17504.299828006864, 17558.03430811305, 18016.36942707012, 18273.725894111598, 2117.851750377474, 2203.768604296558, 2302.82728795341, 2348.612478940973, 2353.5645905507536, 145760.0, 145867.0, 152879.0, 160801.19599402044, 162585.0, 21059.894700526398, 21298.467538311666, 21770.78229217719, 22994.010778598677, 23918.64122038171, 42099.57900420957, 42202.36696449556, 42463.57536424658, 42500.57499425028, 42626.360604590955, 8799.736007919773, 8812.8678069829, 8940.240079593177, 9097.954510227539, 9135.269178465707, 8518.190771876662, 8520.275776558938, 8530.061693213742, 8709.042005379402, 8723.214910658071, 7773.222677732295, 7898.881516777253, 7940.729483282647, 7942.126366099725, 7943.960280198562, 1723.4398820383426, 1795.5421367551191, 1908.8165337490566, 2044.7750747417772, 2280.5210905709987, 921.7142685767434, 954.2461455450117, 956.8277710012126, 988.8417853143462, 994.9054839790208, 19775.901120494305, 20630.381088567367, 20678.896605517177, 20767.0, 21000.579988400146, 870.9738707838775, 915.7865827778221, 999.6101520407047, 999.6900960702205, 1008.4503945349802, 10421.322614030063, 10632.78734425307, 10742.73143171427, 10753.247272690993, 10831.025207731342, 540176.0, 544202.0, 575292.3706144411, 576433.0225062775, 586853.0, 130233.0, 136356.31821840827, 138957.3052134753, 140311.29844350714, 142870.0, 1192.2548407245472, 1203.9879601204052, 1241.3979220078254, 1242.2298175131295, 1252.4990003998473, 20771.376858694264, 20938.685919711523, 21036.47408814792, 21238.89380553087, 21288.467788304795, 53725.462745372046, 55362.0, 56177.71911140418, 56863.431365685814, 57137.71431142984, 72403.63798180975, 72448.0, 73468.89796652948, 74977.25022749921, 76792.2320776785, 8459.196376344238, 8615.22462978335, 8687.39188256816, 8739.431936924333, 8898.976617689048, 13141.474341026253, 13539.98450116265, 13608.863911361155, 13960.650983725489, 14274.357653905807, 11044.33733975964, 11261.831072533754, 11759.88240117622, 11917.0, 12105.939470302592, 10955.452227388758, 11001.834972475579, 11122.99893009633, 11252.381119038531, 11324.0, 11770.88229117732, 11783.821617838148, 12099.697507562381, 12143.392830358624, 12203.511859525519, 8704.56477176126, 8732.738017859474, 8734.301255899385, 8835.160659737314, 8838.823223535623, 10673.733156671145, 10974.945125274322, 11477.713057173638, 11927.60063381932, 12086.033117350767], "value": 10834.526957549262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1195.497890885828, 1421.331973972233, 1458.0741229319378, 1478.3199728125062, 1482.5330021043371, 9541.570629321679, 10031.297809153362, 10031.949840250807, 10040.347377420463, 10044.196464282859, 10611.522481488333, 11323.905077560636, 11375.772484550303, 11401.771964560703, 11424.657260282183, 2464.716557595877, 2528.51958127956, 2529.734377890323, 2529.9747002529925, 2534.3664083979006, 2093.3719884034804, 2360.5868972929757, 2520.848749075052, 2521.042004038472, 2528.6459895614535, 1998.6502362086649, 2138.893055347234, 2155.7844215578475, 2480.7643273888953, 2486.5026994601153, 1798.9910050449664, 2260.8130731366, 2486.639437281602, 2494.5135698538793, 2494.8128890333296, 2072.4197224777085, 2433.3673244956262, 2475.3811547113223, 2475.7276699563035, 2477.19491165372, 9700.27247956399, 9825.656102036395, 9830.705078847646, 9830.90169098307, 9854.65508707199, 6422.646754428504, 6642.767503137416, 6650.301718319555, 6659.63372014539, 6659.6670166491485, 3942.1130245694776, 4191.161767646483, 4254.489461264637, 4301.397804307399, 4304.3113101903855, 1207.7765613361555, 1212.2241765270235, 1243.6704273367566, 1259.162656833205, 1260.1116213069763, 15711.978721383188, 16007.679846403124, 16036.118013509253, 16039.438619648374, 16061.875668703195, 4764.475907650156, 5800.796972105956, 5843.503302219359, 5951.791687290924, 5953.940460595425, 10596.523156457977, 12819.871801282054, 12845.743085138245, 12869.163504372185, 12881.162724422882, 6582.769603063965, 6586.901196482057, 6593.076969224312, 6606.900896486556, 6696.029075784081, 6020.548458865603, 6156.476699480505, 6166.845828854314, 6174.0, 6222.097795819581, 4419.071994881111, 4551.5676010778925, 4579.084183163381, 4628.814847406066, 4629.930551041737, 1415.688548519324, 1463.3926920327945, 1483.9851601484063, 1485.225155938643, 1489.7467430536835, 766.5783818899583, 768.1742127213156, 790.4032455496178, 792.9603519824101, 795.4113955672876, 6448.300953937818, 6604.075429439882, 6789.558678685869, 6815.625140617214, 6888.276730943279, 793.5000949401955, 833.4082801211086, 893.6738090597015, 898.7169041751828, 930.6277489004452, 3514.68367846895, 3701.6783328030738, 3736.402175651937, 4030.1939612077704, 4123.257813593582, 14185.716285674229, 14581.927090364481, 14678.779818302733, 14682.779758303634, 14715.190664513555, 13965.441382344796, 14239.430422782973, 14632.829373650082, 14637.341319640642, 14643.780343294859, 8078.9192108080515, 8347.332213422911, 8502.787430314167, 8534.146585341541, 8551.358648101417, 5372.946270537244, 5531.834044978657, 6779.796606101825, 6853.348931851466, 6859.17689877198, 12159.0, 12488.562900298446, 12720.809187862003, 12746.68133296675, 12755.87244127547, 9741.9025809741, 12925.965922726347, 13116.803247951479, 13266.668333291746, 13628.0, 7466.178720340649, 8152.225538573826, 8781.604827782638, 8848.247898928663, 8949.910500894908, 9229.123233292827, 9936.155426788515, 10048.799024019625, 10052.296339256181, 10076.596936122767, 8585.944284188607, 8681.6093275804, 8812.427192232484, 8948.821023579621, 8957.193852553302, 7234.638268086469, 8595.914040859761, 8752.737417877473, 8754.25588824957, 8826.42628229163, 7860.9213907860185, 7917.247861453153, 8004.199580041949, 8008.399370047153, 8009.519428834288, 5880.558958078076, 5970.999715095491, 6011.338752737282, 6050.485708714808, 6064.181335519648, 5894.263217097863, 5974.761009559569, 6054.727537260922, 6125.9693701531205, 6246.406591373994], "value": 5214.98849859696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.65467715748713, 395.4562476594682, 401.63651895034985, 405.468835825069, 407.47639283520664, 5976.282846058473, 6002.789902353418, 6011.819645410639, 6057.273127224728, 6102.87794244116, 4517.774111294439, 5274.468255237488, 5394.298741163653, 5925.851853703649, 5927.792527261547, 3906.453096566469, 3915.0, 4512.413386259782, 4533.410656614636, 4535.954640453586, 3711.0, 4163.167366526707, 4186.853460128896, 4545.636269140045, 4555.567221114005, 4360.302351623741, 4472.709273897202, 4506.97746511267, 4527.230370836965, 4550.203714349992, 4497.650704788551, 4498.122866041123, 4501.684882058257, 4506.188886000518, 4535.977320113411, 3990.082281075369, 4018.598140185958, 4026.2752704513177, 4037.555868854424, 4039.2527382434346, 4999.500049995007, 5466.371367292772, 5756.597038207286, 5766.250387449647, 5851.941480585182, 4361.105973275471, 4511.571400716926, 4646.372739680134, 4862.217206996221, 5030.924536131961, 5831.0, 6053.4551890330085, 6321.968390158066, 6361.586496877688, 6369.20384951881, 4034.798260086984, 4204.474440694913, 4241.215375155575, 4264.635316698657, 4292.785360731951, 5729.942700573024, 6375.521835862282, 6552.279249282575, 6673.432758215557, 6756.155480564929, 4205.990562265034, 4252.702310838212, 4284.078923031563, 4293.570642935744, 4304.375865499485, 4103.794810259535, 4219.746815191037, 4286.035641980529, 4358.4769827620885, 4363.0, 4449.9777501112285, 5097.974510127426, 5127.923081153711, 5130.33305670268, 5138.58891288696, 6413.262474815456, 6425.614463132227, 6436.3241859605005, 6443.194600674916, 6470.935290647128, 1347.8719521645428, 1360.2042804959012, 1398.4895513137835, 1478.911265324084, 1485.094092603511, 806.7055524733547, 959.4051687953513, 977.3793641037992, 983.7245571240064, 986.5363279258737, 5287.0, 5815.156802263733, 6008.879822403527, 6008.905413711942, 6017.157597936292, 6071.939280607226, 6624.536282460278, 6645.202575690948, 6656.8668626627195, 6676.899846502306, 5918.674472904032, 5930.614510056833, 5935.347111817697, 6040.818775436744, 6084.969575152096, 3382.458806590934, 3448.5689288838894, 3449.8615456899165, 3451.516787649731, 3464.185916309665, 6018.879622407528, 6410.743570257137, 6453.999630057348, 6789.592624442549, 6819.659017049128, 6643.335666433318, 6715.824730672113, 6812.591244525344, 6826.146731658543, 6850.143732033496, 5637.661740295595, 6646.567973081735, 6750.561213521106, 6860.3825655690225, 6868.62222577753, 6552.475801935929, 6643.7674681385915, 6648.0, 6651.43462805667, 6664.866702665822, 5500.862478438071, 6045.798170271795, 6201.596896201732, 6341.207349081365, 6531.869362612816, 6722.899156512558, 6792.524523283323, 6800.795976120724, 6814.182298124257, 6814.829629259309, 3945.861894833667, 4270.295401258758, 4328.675349348874, 4426.75652839097, 4830.347903033045, 5849.736761845642, 6586.946088625797, 6643.435307998874, 6651.434628056476, 6656.7004484797335, 5205.505476979681, 5372.62391632582, 6383.904241436475, 6394.680265986775, 6468.514861385321, 5203.427622961547, 5871.1486834407915, 6142.0, 6415.454686351713, 6431.324710905475, 5738.110592858114, 5739.569532285179, 5766.855828604318, 6224.751009959551, 6313.96843015782, 5832.416758324133, 6230.6884655766125, 6277.654728989949, 6358.459530939737, 6404.583702059351, 5208.322918020633, 5459.535939445032, 6240.843978900382, 6248.312685604671, 6249.281332646622], "value": 4628.279213584977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.6058552480332, 854.9145085491451, 865.7965378136137, 868.3617541107285, 884.8893888263965, 14483.203423811712, 15087.09477431355, 16526.008439493624, 16584.58538536537, 16915.15424228788, 12068.51725930964, 16045.438409655664, 17947.9231246125, 17957.91021044893, 17971.910140449312, 986.6842610364686, 996.4718699089494, 996.8405055191171, 997.1723469520317, 997.6358629100399, 679.3104998426601, 690.7444245629124, 1009.4094954451655, 1010.2524132142198, 1014.0164040880335, 1019.8572199891984, 1042.5464922758586, 1044.759705267785, 1045.5451878432907, 1050.2858056521563, 1031.1905154453718, 1034.9586016559367, 1035.6996471023394, 1035.9171266298715, 1046.4715318764013, 731.0277331149558, 773.2769860180749, 775.0, 776.20051347112, 780.9886197374357, 14487.78268325976, 16212.918935405247, 16785.748213776802, 16972.40596579114, 17536.64926701459, 16925.915370423194, 16925.915370423194, 17106.31574737009, 17313.65372692539, 17572.033538155396, 14008.439662413492, 14187.14877107377, 14194.574162775134, 14375.0, 14386.928065359607, 3403.3873902697505, 3427.0746898337557, 3430.3310854383403, 3435.707964822993, 3438.2263990602164, 105987.0, 125685.0, 127750.36124819316, 128308.0, 129337.99999999905, 11937.104717146249, 12107.03143748498, 12329.815052774216, 12364.319962402154, 12464.189827661354, 21355.78644213569, 21383.89308053481, 21416.78583214148, 24693.38266543315, 24872.005119795005, 6111.96944015277, 6231.376862313732, 6268.811935641938, 7607.771766847003, 7721.7683469496005, 3867.555231148454, 3932.193900250442, 3933.0757272041046, 3941.2117576484816, 3943.38877473992, 3463.8787642432394, 3874.612538746103, 4093.5906409359422, 4170.061736109351, 4183.247015537232, 867.466508097528, 898.0077014898574, 898.5821592959305, 900.2887718702283, 902.3142411767104, 641.4540956295306, 644.5842431631665, 650.5446187668651, 654.5123882707413, 682.2461180395592, 10981.450927453756, 11214.32714037144, 11902.404879755977, 12049.277043377426, 12231.960283376013, 641.5541198866742, 648.5816648261939, 650.6421468192475, 656.9047488114197, 675.1864003875319, 5268.367795864444, 5478.972605136949, 5487.478689524569, 5555.388907220203, 5598.3282006159525, 98106.50946745364, 100460.4976975125, 105527.0, 106444.46777766217, 107346.0, 84044.0, 85787.0, 87913.12086879049, 94204.0, 97555.0, 78189.0, 80721.59639201884, 81376.0, 81570.59214703889, 83476.0, 11700.239484433485, 12393.566225182436, 12405.317707526172, 12473.87526124727, 12523.4364453598, 39638.603613964646, 40151.0, 40349.0, 40670.79664601658, 41204.38193427161, 51197.0, 51248.23127653014, 51551.484485154666, 51686.966260675326, 51883.22175167451, 11714.70713232176, 13740.519081832488, 16003.439879604159, 16299.837001629832, 16513.752293715363, 14771.187584682515, 17764.28942842272, 17986.5503362417, 18177.909110454362, 18468.538286542946, 16435.506934791974, 16516.091614961293, 16586.25361858695, 16767.24547395346, 16960.830391695927, 16269.67460650804, 16541.917290413472, 16625.91687041557, 16654.583635409213, 16717.164141793106, 15707.450239241572, 15956.521304360887, 16412.507624771275, 16541.586460338105, 16611.169441527632, 9486.95256523713, 11466.885331146581, 11701.707457313636, 11806.82289765637, 11827.935485806318, 10302.845457317997, 11303.028185185594, 11801.704957376134, 11823.46794394237, 11952.940235298767], "value": 8129.700094231797, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1410.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 111.0, 112.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 108.0, 108.0, 148.0, 108.0, 105.0, 111.0, 133.0, 129.0, 107.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 182.0, 184.0, 184.0, 184.0, 184.0, 183.0, 187.0, 183.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 56.0, 87.0, 61.0, 57.0, 59.0, 57.0, 79.0, 56.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 68.0, 84.0, 70.0, 70.0, 68.0, 89.0, 67.0, 68.0, 91.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 88.0, 89.0, 89.0, 87.0, 88.0, 88.0, 89.0, 88.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 86.0, 85.0, 84.0, 83.0, 84.0, 86.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 49.0, 46.0, 47.0, 48.0, 48.0, 48.0, 47.0, 48.0], "value": 47.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 61.0, 55.0, 64.0, 58.0, 54.0, 62.0, 74.0, 81.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 82.0, 82.0, 81.0, 83.0, 81.0, 80.0, 81.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 135.0, 140.0, 156.0, 150.0, 134.0, 135.0, 173.0, 151.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 192.0, 173.0, 171.0, 180.0, 184.0, 192.0, 180.0, 184.0, 183.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 67.0, 67.0, 68.0, 65.0, 67.0, 65.0, 66.0], "value": 66.6, "unit": "score"}]}]} 11:10:10 INFO - Return code: 0 11:10:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:10:10 INFO - # TBPL SUCCESS # 11:10:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:10:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:10:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:10:10 INFO - 2017-05-11 11:10:10.228 screenresolution[1660:11730] starting screenresolution argv=screenresolution get 11:10:10 INFO - 2017-05-11 11:10:10.230 screenresolution[1660:11730] Display 0: 1600x1200x32@60 11:10:10 INFO - 2017-05-11 11:10:10.237 screenresolution[1661:11733] starting screenresolution argv=screenresolution list 11:10:10 INFO - Available Modes on Display 0 11:10:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:10:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:10:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:10:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:10:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:10:10 INFO - Intel Iris: 11:10:10 INFO - Chipset Model: Intel Iris 11:10:10 INFO - Type: GPU 11:10:10 INFO - Bus: Built-In 11:10:10 INFO - VRAM (Dynamic, Max): 1536 MB 11:10:10 INFO - Vendor: Intel (0x8086) 11:10:10 INFO - Device ID: 0x0a2e 11:10:10 INFO - Revision ID: 0x0009 11:10:10 INFO - Displays: 11:10:10 INFO - Display: 11:10:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:10:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:10:10 INFO - Display Serial Number: 1600x1200 60 11:10:10 INFO - Main Display: Yes 11:10:10 INFO - Mirror: Off 11:10:10 INFO - Online: Yes 11:10:10 INFO - Rotation: Supported 11:10:10 INFO - Return code: 0 11:10:10 INFO - Running post-action listener: _resource_record_post_action 11:10:10 INFO - [mozharness: 2017-05-11 18:10:10.472984Z] Finished run-tests step (success) 11:10:10 INFO - Running post-run listener: _resource_record_post_run 11:10:10 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 33467904; Write bytes: 529433600; Read time: 213; Write time: 1641 11:10:10 INFO - TinderboxPrint: CPU usage
53.3% 11:10:10 INFO - TinderboxPrint: I/O read bytes / time
33,467,904 / 213 11:10:10 INFO - TinderboxPrint: I/O write bytes / time
529,433,600 / 1,641 11:10:10 INFO - TinderboxPrint: CPU idle
2,232.5 (46.6%) 11:10:10 INFO - TinderboxPrint: CPU system
953.7 (19.9%) 11:10:10 INFO - TinderboxPrint: CPU user
1,599.4 (33.4%) 11:10:10 INFO - TinderboxPrint: Swap in / out
242,700,288 / 0 11:10:10 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 214473216; Write bytes: 214220800; Read time: 17057; Write time: 497 11:10:10 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 29474304; Write bytes: 313603072; Read time: 189; Write time: 1138 11:10:10 INFO - Running post-run listener: _upload_blobber_files 11:10:10 INFO - Blob upload gear active. 11:10:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:10:10 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 11:10:10 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'] 11:10:10 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 11:10:11 INFO - (blobuploader) - INFO - Open directory for files ... 11:10:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:10:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:10:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:12 INFO - (blobuploader) - INFO - Done attempting. 11:10:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:10:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:10:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:13 INFO - (blobuploader) - INFO - Done attempting. 11:10:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:10:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:10:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:14 INFO - (blobuploader) - INFO - Done attempting. 11:10:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:10:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:10:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:16 INFO - (blobuploader) - INFO - Done attempting. 11:10:16 INFO - (blobuploader) - INFO - Iteration through files over. 11:10:16 INFO - Return code: 0 11:10:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:10:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:10:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1b42171683ffd53ae69b79a9b8c5dd9ad6a979e999594d3ca41768a54dfecc3b9c79eac4f9caeabbae23ff9fd11c2f01131b7d29d353e8ada7d171f58e5e67b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06cd867772fd9567ee9bc97fb2376a195842a381b8019a1da69d10759152097a043e70c34fecf35a80a17062e8d5ce10514738e95ff218b46418018be6157b2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32d9af61b3ce4f7e2b23b7830146dc2205f5bc7c418c160f63386703f5a22e0bab6b3f17ac37eca0a0434277647192f6393cdfc32026d3913553b129848da131", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/418f8bb43f24f08b9c23cec14031e954ff2585f784ab5159a0250aced86d8c2f64eb6afe3a2d3624845165c4d336ff2f746f10616a5a508485e1905e2b683193"} 11:10:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:10:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:10:16 INFO - Contents: 11:10:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1b42171683ffd53ae69b79a9b8c5dd9ad6a979e999594d3ca41768a54dfecc3b9c79eac4f9caeabbae23ff9fd11c2f01131b7d29d353e8ada7d171f58e5e67b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06cd867772fd9567ee9bc97fb2376a195842a381b8019a1da69d10759152097a043e70c34fecf35a80a17062e8d5ce10514738e95ff218b46418018be6157b2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32d9af61b3ce4f7e2b23b7830146dc2205f5bc7c418c160f63386703f5a22e0bab6b3f17ac37eca0a0434277647192f6393cdfc32026d3913553b129848da131", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/418f8bb43f24f08b9c23cec14031e954ff2585f784ab5159a0250aced86d8c2f64eb6afe3a2d3624845165c4d336ff2f746f10616a5a508485e1905e2b683193"} 11:10:16 INFO - Running post-run listener: copy_logs_to_upload_dir 11:10:16 INFO - Copying logs to upload dir... 11:10:16 INFO - mkdir: /builds/slave/test/build/upload/logs 11:10:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2482.420075 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 22 secs) (at 2017-05-11 11:10:16.915596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 11:10:16.919600) ========= 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.kjgiyPrDQg/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.scCSC0q2k9/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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/e1b42171683ffd53ae69b79a9b8c5dd9ad6a979e999594d3ca41768a54dfecc3b9c79eac4f9caeabbae23ff9fd11c2f01131b7d29d353e8ada7d171f58e5e67b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06cd867772fd9567ee9bc97fb2376a195842a381b8019a1da69d10759152097a043e70c34fecf35a80a17062e8d5ce10514738e95ff218b46418018be6157b2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32d9af61b3ce4f7e2b23b7830146dc2205f5bc7c418c160f63386703f5a22e0bab6b3f17ac37eca0a0434277647192f6393cdfc32026d3913553b129848da131", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/418f8bb43f24f08b9c23cec14031e954ff2585f784ab5159a0250aced86d8c2f64eb6afe3a2d3624845165c4d336ff2f746f10616a5a508485e1905e2b683193"} build_url:https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010060 build_url: 'https://queue.taskcluster.net/v1/task/AcrmHGpHQDmj8gAyLuoYOg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1b42171683ffd53ae69b79a9b8c5dd9ad6a979e999594d3ca41768a54dfecc3b9c79eac4f9caeabbae23ff9fd11c2f01131b7d29d353e8ada7d171f58e5e67b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06cd867772fd9567ee9bc97fb2376a195842a381b8019a1da69d10759152097a043e70c34fecf35a80a17062e8d5ce10514738e95ff218b46418018be6157b2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32d9af61b3ce4f7e2b23b7830146dc2205f5bc7c418c160f63386703f5a22e0bab6b3f17ac37eca0a0434277647192f6393cdfc32026d3913553b129848da131", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/418f8bb43f24f08b9c23cec14031e954ff2585f784ab5159a0250aced86d8c2f64eb6afe3a2d3624845165c4d336ff2f746f10616a5a508485e1905e2b683193"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 11:10:16.951111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 11:10:16.951639) ========= 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.kjgiyPrDQg/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.scCSC0q2k9/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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.004208 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 11:10:17.001718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 11:10:17.002289) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 11:10:17.002820) ========= ========= Total master_lag: 0.30 =========