builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0364 starttime: 1487768246.58 results: success (0) buildid: 20170222031725 builduid: c922183177f54f509ee48ed29afa7edb revision: c8cefb50d5a80b546777cc712d4de17ca92154f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:26.583447) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:26.583940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:26.584250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:26.609836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:26.610231) ========= 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.9Yty00EBuE/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.tNI2lDozAV/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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-02-22 04:57:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 135M=0s 2017-02-22 04:57:26 (135 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122387 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:26.756841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:26.757171) ========= 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.9Yty00EBuE/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.tNI2lDozAV/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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.021638 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:26.805269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 04:57:26.805640) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c8cefb50d5a80b546777cc712d4de17ca92154f3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c8cefb50d5a80b546777cc712d4de17ca92154f3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9Yty00EBuE/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.tNI2lDozAV/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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-02-22 04:57:26,902 truncating revision to first 12 chars 2017-02-22 04:57:26,902 Setting DEBUG logging. 2017-02-22 04:57:26,902 attempt 1/10 2017-02-22 04:57:26,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c8cefb50d5a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 04:57:27,897 unpacking tar archive at: mozilla-beta-c8cefb50d5a8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.259149 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 04:57:28.090756) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:28.091126) ========= script_repo_revision: c8cefb50d5a80b546777cc712d4de17ca92154f3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:28.091676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:28.091983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 04:57:28.112828) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-22 04:57:28.113310) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9Yty00EBuE/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.tNI2lDozAV/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 04:57:28 INFO - MultiFileLogger online at 20170222 04:57:28 in /builds/slave/test 04:57:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:57:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:57:28 INFO - {'append_to_log': False, 04:57:28 INFO - 'base_work_dir': '/builds/slave/test', 04:57:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:57:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:57:28 INFO - 'branch': 'Mozilla-Beta', 04:57:28 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:28 INFO - 'config_files': ('talos/mac_config.py',), 04:57:28 INFO - 'default_actions': ('clobber', 04:57:28 INFO - 'read-buildbot-config', 04:57:28 INFO - 'download-and-extract', 04:57:28 INFO - 'populate-webroot', 04:57:28 INFO - 'create-virtualenv', 04:57:28 INFO - 'install', 04:57:28 INFO - 'run-tests'), 04:57:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:28 INFO - 'download_minidump_stackwalk': True, 04:57:28 INFO - 'download_symbols': 'ondemand', 04:57:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:28 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:28 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:28 INFO - 'installer_path': 'installer.exe', 04:57:28 INFO - 'log_level': 'info', 04:57:28 INFO - 'log_name': 'talos', 04:57:28 INFO - 'log_to_console': True, 04:57:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:57:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:57:28 INFO - 'opt_config_files': (), 04:57:28 INFO - 'pip_index': False, 04:57:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:28 INFO - 'cmd': ('bash', 04:57:28 INFO - '-c', 04:57:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:28 INFO - 'enabled': True, 04:57:28 INFO - 'halt_on_failure': False, 04:57:28 INFO - 'name': 'check_screen_resolution'},), 04:57:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:28 INFO - 'cmd': ('bash', 04:57:28 INFO - '-c', 04:57:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:28 INFO - 'enabled': True, 04:57:28 INFO - 'halt_on_failure': False, 04:57:28 INFO - 'name': 'check_screen_resolution'},), 04:57:28 INFO - 'run_cmd_checks_enabled': True, 04:57:28 INFO - 'sps_profile': False, 04:57:28 INFO - 'sps_profile_interval': 0, 04:57:28 INFO - 'suite': 'dromaeojs-e10s', 04:57:28 INFO - 'system_bits': '32', 04:57:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:28 INFO - 'title': 't-yosemite-r7-0364', 04:57:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:28 INFO - 'use_talos_json': True, 04:57:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:57:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:28 INFO - 'work_dir': 'build'} 04:57:28 INFO - [mozharness: 2017-02-22 12:57:28.330963Z] Running clobber step. 04:57:28 INFO - Running pre-action listener: _resource_record_pre_action 04:57:28 INFO - Running main action method: clobber 04:57:28 INFO - rmtree: /builds/slave/test/build 04:57:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:57:30 INFO - Running post-action listener: _resource_record_post_action 04:57:30 INFO - [mozharness: 2017-02-22 12:57:30.471062Z] Finished clobber step (success) 04:57:30 INFO - [mozharness: 2017-02-22 12:57:30.471347Z] Running read-buildbot-config step. 04:57:30 INFO - Running pre-action listener: _resource_record_pre_action 04:57:30 INFO - Running main action method: read_buildbot_config 04:57:30 INFO - Using buildbot properties: 04:57:30 INFO - { 04:57:30 INFO - "project": "", 04:57:30 INFO - "product": "firefox", 04:57:30 INFO - "script_repo_revision": "production", 04:57:30 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:57:30 INFO - "repository": "", 04:57:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:57:30 INFO - "buildid": "20170222031725", 04:57:30 INFO - "pgo_build": "False", 04:57:30 INFO - "basedir": "/builds/slave/test", 04:57:30 INFO - "buildnumber": 17, 04:57:30 INFO - "slavename": "t-yosemite-r7-0364", 04:57:30 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:57:30 INFO - "platform": "yosemite_r7", 04:57:30 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:57:30 INFO - "branch": "mozilla-beta", 04:57:30 INFO - "repo_path": "releases/mozilla-beta", 04:57:30 INFO - "revision": "c8cefb50d5a80b546777cc712d4de17ca92154f3", 04:57:30 INFO - "stage_platform": "macosx64", 04:57:30 INFO - "builduid": "c922183177f54f509ee48ed29afa7edb", 04:57:30 INFO - "slavebuilddir": "test" 04:57:30 INFO - } 04:57:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 04:57:30 INFO - Running post-action listener: _resource_record_post_action 04:57:30 INFO - [mozharness: 2017-02-22 12:57:30.477001Z] Finished read-buildbot-config step (success) 04:57:30 INFO - [mozharness: 2017-02-22 12:57:30.477227Z] Running download-and-extract step. 04:57:30 INFO - Running pre-action listener: _resource_record_pre_action 04:57:30 INFO - Running main action method: download_and_extract 04:57:30 INFO - mkdir: /builds/slave/test/build/tests 04:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:30 INFO - trying https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 04:57:30 INFO - Downloading https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 04:57:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 04:57:32 INFO - Downloaded 1165 bytes. 04:57:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 04:57:32 INFO - Using the following test package requirements: 04:57:32 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 04:57:32 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 04:57:32 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 04:57:32 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 04:57:32 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 04:57:32 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:57:32 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 04:57:32 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 04:57:32 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 04:57:32 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 04:57:32 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 04:57:32 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 04:57:32 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 04:57:32 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 04:57:32 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 04:57:32 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 04:57:32 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 04:57:32 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 04:57:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 04:57:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 04:57:32 INFO - Fetch https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 04:57:32 INFO - Http code: 200 04:57:32 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 04:57:32 INFO - x-amz-cf-id: QWFBmjgZM8IGqdjI-1UHjCnDT2NClMexy4_aHk5ceC0rf_i5OKX0-w== 04:57:32 INFO - x-amz-version-id: oqy8kAOG3ECVjIquNq1NsWy8Be41j8VJ 04:57:32 INFO - Expected file size: 16092992 04:57:32 INFO - Obtained file size: 16092992 04:57:39 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:57:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 04:57:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 04:57:39 INFO - Fetch https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 04:57:40 INFO - Http code: 200 04:57:40 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 04:57:40 INFO - x-amz-cf-id: EdJezw2cMgNIMJt9HusHrmXB44D3A3V4a3aMcmmDKCkf_1_fJrmTLw== 04:57:40 INFO - x-amz-version-id: oqy8kAOG3ECVjIquNq1NsWy8Be41j8VJ 04:57:40 INFO - Expected file size: 16092992 04:57:40 INFO - Obtained file size: 16092992 04:57:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 04:57:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 04:57:47 INFO - Fetch https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 04:57:48 INFO - Http code: 200 04:57:48 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 04:57:48 INFO - x-amz-cf-id: FOW9-5yUMCwbKXt9VHceKuU6z3J5hWn6VT-4AMwtam8mDd2YtsyJiQ== 04:57:48 INFO - x-amz-version-id: aK.azzWtdWm9XhQPMU9au8dNmpE1IYK2 04:57:48 INFO - Expected file size: 14403005 04:57:48 INFO - Obtained file size: 14403005 04:57: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')]} 04:57:48 INFO - trying https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 04:57:48 INFO - Downloading https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 04:57:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 04:57:51 INFO - Downloaded 82141540 bytes. 04:57:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 04:57:51 INFO - mkdir: /builds/slave/test/properties 04:57:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:57:51 INFO - Writing to file /builds/slave/test/properties/build_url 04:57:51 INFO - Contents: 04:57:51 INFO - build_url:https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 04:57:51 INFO - Running post-action listener: _resource_record_post_action 04:57:51 INFO - Running post-action listener: set_extra_try_arguments 04:57:51 INFO - [mozharness: 2017-02-22 12:57:51.779049Z] Finished download-and-extract step (success) 04:57:51 INFO - [mozharness: 2017-02-22 12:57:51.779156Z] Running populate-webroot step. 04:57:51 INFO - Running pre-action listener: _resource_record_pre_action 04:57:51 INFO - Running main action method: populate_webroot 04:57:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:51 INFO - '--tppagecycles', 04:57:51 INFO - '7'], 04:57:51 INFO - 'tests': ['tsvgm']}}, 04:57:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:57:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:57:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:57:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:57:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:57:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:51 INFO - 'talos_options': ['--disable-e10s'], 04:57:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:51 INFO - 'talos_options': ['--disable-e10s'], 04:57:51 INFO - 'tests': ['damp', 'tps']}, 04:57:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:51 INFO - 'tests': ['damp', 'tps']}, 04:57:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:57:51 INFO - 'tests': ['dromaeo_dom']}, 04:57:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:57:51 INFO - 'tests': ['basic_compositor_video']}, 04:57:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:57:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:57:51 INFO - 'tests': ['a11yr', 04:57:51 INFO - 'ts_paint', 04:57:51 INFO - 'tpaint', 04:57:51 INFO - 'sessionrestore', 04:57:51 INFO - 'sessionrestore_no_auto_restore', 04:57:51 INFO - 'tabpaint']}, 04:57:51 INFO - 'other-e10s': {'tests': ['a11yr', 04:57:51 INFO - 'ts_paint', 04:57:51 INFO - 'tpaint', 04:57:51 INFO - 'sessionrestore', 04:57:51 INFO - 'sessionrestore_no_auto_restore', 04:57:51 INFO - 'tabpaint']}, 04:57:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:57:51 INFO - 'ts_paint', 04:57:51 INFO - 'tpaint', 04:57:51 INFO - 'sessionrestore', 04:57:51 INFO - 'sessionrestore_no_auto_restore', 04:57:51 INFO - 'tabpaint']}, 04:57:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:57:51 INFO - 'ts_paint', 04:57:51 INFO - 'tpaint', 04:57:51 INFO - 'sessionrestore', 04:57:51 INFO - 'sessionrestore_no_auto_restore', 04:57:51 INFO - 'tabpaint']}, 04:57:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:57:51 INFO - 'tests': ['a11yr', 04:57:51 INFO - 'ts_paint', 04:57:51 INFO - 'tpaint', 04:57:51 INFO - 'sessionrestore', 04:57:51 INFO - 'sessionrestore_no_auto_restore', 04:57:51 INFO - 'tabpaint']}, 04:57:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:57:51 INFO - 'tests': ['a11yr', 04:57:51 INFO - 'ts_paint', 04:57:51 INFO - 'tpaint', 04:57:51 INFO - 'sessionrestore', 04:57:51 INFO - 'sessionrestore_no_auto_restore', 04:57:51 INFO - 'tabpaint']}, 04:57:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:57:51 INFO - 'tests': ['tsvgx', 04:57:51 INFO - 'tsvgr_opacity', 04:57:51 INFO - 'tart', 04:57:51 INFO - 'tscrollx', 04:57:51 INFO - 'cart']}, 04:57:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:57:51 INFO - 'tsvgr_opacity', 04:57:51 INFO - 'tart', 04:57:51 INFO - 'tscrollx', 04:57:51 INFO - 'cart']}, 04:57:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:51 INFO - 'talos_options': ['--disable-e10s'], 04:57:51 INFO - 'tests': ['tp5o']}, 04:57:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:51 INFO - 'tests': ['tp5o']}, 04:57:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:51 INFO - 'talos_options': ['--disable-e10s', 04:57:51 INFO - '--xperf_path', 04:57:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:51 INFO - 'tests': ['tp5n']}, 04:57:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:51 INFO - 'talos_options': ['--xperf_path', 04:57:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:51 INFO - 'tests': ['tp5n']}}, 04:57:51 INFO - 'talos.zip': {'path': '', 04:57:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:51 INFO - Running post-action listener: _resource_record_post_action 04:57:51 INFO - [mozharness: 2017-02-22 12:57:51.798928Z] Finished populate-webroot step (success) 04:57:51 INFO - [mozharness: 2017-02-22 12:57:51.799065Z] Running create-virtualenv step. 04:57:51 INFO - Running pre-action listener: _resource_record_pre_action 04:57:51 INFO - Running main action method: create_virtualenv 04:57:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:57:51 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 04:57:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:57:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:51 INFO - Using real prefix '/tools/python27' 04:57:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:57:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:57:55 INFO - Installing pip.................done. 04:57:55 INFO - Return code: 0 04:57:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:57:55 INFO - Reading from file tmpfile_stdout 04:57:55 INFO - Output received: 04:57:55 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) 04:57:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103470490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab79cc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103284d30>, '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 0x1030eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10327cb20>, '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.9Yty00EBuE/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.tNI2lDozAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 04:57: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', 'pip>=1.5'] in /builds/slave/test/build 04:57: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 pip>=1.5 04:57:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Yty00EBuE/Render', 04:57:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:55 INFO - 'HOME': '/Users/cltbld', 04:57:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:55 INFO - 'LOGNAME': 'cltbld', 04:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:55 INFO - 'MOZ_NO_REMOTE': '1', 04:57:55 INFO - 'NO_EM_RESTART': '1', 04:57:55 INFO - 'PAGER': '/bin/cat', 04:57:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:55 INFO - 'PWD': '/builds/slave/test', 04:57:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:55 INFO - 'SHELL': '/bin/bash', 04:57:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tNI2lDozAV/Listeners', 04:57:55 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 04:57:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:55 INFO - 'USER': 'cltbld', 04:57:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:55 INFO - 'XPC_FLAGS': '0x0', 04:57:55 INFO - 'XPC_SERVICE_NAME': '0', 04:57:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:56 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 04:57:56 INFO - Cleaning up... 04:57:56 INFO - Return code: 0 04:57:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:57:56 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')]} 04:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 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')]} 04:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 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 0x103470490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab79cc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103284d30>, '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 0x1030eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10327cb20>, '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.9Yty00EBuE/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.tNI2lDozAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 04:57:56 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 04:57:56 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 04:57:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Yty00EBuE/Render', 04:57:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:56 INFO - 'HOME': '/Users/cltbld', 04:57:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:56 INFO - 'LOGNAME': 'cltbld', 04:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:56 INFO - 'MOZ_NO_REMOTE': '1', 04:57:56 INFO - 'NO_EM_RESTART': '1', 04:57:56 INFO - 'PAGER': '/bin/cat', 04:57:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:56 INFO - 'PWD': '/builds/slave/test', 04:57:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:56 INFO - 'SHELL': '/bin/bash', 04:57:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tNI2lDozAV/Listeners', 04:57:56 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 04:57:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:56 INFO - 'USER': 'cltbld', 04:57:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:56 INFO - 'XPC_FLAGS': '0x0', 04:57:56 INFO - 'XPC_SERVICE_NAME': '0', 04:57:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:56 INFO - Downloading/unpacking psutil>=3.1.1 04:57:56 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 04:57:56 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 04:57:56 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 04:57:56 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 04:57:56 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 04:57:56 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 04:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:00 INFO - Installing collected packages: psutil 04:58:00 INFO - Running setup.py install for psutil 04:58:00 INFO - building 'psutil._psutil_osx' extension 04:58:00 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 04:58:00 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 04:58:00 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 04:58:00 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 04:58:00 INFO - building 'psutil._psutil_posix' extension 04:58:00 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 04:58:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:58:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:58:00 INFO - ^ 04:58:00 INFO - 1 warning generated. 04:58:00 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 04:58:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:00 INFO - Successfully installed psutil 04:58:00 INFO - Cleaning up... 04:58:00 INFO - Return code: 0 04:58:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:58:00 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')]} 04:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:00 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')]} 04:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:00 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 0x103470490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab79cc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103284d30>, '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 0x1030eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10327cb20>, '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.9Yty00EBuE/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.tNI2lDozAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 04:58:00 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 04:58:00 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 04:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Yty00EBuE/Render', 04:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:00 INFO - 'HOME': '/Users/cltbld', 04:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:00 INFO - 'LOGNAME': 'cltbld', 04:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:00 INFO - 'MOZ_NO_REMOTE': '1', 04:58:00 INFO - 'NO_EM_RESTART': '1', 04:58:00 INFO - 'PAGER': '/bin/cat', 04:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:00 INFO - 'PWD': '/builds/slave/test', 04:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:00 INFO - 'SHELL': '/bin/bash', 04:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tNI2lDozAV/Listeners', 04:58:00 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 04:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:00 INFO - 'USER': 'cltbld', 04:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:00 INFO - 'XPC_FLAGS': '0x0', 04:58:00 INFO - 'XPC_SERVICE_NAME': '0', 04:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:58:01 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 04:58:01 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 04:58:01 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 04:58:01 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 04:58:01 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 04:58:01 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 04:58:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:58:03 INFO - Installing collected packages: mozsystemmonitor 04:58:03 INFO - Running setup.py install for mozsystemmonitor 04:58:03 INFO - Successfully installed mozsystemmonitor 04:58:03 INFO - Cleaning up... 04:58:04 INFO - Return code: 0 04:58:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:58:04 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')]} 04:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:04 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')]} 04:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:04 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 0x103470490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab79cc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103284d30>, '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 0x1030eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10327cb20>, '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.9Yty00EBuE/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.tNI2lDozAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 04:58:04 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 04:58:04 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 04:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Yty00EBuE/Render', 04:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:04 INFO - 'HOME': '/Users/cltbld', 04:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:04 INFO - 'LOGNAME': 'cltbld', 04:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:04 INFO - 'MOZ_NO_REMOTE': '1', 04:58:04 INFO - 'NO_EM_RESTART': '1', 04:58:04 INFO - 'PAGER': '/bin/cat', 04:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:04 INFO - 'PWD': '/builds/slave/test', 04:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:04 INFO - 'SHELL': '/bin/bash', 04:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tNI2lDozAV/Listeners', 04:58:04 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 04:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:04 INFO - 'USER': 'cltbld', 04:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:04 INFO - 'XPC_FLAGS': '0x0', 04:58:04 INFO - 'XPC_SERVICE_NAME': '0', 04:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:04 INFO - Downloading/unpacking jsonschema==2.5.1 04:58:04 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 04:58:04 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 04:58:04 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 04:58:04 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 04:58:04 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 04:58:04 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 04:58:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:58:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:58:06 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 04:58:06 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 04:58:06 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 04:58:06 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 04:58:06 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 04:58:06 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 04:58:07 INFO - Downloading functools32-3.2.3-2.tar.gz 04:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:58:07 INFO - warning: no files found matching '*.txt' 04:58:07 INFO - no previously-included directories found matching 'build' 04:58:07 INFO - no previously-included directories found matching 'dist' 04:58:07 INFO - no previously-included directories found matching '.git*' 04:58:07 INFO - Installing collected packages: jsonschema, functools32 04:58:07 INFO - Running setup.py install for functools32 04:58:07 INFO - warning: no files found matching '*.txt' 04:58:07 INFO - no previously-included directories found matching 'build' 04:58:07 INFO - no previously-included directories found matching 'dist' 04:58:07 INFO - no previously-included directories found matching '.git*' 04:58:07 INFO - Successfully installed jsonschema functools32 04:58:07 INFO - Cleaning up... 04:58:07 INFO - Return code: 0 04:58:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103470490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab79cc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103284d30>, '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 0x1030eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10327cb20>, '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.9Yty00EBuE/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.tNI2lDozAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 04:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:58:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Yty00EBuE/Render', 04:58:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:07 INFO - 'HOME': '/Users/cltbld', 04:58:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:07 INFO - 'LOGNAME': 'cltbld', 04:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:07 INFO - 'MOZ_NO_REMOTE': '1', 04:58:07 INFO - 'NO_EM_RESTART': '1', 04:58:07 INFO - 'PAGER': '/bin/cat', 04:58:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:07 INFO - 'PWD': '/builds/slave/test', 04:58:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:07 INFO - 'SHELL': '/bin/bash', 04:58:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tNI2lDozAV/Listeners', 04:58:07 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 04:58:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:07 INFO - 'USER': 'cltbld', 04:58:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:07 INFO - 'XPC_FLAGS': '0x0', 04:58:07 INFO - 'XPC_SERVICE_NAME': '0', 04:58:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:58:08 INFO - Cleaning up... 04:58:08 INFO - Return code: 0 04:58:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:58:08 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')]} 04:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:08 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')]} 04:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:08 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 0x103470490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab79cc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103284d30>, '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 0x1030eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10327cb20>, '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.9Yty00EBuE/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.tNI2lDozAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 04:58:08 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 04:58:08 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 04:58:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Yty00EBuE/Render', 04:58:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:08 INFO - 'HOME': '/Users/cltbld', 04:58:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:08 INFO - 'LOGNAME': 'cltbld', 04:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:08 INFO - 'MOZ_NO_REMOTE': '1', 04:58:08 INFO - 'NO_EM_RESTART': '1', 04:58:08 INFO - 'PAGER': '/bin/cat', 04:58:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:08 INFO - 'PWD': '/builds/slave/test', 04:58:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:08 INFO - 'SHELL': '/bin/bash', 04:58:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tNI2lDozAV/Listeners', 04:58:08 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 04:58:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:08 INFO - 'USER': 'cltbld', 04:58:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:08 INFO - 'XPC_FLAGS': '0x0', 04:58:08 INFO - 'XPC_SERVICE_NAME': '0', 04:58:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:58:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:58:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:58:11 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 04:58:11 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 04:58:11 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 04:58:11 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 04:58:11 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 04:58:11 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 04:58:12 INFO - Downloading docopt-0.6.1.tar.gz 04:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:58:12 INFO - Installing collected packages: blobuploader, requests, docopt 04:58:12 INFO - Running setup.py install for blobuploader 04:58:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:58:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:58:12 INFO - Running setup.py install for requests 04:58:12 INFO - Running setup.py install for docopt 04:58:13 INFO - Successfully installed blobuploader requests docopt 04:58:13 INFO - Cleaning up... 04:58:13 INFO - Return code: 0 04:58:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:13 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')]} 04:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:13 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')]} 04:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:13 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 0x103470490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab79cc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103284d30>, '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 0x1030eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10327cb20>, '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.9Yty00EBuE/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.tNI2lDozAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 04:58:13 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 04:58:13 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 04:58:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Yty00EBuE/Render', 04:58:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:13 INFO - 'HOME': '/Users/cltbld', 04:58:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:13 INFO - 'LOGNAME': 'cltbld', 04:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:13 INFO - 'MOZ_NO_REMOTE': '1', 04:58:13 INFO - 'NO_EM_RESTART': '1', 04:58:13 INFO - 'PAGER': '/bin/cat', 04:58:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:13 INFO - 'PWD': '/builds/slave/test', 04:58:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:13 INFO - 'SHELL': '/bin/bash', 04:58:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tNI2lDozAV/Listeners', 04:58:13 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 04:58:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:13 INFO - 'USER': 'cltbld', 04:58:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:13 INFO - 'XPC_FLAGS': '0x0', 04:58:13 INFO - 'XPC_SERVICE_NAME': '0', 04:58:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-eJIqUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-MuIibx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-gZ3ePy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-frbSWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-emElLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-CrQQtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-spuUs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-neo5d2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-p6dPJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:15 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-5Wv6S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:15 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-uQbRQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:15 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-YhpoZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:15 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-q9mgWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:15 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-QLNvje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:15 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-wf6XKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:15 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-mWure3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:15 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-ITVSwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:58:15 INFO - Running setup.py install for manifestparser 04:58:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:58:16 INFO - Running setup.py install for mozcrash 04:58:16 INFO - Running setup.py install for mozdebug 04:58:16 INFO - Running setup.py install for mozdevice 04:58:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:58:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:58:16 INFO - Running setup.py install for mozfile 04:58:16 INFO - Running setup.py install for mozhttpd 04:58:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:58:16 INFO - Running setup.py install for mozinfo 04:58:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:58:16 INFO - Running setup.py install for mozInstall 04:58:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Running setup.py install for mozleak 04:58:17 INFO - Running setup.py install for mozlog 04:58:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Running setup.py install for moznetwork 04:58:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Running setup.py install for mozprocess 04:58:17 INFO - Running setup.py install for mozprofile 04:58:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Running setup.py install for mozrunner 04:58:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:58:18 INFO - Running setup.py install for mozscreenshot 04:58:18 INFO - Running setup.py install for moztest 04:58:18 INFO - Running setup.py install for mozversion 04:58:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:58:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:58:18 INFO - Cleaning up... 04:58:18 INFO - Return code: 0 04:58:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:18 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 0x103470490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab79cc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103284d30>, '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 0x1030eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10327cb20>, '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.9Yty00EBuE/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.tNI2lDozAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 04:58:18 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 04:58:18 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 04:58:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Yty00EBuE/Render', 04:58:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:18 INFO - 'HOME': '/Users/cltbld', 04:58:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:18 INFO - 'LOGNAME': 'cltbld', 04:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:18 INFO - 'MOZ_NO_REMOTE': '1', 04:58:18 INFO - 'NO_EM_RESTART': '1', 04:58:18 INFO - 'PAGER': '/bin/cat', 04:58:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:18 INFO - 'PWD': '/builds/slave/test', 04:58:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:18 INFO - 'SHELL': '/bin/bash', 04:58:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tNI2lDozAV/Listeners', 04:58:18 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 04:58:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:18 INFO - 'USER': 'cltbld', 04:58:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:18 INFO - 'XPC_FLAGS': '0x0', 04:58:18 INFO - 'XPC_SERVICE_NAME': '0', 04:58:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-sir58i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-u8KiM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-lC3U_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-43eP6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Sc3L8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-lLLday-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-ZmkEKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-W1uMCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Zgxb_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:20 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-IaKw4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:20 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-wP_wxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:20 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-xLlIYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:20 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-xZBbaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:20 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-toCgbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:20 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-_PWR9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:20 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-_YG3vD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:20 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-dH9pWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:20 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)) 04:58:20 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)) 04:58:20 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)) 04:58:20 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)) 04:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:58:20 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 04:58:20 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 04:58:20 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 04:58:20 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 04:58:20 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 04:58:20 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 04:58:23 INFO - Downloading blessings-1.6.tar.gz 04:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:58:24 INFO - Installing collected packages: blessings 04:58:24 INFO - Running setup.py install for blessings 04:58:24 INFO - Successfully installed blessings 04:58:24 INFO - Cleaning up... 04:58:24 INFO - Return code: 0 04:58:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:58:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:24 INFO - Reading from file tmpfile_stdout 04:58:24 INFO - Current package versions: 04:58:24 INFO - blessings == 1.6 04:58:24 INFO - blobuploader == 1.2.4 04:58:24 INFO - docopt == 0.6.1 04:58:24 INFO - functools32 == 3.2.3-2 04:58:24 INFO - jsonschema == 2.5.1 04:58:24 INFO - manifestparser == 1.1 04:58:24 INFO - mozInstall == 1.12 04:58:24 INFO - mozcrash == 1.0 04:58:24 INFO - mozdebug == 0.1 04:58:24 INFO - mozdevice == 0.48 04:58:24 INFO - mozfile == 1.2 04:58:24 INFO - mozhttpd == 0.7 04:58:24 INFO - mozinfo == 0.9 04:58:24 INFO - mozleak == 0.1 04:58:24 INFO - mozlog == 3.4 04:58:24 INFO - moznetwork == 0.27 04:58:24 INFO - mozprocess == 0.23 04:58:24 INFO - mozprofile == 0.28 04:58:24 INFO - mozrunner == 6.13 04:58:24 INFO - mozscreenshot == 0.1 04:58:24 INFO - mozsystemmonitor == 0.3 04:58:24 INFO - moztest == 0.8 04:58:24 INFO - mozversion == 1.4 04:58:24 INFO - psutil == 3.1.1 04:58:24 INFO - requests == 1.2.3 04:58:24 INFO - wsgiref == 0.1.2 04:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:24 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')]} 04:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:24 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')]} 04:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:24 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 0x103470490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab79cc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103284d30>, '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 0x1030eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10327cb20>, '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.9Yty00EBuE/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.tNI2lDozAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 04:58:24 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 04:58:24 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 04:58:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Yty00EBuE/Render', 04:58:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:24 INFO - 'HOME': '/Users/cltbld', 04:58:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:24 INFO - 'LOGNAME': 'cltbld', 04:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:24 INFO - 'MOZ_NO_REMOTE': '1', 04:58:24 INFO - 'NO_EM_RESTART': '1', 04:58:24 INFO - 'PAGER': '/bin/cat', 04:58:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:24 INFO - 'PWD': '/builds/slave/test', 04:58:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:24 INFO - 'SHELL': '/bin/bash', 04:58:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tNI2lDozAV/Listeners', 04:58:24 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 04:58:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:24 INFO - 'USER': 'cltbld', 04:58:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:24 INFO - 'XPC_FLAGS': '0x0', 04:58:24 INFO - 'XPC_SERVICE_NAME': '0', 04:58:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:24 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)) 04:58:24 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)) 04:58:24 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)) 04:58:24 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)) 04:58:24 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)) 04:58:24 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)) 04:58:24 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)) 04:58:24 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)) 04:58:24 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)) 04:58:24 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)) 04:58:24 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)) 04:58:24 INFO - Cleaning up... 04:58:24 INFO - Return code: 0 04:58:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:58:24 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')]} 04:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:24 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')]} 04:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:24 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 0x103470490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab79cc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103284d30>, '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 0x1030eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10327cb20>, '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.9Yty00EBuE/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.tNI2lDozAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 04:58:24 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 04:58:24 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 04:58:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Yty00EBuE/Render', 04:58:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:24 INFO - 'HOME': '/Users/cltbld', 04:58:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:24 INFO - 'LOGNAME': 'cltbld', 04:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:24 INFO - 'MOZ_NO_REMOTE': '1', 04:58:24 INFO - 'NO_EM_RESTART': '1', 04:58:24 INFO - 'PAGER': '/bin/cat', 04:58:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:24 INFO - 'PWD': '/builds/slave/test', 04:58:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:24 INFO - 'SHELL': '/bin/bash', 04:58:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tNI2lDozAV/Listeners', 04:58:24 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 04:58:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:24 INFO - 'USER': 'cltbld', 04:58:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:24 INFO - 'XPC_FLAGS': '0x0', 04:58:24 INFO - 'XPC_SERVICE_NAME': '0', 04:58:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:58:25 INFO - Cleaning up... 04:58:25 INFO - Return code: 0 04:58:25 INFO - Running post-action listener: _resource_record_post_action 04:58:25 INFO - Running post-action listener: _start_resource_monitoring 04:58:25 INFO - Starting resource monitoring. 04:58:25 INFO - [mozharness: 2017-02-22 12:58:25.136336Z] Finished create-virtualenv step (success) 04:58:25 INFO - [mozharness: 2017-02-22 12:58:25.137172Z] Running install step. 04:58:25 INFO - Running pre-action listener: _resource_record_pre_action 04:58:25 INFO - Running main action method: install 04:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:25 INFO - Reading from file tmpfile_stdout 04:58:25 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:58:25 INFO - Reading from file tmpfile_stdout 04:58:25 INFO - Output received: 04:58:25 INFO - Usage: mozinstall [options] installer 04:58:25 INFO - Options: 04:58:25 INFO - -h, --help show this help message and exit 04:58:25 INFO - -d DEST, --destination=DEST 04:58:25 INFO - Directory to install application into. [default: 04:58:25 INFO - "/builds/slave/test"] 04:58:25 INFO - --app=APP Application being installed. [default: firefox] 04:58:25 INFO - mkdir: /builds/slave/test/build/application 04:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:58:46 INFO - Reading from file tmpfile_stdout 04:58:46 INFO - Output received: 04:58:46 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:58:46 INFO - Running post-action listener: _resource_record_post_action 04:58:46 INFO - [mozharness: 2017-02-22 12:58:46.959334Z] Finished install step (success) 04:58:46 INFO - [mozharness: 2017-02-22 12:58:46.959523Z] Running run-tests step. 04:58:46 INFO - Running pre-action listener: _resource_record_pre_action 04:58:46 INFO - Running main action method: run_tests 04:58:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:46 INFO - 2017-02-22 04:58:46.974 screenresolution[2557:34857] starting screenresolution argv=screenresolution get 04:58:46 INFO - 2017-02-22 04:58:46.977 screenresolution[2557:34857] Display 0: 1600x1200x32@60 04:58:46 INFO - 2017-02-22 04:58:46.983 screenresolution[2558:34859] starting screenresolution argv=screenresolution list 04:58:46 INFO - Available Modes on Display 0 04:58:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:47 INFO - Intel Iris: 04:58:47 INFO - Chipset Model: Intel Iris 04:58:47 INFO - Type: GPU 04:58:47 INFO - Bus: Built-In 04:58:47 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:47 INFO - Vendor: Intel (0x8086) 04:58:47 INFO - Device ID: 0x0a2e 04:58:47 INFO - Revision ID: 0x0009 04:58:47 INFO - Displays: 04:58:47 INFO - Display: 04:58:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:47 INFO - Display Serial Number: 1600x1200 60 04:58:47 INFO - Main Display: Yes 04:58:47 INFO - Mirror: Off 04:58:47 INFO - Online: Yes 04:58:47 INFO - Rotation: Supported 04:58:47 INFO - Return code: 0 04:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:58:47 INFO - Python 2.7.3 04:58:47 INFO - Return code: 0 04:58:47 INFO - grabbing minidump binary from tooltool 04:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:47 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 0x103284d30>, '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 0x1030eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10327cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:58:47 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 04:58:47 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 04:58:47 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 04:58:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:47 INFO - Return code: 0 04:58:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:58:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:58:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:58:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:58:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0364', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0364 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:58:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Yty00EBuE/Render', 04:58:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:47 INFO - 'HOME': '/Users/cltbld', 04:58:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:47 INFO - 'LOGNAME': 'cltbld', 04:58:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:58:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:47 INFO - 'MOZ_NO_REMOTE': '1', 04:58:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:58:47 INFO - 'NO_EM_RESTART': '1', 04:58:47 INFO - 'PAGER': '/bin/cat', 04:58:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:47 INFO - 'PWD': '/builds/slave/test', 04:58:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:58:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:47 INFO - 'SHELL': '/bin/bash', 04:58:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tNI2lDozAV/Listeners', 04:58:47 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 04:58:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:47 INFO - 'USER': 'cltbld', 04:58:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:47 INFO - 'XPC_FLAGS': '0x0', 04:58:47 INFO - 'XPC_SERVICE_NAME': '0', 04:58:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0364', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:58:47 INFO - mozversion application_buildid: 20170222031725 04:58:47 INFO - mozversion application_changeset: c8cefb50d5a80b546777cc712d4de17ca92154f3 04:58:47 INFO - mozversion application_display_name: Firefox 04:58:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:47 INFO - mozversion application_name: Firefox 04:58:47 INFO - mozversion application_remotingname: firefox 04:58:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:58:47 INFO - mozversion application_vendor: Mozilla 04:58:47 INFO - mozversion application_version: 52.0 04:58:47 INFO - mozversion platform_buildid: 20170222031725 04:58:47 INFO - mozversion platform_changeset: c8cefb50d5a80b546777cc712d4de17ca92154f3 04:58:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:58:47 INFO - mozversion platform_version: 52.0 04:58:47 INFO - using testdate: 1487768327 04:58:47 INFO - actual date: 1487768327 04:58:47 INFO - starting webserver on 'localhost:58643' 04:58:47 INFO - SUITE-START | Running 2 tests 04:58:47 INFO - TEST-START | dromaeo_css 04:58:47 INFO - operating with platform_type : mac_ 04:58:47 INFO - Initialising browser for dromaeo_css test... 04:58:47 INFO - TEST-INFO | started process 2568 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmpPFCorL/profile http://localhost:58643/getInfo.html) 04:58:50 INFO - PROCESS | 2568 | 2017-02-22 04:58:50.680 plugin-container[2571:35023] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 04:58:50 INFO - PROCESS | 2568 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:50 INFO - PROCESS | 2568 | 2017-02-22 04:58:50.681 plugin-container[2571:35023] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 04:58:50 INFO - PROCESS | 2568 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:50 INFO - PROCESS | 2568 | 2017-02-22 04:58:50.681 plugin-container[2571:35023] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:58:50 INFO - PROCESS | 2568 | __metrics Screen width/height:1600/1200 04:58:50 INFO - PROCESS | 2568 | colorDepth:24 04:58:50 INFO - PROCESS | 2568 | Browser inner width/height: 1024/689 04:58:50 INFO - PROCESS | 2568 | __metrics 04:58:50 ERROR - PROCESS | 2568 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 04:58:51 INFO - TEST-INFO | 2568: exit 0 04:58:51 INFO - Browser initialized. 04:58:51 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:51 INFO - TEST-INFO | started process 2572 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmpPFCorL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:53 INFO - PROCESS | 2572 | 2017-02-22 04:58:53.975 plugin-container[2573:35161] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 04:58:53 INFO - PROCESS | 2572 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:53 INFO - PROCESS | 2572 | 2017-02-22 04:58:53.975 plugin-container[2573:35161] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x860b, name = 'com.apple.CFPasteboardClient' 04:58:53 INFO - PROCESS | 2572 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:53 INFO - PROCESS | 2572 | 2017-02-22 04:58:53.975 plugin-container[2573:35161] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:59:03 INFO - PROCESS | 2572 | RSS: Main: 177606656 04:59:03 INFO - PROCESS | 2572 | 05:02:06 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:58643/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58643/tests/dromaeo/cssquery-ext.html) 05:02:08 INFO - PROCESS | 2572 | RSS: Main: 183128064 05:02:08 INFO - PROCESS | 2572 | 05:05:10 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:58643/tests/dromaeo/cssquery-ext.html (next: http://localhost:58643/tests/dromaeo/cssquery-jquery.html) 05:05:11 INFO - PROCESS | 2572 | RSS: Main: 197779456 05:05:11 INFO - PROCESS | 2572 | 05:08:12 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:58643/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58643/tests/dromaeo/cssquery-mootools.html) 05:08:13 INFO - PROCESS | 2572 | RSS: Main: 199618560 05:08:13 INFO - PROCESS | 2572 | 05:11:15 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:58643/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58643/tests/dromaeo/cssquery-prototype.html) 05:11:16 INFO - PROCESS | 2572 | RSS: Main: 202899456 05:11:16 INFO - PROCESS | 2572 | 05:14:18 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:58643/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58643/tests/dromaeo/cssquery-yui.html) 05:14:19 INFO - PROCESS | 2572 | RSS: Main: 205582336 05:14:19 INFO - PROCESS | 2572 | 05:17:22 INFO - PROCESS | 2572 | Cycle 1(1): loaded http://localhost:58643/tests/dromaeo/cssquery-yui.html (next: http://localhost:58643/tests/dromaeo/cssquery-dojo.html) 05:17:22 INFO - PROCESS | 2572 | RSS: Main: 205422592 05:17:22 INFO - PROCESS | 2572 | 05:17:22 INFO - PROCESS | 2572 | __start_tp_report 05:17:22 INFO - PROCESS | 2572 | _x_x_mozilla_page_load 05:17:22 INFO - PROCESS | 2572 | _x_x_mozilla_page_load_details 05:17:22 INFO - PROCESS | 2572 | |i|pagename|runs| 05:17:22 INFO - PROCESS | 2572 | |0;dojo.html;3349.4305967985442;3532.2052538178914;3546.7339949503794;3568.857245710172;3580.445031020193;5897.174395584616;5911.49752271057;5977.312609049961;5985.640861548311;6007.219061522007;5919.88160236795;6000.909986350208;6031.215941927543;6034.004389275764;6061.87876242476;5317.9468205317935;5321.281626980347;5361.383440904287;5365;5458.61789674723;4512.684112112153;5388.245645609618;5417.997670430963;5420.403755586883;5427.3215848019;5251.396089449724;5267.0519306525;5410.8917821643545;5416.972915135419;5438.755256013469;4446;5341.03861304963;5359.383670877841;5380.515753582196;5383.811566595189;5213.348331458567;5317.973410132963;5319.813806516792;5336.493033161843;5367.490088441592;5969.104634304846;5996.460318571306;6017.398260173992;6018.909716354258;6033.607815491979;5090.694558326512;5887.793927212527;6136.672258167605;6171.228596425447;6210.5963112398;5252.71110088945;6208.689565521751;6306.905396419057;6307.24313082433;6342.334054924258;6025.246844144482;6046.062860256668;6048.7882924097885;6055.394460553954;6065.332813390523;6177.62934223939;6249.218847644044;6470.773522926722;6527.738890444424;6528.706208220641;6082.939170608326;6106.236720409949;6115.757578773014;6117.113018612276;6160.691965401712;6214.223222097238;6259.405356491126;6331.303556608769;6345.17512723343;6392.20097487814;6128.380904898417;6232.937670623236;6238.469730072904;6239.344868788802;6241.282252540925;6125.693715314216;6173.722182501798;6214.2542894852;6228.439440450381;6231.22109736283;5061.342025536656;5078.619103567247;5089.821856235014;5093.923591146062;5109.131447653907;4486.461624605068;4488.192125417391;4508.1659892919915;4570.154521413549;4572.862814115582;5914.9112763308585;5973;6062.878742425127;6083.148359229712;6112.786052488142;6328.71520781566;6335.68321583919;6344.238691357066;6363.5863668861375;6376.681165941684;5931.0213814720955;6033.607815491979;6047.667378294236;6071.483923866433;6096.72564734588;5538.612297139242;5544.528715059265;5574.108142697149;5602.52378547828;5629.24005259293;6495.999999999905;6499.38255865692;6535.117759102651;6538.280789113193;6555.770548030796;6155.507559395148;6209;6285.717142728497;6368.108464815023;6385.265694445198;6417.8716425672155;6448.387403196689;6464.709088090953;6576.76981305652;6579.374959378852;6225.533085018732;6237.7193026314835;6237.781677641442;6245.18812554365;6254.593451425642;6143.078538219124;6191.1641928339095;6329.9050514243245;6351.904721429275;6378.904316435164;5096.311997880387;6153.230846144232;6176.289726681489;6185.938140618716;6207.534434917309;6157.230346206724;6186.752529898754;6191.84520386994;6206.813795586139;6212.316645169119;5167.767450464663;5380.461953804745;6134.202553667995;6151.96924015395;6199.411055949678;6136.028952951454;6138.2044803098925;6156.445919867234;6196.349383314687;6198.938010620016;6130.5402094842175;6160.199174107337;6160.229971253593;6164.137020816999;6195.039768835657 05:17:22 INFO - PROCESS | 2572 | |1;ext.html;534.5189329603355;544.0560627311613;544.3331918399958;545.860805494599;554.1466142141103;38469;39909.80045099774;40004.59995400045;40068.59931400685;42245.94385140373;41544.169116617646;42098.94752631186;42150.57849421505;42240.57759422405;42269.94325141873;9472.57373418196;9656;9676.612935482572;9684.903150968506;9691.98234185411;9427.717168484956;9513.524323783819;9514.524273786317;9527.285453590974;9531.046895310483;8182.713605023825;9330.813383732322;9498.762530936747;9559.283053770994;9563.426194428323;9329.580168892417;9441.905580944205;9527.52362381878;9530.52347382635;9533.189678877303;9377.76555586109;9476.194523465514;9571.521423928776;9576.90423095774;9601.807963840683;39803;39849.80075099606;39948.6017989369;40083.99790005244;40160;3351.631320554737;3376.358491886558;3484.9128771780656;3509.666581674737;3528.647135286451;28562;29506.55740163899;30006;30545;30881.536776948138;3131.592892923928;3167.17653410115;3171.984140079308;3196.2968147007855;3289.4572395554706;409980;484912;487627;488272.99999999645;488995;59745;60260.69869650624;60291.39708602858;60366.69816650889;60382.09426858601;64316.67841660762;64581;64892.675536622955;64909.35090649127;65040.34959650343;13077;15944.2825072872;15994.920025400032;16036.679266414607;16038.358465661242;12846.67883302925;12900.677483062998;12909.967202623768;12919.966402687762;12919.966402687762;16992.660146797243;17175.020002682504;18838.24647014104;18915.243390264237;19188.71216931747;7180;7458.589777562286;7909.446338756232;7926.4847784894955;8203.138670439517;890.8351954888367;959.6928982725461;965.5751469353603;979.9951000244953;1016.0499932563077;29072;29764.702352976194;29788.404231915672;30521.694783052328;30597.08208753741;954.4178051388648;1024.846273059047;1044.3055368180228;1057.259918057363;1090.465671820802;14521.85478145205;16324.857259991924;16398.83601163997;16425.58936026585;17001.149942502827;670683;674256;690981;691974;909946;53272.46727532675;54258;54715.17927231095;54879;55091.724541377036;1393.5610282760897;1401.85981401859;1429.371076726258;1431.9713605727827;1436;27959.021434249702;28454.43091138124;29056.54396322913;29228.123156305344;29433.55849662214;45963.77018114888;46386.53613463957;47012.294815578476;47392.52607474019;47532.811679708284;520663;521877.7342793136;522282;522425;527705;25858.87070564635;26284.73715262823;26447.471050578497;26627.600585990836;26729.19812405631;42693.35959960665;43553.911152221444;43674.563254368324;43737.343939841565;43849.78075109604;28169;35339.823300883334;35631.82184089063;35749.92750217498;36888.44667329938;35496.46755298621;35943.64056359403;36256.818715907306;36269.63730362662;36410.63589364073;35875.64124358723;35892.64107358998;36585.817070914476;36592.45111323279;38017.809910950265;32257.838710806296;33611.714793490966;33825.15437114092;33888;34162.48756268708;24729.1344802931;25233.747662523874;25556;25635.949124069655;25967.480650386507 05:17:22 INFO - PROCESS | 2572 | |2;jquery.html;340.29728610419465;367.5791219054183;385.6240165838308;392.7918203352223;414.9709520333576;19309.903450482747;19997.400077997667;20360.67655602385;20638.277660281892;20716.585668286625;20122.19511219553;20163.899180504115;20433.97830108496;20635.968201589934;20713.896430517863;4503.977480112595;5475.397706252329;5764.135379693038;5789.507891829189;5973.313068997056;5776.711164441782;5823.505002074829;5921.200637913869;5926.288845338566;6124.326324104345;5151.253068305094;6099.878002439971;6146.231721034871;6160.414760597736;6180.81457556274;5991.161237426763;6139.171211886405;6662.467002639777;6691.598504089721;6729.22613899398;5068.366454193226;5096.79612815487;5927.851803704899;5963.552733544958;5969.313528944183;13277.53528626503;13417.46330146793;23451;24103.91532381047;24341.756582434125;2237.59723249815;2336.3925379401308;2351.564960482316;2728.7680547153514;2824.997126020274;9622.615095396246;9930.602775888956;10117.268337548821;10439.008294212037;10734.838977415346;1754.4911975527082;1930.8165724256173;1942;1944.6402415553168;1959.470942845438;118111;124500;126693.46613067779;128787.35606322002;131062.34468827595;9613.279004074722;11163.218574699693;11625.360605166628;11781.882181178249;12132.63602091921;14775;14784.965052446225;14796.778048329285;14811.963162578731;14830;8456.577171141418;8709.738707838775;8781.990071141772;8883.911160888438;8947.865782013276;7253.274672532704;7316.707331706779;8717.825643487095;8735.912640873637;8745.868811967826;4496.7077139985795;4521.615662668644;4627.490975992638;4646.790894409692;4675.129948020751;1630.7716919631262;1721.7073097573443;1725.5858593937364;2023.1199428248758;2052.4971382011504;862.2584577263548;924.5746956400131;971.4851128901694;981.4847205217176;1016.9593216271414;20456.488587785127;20938.895305523376;20995.47511312199;21047.473813154793;21104.261350852645;932.2572950624123;937.1752857485369;966.8646389505475;969.2343048991359;985.7289245457556;8598.699045533502;9069.911610606638;10799.76415801415;11122;11157.330560166416;597516.0372594415;611978;617118;624018;630996;112563.43718281356;127418;129521;130611.69388306186;133708;948.5636607160783;956.9282303827241;985.3693636072919;995.5868314649484;997.8923395031509;18159.727604086213;18178.72731908996;18465.353712619995;18518.629627407645;18610;52036.73981630067;56720.58198544904;57047;57592;58336.416635834794;75406;78224;79572.2042779588;80282.79575806485;80680;7161.283871612797;7360.77917662471;7390.815229619087;7477.551346919202;7796.532208067534;11197.216194866282;13078.934605327293;13092.476300947856;13451;13529.59411217665;8847.73456796297;9447.744621099344;11206.991370776343;11237.662870113909;11292.717682057686;10328.431936243578;10564.894351056391;11088.112950964065;11544.769104618028;11959.04327653803;11139.387333696724;11169.88830111721;11409.20135590534;11544.01875840563;11594;6564.573302735307;7472.29013243741;7570.545767253982;7700.306972372513;7764.262395072459;9978;11068.833967490333;11106.722331941442;11395.658130256106;11399.772004560029 05:17:22 INFO - PROCESS | 2572 | |3;mootools.html;1390.652336915771;1493.6863258715669;1696.5249730075575;1838.3473866777285;1907.988765954044;7553.924460755391;7821.178776228499;8094.91905080949;8490.27832634226;8492.235698787108;6975.1978522469935;7665.4634175607725;8306.626201820918;8387.203215694499;8409.411341206118;2348.7416384197722;2352.0591763294733;2353.752855950126;2380.8690522021284;2396.880155992202;2341.7072865891764;2383.7139543254834;2395.2454976682375;2401;2429.1133736186252;2344.0623750499853;2349.89425475854;2379.1078345620394;2383.511380167062;2384.177458776719;2320.3039088273536;2339.649052642117;2340.0639744102323;2357.0571771291447;2365.7042869641296;2336.4509340305185;2374.1215750172373;2379;2400.255920664582;2401.8438801477846;8242.093369729386;8290.792730181794;8305.626246818847;8339.83320333596;8463;5082.974585127051;5206.843794686166;5224.0074385866565;5249.527542521191;5257.185136303879;3417.5044618530173;3516.279162771651;3517.683408493248;3541.451075083366;3593.730470214718;1077.2351630342466;1077.342820879263;1101.2676570080887;1119.0488085127658;1123.129574579699;9129.908700913038;10957.616483423122;10958.56165753369;10970.506327215295;10974.945125274322;4458.598726114666;4657.767111644472;4762.833300834454;4763.7141771493825;4769.928451073237;9456.148946594702;9479.383840050376;9496.335256531976;9501.334906556613;9502;5217.191335343028;5231.450697676765;5240.423553409122;5255.553277971415;5271.947280527223;4356.499002614676;4364.60332693535;4748.857534273978;4802.039592081528;4829.879253018632;3806.467094606757;3872.186840763471;3889.649931506178;3947.4078888167005;3978.0651546886456;1284.1652925598435;1294.087668193921;1294.7345794112373;1300.057458342694;1301.3948513941064;829.3531045784298;912.6668765900531;916.4134953629682;926.3284119013796;928;5574.58190635704;5749.655020698771;5833.38749431312;5893.5579831512805;6049.032154855202;459.43030642004345;461.42552522110185;471.3895505320618;980.2305190425482;1008.5713571731984;3365.9831700841337;3457.360388328117;3554.733394995386;3813.7139714521522;3843.673287770515;9890.554925028391;10050.195984321383;10134.54394552247;10168.796624067625;10196.643117490852;10109.949450252701;10144.746381340377;10148.137408320375;10155.492225388702;10244;7732.149463559004;7879.0939042010905;7895.6052197391045;7924.762257132295;7997.080335761346;5570.220169176399;5653.915191272216;5764.827055188351;5774.48029677331;5895.263092113486;8400.915990840258;8952.23905968;9104.408213466368;9196.54017299119;9359.625614975597;9345.252379809735;9417.434953902788;9444.669436569688;9523.904760952302;9603.37578057424;6687.264400915993;6885.311468853075;7094.964525177341;7225.855482890418;7346.449016323904;7846.843063138819;8103.108658047492;8106.189381061847;8108.14864439249;8110.188981101843;6222.533310001678;7141.535800172972;7256.600886951268;7272.781816545512;7387.667554959932;7148.964255178691;7160.964195178991;7170.928290717026;7177.210506844139;7288.635568221462;6777.423918966746;6803.183617965876;6829.829254268683;6836.418904392984;6842;4882.804687812448;4917.852464426073;4929.778159982881;4950.727709975986;5008.198688209869;4631.861044168681;4640.93038604428;4659.906801864012;4681.157391669532;4872.244802055687 05:17:22 INFO - PROCESS | 2572 | |4;prototype.html;316.42094966211835;320.3432962427024;322.37137581715655;324.0763823104152;326.17477781213523;5145.0481660892765;5230.6338556301025;5469.726513674315;5535.889282214358;5647.37878833328;5003.824866129687;5321.787128514855;5425.104857698475;5479.397266300713;5479.671219726819;3585.9820700896457;3984.5694126582835;4106.973256685828;4143.446207672123;4252.574742525753;3505.2288496530723;4203.285441474956;4213.768242746648;4231.894202644928;4236.428082208909;4082.3468245080794;4184.100418410041;4231.1749208904275;4233.322668373061;4235.512916014667;4167.979160104211;4180.038591124058;4253.744775313491;4257.510386305584;4257.893552661178;3185.4743967245377;3639.945400818963;3645.6172101929446;3662.432322989941;3720.8325625346924;4176.227397931392;5413.9729301353245;5465.4261302563455;5477.726113694339;5512.641678290938;4402.295632698785;4801.815174095778;4803.9039219215765;4941.258811178316;4941.629377796644;5018.096742586333;5169;5486.61593688442;5781.161731548944;5793.420657934215;3564.002079417767;3912.2371137628174;4021.477207962946;4054.9594504054876;4087.1621317629815;5630.014747419185;5891.823245302648;5942.405759424067;6108.541859360521;6217.440430361244;3670.339338918967;4145.491977353718;4147.8963025924595;4163.8334466621;4175.457190565207;4187.937180942288;4217.177650358212;4226.915461690749;4236.745795252295;4246.936295955563;4307.741535507879;4530.799338175386;4799;4825.734584597881;4838.879028024327;5090.10923088458;5571.904650082186;5835.299764028259;5848.824535263949;5857.970710146507;1312.337269678806;1316.7432350691715;1353.7766268565774;1370.9108907920954;1384.1764150330537;869.4218344800763;871.8430682477089;937.8604994931192;945.8628498867763;948.2745699539857;4371.568318869672;4377;4700.929486057712;4702.9764851176205;5060.84817455477;4746.588888666923;4948.935978764511;5125.103711626647;5537.6954267515675;5605.215269862222;4284.857571214393;4793.285203966953;5085.973845561884;5219.399769026611;5227.098960077117;2309.907603695867;2701.392186758003;2955.138262894363;2957.5267957126757;3022.9848850755607;4906.2640603909695;5417.404085550586;5589.9099675562875;5805.535557155417;5906.8651943639625;5395.73021348931;5534;5640.730835561966;5783;5906.970465147732;5425.12468391753;5537.975474537143;5629.958457685341;5916.585838991229;5928.614640048383;4740.6444516660695;5445.53712934405;5493.807716729895;5604.495595396434;5674.971625141848;4494.393256910275;4851;5451.591130665137;5520.227168196536;5565.998120338378;5216.582673386196;5507.752151153128;5752.734398432338;5787.5692209271365;5953.970230148995;3277.8033318001;3426.811525366029;3801.619838016287;3833.195029043932;3838.865639702597;4926.679765815211;5148.330717006766;5243.842684719464;5295.338082739658;5647.745851436613;4530.660200484911;5366.919496207482;5424.593155513273;5448.182772584144;5535.501804837584;4739.739314337607;4833.250846118857;4953.2074868020945;5404.78380864761;5479;4843.176659967743;5044.470330615232;5722.370539240764;5753.712314384347;5853.853653658693;4652.9294463963215;4791.976040119777;5409.998300628792;5908.223135126484;5957.366006735974;5051.393832740095;5762.683052432157;5803.187553742564;5805.680687562056;5829.3296270927685 05:17:22 INFO - PROCESS | 2572 | |5;yui.html;697.7767114523352;704.0741425026088;770.4997283814024;775.3719487215352;797.2545669798736;14377.353019114138;15186.468473603398;15190.54428367148;15217.163056031914;15285.923570382147;13691.863081369183;13700.451981920736;13717.58847234582;13731.725365492684;13862.514811981582;656.8916128838736;690.6029033305845;790.0006491787864;835.8996920369534;838.9790255243622;842.7008412013739;850.3027517435705;858.0818524179131;859.9699010534632;862.9395942284043;908.636545381846;921.8525035994243;927.2952556057411;927.8840144981878;927.9860802087974;771.7106085218044;871.5511511571545;883.2492381475759;919.384012711485;923.6582464488115;667.6861874918781;681.465049935798;685.6023506366296;689.5724650716538;692.972281108755;13511;13543.796843047363;13905.930470347583;14023.228722420263;14453.566393008226;12653.810192847115;12689.428975696115;12892.290923999177;12900.03249756272;14006.94947878913;9245.982941876387;9662.75843103921;9923.553440095213;11083.168762342857;11582;3665.8350374233223;3712.350338690718;3760.097576581628;3891.1633998690418;3893.3186692328727;90994;92089.53955230181;94485.52757236239;94731.00055494717;96708.06583868354;9083.834383349013;10379.429131397694;10641.201909856636;10678.51946662402;10759.892401076046;20384.796152038587;20559.8972005139;20576;20594;20600.58798824015;7516.887246691304;7712.074551053909;7741.264579864904;8029.197080291924;8055.677772889018;4250.468691413574;4260.531341552489;4291.592298731615;4408.7375342246505;4581.427321584802;3370.9662903370654;3437.2609888874013;3458.8962331130106;3470.410030294856;3476.3047390521997;620.6369273974775;627.5983370642792;646.8382904273932;650.3464018661215;651.5829868883918;623.1680706257107;631.3465563142125;657.3098246840798;661.5865084322298;672.3746915368656;9123.908760912438;9287.442753434816;9356.859647105299;9406.38858474197;9674.70975870725;541.3638974205372;689.5449003657562;696.7178292791427;707.1726080485844;715.2918610575597;4232.4286221360335;4636.930446043312;4644.117617652635;4660.370849935283;4767.427908650984;115802;119714;120515;120725;126350;102087;102538;103429;103793;105007;73594.8960765589;91877;93171;93371.06628933623;94896;8744.606492707971;9682.370645908275;9735.513224338612;10177.745556361151;10198.694039178836;43442;53082.20376694275;54112.45887541074;54115;55760.605984849084;53888;54860.45139548713;57835.421645783004;63600;74738;10955.671329860117;11333.659990200307;12376.876231237573;12491.250524968531;12654.620361389174;12210.633680989584;13173.31345508759;13618.547202231006;14264.07283526609;14402.20787856678;13106.475740970254;13485.460581576626;13551.52569660057;13713.794293085812;14163.858361416666;11688.240264382788;12889.548865789653;13381.464741410235;13840.377183026587;13847.584572462842;12663.810042849549;12759.425825837674;13267.46930122823;13691.041627086008;13730.794038089636;10635.255532112678;11114.333140011302;11146.05258553032;11574.247673901169;11784.351860647404;9950.900490995287;10351.43067131315;10869.728256793644;10941.945290273497;11177.944110279723 05:17:22 INFO - PROCESS | 2572 | __end_tp_report 05:17:22 INFO - PROCESS | 2572 | __start_cc_report 05:17:22 INFO - PROCESS | 2572 | _x_x_mozilla_cycle_collect,369 05:17:22 INFO - PROCESS | 2572 | __end_cc_report 05:17:22 INFO - PROCESS | 2572 | __startTimestamp1487769442898__endTimestamp 05:17:22 INFO - PROCESS | 2572 | 05:17:22 INFO - PROCESS | 2572 | ------- Summary: start ------- 05:17:22 INFO - PROCESS | 2572 | Number of tests: 6 05:17:22 INFO - PROCESS | 2572 | 05:17:22 INFO - PROCESS | 2572 | [#0] dojo.html Cycles:165 Average:5845.75 Median:6112.79 stddev:643.21 (10.5%) stddev-sans-first:614.65 05:17:22 INFO - PROCESS | 2572 | Values: 3349.4 3532.2 3546.7 3568.9 3580.4 5897.2 5911.5 5977.3 5985.6 6007.2 5919.9 6000.9 6031.2 6034.0 6061.9 5317.9 5321.3 5361.4 5365.0 5458.6 4512.7 5388.2 5418.0 5420.4 5427.3 5251.4 5267.1 5410.9 5417.0 5438.8 4446.0 5341.0 5359.4 5380.5 5383.8 5213.3 5318.0 5319.8 5336.5 5367.5 5969.1 5996.5 6017.4 6018.9 6033.6 5090.7 5887.8 6136.7 6171.2 6210.6 5252.7 6208.7 6306.9 6307.2 6342.3 6025.2 6046.1 6048.8 6055.4 6065.3 6177.6 6249.2 6470.8 6527.7 6528.7 6082.9 6106.2 6115.8 6117.1 6160.7 6214.2 6259.4 6331.3 6345.2 6392.2 6128.4 6232.9 6238.5 6239.3 6241.3 6125.7 6173.7 6214.3 6228.4 6231.2 5061.3 5078.6 5089.8 5093.9 5109.1 4486.5 4488.2 4508.2 4570.2 4572.9 5914.9 5973.0 6062.9 6083.1 6112.8 6328.7 6335.7 6344.2 6363.6 6376.7 5931.0 6033.6 6047.7 6071.5 6096.7 5538.6 5544.5 5574.1 5602.5 5629.2 6496.0 6499.4 6535.1 6538.3 6555.8 6155.5 6209.0 6285.7 6368.1 6385.3 6417.9 6448.4 6464.7 6576.8 6579.4 6225.5 6237.7 6237.8 6245.2 6254.6 6143.1 6191.2 6329.9 6351.9 6378.9 5096.3 6153.2 6176.3 6185.9 6207.5 6157.2 6186.8 6191.8 6206.8 6212.3 5167.8 5380.5 6134.2 6152.0 6199.4 6136.0 6138.2 6156.4 6196.3 6198.9 6130.5 6160.2 6160.2 6164.1 6195.0 05:17:22 INFO - PROCESS | 2572 | 05:17:22 INFO - PROCESS | 2572 | [#1] ext.html Cycles:180 Average:70107.74 Median:40036.60 stddev:157524.52 (393.5%) stddev-sans-first:157879.81 05:17:22 INFO - PROCESS | 2572 | Values: 534.5 544.1 544.3 545.9 554.1 38469.0 39909.8 40004.6 40068.6 42245.9 41544.2 42098.9 42150.6 42240.6 42269.9 9472.6 9656.0 9676.6 9684.9 9692.0 9427.7 9513.5 9514.5 9527.3 9531.0 8182.7 9330.8 9498.8 9559.3 9563.4 9329.6 9441.9 9527.5 9530.5 9533.2 9377.8 9476.2 9571.5 9576.9 9601.8 39803.0 39849.8 39948.6 40084.0 40160.0 3351.6 3376.4 3484.9 3509.7 3528.6 28562.0 29506.6 30006.0 30545.0 30881.5 3131.6 3167.2 3172.0 3196.3 3289.5 409980.0 484912.0 487627.0 488273.0 488995.0 59745.0 60260.7 60291.4 60366.7 60382.1 64316.7 64581.0 64892.7 64909.4 65040.3 13077.0 15944.3 15994.9 16036.7 16038.4 12846.7 12900.7 12910.0 12920.0 12920.0 16992.7 17175.0 18838.2 18915.2 19188.7 7180.0 7458.6 7909.4 7926.5 8203.1 890.8 959.7 965.6 980.0 1016.0 29072.0 29764.7 29788.4 30521.7 30597.1 954.4 1024.8 1044.3 1057.3 1090.5 14521.9 16324.9 16398.8 16425.6 17001.1 670683.0 674256.0 690981.0 691974.0 909946.0 53272.5 54258.0 54715.2 54879.0 55091.7 1393.6 1401.9 1429.4 1432.0 1436.0 27959.0 28454.4 29056.5 29228.1 29433.6 45963.8 46386.5 47012.3 47392.5 47532.8 520663.0 521877.7 522282.0 522425.0 527705.0 25858.9 26284.7 26447.5 26627.6 26729.2 42693.4 43553.9 43674.6 43737.3 43849.8 28169.0 35339.8 35631.8 35749.9 36888.4 35496.5 35943.6 36256.8 36269.6 36410.6 35875.6 35892.6 36585.8 36592.5 38017.8 32257.8 33611.7 33825.2 33888.0 34162.5 24729.1 25233.7 25556.0 25635.9 25967.5 05:17:22 INFO - PROCESS | 2572 | 05:17:22 INFO - PROCESS | 2572 | [#2] jquery.html Cycles:180 Average:35614.28 Median:389.21 stddev:102943.57 (26449.5%) stddev-sans-first:103198.28 05:17:22 INFO - PROCESS | 2572 | Values: 340.3 367.6 385.6 392.8 415.0 19309.9 19997.4 20360.7 20638.3 20716.6 20122.2 20163.9 20434.0 20636.0 20713.9 4504.0 5475.4 5764.1 5789.5 5973.3 5776.7 5823.5 5921.2 5926.3 6124.3 5151.3 6099.9 6146.2 6160.4 6180.8 5991.2 6139.2 6662.5 6691.6 6729.2 5068.4 5096.8 5927.9 5963.6 5969.3 13277.5 13417.5 23451.0 24103.9 24341.8 2237.6 2336.4 2351.6 2728.8 2825.0 9622.6 9930.6 10117.3 10439.0 10734.8 1754.5 1930.8 1942.0 1944.6 1959.5 118111.0 124500.0 126693.5 128787.4 131062.3 9613.3 11163.2 11625.4 11781.9 12132.6 14775.0 14785.0 14796.8 14812.0 14830.0 8456.6 8709.7 8782.0 8883.9 8947.9 7253.3 7316.7 8717.8 8735.9 8745.9 4496.7 4521.6 4627.5 4646.8 4675.1 1630.8 1721.7 1725.6 2023.1 2052.5 862.3 924.6 971.5 981.5 1017.0 20456.5 20938.9 20995.5 21047.5 21104.3 932.3 937.2 966.9 969.2 985.7 8598.7 9069.9 10799.8 11122.0 11157.3 597516.0 611978.0 617118.0 624018.0 630996.0 112563.4 127418.0 129521.0 130611.7 133708.0 948.6 956.9 985.4 995.6 997.9 18159.7 18178.7 18465.4 18518.6 18610.0 52036.7 56720.6 57047.0 57592.0 58336.4 75406.0 78224.0 79572.2 80282.8 80680.0 7161.3 7360.8 7390.8 7477.6 7796.5 11197.2 13078.9 13092.5 13451.0 13529.6 8847.7 9447.7 11207.0 11237.7 11292.7 10328.4 10564.9 11088.1 11544.8 11959.0 11139.4 11169.9 11409.2 11544.0 11594.0 6564.6 7472.3 7570.5 7700.3 7764.3 9978.0 11068.8 11106.7 11395.7 11399.8 05:17:22 INFO - PROCESS | 2572 | 05:17:22 INFO - PROCESS | 2572 | [#3] mootools.html Cycles:180 Average:5463.05 Median:4979.46 stddev:2964.14 (59.5%) stddev-sans-first:2956.65 05:17:22 INFO - PROCESS | 2572 | Values: 1390.7 1493.7 1696.5 1838.3 1908.0 7553.9 7821.2 8094.9 8490.3 8492.2 6975.2 7665.5 8306.6 8387.2 8409.4 2348.7 2352.1 2353.8 2380.9 2396.9 2341.7 2383.7 2395.2 2401.0 2429.1 2344.1 2349.9 2379.1 2383.5 2384.2 2320.3 2339.6 2340.1 2357.1 2365.7 2336.5 2374.1 2379.0 2400.3 2401.8 8242.1 8290.8 8305.6 8339.8 8463.0 5083.0 5206.8 5224.0 5249.5 5257.2 3417.5 3516.3 3517.7 3541.5 3593.7 1077.2 1077.3 1101.3 1119.0 1123.1 9129.9 10957.6 10958.6 10970.5 10974.9 4458.6 4657.8 4762.8 4763.7 4769.9 9456.1 9479.4 9496.3 9501.3 9502.0 5217.2 5231.5 5240.4 5255.6 5271.9 4356.5 4364.6 4748.9 4802.0 4829.9 3806.5 3872.2 3889.6 3947.4 3978.1 1284.2 1294.1 1294.7 1300.1 1301.4 829.4 912.7 916.4 926.3 928.0 5574.6 5749.7 5833.4 5893.6 6049.0 459.4 461.4 471.4 980.2 1008.6 3366.0 3457.4 3554.7 3813.7 3843.7 9890.6 10050.2 10134.5 10168.8 10196.6 10109.9 10144.7 10148.1 10155.5 10244.0 7732.1 7879.1 7895.6 7924.8 7997.1 5570.2 5653.9 5764.8 5774.5 5895.3 8400.9 8952.2 9104.4 9196.5 9359.6 9345.3 9417.4 9444.7 9523.9 9603.4 6687.3 6885.3 7095.0 7225.9 7346.4 7846.8 8103.1 8106.2 8108.1 8110.2 6222.5 7141.5 7256.6 7272.8 7387.7 7149.0 7161.0 7170.9 7177.2 7288.6 6777.4 6803.2 6829.8 6836.4 6842.0 4882.8 4917.9 4929.8 4950.7 5008.2 4631.9 4640.9 4659.9 4681.2 4872.2 05:17:22 INFO - PROCESS | 2572 | 05:17:22 INFO - PROCESS | 2572 | [#4] prototype.html Cycles:180 Average:4544.82 Median:4978.52 stddev:1363.20 (27.4%) stddev-sans-first:1329.57 05:17:22 INFO - PROCESS | 2572 | Values: 316.4 320.3 322.4 324.1 326.2 5145.0 5230.6 5469.7 5535.9 5647.4 5003.8 5321.8 5425.1 5479.4 5479.7 3586.0 3984.6 4107.0 4143.4 4252.6 3505.2 4203.3 4213.8 4231.9 4236.4 4082.3 4184.1 4231.2 4233.3 4235.5 4168.0 4180.0 4253.7 4257.5 4257.9 3185.5 3639.9 3645.6 3662.4 3720.8 4176.2 5414.0 5465.4 5477.7 5512.6 4402.3 4801.8 4803.9 4941.3 4941.6 5018.1 5169.0 5486.6 5781.2 5793.4 3564.0 3912.2 4021.5 4055.0 4087.2 5630.0 5891.8 5942.4 6108.5 6217.4 3670.3 4145.5 4147.9 4163.8 4175.5 4187.9 4217.2 4226.9 4236.7 4246.9 4307.7 4530.8 4799.0 4825.7 4838.9 5090.1 5571.9 5835.3 5848.8 5858.0 1312.3 1316.7 1353.8 1370.9 1384.2 869.4 871.8 937.9 945.9 948.3 4371.6 4377.0 4700.9 4703.0 5060.8 4746.6 4948.9 5125.1 5537.7 5605.2 4284.9 4793.3 5086.0 5219.4 5227.1 2309.9 2701.4 2955.1 2957.5 3023.0 4906.3 5417.4 5589.9 5805.5 5906.9 5395.7 5534.0 5640.7 5783.0 5907.0 5425.1 5538.0 5630.0 5916.6 5928.6 4740.6 5445.5 5493.8 5604.5 5675.0 4494.4 4851.0 5451.6 5520.2 5566.0 5216.6 5507.8 5752.7 5787.6 5954.0 3277.8 3426.8 3801.6 3833.2 3838.9 4926.7 5148.3 5243.8 5295.3 5647.7 4530.7 5366.9 5424.6 5448.2 5535.5 4739.7 4833.3 4953.2 5404.8 5479.0 4843.2 5044.5 5722.4 5753.7 5853.9 4652.9 4792.0 5410.0 5908.2 5957.4 5051.4 5762.7 5803.2 5805.7 5829.3 05:17:22 INFO - PROCESS | 2572 | 05:17:22 INFO - PROCESS | 2572 | [#5] yui.html Cycles:180 Average:20954.20 Median:23866.80 stddev:31551.11 (132.2%) stddev-sans-first:31602.96 05:17:22 INFO - PROCESS | 2572 | Values: 697.8 704.1 770.5 775.4 797.3 14377.4 15186.5 15190.5 15217.2 15285.9 13691.9 13700.5 13717.6 13731.7 13862.5 656.9 690.6 790.0 835.9 839.0 842.7 850.3 858.1 860.0 862.9 908.6 921.9 927.3 927.9 928.0 771.7 871.6 883.2 919.4 923.7 667.7 681.5 685.6 689.6 693.0 13511.0 13543.8 13905.9 14023.2 14453.6 12653.8 12689.4 12892.3 12900.0 14006.9 9246.0 9662.8 9923.6 11083.2 11582.0 3665.8 3712.4 3760.1 3891.2 3893.3 90994.0 92089.5 94485.5 94731.0 96708.1 9083.8 10379.4 10641.2 10678.5 10759.9 20384.8 20559.9 20576.0 20594.0 20600.6 7516.9 7712.1 7741.3 8029.2 8055.7 4250.5 4260.5 4291.6 4408.7 4581.4 3371.0 3437.3 3458.9 3470.4 3476.3 620.6 627.6 646.8 650.3 651.6 623.2 631.3 657.3 661.6 672.4 9123.9 9287.4 9356.9 9406.4 9674.7 541.4 689.5 696.7 707.2 715.3 4232.4 4636.9 4644.1 4660.4 4767.4 115802.0 119714.0 120515.0 120725.0 126350.0 102087.0 102538.0 103429.0 103793.0 105007.0 73594.9 91877.0 93171.0 93371.1 94896.0 8744.6 9682.4 9735.5 10177.7 10198.7 43442.0 53082.2 54112.5 54115.0 55760.6 53888.0 54860.5 57835.4 63600.0 74738.0 10955.7 11333.7 12376.9 12491.3 12654.6 12210.6 13173.3 13618.5 14264.1 14402.2 13106.5 13485.5 13551.5 13713.8 14163.9 11688.2 12889.5 13381.5 13840.4 13847.6 12663.8 12759.4 13267.5 13691.0 13730.8 10635.3 11114.3 11146.1 11574.2 11784.4 9950.9 10351.4 10869.7 10941.9 11177.9 05:17:22 INFO - PROCESS | 2572 | -------- Summary: end -------- 05:17:22 INFO - PROCESS | 2572 | 05:17:23 INFO - TEST-INFO | 2572: exit 0 05:17:23 INFO - TEST-OK | dromaeo_css | took 1115962ms 05:17:23 INFO - TEST-START | kraken 05:17:23 INFO - operating with platform_type : mac_ 05:17:23 INFO - Initialising browser for kraken test... 05:17:23 INFO - TEST-INFO | started process 2576 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmphdHebp/profile http://localhost:58643/getInfo.html) 05:17:26 INFO - PROCESS | 2576 | 2017-02-22 05:17:26.187 plugin-container[2578:37073] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 05:17:26 INFO - PROCESS | 2576 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:17:26 INFO - PROCESS | 2576 | 2017-02-22 05:17:26.188 plugin-container[2578:37073] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0f, name = 'com.apple.CFPasteboardClient' 05:17:26 INFO - PROCESS | 2576 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:17:26 INFO - PROCESS | 2576 | 2017-02-22 05:17:26.188 plugin-container[2578:37073] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:17:26 INFO - PROCESS | 2576 | __metrics Screen width/height:1600/1200 05:17:26 INFO - PROCESS | 2576 | colorDepth:24 05:17:26 INFO - PROCESS | 2576 | Browser inner width/height: 1024/689 05:17:26 INFO - PROCESS | 2576 | __metrics 05:17:26 ERROR - PROCESS | 2576 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 05:17:27 INFO - TEST-INFO | 2576: exit 0 05:17:27 INFO - Browser initialized. 05:17:27 INFO - Running cycle 1/1 for kraken test... 05:17:27 INFO - TEST-INFO | started process 2579 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmphdHebp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:29 INFO - PROCESS | 2579 | 2017-02-22 05:17:29.562 plugin-container[2580:37197] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444f, name = 'com.apple.tsm.portname' 05:17:29 INFO - PROCESS | 2579 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:17:29 INFO - PROCESS | 2579 | 2017-02-22 05:17:29.562 plugin-container[2580:37197] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 05:17:29 INFO - PROCESS | 2579 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:17:29 INFO - PROCESS | 2579 | 2017-02-22 05:17:29.562 plugin-container[2580:37197] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:17:39 INFO - PROCESS | 2579 | RSS: Main: 177647616 05:17:39 INFO - PROCESS | 2579 | 05:17:42 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58643/tests/kraken/driver.html?testName=audio-beat-detection) 05:17:43 INFO - PROCESS | 2579 | RSS: Main: 190619648 05:17:43 INFO - PROCESS | 2579 | 05:17:45 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58643/tests/kraken/driver.html?testName=audio-dft) 05:17:46 INFO - PROCESS | 2579 | RSS: Main: 198471680 05:17:46 INFO - PROCESS | 2579 | 05:17:49 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58643/tests/kraken/driver.html?testName=audio-fft) 05:17:50 INFO - PROCESS | 2579 | RSS: Main: 202776576 05:17:50 INFO - PROCESS | 2579 | 05:17:52 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58643/tests/kraken/driver.html?testName=audio-oscillator) 05:17:52 INFO - PROCESS | 2579 | RSS: Main: 203755520 05:17:52 INFO - PROCESS | 2579 | 05:17:54 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58643/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:17:55 INFO - PROCESS | 2579 | RSS: Main: 203714560 05:17:55 INFO - PROCESS | 2579 | 05:17:58 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58643/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:58 INFO - PROCESS | 2579 | RSS: Main: 207540224 05:17:58 INFO - PROCESS | 2579 | 05:18:02 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58643/tests/kraken/driver.html?testName=imaging-desaturate) 05:18:02 INFO - PROCESS | 2579 | RSS: Main: 208543744 05:18:02 INFO - PROCESS | 2579 | 05:18:05 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58643/tests/kraken/driver.html?testName=json-parse-financial) 05:18:06 INFO - PROCESS | 2579 | RSS: Main: 207982592 05:18:06 INFO - PROCESS | 2579 | 05:18:07 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58643/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:18:08 INFO - PROCESS | 2579 | RSS: Main: 207138816 05:18:08 INFO - PROCESS | 2579 | 05:18:10 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58643/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:18:11 INFO - PROCESS | 2579 | RSS: Main: 207175680 05:18:11 INFO - PROCESS | 2579 | 05:18:13 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58643/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:18:13 INFO - PROCESS | 2579 | RSS: Main: 207171584 05:18:13 INFO - PROCESS | 2579 | 05:18:16 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58643/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:18:17 INFO - PROCESS | 2579 | RSS: Main: 207253504 05:18:17 INFO - PROCESS | 2579 | 05:18:20 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58643/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:18:20 INFO - PROCESS | 2579 | RSS: Main: 207589376 05:18:20 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | Cycle 1(1): loaded http://localhost:58643/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58643/tests/kraken/driver.html?testName=ai-astar) 05:18:22 INFO - PROCESS | 2579 | RSS: Main: 209256448 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | __start_tp_report 05:18:22 INFO - PROCESS | 2579 | _x_x_mozilla_page_load 05:18:22 INFO - PROCESS | 2579 | _x_x_mozilla_page_load_details 05:18:22 INFO - PROCESS | 2579 | |i|pagename|runs| 05:18:22 INFO - PROCESS | 2579 | |0;ai-astar;114;132;171;177;115;118;116;117;115;118 05:18:22 INFO - PROCESS | 2579 | |1;audio-beat-detection;159;110;110;142;110;109;109;114;136;108 05:18:22 INFO - PROCESS | 2579 | |2;audio-dft;192;201;195;194;197;196;199;222;225;196 05:18:22 INFO - PROCESS | 2579 | |3;audio-fft;82;65;61;89;74;85;83;60;76;58 05:18:22 INFO - PROCESS | 2579 | |4;audio-oscillator;100;100;76;95;62;75;115;57;85;103 05:18:22 INFO - PROCESS | 2579 | |5;imaging-gaussian-blur;93;88;90;88;99;131;119;104;90;86 05:18:22 INFO - PROCESS | 2579 | |6;imaging-darkroom;100;102;105;136;104;156;168;108;114;100 05:18:22 INFO - PROCESS | 2579 | |7;imaging-desaturate;114;143;133;78;137;131;90;91;89;72 05:18:22 INFO - PROCESS | 2579 | |8;json-parse-financial;55;56;55;56;58;60;61;60;59;60 05:18:22 INFO - PROCESS | 2579 | |9;json-stringify-tinderbox;71;71;72;77;70;67;69;71;71;72 05:18:22 INFO - PROCESS | 2579 | |10;stanford-crypto-aes;80;84;82;83;87;82;83;86;81;82 05:18:22 INFO - PROCESS | 2579 | |11;stanford-crypto-ccm;151;158;144;143;147;161;142;147;209;166 05:18:22 INFO - PROCESS | 2579 | |12;stanford-crypto-pbkdf2;163;167;161;162;166;165;161;168;165;166 05:18:22 INFO - PROCESS | 2579 | |13;stanford-crypto-sha256-iterative;68;67;66;65;67;66;67;66;65;72 05:18:22 INFO - PROCESS | 2579 | __end_tp_report 05:18:22 INFO - PROCESS | 2579 | __start_cc_report 05:18:22 INFO - PROCESS | 2579 | _x_x_mozilla_cycle_collect,938 05:18:22 INFO - PROCESS | 2579 | __end_cc_report 05:18:22 INFO - PROCESS | 2579 | __startTimestamp1487769502753__endTimestamp 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | ------- Summary: start ------- 05:18:22 INFO - PROCESS | 2579 | Number of tests: 14 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#0] ai-astar Cycles:10 Average:129.30 Median:118.00 stddev:24.15 (20.5%) stddev-sans-first:24.97 05:18:22 INFO - PROCESS | 2579 | Values: 114.0 132.0 171.0 177.0 115.0 118.0 116.0 117.0 115.0 118.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:112.00 stddev:18.19 (16.2%) stddev-sans-first:12.98 05:18:22 INFO - PROCESS | 2579 | Values: 159.0 110.0 110.0 142.0 110.0 109.0 109.0 114.0 136.0 108.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#2] audio-dft Cycles:10 Average:201.70 Median:198.00 stddev:11.78 (5.9%) stddev-sans-first:11.96 05:18:22 INFO - PROCESS | 2579 | Values: 192.0 201.0 195.0 194.0 197.0 196.0 199.0 222.0 225.0 196.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#3] audio-fft Cycles:10 Average:73.30 Median:79.00 stddev:11.51 (14.6%) stddev-sans-first:11.77 05:18:22 INFO - PROCESS | 2579 | Values: 82.0 65.0 61.0 89.0 74.0 85.0 83.0 60.0 76.0 58.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:68.50 stddev:18.96 (27.7%) stddev-sans-first:19.50 05:18:22 INFO - PROCESS | 2579 | Values: 100.0 100.0 76.0 95.0 62.0 75.0 115.0 57.0 85.0 103.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#5] imaging-gaussian-blur Cycles:10 Average:98.80 Median:89.00 stddev:15.12 (17.0%) stddev-sans-first:15.89 05:18:22 INFO - PROCESS | 2579 | Values: 93.0 88.0 90.0 88.0 99.0 131.0 119.0 104.0 90.0 86.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#6] imaging-darkroom Cycles:10 Average:119.30 Median:111.00 stddev:25.02 (22.5%) stddev-sans-first:25.55 05:18:22 INFO - PROCESS | 2579 | Values: 100.0 102.0 105.0 136.0 104.0 156.0 168.0 108.0 114.0 100.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#7] imaging-desaturate Cycles:10 Average:107.80 Median:75.00 stddev:26.72 (35.6%) stddev-sans-first:28.25 05:18:22 INFO - PROCESS | 2579 | Values: 114.0 143.0 133.0 78.0 137.0 131.0 90.0 91.0 89.0 72.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:59.50 stddev:2.31 (3.9%) stddev-sans-first:2.18 05:18:22 INFO - PROCESS | 2579 | Values: 55.0 56.0 55.0 56.0 58.0 60.0 61.0 60.0 59.0 60.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:2.56 (3.6%) stddev-sans-first:2.71 05:18:22 INFO - PROCESS | 2579 | Values: 71.0 71.0 72.0 77.0 70.0 67.0 69.0 71.0 71.0 72.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:2.16 (2.6%) stddev-sans-first:2.00 05:18:22 INFO - PROCESS | 2579 | Values: 80.0 84.0 82.0 83.0 87.0 82.0 83.0 86.0 81.0 82.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#11] stanford-crypto-ccm Cycles:10 Average:156.80 Median:154.50 stddev:20.08 (13.0%) stddev-sans-first:21.18 05:18:22 INFO - PROCESS | 2579 | Values: 151.0 158.0 144.0 143.0 147.0 161.0 142.0 147.0 209.0 166.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:165.50 stddev:2.50 (1.5%) stddev-sans-first:2.60 05:18:22 INFO - PROCESS | 2579 | Values: 163.0 167.0 161.0 162.0 166.0 165.0 161.0 168.0 165.0 166.0 05:18:22 INFO - PROCESS | 2579 | 05:18:22 INFO - PROCESS | 2579 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:2.02 (3.0%) stddev-sans-first:2.11 05:18:22 INFO - PROCESS | 2579 | Values: 68.0 67.0 66.0 65.0 67.0 66.0 67.0 66.0 65.0 72.0 05:18:22 INFO - PROCESS | 2579 | -------- Summary: end -------- 05:18:22 INFO - PROCESS | 2579 | 05:18:23 INFO - TEST-INFO | 2579: exit 0 05:18:23 INFO - TEST-OK | kraken | took 60191ms 05:18:23 INFO - SUITE-END | took 1176s 05:18:23 INFO - Completed test suite (00:19:36) 05:18:23 INFO - javascript benchmark 05:18:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7258.247511273071, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.4305967985442, 3532.2052538178914, 3546.7339949503794, 3568.857245710172, 3580.445031020193, 5897.174395584616, 5911.49752271057, 5977.312609049961, 5985.640861548311, 6007.219061522007, 5919.88160236795, 6000.909986350208, 6031.215941927543, 6034.004389275764, 6061.87876242476, 5317.9468205317935, 5321.281626980347, 5361.383440904287, 5365.0, 5458.61789674723, 4512.684112112153, 5388.245645609618, 5417.997670430963, 5420.403755586883, 5427.3215848019, 5251.396089449724, 5267.0519306525, 5410.8917821643545, 5416.972915135419, 5438.755256013469, 4446.0, 5341.03861304963, 5359.383670877841, 5380.515753582196, 5383.811566595189, 5213.348331458567, 5317.973410132963, 5319.813806516792, 5336.493033161843, 5367.490088441592, 5969.104634304846, 5996.460318571306, 6017.398260173992, 6018.909716354258, 6033.607815491979, 5090.694558326512, 5887.793927212527, 6136.672258167605, 6171.228596425447, 6210.5963112398, 5252.71110088945, 6208.689565521751, 6306.905396419057, 6307.24313082433, 6342.334054924258, 6025.246844144482, 6046.062860256668, 6048.7882924097885, 6055.394460553954, 6065.332813390523, 6177.62934223939, 6249.218847644044, 6470.773522926722, 6527.738890444424, 6528.706208220641, 6082.939170608326, 6106.236720409949, 6115.757578773014, 6117.113018612276, 6160.691965401712, 6214.223222097238, 6259.405356491126, 6331.303556608769, 6345.17512723343, 6392.20097487814, 6128.380904898417, 6232.937670623236, 6238.469730072904, 6239.344868788802, 6241.282252540925, 6125.693715314216, 6173.722182501798, 6214.2542894852, 6228.439440450381, 6231.22109736283, 5061.342025536656, 5078.619103567247, 5089.821856235014, 5093.923591146062, 5109.131447653907, 4486.461624605068, 4488.192125417391, 4508.1659892919915, 4570.154521413549, 4572.862814115582, 5914.9112763308585, 5973.0, 6062.878742425127, 6083.148359229712, 6112.786052488142, 6328.71520781566, 6335.68321583919, 6344.238691357066, 6363.5863668861375, 6376.681165941684, 5931.0213814720955, 6033.607815491979, 6047.667378294236, 6071.483923866433, 6096.72564734588, 5538.612297139242, 5544.528715059265, 5574.108142697149, 5602.52378547828, 5629.24005259293, 6495.999999999905, 6499.38255865692, 6535.117759102651, 6538.280789113193, 6555.770548030796, 6155.507559395148, 6209.0, 6285.717142728497, 6368.108464815023, 6385.265694445198, 6417.8716425672155, 6448.387403196689, 6464.709088090953, 6576.76981305652, 6579.374959378852, 6225.533085018732, 6237.7193026314835, 6237.781677641442, 6245.18812554365, 6254.593451425642, 6143.078538219124, 6191.1641928339095, 6329.9050514243245, 6351.904721429275, 6378.904316435164, 5096.311997880387, 6153.230846144232, 6176.289726681489, 6185.938140618716, 6207.534434917309, 6157.230346206724, 6186.752529898754, 6191.84520386994, 6206.813795586139, 6212.316645169119, 5167.767450464663, 5380.461953804745, 6134.202553667995, 6151.96924015395, 6199.411055949678, 6136.028952951454, 6138.2044803098925, 6156.445919867234, 6196.349383314687, 6198.938010620016, 6130.5402094842175, 6160.199174107337, 6160.229971253593, 6164.137020816999, 6195.039768835657], "value": 5807.290065538955, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.5189329603355, 544.0560627311613, 544.3331918399958, 545.860805494599, 554.1466142141103, 38469.0, 39909.80045099774, 40004.59995400045, 40068.59931400685, 42245.94385140373, 41544.169116617646, 42098.94752631186, 42150.57849421505, 42240.57759422405, 42269.94325141873, 9472.57373418196, 9656.0, 9676.612935482572, 9684.903150968506, 9691.98234185411, 9427.717168484956, 9513.524323783819, 9514.524273786317, 9527.285453590974, 9531.046895310483, 8182.713605023825, 9330.813383732322, 9498.762530936747, 9559.283053770994, 9563.426194428323, 9329.580168892417, 9441.905580944205, 9527.52362381878, 9530.52347382635, 9533.189678877303, 9377.76555586109, 9476.194523465514, 9571.521423928776, 9576.90423095774, 9601.807963840683, 39803.0, 39849.80075099606, 39948.6017989369, 40083.99790005244, 40160.0, 3351.631320554737, 3376.358491886558, 3484.9128771780656, 3509.666581674737, 3528.647135286451, 28562.0, 29506.55740163899, 30006.0, 30545.0, 30881.536776948138, 3131.592892923928, 3167.17653410115, 3171.984140079308, 3196.2968147007855, 3289.4572395554706, 409980.0, 484912.0, 487627.0, 488272.99999999645, 488995.0, 59745.0, 60260.69869650624, 60291.39708602858, 60366.69816650889, 60382.09426858601, 64316.67841660762, 64581.0, 64892.675536622955, 64909.35090649127, 65040.34959650343, 13077.0, 15944.2825072872, 15994.920025400032, 16036.679266414607, 16038.358465661242, 12846.67883302925, 12900.677483062998, 12909.967202623768, 12919.966402687762, 12919.966402687762, 16992.660146797243, 17175.020002682504, 18838.24647014104, 18915.243390264237, 19188.71216931747, 7180.0, 7458.589777562286, 7909.446338756232, 7926.4847784894955, 8203.138670439517, 890.8351954888367, 959.6928982725461, 965.5751469353603, 979.9951000244953, 1016.0499932563077, 29072.0, 29764.702352976194, 29788.404231915672, 30521.694783052328, 30597.08208753741, 954.4178051388648, 1024.846273059047, 1044.3055368180228, 1057.259918057363, 1090.465671820802, 14521.85478145205, 16324.857259991924, 16398.83601163997, 16425.58936026585, 17001.149942502827, 670683.0, 674256.0, 690981.0, 691974.0, 909946.0, 53272.46727532675, 54258.0, 54715.17927231095, 54879.0, 55091.724541377036, 1393.5610282760897, 1401.85981401859, 1429.371076726258, 1431.9713605727827, 1436.0, 27959.021434249702, 28454.43091138124, 29056.54396322913, 29228.123156305344, 29433.55849662214, 45963.77018114888, 46386.53613463957, 47012.294815578476, 47392.52607474019, 47532.811679708284, 520663.0, 521877.7342793136, 522282.0, 522425.0, 527705.0, 25858.87070564635, 26284.73715262823, 26447.471050578497, 26627.600585990836, 26729.19812405631, 42693.35959960665, 43553.911152221444, 43674.563254368324, 43737.343939841565, 43849.78075109604, 28169.0, 35339.823300883334, 35631.82184089063, 35749.92750217498, 36888.44667329938, 35496.46755298621, 35943.64056359403, 36256.818715907306, 36269.63730362662, 36410.63589364073, 35875.64124358723, 35892.64107358998, 36585.817070914476, 36592.45111323279, 38017.809910950265, 32257.838710806296, 33611.714793490966, 33825.15437114092, 33888.0, 34162.48756268708, 24729.1344802931, 25233.747662523874, 25556.0, 25635.949124069655, 25967.480650386507], "value": 19708.547256033406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.29728610419465, 367.5791219054183, 385.6240165838308, 392.7918203352223, 414.9709520333576, 19309.903450482747, 19997.400077997667, 20360.67655602385, 20638.277660281892, 20716.585668286625, 20122.19511219553, 20163.899180504115, 20433.97830108496, 20635.968201589934, 20713.896430517863, 4503.977480112595, 5475.397706252329, 5764.135379693038, 5789.507891829189, 5973.313068997056, 5776.711164441782, 5823.505002074829, 5921.200637913869, 5926.288845338566, 6124.326324104345, 5151.253068305094, 6099.878002439971, 6146.231721034871, 6160.414760597736, 6180.81457556274, 5991.161237426763, 6139.171211886405, 6662.467002639777, 6691.598504089721, 6729.22613899398, 5068.366454193226, 5096.79612815487, 5927.851803704899, 5963.552733544958, 5969.313528944183, 13277.53528626503, 13417.46330146793, 23451.0, 24103.91532381047, 24341.756582434125, 2237.59723249815, 2336.3925379401308, 2351.564960482316, 2728.7680547153514, 2824.997126020274, 9622.615095396246, 9930.602775888956, 10117.268337548821, 10439.008294212037, 10734.838977415346, 1754.4911975527082, 1930.8165724256173, 1942.0, 1944.6402415553168, 1959.470942845438, 118111.0, 124500.0, 126693.46613067779, 128787.35606322002, 131062.34468827595, 9613.279004074722, 11163.218574699693, 11625.360605166628, 11781.882181178249, 12132.63602091921, 14775.0, 14784.965052446225, 14796.778048329285, 14811.963162578731, 14830.0, 8456.577171141418, 8709.738707838775, 8781.990071141772, 8883.911160888438, 8947.865782013276, 7253.274672532704, 7316.707331706779, 8717.825643487095, 8735.912640873637, 8745.868811967826, 4496.7077139985795, 4521.615662668644, 4627.490975992638, 4646.790894409692, 4675.129948020751, 1630.7716919631262, 1721.7073097573443, 1725.5858593937364, 2023.1199428248758, 2052.4971382011504, 862.2584577263548, 924.5746956400131, 971.4851128901694, 981.4847205217176, 1016.9593216271414, 20456.488587785127, 20938.895305523376, 20995.47511312199, 21047.473813154793, 21104.261350852645, 932.2572950624123, 937.1752857485369, 966.8646389505475, 969.2343048991359, 985.7289245457556, 8598.699045533502, 9069.911610606638, 10799.76415801415, 11122.0, 11157.330560166416, 597516.0372594415, 611978.0, 617118.0, 624018.0, 630996.0, 112563.43718281356, 127418.0, 129521.0, 130611.69388306186, 133708.0, 948.5636607160783, 956.9282303827241, 985.3693636072919, 995.5868314649484, 997.8923395031509, 18159.727604086213, 18178.72731908996, 18465.353712619995, 18518.629627407645, 18610.0, 52036.73981630067, 56720.58198544904, 57047.0, 57592.0, 58336.416635834794, 75406.0, 78224.0, 79572.2042779588, 80282.79575806485, 80680.0, 7161.283871612797, 7360.77917662471, 7390.815229619087, 7477.551346919202, 7796.532208067534, 11197.216194866282, 13078.934605327293, 13092.476300947856, 13451.0, 13529.59411217665, 8847.73456796297, 9447.744621099344, 11206.991370776343, 11237.662870113909, 11292.717682057686, 10328.431936243578, 10564.894351056391, 11088.112950964065, 11544.769104618028, 11959.04327653803, 11139.387333696724, 11169.88830111721, 11409.20135590534, 11544.01875840563, 11594.0, 6564.573302735307, 7472.29013243741, 7570.545767253982, 7700.306972372513, 7764.262395072459, 9978.0, 11068.833967490333, 11106.722331941442, 11395.658130256106, 11399.772004560029], "value": 9509.623204638972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.652336915771, 1493.6863258715669, 1696.5249730075575, 1838.3473866777285, 1907.988765954044, 7553.924460755391, 7821.178776228499, 8094.91905080949, 8490.27832634226, 8492.235698787108, 6975.1978522469935, 7665.4634175607725, 8306.626201820918, 8387.203215694499, 8409.411341206118, 2348.7416384197722, 2352.0591763294733, 2353.752855950126, 2380.8690522021284, 2396.880155992202, 2341.7072865891764, 2383.7139543254834, 2395.2454976682375, 2401.0, 2429.1133736186252, 2344.0623750499853, 2349.89425475854, 2379.1078345620394, 2383.511380167062, 2384.177458776719, 2320.3039088273536, 2339.649052642117, 2340.0639744102323, 2357.0571771291447, 2365.7042869641296, 2336.4509340305185, 2374.1215750172373, 2379.0, 2400.255920664582, 2401.8438801477846, 8242.093369729386, 8290.792730181794, 8305.626246818847, 8339.83320333596, 8463.0, 5082.974585127051, 5206.843794686166, 5224.0074385866565, 5249.527542521191, 5257.185136303879, 3417.5044618530173, 3516.279162771651, 3517.683408493248, 3541.451075083366, 3593.730470214718, 1077.2351630342466, 1077.342820879263, 1101.2676570080887, 1119.0488085127658, 1123.129574579699, 9129.908700913038, 10957.616483423122, 10958.56165753369, 10970.506327215295, 10974.945125274322, 4458.598726114666, 4657.767111644472, 4762.833300834454, 4763.7141771493825, 4769.928451073237, 9456.148946594702, 9479.383840050376, 9496.335256531976, 9501.334906556613, 9502.0, 5217.191335343028, 5231.450697676765, 5240.423553409122, 5255.553277971415, 5271.947280527223, 4356.499002614676, 4364.60332693535, 4748.857534273978, 4802.039592081528, 4829.879253018632, 3806.467094606757, 3872.186840763471, 3889.649931506178, 3947.4078888167005, 3978.0651546886456, 1284.1652925598435, 1294.087668193921, 1294.7345794112373, 1300.057458342694, 1301.3948513941064, 829.3531045784298, 912.6668765900531, 916.4134953629682, 926.3284119013796, 928.0, 5574.58190635704, 5749.655020698771, 5833.38749431312, 5893.5579831512805, 6049.032154855202, 459.43030642004345, 461.42552522110185, 471.3895505320618, 980.2305190425482, 1008.5713571731984, 3365.9831700841337, 3457.360388328117, 3554.733394995386, 3813.7139714521522, 3843.673287770515, 9890.554925028391, 10050.195984321383, 10134.54394552247, 10168.796624067625, 10196.643117490852, 10109.949450252701, 10144.746381340377, 10148.137408320375, 10155.492225388702, 10244.0, 7732.149463559004, 7879.0939042010905, 7895.6052197391045, 7924.762257132295, 7997.080335761346, 5570.220169176399, 5653.915191272216, 5764.827055188351, 5774.48029677331, 5895.263092113486, 8400.915990840258, 8952.23905968, 9104.408213466368, 9196.54017299119, 9359.625614975597, 9345.252379809735, 9417.434953902788, 9444.669436569688, 9523.904760952302, 9603.37578057424, 6687.264400915993, 6885.311468853075, 7094.964525177341, 7225.855482890418, 7346.449016323904, 7846.843063138819, 8103.108658047492, 8106.189381061847, 8108.14864439249, 8110.188981101843, 6222.533310001678, 7141.535800172972, 7256.600886951268, 7272.781816545512, 7387.667554959932, 7148.964255178691, 7160.964195178991, 7170.928290717026, 7177.210506844139, 7288.635568221462, 6777.423918966746, 6803.183617965876, 6829.829254268683, 6836.418904392984, 6842.0, 4882.804687812448, 4917.852464426073, 4929.778159982881, 4950.727709975986, 5008.198688209869, 4631.861044168681, 4640.93038604428, 4659.906801864012, 4681.157391669532, 4872.244802055687], "value": 4424.615538512036, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.42094966211835, 320.3432962427024, 322.37137581715655, 324.0763823104152, 326.17477781213523, 5145.0481660892765, 5230.6338556301025, 5469.726513674315, 5535.889282214358, 5647.37878833328, 5003.824866129687, 5321.787128514855, 5425.104857698475, 5479.397266300713, 5479.671219726819, 3585.9820700896457, 3984.5694126582835, 4106.973256685828, 4143.446207672123, 4252.574742525753, 3505.2288496530723, 4203.285441474956, 4213.768242746648, 4231.894202644928, 4236.428082208909, 4082.3468245080794, 4184.100418410041, 4231.1749208904275, 4233.322668373061, 4235.512916014667, 4167.979160104211, 4180.038591124058, 4253.744775313491, 4257.510386305584, 4257.893552661178, 3185.4743967245377, 3639.945400818963, 3645.6172101929446, 3662.432322989941, 3720.8325625346924, 4176.227397931392, 5413.9729301353245, 5465.4261302563455, 5477.726113694339, 5512.641678290938, 4402.295632698785, 4801.815174095778, 4803.9039219215765, 4941.258811178316, 4941.629377796644, 5018.096742586333, 5169.0, 5486.61593688442, 5781.161731548944, 5793.420657934215, 3564.002079417767, 3912.2371137628174, 4021.477207962946, 4054.9594504054876, 4087.1621317629815, 5630.014747419185, 5891.823245302648, 5942.405759424067, 6108.541859360521, 6217.440430361244, 3670.339338918967, 4145.491977353718, 4147.8963025924595, 4163.8334466621, 4175.457190565207, 4187.937180942288, 4217.177650358212, 4226.915461690749, 4236.745795252295, 4246.936295955563, 4307.741535507879, 4530.799338175386, 4799.0, 4825.734584597881, 4838.879028024327, 5090.10923088458, 5571.904650082186, 5835.299764028259, 5848.824535263949, 5857.970710146507, 1312.337269678806, 1316.7432350691715, 1353.7766268565774, 1370.9108907920954, 1384.1764150330537, 869.4218344800763, 871.8430682477089, 937.8604994931192, 945.8628498867763, 948.2745699539857, 4371.568318869672, 4377.0, 4700.929486057712, 4702.9764851176205, 5060.84817455477, 4746.588888666923, 4948.935978764511, 5125.103711626647, 5537.6954267515675, 5605.215269862222, 4284.857571214393, 4793.285203966953, 5085.973845561884, 5219.399769026611, 5227.098960077117, 2309.907603695867, 2701.392186758003, 2955.138262894363, 2957.5267957126757, 3022.9848850755607, 4906.2640603909695, 5417.404085550586, 5589.9099675562875, 5805.535557155417, 5906.8651943639625, 5395.73021348931, 5534.0, 5640.730835561966, 5783.0, 5906.970465147732, 5425.12468391753, 5537.975474537143, 5629.958457685341, 5916.585838991229, 5928.614640048383, 4740.6444516660695, 5445.53712934405, 5493.807716729895, 5604.495595396434, 5674.971625141848, 4494.393256910275, 4851.0, 5451.591130665137, 5520.227168196536, 5565.998120338378, 5216.582673386196, 5507.752151153128, 5752.734398432338, 5787.5692209271365, 5953.970230148995, 3277.8033318001, 3426.811525366029, 3801.619838016287, 3833.195029043932, 3838.865639702597, 4926.679765815211, 5148.330717006766, 5243.842684719464, 5295.338082739658, 5647.745851436613, 4530.660200484911, 5366.919496207482, 5424.593155513273, 5448.182772584144, 5535.501804837584, 4739.739314337607, 4833.250846118857, 4953.2074868020945, 5404.78380864761, 5479.0, 4843.176659967743, 5044.470330615232, 5722.370539240764, 5753.712314384347, 5853.853653658693, 4652.9294463963215, 4791.976040119777, 5409.998300628792, 5908.223135126484, 5957.366006735974, 5051.393832740095, 5762.683052432157, 5803.187553742564, 5805.680687562056, 5829.3296270927685], "value": 4116.172209532922, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.7767114523352, 704.0741425026088, 770.4997283814024, 775.3719487215352, 797.2545669798736, 14377.353019114138, 15186.468473603398, 15190.54428367148, 15217.163056031914, 15285.923570382147, 13691.863081369183, 13700.451981920736, 13717.58847234582, 13731.725365492684, 13862.514811981582, 656.8916128838736, 690.6029033305845, 790.0006491787864, 835.8996920369534, 838.9790255243622, 842.7008412013739, 850.3027517435705, 858.0818524179131, 859.9699010534632, 862.9395942284043, 908.636545381846, 921.8525035994243, 927.2952556057411, 927.8840144981878, 927.9860802087974, 771.7106085218044, 871.5511511571545, 883.2492381475759, 919.384012711485, 923.6582464488115, 667.6861874918781, 681.465049935798, 685.6023506366296, 689.5724650716538, 692.972281108755, 13511.0, 13543.796843047363, 13905.930470347583, 14023.228722420263, 14453.566393008226, 12653.810192847115, 12689.428975696115, 12892.290923999177, 12900.03249756272, 14006.94947878913, 9245.982941876387, 9662.75843103921, 9923.553440095213, 11083.168762342857, 11582.0, 3665.8350374233223, 3712.350338690718, 3760.097576581628, 3891.1633998690418, 3893.3186692328727, 90994.0, 92089.53955230181, 94485.52757236239, 94731.00055494717, 96708.06583868354, 9083.834383349013, 10379.429131397694, 10641.201909856636, 10678.51946662402, 10759.892401076046, 20384.796152038587, 20559.8972005139, 20576.0, 20594.0, 20600.58798824015, 7516.887246691304, 7712.074551053909, 7741.264579864904, 8029.197080291924, 8055.677772889018, 4250.468691413574, 4260.531341552489, 4291.592298731615, 4408.7375342246505, 4581.427321584802, 3370.9662903370654, 3437.2609888874013, 3458.8962331130106, 3470.410030294856, 3476.3047390521997, 620.6369273974775, 627.5983370642792, 646.8382904273932, 650.3464018661215, 651.5829868883918, 623.1680706257107, 631.3465563142125, 657.3098246840798, 661.5865084322298, 672.3746915368656, 9123.908760912438, 9287.442753434816, 9356.859647105299, 9406.38858474197, 9674.70975870725, 541.3638974205372, 689.5449003657562, 696.7178292791427, 707.1726080485844, 715.2918610575597, 4232.4286221360335, 4636.930446043312, 4644.117617652635, 4660.370849935283, 4767.427908650984, 115802.0, 119714.0, 120515.0, 120725.0, 126350.0, 102087.0, 102538.0, 103429.0, 103793.0, 105007.0, 73594.8960765589, 91877.0, 93171.0, 93371.06628933623, 94896.0, 8744.606492707971, 9682.370645908275, 9735.513224338612, 10177.745556361151, 10198.694039178836, 43442.0, 53082.20376694275, 54112.45887541074, 54115.0, 55760.605984849084, 53888.0, 54860.45139548713, 57835.421645783004, 63600.0, 74738.0, 10955.671329860117, 11333.659990200307, 12376.876231237573, 12491.250524968531, 12654.620361389174, 12210.633680989584, 13173.31345508759, 13618.547202231006, 14264.07283526609, 14402.20787856678, 13106.475740970254, 13485.460581576626, 13551.52569660057, 13713.794293085812, 14163.858361416666, 11688.240264382788, 12889.548865789653, 13381.464741410235, 13840.377183026587, 13847.584572462842, 12663.810042849549, 12759.425825837674, 13267.46930122823, 13691.041627086008, 13730.794038089636, 10635.255532112678, 11114.333140011302, 11146.05258553032, 11574.247673901169, 11784.351860647404, 9950.900490995287, 10351.43067131315, 10869.728256793644, 10941.945290273497, 11177.944110279723], "value": 7375.375030810836, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 132.0, 171.0, 177.0, 115.0, 118.0, 116.0, 117.0, 115.0, 118.0], "value": 129.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 110.0, 110.0, 142.0, 110.0, 109.0, 109.0, 114.0, 136.0, 108.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 201.0, 195.0, 194.0, 197.0, 196.0, 199.0, 222.0, 225.0, 196.0], "value": 201.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 65.0, 61.0, 89.0, 74.0, 85.0, 83.0, 60.0, 76.0, 58.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 76.0, 95.0, 62.0, 75.0, 115.0, 57.0, 85.0, 103.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 88.0, 90.0, 88.0, 99.0, 131.0, 119.0, 104.0, 90.0, 86.0], "value": 98.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 102.0, 105.0, 136.0, 104.0, 156.0, 168.0, 108.0, 114.0, 100.0], "value": 119.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 143.0, 133.0, 78.0, 137.0, 131.0, 90.0, 91.0, 89.0, 72.0], "value": 107.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 58.0, 60.0, 61.0, 60.0, 59.0, 60.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 72.0, 77.0, 70.0, 67.0, 69.0, 71.0, 71.0, 72.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 82.0, 83.0, 87.0, 82.0, 83.0, 86.0, 81.0, 82.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 158.0, 144.0, 143.0, 147.0, 161.0, 142.0, 147.0, 209.0, 166.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 161.0, 162.0, 166.0, 165.0, 161.0, 168.0, 165.0, 166.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 65.0, 67.0, 66.0, 67.0, 66.0, 65.0, 72.0], "value": 66.9, "unit": "score"}]}]} 05:18:24 INFO - Return code: 0 05:18:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:18:24 ERROR - # TBPL SUCCESS # 05:18:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:18:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:18:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:18:24 INFO - 2017-02-22 05:18:24.086 screenresolution[2584:37575] starting screenresolution argv=screenresolution get 05:18:24 INFO - 2017-02-22 05:18:24.090 screenresolution[2584:37575] Display 0: 1600x1200x32@60 05:18:24 INFO - 2017-02-22 05:18:24.097 screenresolution[2585:37578] starting screenresolution argv=screenresolution list 05:18:24 INFO - Available Modes on Display 0 05:18:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:18:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:18:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:18:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:18:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:18:24 INFO - Intel Iris: 05:18:24 INFO - Chipset Model: Intel Iris 05:18:24 INFO - Type: GPU 05:18:24 INFO - Bus: Built-In 05:18:24 INFO - VRAM (Dynamic, Max): 1536 MB 05:18:24 INFO - Vendor: Intel (0x8086) 05:18:24 INFO - Device ID: 0x0a2e 05:18:24 INFO - Revision ID: 0x0009 05:18:24 INFO - Displays: 05:18:24 INFO - Display: 05:18:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:18:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:18:24 INFO - Display Serial Number: 1600x1200 60 05:18:24 INFO - Main Display: Yes 05:18:24 INFO - Mirror: Off 05:18:24 INFO - Online: Yes 05:18:24 INFO - Rotation: Supported 05:18:24 INFO - Return code: 0 05:18:24 INFO - Running post-action listener: _resource_record_post_action 05:18:24 INFO - [mozharness: 2017-02-22 13:18:24.337512Z] Finished run-tests step (success) 05:18:24 INFO - Running post-run listener: _resource_record_post_run 05:18:24 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 1339392; Write bytes: 502501376; Read time: 11; Write time: 1605 05:18:24 INFO - TinderboxPrint: CPU usage
54.3% 05:18:24 INFO - TinderboxPrint: I/O read bytes / time
1,339,392 / 11 05:18:24 INFO - TinderboxPrint: I/O write bytes / time
502,501,376 / 1,605 05:18:24 INFO - TinderboxPrint: CPU idle
2,191.6 (45.7%) 05:18:24 INFO - TinderboxPrint: CPU system
968.1 (20.2%) 05:18:24 INFO - TinderboxPrint: CPU user
1,634.1 (34.1%) 05:18:24 INFO - TinderboxPrint: Swap in / out
192,655,360 / 0 05:18:24 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181221888; Write bytes: 174936064; Read time: 16811; Write time: 377 05:18:24 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1339392; Write bytes: 309829632; Read time: 11; Write time: 1174 05:18:24 INFO - Running post-run listener: _upload_blobber_files 05:18:24 INFO - Blob upload gear active. 05:18:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:18:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:18:24 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:18:24 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:18:25 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:18:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:18:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:25 INFO - (blobuploader) - INFO - Done attempting. 05:18:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:18:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:18:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:27 INFO - (blobuploader) - INFO - Done attempting. 05:18:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:18:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:18:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:30 INFO - (blobuploader) - INFO - Done attempting. 05:18:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:30 INFO - Return code: 0 05:18:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:18:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1d3bfdb75aba5e8a0f03ae5761f7ce41de3e01fd458dd517fd1033af8c6e6d5af9cf90e028ac903a997abc52433ba70c74ae6296d7ad0daf1067074b61d4390", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/706266328f6646c7636faae64b7c785ce52e2c742d45db73522e143182a7e49343de3050ca14d1b879205d579b481f7b70f33e5277de8e57acbfb51ded984d4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/407ce03469fb8400a5dc1255fce27fbdfb0493d39e70ea0b4ce51ef579573e884f9c8cf62d64c027d68fe45ca4cdc82111f96b789a43bc35975094141ed63d36"} 05:18:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:18:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:18:30 INFO - Contents: 05:18:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1d3bfdb75aba5e8a0f03ae5761f7ce41de3e01fd458dd517fd1033af8c6e6d5af9cf90e028ac903a997abc52433ba70c74ae6296d7ad0daf1067074b61d4390", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/706266328f6646c7636faae64b7c785ce52e2c742d45db73522e143182a7e49343de3050ca14d1b879205d579b481f7b70f33e5277de8e57acbfb51ded984d4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/407ce03469fb8400a5dc1255fce27fbdfb0493d39e70ea0b4ce51ef579573e884f9c8cf62d64c027d68fe45ca4cdc82111f96b789a43bc35975094141ed63d36"} 05:18:30 INFO - Running post-run listener: copy_logs_to_upload_dir 05:18:30 INFO - Copying logs to upload dir... 05:18:30 INFO - mkdir: /builds/slave/test/build/upload/logs 05:18:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.021370 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-22 05:18:30.172722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 05:18:30.175956) ========= 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.9Yty00EBuE/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.tNI2lDozAV/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1d3bfdb75aba5e8a0f03ae5761f7ce41de3e01fd458dd517fd1033af8c6e6d5af9cf90e028ac903a997abc52433ba70c74ae6296d7ad0daf1067074b61d4390", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/706266328f6646c7636faae64b7c785ce52e2c742d45db73522e143182a7e49343de3050ca14d1b879205d579b481f7b70f33e5277de8e57acbfb51ded984d4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/407ce03469fb8400a5dc1255fce27fbdfb0493d39e70ea0b4ce51ef579573e884f9c8cf62d64c027d68fe45ca4cdc82111f96b789a43bc35975094141ed63d36"} build_url:https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/P0sw68RHS1yNi6YaCM7eMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1d3bfdb75aba5e8a0f03ae5761f7ce41de3e01fd458dd517fd1033af8c6e6d5af9cf90e028ac903a997abc52433ba70c74ae6296d7ad0daf1067074b61d4390", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/706266328f6646c7636faae64b7c785ce52e2c742d45db73522e143182a7e49343de3050ca14d1b879205d579b481f7b70f33e5277de8e57acbfb51ded984d4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/407ce03469fb8400a5dc1255fce27fbdfb0493d39e70ea0b4ce51ef579573e884f9c8cf62d64c027d68fe45ca4cdc82111f96b789a43bc35975094141ed63d36"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 05:18:30.211007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 05:18:30.211289) ========= 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.9Yty00EBuE/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.tNI2lDozAV/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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.005338 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 05:18:30.258905) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 05:18:30.259213) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 05:18:30.259497) ========= ========= Total master_lag: 0.18 =========