builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0269 starttime: 1486497206.62 results: success (0) buildid: 20170207093257 builduid: d1b00b423c824d54aec10f4ec8a66f6b revision: be5204c4c3eeadb750181b939e58fbecada490db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:26.623320) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:26.623742) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:26.624015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:26.652651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:26.653056) ========= 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.ugxbg7s9zS/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.lG7rslhXQV/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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-07 11:53:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.2M=0.001s 2017-02-07 11:53:26 (21.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089939 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:26.766948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:26.767269) ========= 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.ugxbg7s9zS/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.lG7rslhXQV/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.026425 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:26.815217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 11:53:26.815572) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev be5204c4c3eeadb750181b939e58fbecada490db --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 be5204c4c3eeadb750181b939e58fbecada490db --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ugxbg7s9zS/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.lG7rslhXQV/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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-07 11:53:26,918 truncating revision to first 12 chars 2017-02-07 11:53:26,918 Setting DEBUG logging. 2017-02-07 11:53:26,918 attempt 1/10 2017-02-07 11:53:26,918 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/be5204c4c3ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-07 11:53:27,835 unpacking tar archive at: mozilla-beta-be5204c4c3ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.199223 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 11:53:28.037962) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:28.038290) ========= script_repo_revision: be5204c4c3eeadb750181b939e58fbecada490db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:28.038682) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:28.038946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 11:53:28.059174) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-07 11:53:28.059793) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.ugxbg7s9zS/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.lG7rslhXQV/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 11:53:28 INFO - MultiFileLogger online at 20170207 11:53:28 in /builds/slave/test 11:53:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:53:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:53:28 INFO - {'append_to_log': False, 11:53:28 INFO - 'base_work_dir': '/builds/slave/test', 11:53:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:53:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:53:28 INFO - 'branch': 'Mozilla-Beta', 11:53:28 INFO - 'buildbot_json_path': 'buildprops.json', 11:53:28 INFO - 'config_files': ('talos/mac_config.py',), 11:53:28 INFO - 'default_actions': ('clobber', 11:53:28 INFO - 'read-buildbot-config', 11:53:28 INFO - 'download-and-extract', 11:53:28 INFO - 'populate-webroot', 11:53:28 INFO - 'create-virtualenv', 11:53:28 INFO - 'install', 11:53:28 INFO - 'run-tests'), 11:53:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:53:28 INFO - 'download_minidump_stackwalk': True, 11:53:28 INFO - 'download_symbols': 'ondemand', 11:53:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:53:28 INFO - 'tooltool.py': '/tools/tooltool.py', 11:53:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:53:28 INFO - '/tools/misc-python/virtualenv.py')}, 11:53:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:53:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:53:28 INFO - 'installer_path': 'installer.exe', 11:53:28 INFO - 'log_level': 'info', 11:53:28 INFO - 'log_name': 'talos', 11:53:28 INFO - 'log_to_console': True, 11:53:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:53:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:53:28 INFO - 'opt_config_files': (), 11:53:28 INFO - 'pip_index': False, 11:53:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:53:28 INFO - 'cmd': ('bash', 11:53:28 INFO - '-c', 11:53:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:53:28 INFO - 'enabled': True, 11:53:28 INFO - 'halt_on_failure': False, 11:53:28 INFO - 'name': 'check_screen_resolution'},), 11:53:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:53:28 INFO - 'cmd': ('bash', 11:53:28 INFO - '-c', 11:53:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:53:28 INFO - 'enabled': True, 11:53:28 INFO - 'halt_on_failure': False, 11:53:28 INFO - 'name': 'check_screen_resolution'},), 11:53:28 INFO - 'run_cmd_checks_enabled': True, 11:53:28 INFO - 'sps_profile': False, 11:53:28 INFO - 'sps_profile_interval': 0, 11:53:28 INFO - 'suite': 'dromaeojs', 11:53:28 INFO - 'system_bits': '32', 11:53:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:53:28 INFO - 'title': 't-yosemite-r7-0269', 11:53:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:53:28 INFO - 'use_talos_json': True, 11:53:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:53:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:53:28 INFO - 'work_dir': 'build'} 11:53:28 INFO - [mozharness: 2017-02-07 19:53:28.269990Z] Running clobber step. 11:53:28 INFO - Running pre-action listener: _resource_record_pre_action 11:53:28 INFO - Running main action method: clobber 11:53:28 INFO - rmtree: /builds/slave/test/build 11:53:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:53:30 INFO - Running post-action listener: _resource_record_post_action 11:53:30 INFO - [mozharness: 2017-02-07 19:53:30.690082Z] Finished clobber step (success) 11:53:30 INFO - [mozharness: 2017-02-07 19:53:30.690213Z] Running read-buildbot-config step. 11:53:30 INFO - Running pre-action listener: _resource_record_pre_action 11:53:30 INFO - Running main action method: read_buildbot_config 11:53:30 INFO - Using buildbot properties: 11:53:30 INFO - { 11:53:30 INFO - "project": "", 11:53:30 INFO - "product": "firefox", 11:53:30 INFO - "script_repo_revision": "production", 11:53:30 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:53:30 INFO - "repository": "", 11:53:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:53:30 INFO - "buildid": "20170207093257", 11:53:30 INFO - "pgo_build": "False", 11:53:30 INFO - "basedir": "/builds/slave/test", 11:53:30 INFO - "buildnumber": 20, 11:53:30 INFO - "slavename": "t-yosemite-r7-0269", 11:53:30 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:53:30 INFO - "platform": "yosemite_r7", 11:53:30 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:53:30 INFO - "branch": "mozilla-beta", 11:53:30 INFO - "repo_path": "releases/mozilla-beta", 11:53:30 INFO - "revision": "be5204c4c3eeadb750181b939e58fbecada490db", 11:53:30 INFO - "stage_platform": "macosx64", 11:53:30 INFO - "builduid": "d1b00b423c824d54aec10f4ec8a66f6b", 11:53:30 INFO - "slavebuilddir": "test" 11:53:30 INFO - } 11:53:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 11:53:30 INFO - Running post-action listener: _resource_record_post_action 11:53:30 INFO - [mozharness: 2017-02-07 19:53:30.693405Z] Finished read-buildbot-config step (success) 11:53:30 INFO - [mozharness: 2017-02-07 19:53:30.693520Z] Running download-and-extract step. 11:53:30 INFO - Running pre-action listener: _resource_record_pre_action 11:53:30 INFO - Running main action method: download_and_extract 11:53:30 INFO - mkdir: /builds/slave/test/build/tests 11:53: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')]} 11:53:30 INFO - trying https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 11:53:30 INFO - Downloading https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/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 11:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/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 11:53:31 INFO - Downloaded 1165 bytes. 11:53:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:53:31 INFO - Using the following test package requirements: 11:53:31 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:53:31 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:53:31 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 11:53:31 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:53:31 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 11:53:31 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:53:31 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:53:31 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 11:53:31 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:53:31 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:53:31 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 11:53:31 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:53:31 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 11:53:31 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:53:31 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 11:53:31 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:53:31 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 11:53:31 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 11:53:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:53:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:53:31 INFO - Fetch https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:53:31 INFO - Http code: 200 11:53:31 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 11:53:31 INFO - x-amz-cf-id: KfJ44LQeOjQOH74rdvtDjyCA4rimbUfL45EHZ4HIyb36NkPf0Tkrmw== 11:53:31 INFO - x-amz-version-id: WnP4TtB.y4WiGCKi1983Ybu6o2j9jf58 11:53:32 INFO - Expected file size: 16093021 11:53:32 INFO - Obtained file size: 16093021 11:53:38 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 11:53:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:53:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:53:38 INFO - Fetch https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:53:39 INFO - Http code: 200 11:53:39 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 11:53:39 INFO - x-amz-cf-id: Na3GbV2ZoagW2FYFxg4wbzkCEiI5IOyhGl7bgivoVZDNR1CsW960zA== 11:53:39 INFO - x-amz-version-id: WnP4TtB.y4WiGCKi1983Ybu6o2j9jf58 11:53:39 INFO - Expected file size: 16093021 11:53:39 INFO - Obtained file size: 16093021 11:53:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 11:53:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 11:53:45 INFO - Fetch https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 11:53:46 INFO - Http code: 200 11:53:46 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 11:53:46 INFO - x-amz-cf-id: bD9gYRcPz32ZVx1RKMWSE4xe3s95pdVeHXwWA5R9nOek8qeTmfnq7w== 11:53:46 INFO - x-amz-version-id: 3SNd6UabZf0ocy6JjfkduRUj1h5jQZlc 11:53:46 INFO - Expected file size: 14403005 11:53:46 INFO - Obtained file size: 14403005 11:53: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')]} 11:53:47 INFO - trying https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:53:47 INFO - Downloading https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 11:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/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 11:53:49 INFO - Downloaded 82139331 bytes. 11:53:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:53:49 INFO - mkdir: /builds/slave/test/properties 11:53:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:53:49 INFO - Writing to file /builds/slave/test/properties/build_url 11:53:49 INFO - Contents: 11:53:49 INFO - build_url:https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:53:50 INFO - Running post-action listener: _resource_record_post_action 11:53:50 INFO - Running post-action listener: set_extra_try_arguments 11:53:50 INFO - [mozharness: 2017-02-07 19:53:50.474514Z] Finished download-and-extract step (success) 11:53:50 INFO - [mozharness: 2017-02-07 19:53:50.474662Z] Running populate-webroot step. 11:53:50 INFO - Running pre-action listener: _resource_record_pre_action 11:53:50 INFO - Running main action method: populate_webroot 11:53:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:53:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:53:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:53:50 INFO - '--tppagecycles', 11:53:50 INFO - '7'], 11:53:50 INFO - 'tests': ['tsvgm']}}, 11:53:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:53:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:53:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:53:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:53:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:53:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:53:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:50 INFO - 'talos_options': ['--disable-e10s'], 11:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:50 INFO - 'talos_options': ['--disable-e10s'], 11:53:50 INFO - 'tests': ['damp', 'tps']}, 11:53:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:50 INFO - 'tests': ['damp', 'tps']}, 11:53:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:53:50 INFO - 'tests': ['dromaeo_dom']}, 11:53:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:53:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:53:50 INFO - 'tests': ['basic_compositor_video']}, 11:53:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:53:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:53:50 INFO - 'tests': ['a11yr', 11:53:50 INFO - 'ts_paint', 11:53:50 INFO - 'tpaint', 11:53:50 INFO - 'sessionrestore', 11:53:50 INFO - 'sessionrestore_no_auto_restore', 11:53:50 INFO - 'tabpaint']}, 11:53:50 INFO - 'other-e10s': {'tests': ['a11yr', 11:53:50 INFO - 'ts_paint', 11:53:50 INFO - 'tpaint', 11:53:50 INFO - 'sessionrestore', 11:53:50 INFO - 'sessionrestore_no_auto_restore', 11:53:50 INFO - 'tabpaint']}, 11:53:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:53:50 INFO - 'ts_paint', 11:53:50 INFO - 'tpaint', 11:53:50 INFO - 'sessionrestore', 11:53:50 INFO - 'sessionrestore_no_auto_restore', 11:53:50 INFO - 'tabpaint']}, 11:53:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:53:50 INFO - 'ts_paint', 11:53:50 INFO - 'tpaint', 11:53:50 INFO - 'sessionrestore', 11:53:50 INFO - 'sessionrestore_no_auto_restore', 11:53:50 INFO - 'tabpaint']}, 11:53:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:53:50 INFO - 'tests': ['a11yr', 11:53:50 INFO - 'ts_paint', 11:53:50 INFO - 'tpaint', 11:53:50 INFO - 'sessionrestore', 11:53:50 INFO - 'sessionrestore_no_auto_restore', 11:53:50 INFO - 'tabpaint']}, 11:53:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:53:50 INFO - 'tests': ['a11yr', 11:53:50 INFO - 'ts_paint', 11:53:50 INFO - 'tpaint', 11:53:50 INFO - 'sessionrestore', 11:53:50 INFO - 'sessionrestore_no_auto_restore', 11:53:50 INFO - 'tabpaint']}, 11:53:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:53:50 INFO - 'tests': ['tsvgx', 11:53:50 INFO - 'tsvgr_opacity', 11:53:50 INFO - 'tart', 11:53:50 INFO - 'tscrollx', 11:53:50 INFO - 'cart']}, 11:53:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:53:50 INFO - 'tsvgr_opacity', 11:53:50 INFO - 'tart', 11:53:50 INFO - 'tscrollx', 11:53:50 INFO - 'cart']}, 11:53:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:50 INFO - 'talos_options': ['--disable-e10s'], 11:53:50 INFO - 'tests': ['tp5o']}, 11:53:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:50 INFO - 'tests': ['tp5o']}, 11:53:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:50 INFO - 'talos_options': ['--disable-e10s', 11:53:50 INFO - '--xperf_path', 11:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:50 INFO - 'tests': ['tp5n']}, 11:53:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:50 INFO - 'talos_options': ['--xperf_path', 11:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:50 INFO - 'tests': ['tp5n']}}, 11:53:50 INFO - 'talos.zip': {'path': '', 11:53:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:53:50 INFO - Running post-action listener: _resource_record_post_action 11:53:50 INFO - [mozharness: 2017-02-07 19:53:50.493869Z] Finished populate-webroot step (success) 11:53:50 INFO - [mozharness: 2017-02-07 19:53:50.494004Z] Running create-virtualenv step. 11:53:50 INFO - Running pre-action listener: _resource_record_pre_action 11:53:50 INFO - Running main action method: create_virtualenv 11:53:50 INFO - Creating virtualenv /builds/slave/test/build/venv 11:53:50 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 11:53:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:53:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:53:50 INFO - Using real prefix '/tools/python27' 11:53:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:53:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:53:54 INFO - Installing pip.................done. 11:53:54 INFO - Return code: 0 11:53:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:53:54 INFO - Reading from file tmpfile_stdout 11:53:54 INFO - Output received: 11:53:54 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) 11:53:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:54 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 0x108538490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15a57b930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10834cd30>, '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 0x1081b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108344b20>, '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.ugxbg7s9zS/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.lG7rslhXQV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 11:53:54 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 11:53:54 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 11:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugxbg7s9zS/Render', 11:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:54 INFO - 'HOME': '/Users/cltbld', 11:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:54 INFO - 'LOGNAME': 'cltbld', 11:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:54 INFO - 'MOZ_NO_REMOTE': '1', 11:53:54 INFO - 'NO_EM_RESTART': '1', 11:53:54 INFO - 'PAGER': '/bin/cat', 11:53:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:54 INFO - 'PWD': '/builds/slave/test', 11:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:54 INFO - 'SHELL': '/bin/bash', 11:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lG7rslhXQV/Listeners', 11:53:54 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 11:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:54 INFO - 'USER': 'cltbld', 11:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:54 INFO - 'XPC_FLAGS': '0x0', 11:53:54 INFO - 'XPC_SERVICE_NAME': '0', 11:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:54 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 11:53:54 INFO - Cleaning up... 11:53:54 INFO - Return code: 0 11:53:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:54 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 0x108538490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15a57b930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10834cd30>, '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 0x1081b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108344b20>, '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.ugxbg7s9zS/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.lG7rslhXQV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 11:53:54 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 11:53:54 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 11:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugxbg7s9zS/Render', 11:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:54 INFO - 'HOME': '/Users/cltbld', 11:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:54 INFO - 'LOGNAME': 'cltbld', 11:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:54 INFO - 'MOZ_NO_REMOTE': '1', 11:53:54 INFO - 'NO_EM_RESTART': '1', 11:53:54 INFO - 'PAGER': '/bin/cat', 11:53:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:54 INFO - 'PWD': '/builds/slave/test', 11:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:54 INFO - 'SHELL': '/bin/bash', 11:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lG7rslhXQV/Listeners', 11:53:54 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 11:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:54 INFO - 'USER': 'cltbld', 11:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:54 INFO - 'XPC_FLAGS': '0x0', 11:53:54 INFO - 'XPC_SERVICE_NAME': '0', 11:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:54 INFO - Downloading/unpacking psutil>=3.1.1 11:53:54 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 11:53:54 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 11:53:54 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 11:53:54 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 11:53:54 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 11:53:54 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 11:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:53:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:58 INFO - Installing collected packages: psutil 11:53:58 INFO - Running setup.py install for psutil 11:53:58 INFO - building 'psutil._psutil_osx' extension 11:53:58 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 11:53:59 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 11:53:59 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 11:53:59 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 11:53:59 INFO - building 'psutil._psutil_posix' extension 11:53:59 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 11:53:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:53:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:53:59 INFO - ^ 11:53:59 INFO - 1 warning generated. 11:53:59 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 11:53:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:59 INFO - Successfully installed psutil 11:53:59 INFO - Cleaning up... 11:53:59 INFO - Return code: 0 11:53:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:53:59 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')]} 11:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:59 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')]} 11:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:59 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 0x108538490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15a57b930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10834cd30>, '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 0x1081b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108344b20>, '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.ugxbg7s9zS/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.lG7rslhXQV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 11:53:59 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 11:53:59 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 11:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugxbg7s9zS/Render', 11:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:59 INFO - 'HOME': '/Users/cltbld', 11:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:59 INFO - 'LOGNAME': 'cltbld', 11:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:59 INFO - 'MOZ_NO_REMOTE': '1', 11:53:59 INFO - 'NO_EM_RESTART': '1', 11:53:59 INFO - 'PAGER': '/bin/cat', 11:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:59 INFO - 'PWD': '/builds/slave/test', 11:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:59 INFO - 'SHELL': '/bin/bash', 11:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lG7rslhXQV/Listeners', 11:53:59 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 11:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:59 INFO - 'USER': 'cltbld', 11:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:59 INFO - 'XPC_FLAGS': '0x0', 11:53:59 INFO - 'XPC_SERVICE_NAME': '0', 11:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:54:02 INFO - Installing collected packages: mozsystemmonitor 11:54:02 INFO - Running setup.py install for mozsystemmonitor 11:54:02 INFO - Successfully installed mozsystemmonitor 11:54:02 INFO - Cleaning up... 11:54:02 INFO - Return code: 0 11:54:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108538490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15a57b930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10834cd30>, '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 0x1081b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108344b20>, '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.ugxbg7s9zS/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.lG7rslhXQV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 11:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:54:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugxbg7s9zS/Render', 11:54:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:02 INFO - 'HOME': '/Users/cltbld', 11:54:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:02 INFO - 'LOGNAME': 'cltbld', 11:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:02 INFO - 'MOZ_NO_REMOTE': '1', 11:54:02 INFO - 'NO_EM_RESTART': '1', 11:54:02 INFO - 'PAGER': '/bin/cat', 11:54:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:02 INFO - 'PWD': '/builds/slave/test', 11:54:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:02 INFO - 'SHELL': '/bin/bash', 11:54:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lG7rslhXQV/Listeners', 11:54:02 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 11:54:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:02 INFO - 'USER': 'cltbld', 11:54:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:02 INFO - 'XPC_FLAGS': '0x0', 11:54:02 INFO - 'XPC_SERVICE_NAME': '0', 11:54:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:03 INFO - Downloading/unpacking jsonschema==2.5.1 11:54:03 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 11:54:03 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 11:54:03 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 11:54:03 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 11:54:03 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 11:54:03 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 11:54:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:54:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:54:05 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 11:54:05 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 11:54:05 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 11:54:05 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 11:54:05 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 11:54:05 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 11:54:06 INFO - Downloading functools32-3.2.3-2.tar.gz 11:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:54:06 INFO - warning: no files found matching '*.txt' 11:54:06 INFO - no previously-included directories found matching 'build' 11:54:06 INFO - no previously-included directories found matching 'dist' 11:54:06 INFO - no previously-included directories found matching '.git*' 11:54:06 INFO - Installing collected packages: jsonschema, functools32 11:54:06 INFO - Running setup.py install for functools32 11:54:06 INFO - warning: no files found matching '*.txt' 11:54:06 INFO - no previously-included directories found matching 'build' 11:54:06 INFO - no previously-included directories found matching 'dist' 11:54:06 INFO - no previously-included directories found matching '.git*' 11:54:06 INFO - Successfully installed jsonschema functools32 11:54:06 INFO - Cleaning up... 11:54:06 INFO - Return code: 0 11:54:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:54:06 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')]} 11:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:06 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')]} 11:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:06 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 0x108538490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15a57b930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10834cd30>, '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 0x1081b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108344b20>, '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.ugxbg7s9zS/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.lG7rslhXQV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 11:54:06 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 11:54:06 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 11:54:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugxbg7s9zS/Render', 11:54:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:06 INFO - 'HOME': '/Users/cltbld', 11:54:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:06 INFO - 'LOGNAME': 'cltbld', 11:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:06 INFO - 'MOZ_NO_REMOTE': '1', 11:54:06 INFO - 'NO_EM_RESTART': '1', 11:54:06 INFO - 'PAGER': '/bin/cat', 11:54:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:06 INFO - 'PWD': '/builds/slave/test', 11:54:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:06 INFO - 'SHELL': '/bin/bash', 11:54:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lG7rslhXQV/Listeners', 11:54:06 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 11:54:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:06 INFO - 'USER': 'cltbld', 11:54:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:06 INFO - 'XPC_FLAGS': '0x0', 11:54:06 INFO - 'XPC_SERVICE_NAME': '0', 11:54:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:54:06 INFO - Cleaning up... 11:54:06 INFO - Return code: 0 11:54:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:54:06 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')]} 11:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:06 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')]} 11:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:06 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 0x108538490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15a57b930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10834cd30>, '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 0x1081b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108344b20>, '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.ugxbg7s9zS/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.lG7rslhXQV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 11:54:06 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 11:54:06 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 11:54:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugxbg7s9zS/Render', 11:54:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:06 INFO - 'HOME': '/Users/cltbld', 11:54:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:06 INFO - 'LOGNAME': 'cltbld', 11:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:06 INFO - 'MOZ_NO_REMOTE': '1', 11:54:06 INFO - 'NO_EM_RESTART': '1', 11:54:06 INFO - 'PAGER': '/bin/cat', 11:54:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:06 INFO - 'PWD': '/builds/slave/test', 11:54:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:06 INFO - 'SHELL': '/bin/bash', 11:54:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lG7rslhXQV/Listeners', 11:54:06 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 11:54:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:06 INFO - 'USER': 'cltbld', 11:54:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:06 INFO - 'XPC_FLAGS': '0x0', 11:54:06 INFO - 'XPC_SERVICE_NAME': '0', 11:54:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:06 INFO - Downloading/unpacking blobuploader==1.2.4 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54:09 INFO - Downloading blobuploader-1.2.4.tar.gz 11:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:54:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:54:09 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 11:54:09 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 11:54:09 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 11:54:09 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 11:54:09 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 11:54:09 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 11:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:54:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54:10 INFO - Downloading docopt-0.6.1.tar.gz 11:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:54:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:54:11 INFO - Running setup.py install for blobuploader 11:54:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:54:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:54:11 INFO - Running setup.py install for requests 11:54:11 INFO - Running setup.py install for docopt 11:54:11 INFO - Successfully installed blobuploader requests docopt 11:54:11 INFO - Cleaning up... 11:54:11 INFO - Return code: 0 11:54:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:11 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 0x108538490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15a57b930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10834cd30>, '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 0x1081b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108344b20>, '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.ugxbg7s9zS/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.lG7rslhXQV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 11:54:11 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 11:54:11 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 11:54:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugxbg7s9zS/Render', 11:54:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:11 INFO - 'HOME': '/Users/cltbld', 11:54:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:11 INFO - 'LOGNAME': 'cltbld', 11:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:11 INFO - 'MOZ_NO_REMOTE': '1', 11:54:11 INFO - 'NO_EM_RESTART': '1', 11:54:11 INFO - 'PAGER': '/bin/cat', 11:54:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:11 INFO - 'PWD': '/builds/slave/test', 11:54:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:11 INFO - 'SHELL': '/bin/bash', 11:54:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lG7rslhXQV/Listeners', 11:54:11 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 11:54:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:11 INFO - 'USER': 'cltbld', 11:54:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:11 INFO - 'XPC_FLAGS': '0x0', 11:54:11 INFO - 'XPC_SERVICE_NAME': '0', 11:54:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-GbDVCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-r7pDN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-IBcgJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-n3XBsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-E1kNaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-9jL63e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Xyv5Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-BdnYfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-w3DNF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-SD0vGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-aYNxAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-scAqeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-k_7e8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-4yvuNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ldLD9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-UVzSMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Fxcpn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:54:13 INFO - Running setup.py install for manifestparser 11:54:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:54:14 INFO - Running setup.py install for mozcrash 11:54:14 INFO - Running setup.py install for mozdebug 11:54:14 INFO - Running setup.py install for mozdevice 11:54:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:54:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:54:14 INFO - Running setup.py install for mozfile 11:54:14 INFO - Running setup.py install for mozhttpd 11:54:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:54:14 INFO - Running setup.py install for mozinfo 11:54:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:54:14 INFO - Running setup.py install for mozInstall 11:54:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:54:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:54:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:54:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:54:15 INFO - Running setup.py install for mozleak 11:54:15 INFO - Running setup.py install for mozlog 11:54:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:54:15 INFO - Running setup.py install for moznetwork 11:54:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:54:15 INFO - Running setup.py install for mozprocess 11:54:15 INFO - Running setup.py install for mozprofile 11:54:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:54:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:54:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:54:15 INFO - Running setup.py install for mozrunner 11:54:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:54:16 INFO - Running setup.py install for mozscreenshot 11:54:16 INFO - Running setup.py install for moztest 11:54:16 INFO - Running setup.py install for mozversion 11:54:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:54:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:54:16 INFO - Cleaning up... 11:54:16 INFO - Return code: 0 11:54:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:16 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 0x108538490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15a57b930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10834cd30>, '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 0x1081b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108344b20>, '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.ugxbg7s9zS/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.lG7rslhXQV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 11:54:16 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 11:54:16 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 11:54:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugxbg7s9zS/Render', 11:54:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:16 INFO - 'HOME': '/Users/cltbld', 11:54:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:16 INFO - 'LOGNAME': 'cltbld', 11:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:16 INFO - 'MOZ_NO_REMOTE': '1', 11:54:16 INFO - 'NO_EM_RESTART': '1', 11:54:16 INFO - 'PAGER': '/bin/cat', 11:54:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:16 INFO - 'PWD': '/builds/slave/test', 11:54:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:16 INFO - 'SHELL': '/bin/bash', 11:54:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lG7rslhXQV/Listeners', 11:54:16 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 11:54:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:16 INFO - 'USER': 'cltbld', 11:54:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:16 INFO - 'XPC_FLAGS': '0x0', 11:54:16 INFO - 'XPC_SERVICE_NAME': '0', 11:54:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:16 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-PukCeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:16 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)) 11:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:16 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-19WkkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:16 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)) 11:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:16 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-0v7gsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:17 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)) 11:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-MnpE9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:17 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)) 11:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-gSRaa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:17 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)) 11:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-pPCc8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:17 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)) 11:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-0o52Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:17 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)) 11:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-1Cz1Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:17 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)) 11:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-5KBixH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:17 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)) 11:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-OXbSRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:17 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)) 11:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-vUEYE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:17 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)) 11:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-wkwbrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:17 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)) 11:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-lUP0Ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:18 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)) 11:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-uAkAb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:18 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)) 11:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-RAahk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:18 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)) 11:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ttTIb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:18 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)) 11:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-s_lZ_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:18 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)) 11:54:18 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)) 11:54:18 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)) 11:54:18 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)) 11:54:18 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)) 11:54:18 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)) 11:54:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:54:18 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 11:54:18 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 11:54:18 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 11:54:18 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 11:54:18 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 11:54:18 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 11:54:21 INFO - Downloading blessings-1.6.tar.gz 11:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:54:21 INFO - Installing collected packages: blessings 11:54:21 INFO - Running setup.py install for blessings 11:54:21 INFO - Successfully installed blessings 11:54:21 INFO - Cleaning up... 11:54:21 INFO - Return code: 0 11:54:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:54:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:21 INFO - Reading from file tmpfile_stdout 11:54:21 INFO - Current package versions: 11:54:21 INFO - blessings == 1.6 11:54:21 INFO - blobuploader == 1.2.4 11:54:21 INFO - docopt == 0.6.1 11:54:21 INFO - functools32 == 3.2.3-2 11:54:21 INFO - jsonschema == 2.5.1 11:54:21 INFO - manifestparser == 1.1 11:54:21 INFO - mozInstall == 1.12 11:54:21 INFO - mozcrash == 1.0 11:54:21 INFO - mozdebug == 0.1 11:54:21 INFO - mozdevice == 0.48 11:54:21 INFO - mozfile == 1.2 11:54:21 INFO - mozhttpd == 0.7 11:54:21 INFO - mozinfo == 0.9 11:54:21 INFO - mozleak == 0.1 11:54:21 INFO - mozlog == 3.4 11:54:21 INFO - moznetwork == 0.27 11:54:21 INFO - mozprocess == 0.23 11:54:21 INFO - mozprofile == 0.28 11:54:21 INFO - mozrunner == 6.13 11:54:21 INFO - mozscreenshot == 0.1 11:54:21 INFO - mozsystemmonitor == 0.3 11:54:21 INFO - moztest == 0.8 11:54:21 INFO - mozversion == 1.4 11:54:21 INFO - psutil == 3.1.1 11:54:21 INFO - requests == 1.2.3 11:54:21 INFO - wsgiref == 0.1.2 11:54:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:21 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')]} 11:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:21 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')]} 11:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:21 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 0x108538490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15a57b930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10834cd30>, '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 0x1081b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108344b20>, '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.ugxbg7s9zS/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.lG7rslhXQV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 11:54:21 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 11:54:21 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 11:54:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugxbg7s9zS/Render', 11:54:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:21 INFO - 'HOME': '/Users/cltbld', 11:54:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:21 INFO - 'LOGNAME': 'cltbld', 11:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:21 INFO - 'MOZ_NO_REMOTE': '1', 11:54:21 INFO - 'NO_EM_RESTART': '1', 11:54:21 INFO - 'PAGER': '/bin/cat', 11:54:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:21 INFO - 'PWD': '/builds/slave/test', 11:54:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:21 INFO - 'SHELL': '/bin/bash', 11:54:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lG7rslhXQV/Listeners', 11:54:21 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 11:54:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:21 INFO - 'USER': 'cltbld', 11:54:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:21 INFO - 'XPC_FLAGS': '0x0', 11:54:21 INFO - 'XPC_SERVICE_NAME': '0', 11:54:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:21 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)) 11:54:21 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)) 11:54:21 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)) 11:54:21 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)) 11:54:21 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)) 11:54:21 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)) 11:54:21 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)) 11:54:21 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)) 11:54:21 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)) 11:54:21 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)) 11:54:21 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)) 11:54:21 INFO - Cleaning up... 11:54:21 INFO - Return code: 0 11:54:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:54:21 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')]} 11:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:21 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')]} 11:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:21 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 0x108538490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15a57b930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10834cd30>, '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 0x1081b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108344b20>, '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.ugxbg7s9zS/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.lG7rslhXQV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 11:54:21 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 11:54:21 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 11:54:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugxbg7s9zS/Render', 11:54:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:21 INFO - 'HOME': '/Users/cltbld', 11:54:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:21 INFO - 'LOGNAME': 'cltbld', 11:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:21 INFO - 'MOZ_NO_REMOTE': '1', 11:54:21 INFO - 'NO_EM_RESTART': '1', 11:54:21 INFO - 'PAGER': '/bin/cat', 11:54:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:21 INFO - 'PWD': '/builds/slave/test', 11:54:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:21 INFO - 'SHELL': '/bin/bash', 11:54:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lG7rslhXQV/Listeners', 11:54:21 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 11:54:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:21 INFO - 'USER': 'cltbld', 11:54:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:21 INFO - 'XPC_FLAGS': '0x0', 11:54:21 INFO - 'XPC_SERVICE_NAME': '0', 11:54:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:54:22 INFO - Cleaning up... 11:54:22 INFO - Return code: 0 11:54:22 INFO - Running post-action listener: _resource_record_post_action 11:54:22 INFO - Running post-action listener: _start_resource_monitoring 11:54:22 INFO - Starting resource monitoring. 11:54:22 INFO - [mozharness: 2017-02-07 19:54:22.284776Z] Finished create-virtualenv step (success) 11:54:22 INFO - [mozharness: 2017-02-07 19:54:22.285718Z] Running install step. 11:54:22 INFO - Running pre-action listener: _resource_record_pre_action 11:54:22 INFO - Running main action method: install 11:54:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:22 INFO - Reading from file tmpfile_stdout 11:54:22 INFO - Detecting whether we're running mozinstall >=1.0... 11:54:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:54:22 INFO - Reading from file tmpfile_stdout 11:54:22 INFO - Output received: 11:54:22 INFO - Usage: mozinstall [options] installer 11:54:22 INFO - Options: 11:54:22 INFO - -h, --help show this help message and exit 11:54:22 INFO - -d DEST, --destination=DEST 11:54:22 INFO - Directory to install application into. [default: 11:54:22 INFO - "/builds/slave/test"] 11:54:22 INFO - --app=APP Application being installed. [default: firefox] 11:54:22 INFO - mkdir: /builds/slave/test/build/application 11:54:22 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'] 11:54:22 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 11:54:44 INFO - Reading from file tmpfile_stdout 11:54:44 INFO - Output received: 11:54:44 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:54:44 INFO - Running post-action listener: _resource_record_post_action 11:54:44 INFO - [mozharness: 2017-02-07 19:54:44.072407Z] Finished install step (success) 11:54:44 INFO - [mozharness: 2017-02-07 19:54:44.072545Z] Running run-tests step. 11:54:44 INFO - Running pre-action listener: _resource_record_pre_action 11:54:44 INFO - Running main action method: run_tests 11:54:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:54:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:54:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:54:44 INFO - 2017-02-07 11:54:44.086 screenresolution[1630:7408] starting screenresolution argv=screenresolution get 11:54:44 INFO - 2017-02-07 11:54:44.089 screenresolution[1630:7408] Display 0: 1600x1200x32@60 11:54:44 INFO - 2017-02-07 11:54:44.095 screenresolution[1631:7410] starting screenresolution argv=screenresolution list 11:54:44 INFO - Available Modes on Display 0 11:54:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:54:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:54:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:54:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:54:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:54:44 INFO - Intel Iris: 11:54:44 INFO - Chipset Model: Intel Iris 11:54:44 INFO - Type: GPU 11:54:44 INFO - Bus: Built-In 11:54:44 INFO - VRAM (Dynamic, Max): 1536 MB 11:54:44 INFO - Vendor: Intel (0x8086) 11:54:44 INFO - Device ID: 0x0a2e 11:54:44 INFO - Revision ID: 0x0009 11:54:44 INFO - Displays: 11:54:44 INFO - Display: 11:54:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:54:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:54:44 INFO - Display Serial Number: 1600x1200 60 11:54:44 INFO - Main Display: Yes 11:54:44 INFO - Mirror: Off 11:54:44 INFO - Online: Yes 11:54:44 INFO - Rotation: Supported 11:54:44 INFO - Return code: 0 11:54:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:54:44 INFO - Python 2.7.3 11:54:44 INFO - Return code: 0 11:54:44 INFO - grabbing minidump binary from tooltool 11:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:44 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 0x10834cd30>, '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 0x1081b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108344b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:54:44 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 11:54:44 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 11:54:44 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 11:54:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:54:44 INFO - Return code: 0 11:54:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:54:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:54:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:54:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:54:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:54:44 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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:54:44 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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0269 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:54:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugxbg7s9zS/Render', 11:54:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:44 INFO - 'HOME': '/Users/cltbld', 11:54:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:44 INFO - 'LOGNAME': 'cltbld', 11:54:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:54:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:44 INFO - 'MOZ_NO_REMOTE': '1', 11:54:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:54:44 INFO - 'NO_EM_RESTART': '1', 11:54:44 INFO - 'PAGER': '/bin/cat', 11:54:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:44 INFO - 'PWD': '/builds/slave/test', 11:54:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:54:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:44 INFO - 'SHELL': '/bin/bash', 11:54:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lG7rslhXQV/Listeners', 11:54:44 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 11:54:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:44 INFO - 'USER': 'cltbld', 11:54:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:44 INFO - 'XPC_FLAGS': '0x0', 11:54:44 INFO - 'XPC_SERVICE_NAME': '0', 11:54:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:54:44 INFO - mozversion application_buildid: 20170207093257 11:54:44 INFO - mozversion application_changeset: be5204c4c3eeadb750181b939e58fbecada490db 11:54:44 INFO - mozversion application_display_name: Firefox 11:54:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:54:44 INFO - mozversion application_name: Firefox 11:54:44 INFO - mozversion application_remotingname: firefox 11:54:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:54:44 INFO - mozversion application_vendor: Mozilla 11:54:44 INFO - mozversion application_version: 52.0 11:54:44 INFO - mozversion platform_buildid: 20170207093257 11:54:44 INFO - mozversion platform_changeset: be5204c4c3eeadb750181b939e58fbecada490db 11:54:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:54:44 INFO - mozversion platform_version: 52.0 11:54:44 INFO - using testdate: 1486497284 11:54:44 INFO - actual date: 1486497284 11:54:44 INFO - starting webserver on 'localhost:49246' 11:54:44 INFO - SUITE-START | Running 2 tests 11:54:44 INFO - TEST-START | dromaeo_css 11:54:44 INFO - operating with platform_type : mac_ 11:54:44 INFO - Initialising browser for dromaeo_css test... 11:54:44 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpz_FxVB/profile http://localhost:49246/getInfo.html) 11:54:47 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 11:54:47 INFO - PROCESS | 1641 | colorDepth:24 11:54:47 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 11:54:47 INFO - PROCESS | 1641 | __metrics 11:54:47 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:54:47 INFO - PROCESS | 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:54:48 INFO - TEST-INFO | 1641: exit 0 11:54:48 INFO - Browser initialized. 11:54:48 INFO - Running cycle 1/1 for dromaeo_css test... 11:54:48 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpz_FxVB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:55:00 INFO - PROCESS | 1644 | RSS: Main: 171634688 11:55:00 INFO - PROCESS | 1644 | 11:58:04 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 11:58:05 INFO - PROCESS | 1644 | RSS: Main: 314122240 11:58:05 INFO - PROCESS | 1644 | 12:01:08 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 12:01:09 INFO - PROCESS | 1644 | RSS: Main: 299126784 12:01:09 INFO - PROCESS | 1644 | 12:04:11 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 12:04:12 INFO - PROCESS | 1644 | RSS: Main: 277766144 12:04:12 INFO - PROCESS | 1644 | 12:07:14 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 12:07:15 INFO - PROCESS | 1644 | RSS: Main: 282693632 12:07:15 INFO - PROCESS | 1644 | 12:10:18 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 12:10:19 INFO - PROCESS | 1644 | RSS: Main: 260493312 12:10:19 INFO - PROCESS | 1644 | 12:13:22 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 12:13:22 INFO - PROCESS | 1644 | RSS: Main: 306651136 12:13:22 INFO - PROCESS | 1644 | 12:13:22 INFO - PROCESS | 1644 | __start_tp_report 12:13:22 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 12:13:22 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 12:13:22 INFO - PROCESS | 1644 | |i|pagename|runs| 12:13:22 INFO - PROCESS | 1644 | |0;dojo.html;3482.3557641836264;3497.615262321146;3504.176518518148;3520.9471857922126;3574.982125089374;5704.030314846475;5725.713714314288;5764.7982320618785;5801.332846722628;5820.8253752387445;5685.687287199203;5754.884902301951;5759.136129580565;5773.191753154561;5789.797357092502;5219.321488206538;5255.474452554752;5259.526642602165;5286.841394758163;5351.384590772052;5203.739813009353;5210.374755029383;5217.452167522412;5346.117890548055;5357.1696387060065;5226.477352264781;5310.548603368699;5315.734213289339;5317.096093664087;5319.361676598814;5246.842594722164;5260.921086183691;5267.604929630254;5296.311479507678;5340.465953404629;5218.7912483500995;5257.921131183035;5265.341832270966;5274;5298.682079075268;4636.930446043312;5577.330720313588;5628.380878103405;5663.7168141593165;5751.712414379264;6135.967692822223;6187.4740647045055;6199.783007594758;6217.720202590849;6224.190855188796;6195.87608247837;6201.937980620181;6210.378962103753;6281.811545653592;6285.654289014103;5718.399568045378;5774.48029677331;5813.040848260074;5901.23283973085;5934.851628709317;6288.937110628926;6314.242290925118;6316.115743795872;6320.209973753281;6324.114623952651;6136.140940268366;6137;6143.109249158936;6148.385161483905;6164.013757798731;6113.962834745899;6119.694015299217;6131.541266919159;6141.547378150805;6189.133521307021;6118.663473509;6150.323464418911;6154.692265386713;6164.660943648142;6177.4749146322165;6174;6200.286966998763;6219.378062193744;6233.657148856766;6237.1891654084675;4923.113839508923;4967.379077615298;4972.801087956441;4982.950170498249;4992.775325110379;4452.287633978548;4481.439820022497;4513.210188217049;4519.570640789186;4529.456465224194;5767.971160144172;5827.388124246978;5845.824625261249;5913.408659134052;5956.493698035629;6130.601510901866;6164.660943648053;6166.445019948226;6182.474489668339;6184;5643.746031428595;5811.3026436827;5885.5585831062845;5896.675682837399;5903.321118071391;4576.405067341224;5372.516473517324;5389.434109418533;5415.53967912724;5488.17677348401;6332.968335158294;6379.617222966544;6391.840203994937;6415.807525774234;6418.261899881573;6162.106494558354;6173.290071641639;6184.5980011299125;6189.071639254148;6205;6121.178620693132;6131.499004853578;6254.030625253093;6257.374262573706;6296.622202667854;6150.661713605616;6185.907211391923;6189.195404597373;6223.128761973237;6238.064290356301;6164.198654174928;6166.568340216142;6179.84550386244;6183.628982261079;6195.628262304276;6010.789622363196;6082.695865206811;6089.269287685506;6100.389961004042;6237.625742455467;5703.62926409782;6094.14681944537;6147.3709466990385;6171.506279497719;6205.472534834409;6014.789482368096;6016;6024.427679370453;6026.578139530191;6033.456988871023;5890.852728681817;6012.9098063529955;6095.908561371494;6148.262208535004;6151.907721384094;5914.467697907209;5942.316633587193;5942.97028514872;6035.879282414415;6057.333693293646 12:13:22 INFO - PROCESS | 1644 | |1;ext.html;429.29595463439955;500.8780332056193;526.9920951185733;534.7727215933228;535.2265975665163;30445;39904.80047599762;41062.97342566437;41246.587534124614;43225.78387108068;42596;42711.78644106783;42909;42977.35533966993;43125;9585.041495850412;9756.902430975706;9768.511574421285;9778.657746978857;9781.266405019616;9575.473348965805;9686.70939871805;9691.95154024229;9696.030396960317;9696.612135514606;9702.466364349957;9746.46394448305;9754.804903901953;9764.804703905918;9776.755581110494;9653.855192172088;9721.562529686182;9725.076117768871;9735.36720113194;9736.513174341255;9581.520923953774;9600.711978640651;9688.079632434907;9690.806183876353;9704.90295097047;40495;40888;40909.59090409117;40926.59073409258;40969.79515102435;3230.402375560529;3393.9490907636405;3409.9488507672404;3736.1220113273357;3983.4423180754716;29380.41239175226;29968.8501557493;31957.680423195936;32067.51898721521;32801.83599082013;3299.5710557627594;3355;3373.881914133018;3388.457846744509;3423.3666771647327;523040.3847980774;527782;528231;529415.9999999962;529840;35892.92321230367;67866.32133678699;68790;68961;68973.3102668977;36668.81665591655;37339.06652333713;37591;37622.8118859404;37669.43495847564;15467.381304747909;15629.140397278032;15654.452094176877;15704.371825127095;15719.899607027626;13069.738605227842;13101.082924195405;13159.94720422383;13178.736425271632;13188.142770719873;8211.21993410625;8225.95887020573;8271.917280827234;8296.087430382653;8304.792380190424;2879.294572829628;3467.9826600866836;3470.392681280766;3497.720182385403;3615.023943535231;919.9402038867452;933.4632586262926;1014.1177175856905;1027.4811220333684;1032.2464600841429;29652.0831564699;29798.702012979593;29918.401631967237;30009.849950750107;30766.69233307683;929.818685356349;999.5551979369111;1021.6628512590827;1023.7542989682422;1086.163653986426;13715.1085179463;14234.399632815133;14373.78439323411;14428.567142985727;14551.199684017269;676117;709903;717417;719407;721422;55564;55608.443915560325;55781.16328255079;55822.72088639612;55847.16229256564;1251.555697727312;1309.9672508187182;1369.9931500342434;1429.106808244847;1430.9856901430853;29210.853945730134;29713.851430742707;29720.702792971795;29777.5533367004;30269.243268917573;45994.31008534808;46511.30233046575;46603.766981164874;46654.53345466638;46700.532994670975;469180;471683;473049;473484;673903;22014.88992555027;23058.192963246205;26051;26822.731772682804;26861.328466788487;43452.56547434612;43739.56260437355;43789;43853;44004.77997609991;36025.459618105226;36183.27633447369;36913.44629830609;38309.04227394226;38396.808015959745;36411;36786.08034799151;36927;37479.25041499209;37523.624763753105;36377.09057273589;37024.814875926524;37112.25775484421;37142;37276.44085338668;32439.67560324461;32568;33327.666723332455;33359.49960750542;33511.497327540594;24849.378765531008;24929.626055608816;24962.001519939;25069.498610028062;25277.11530096438 12:13:22 INFO - PROCESS | 1644 | |2;jquery.html;348.4668457260392;381.77856843031026;392.8840991907387;396.75797763364363;411.17559293616296;19498.8300701958;20230.39308820734;20794.688079678817;21131.57736845262;21263.787362126375;12188.695282617939;12366.629001129959;14792.112473251585;20474.385768426935;21137.26019589315;4978.7801988512865;5346.705931173774;5586.581006424514;5587.217789509452;5590.944090559104;5422.810201642943;6158.137860699483;6225.750969961219;6235.095911092889;6240.750369985195;4922.827701030465;6053.697315134248;6197.69011549423;6206.565540412173;6207.441330280274;6107.664078475682;6149.077638354238;6155.630662160263;6158.445739883432;6161;4071.5928407159345;4951.480094590052;5185.637005409585;5422.915416916632;5428.4028756836715;13464.663383415394;13496.325183740773;13550.186988780704;13706.38321275545;13714.51999180024;2295.414669259345;2304.147465437782;2395.4490467192645;2454.0674543673467;2471.6910386201725;8264.958675206586;9800.970898055673;10675.893241067568;10689.572417103307;10911.56353745857;1618.5872602486409;1716.373523663866;1740.8346207110305;1803.323753592403;1842;98422;106235;108347;108861;120522;11253.324800511995;11680.123990700731;11720.355380453986;11756.94121529387;11823.586174483851;12455.875441245471;15206.695866082837;15211.315490802941;15211.771823422658;15214.391424343125;8548.48709077445;8797.340199485065;8828.690995815115;8959.328050396247;8960.417572857874;7138.571685698875;8763.255123314462;8785.648574057093;8787.34094942869;8935.151160639729;4233.322668373045;4370.562943705604;4550.635949124062;4611.792469338888;4685;1788.3830078622855;1865.5056410051347;1905.3426567834076;1944.6402415553168;1958.8530860185542;864.8659457783928;899.2940541674753;936.990630093704;953.7424895278375;988.4415305352453;20399.478550129756;21991.676397496907;22006.84093576018;22049.889750551465;22081.971711527363;918.4443411735937;944.579662050381;949.3070058856935;984.2618036472645;990.7820279538635;10700.892991070144;11653.59212427561;11654.53381864733;11686.824697629543;11689.532418703157;553755.2312238413;554090;556881;561362;563797.1810141006;91284;119466;127430;133543;137592;962.8603852441357;984.1290457944771;993.7714325705128;1000.2797985450464;1000.9199264058858;18985.43043708691;19559.804401955796;20210.59578808386;20255.898720506302;20334.084966176262;48776.2683559754;48892.022159557324;50684.986300274526;57472;58113;73730.89403658842;81438.18561814306;81971;85746.28507429692;85854;7868.72459463916;8092.231238032377;8099.8380032397845;8354.832903342021;8565.657373704982;9548.140667339972;11874.940625296818;11968.640940771791;12506.68733281639;12829.486820527447;10986.890131098588;11005.669829905115;11497.94251028773;11683.240589361665;11709.414529273672;10314.071733544017;10532.842007369742;10702.732431688959;10762.085222756154;11416.543338266376;11222.831657525307;11511.827322590336;11577.710557236136;11606.245594036698;11927;8106.797330066795;8191.426600137933;8360;8366.665333386596;8421.15788421153;10738.677839664822;11304.773904522028;11312.547498100314;11395.031422329195;11648.41757912084 12:13:22 INFO - PROCESS | 1644 | |3;mootools.html;1483.1471903655397;1523.801905752252;1646.3990643415157;1819.7998220195784;1858.3495776478226;8247.463914845532;8703.695370662028;8711.346649001318;8714.694985675502;8758.948926128858;6812.284710105429;7654.081510218768;7858.685652573905;7867.134615192324;8506.234438900497;2356.9057237710513;2403.4952659941346;2403.7596240375997;2404.014354114813;2407.7471865454136;2390.282915125464;2408.1451084864884;2430.4774473488196;2434.4887573609476;2436.049940523197;2374.299581623425;2381.714194296687;2404.002339029301;2408.952105833968;2411.5176964607062;2367.2188177901253;2370.383700237933;2392.6650268962358;2394.8563086214795;2395.5448464791807;1997.4806550296883;2389.5220955808736;2390.9880450597634;2416.5287768885073;2417.9516409671883;8522.14778522149;8558.315334773204;8629.784255393603;8644.178803013767;8695.869561956575;5182.326297581328;5321.813736519203;5336.039512887679;5350.5452036576935;5358.410574836765;3095.860686269101;3526.690018038189;3548.964510354889;3605.94591081134;3624.474451204587;1050.4327663061938;1078.412265315405;1090.650991682662;1125.724197571592;1128.0298942909092;11243.269187502787;11331.943340283327;11352.48913798881;11356.375399353032;11384.886151138548;4558.1795276849825;4718.811247550128;4816.614670826326;4837.032593481318;4881.072596206709;9560.90439095614;9747.220222382193;9753.073458021476;9762.90237097634;9774.413535187912;5354.892902141935;5356.196570514454;5358.946410535923;5365.061114305059;5375.086235340002;4402;4446.755428451402;4655.790489427984;4893.535114164149;4937.333459982929;3199.472087105648;3279.6884295991845;3937.3503371943307;4035.5270326331265;4051.655609273245;1280.180684362009;1283.1980012492193;1289.9097063205486;1296.941637626309;1304.4325718312564;760.2701406649568;857.9404435522125;897.3359713811732;897.3628723606182;920.1764420843441;5582.581306402036;5611.9719401403545;5676.2337084493065;5798.217240672539;5953.791617293374;448.5805771603496;448.6276390595863;454.07368967306326;464.1042787420244;466.2260647325491;3773.6792372648083;3774.3206222879594;3797.6582107610448;3848.4804551385764;3902.2195560887935;9867.851982220272;9946.751331216778;10308.814486334168;10450.68647940563;10473.581056757797;10076.84884726715;10357.223208259411;10362;10384.37693738378;10393.740156495996;7955.4828936118965;7991.0410750709125;8068.273855353046;8176.632051557575;8200.630971606173;5502.339719233718;5684.090545512699;5740;5741.712914354349;5834.620749651259;9234.076592340713;9407.4825884577;9498.572564234488;9505.857412138685;9605.759856003655;9464.1009104135;9728.367656102331;9747.707568772948;9837.704868853945;9851.950740246253;6818.965905170442;7052.471064670068;7296.306850849161;7405.555666660018;7564.886526701994;8052.315553177811;8308.584570771316;8317.750467485985;8331.250187483156;8334.08325084228;7280.199178090512;7360.521566098187;7394.741184058532;7531.246875312425;7549.1695913448375;5976.850578735392;7224.602646854473;7285.635718214174;7298.087739032621;7363.926360736324;5913.46778789911;6510.0885875976455;6576.408123268929;6750.426213771688;6754.257031726408;4837.854864354075;4889.095517329305;4911.63162762787;4940.110780059624;4978.452370239198;4869.586085182799;4870.391201099863;4879;4913.361263035782;5040.168372218543 12:13:22 INFO - PROCESS | 1644 | |4;prototype.html;304.3517308133676;308.9830059346736;316.966718494558;322.9644739078701;325.1935200702257;4936.728479933602;5014.774335154918;5153.81961631343;5174.508421699942;5194.92207616886;4134.689898257628;4992.480301387523;5036.597072234222;5110.616703747215;5111.361079865017;3275.4431746603013;3719.4978677878544;3904.9804750976205;3999.3401088820383;4026.71812973092;2918.401727645838;3479.1038883808387;3751.4865040422983;3823;4013.9197216055663;3827.8660246891363;3985.80070996449;3999.2201520703475;4005.9198816023663;4018.5780493048246;3968.5436174839974;3984.203159368109;3989.620986006339;3992.2215168042244;4009.1380353223904;3470.670286322795;3492.0920560654413;3498.772579782306;3503.5095086687884;3553.6446355364515;4247.851325203634;4720.763961801897;4925.704457732548;4971.776270067856;5001.774920128603;4501.279795232747;4502.212112880233;4539.931901021488;4540.616176507327;4546.249868771649;5331.893362132736;5349.358077030743;5353.420740881449;5361.329833770778;5381.408045115034;3326.700596946262;3478.4260597001467;3869.187470631171;3876.1432374786987;3887.688984881203;4790.712557246577;4840.346553215306;5608.831010479066;5620.3865202680545;5645.1532270159805;3479.860805567749;3770.1517158639085;3793.886183414502;3813.618638136164;3816.2939856126704;3238.5588413156393;3463.3246516928957;3681.0613293610495;3901.8244179012013;3910.452536644872;3686.668199862025;4163.10493243954;4467.843625473158;4477.500037487478;4479.200499687695;4650.720956742539;5059.038782631288;5456.481634244819;5456.727163641882;5533.529649979716;1069.1340014588052;1215.4442313838301;1236.9281453565243;1236.9443375048145;1243.664210663116;651.9674016299166;804.4851295171095;859.9828003439897;873.702941000063;873.7422460374205;3973.1854969731135;4651.2557990721325;4780.4741478437345;4828.233977497557;4907.631927605444;4846.684965477232;4938.753062346868;5078.771455284521;5322.4411436799355;5324.444266751981;4305.182015417061;4438.800253988578;4649.790759415834;4794.2808578713475;4839.596517010028;2453.4970331082086;2531.784798292129;2704.7971402144917;2747.7801775857884;2758.2828464599347;5447.591430642718;5453.345598528202;5480.615932069562;5490.203920431515;5509.752061157257;4817.626976311734;5446.2647542582035;5770.422957704196;5777.24895763548;5797.652140871562;4462.41988541494;4520.706154099973;5656.190019193818;5808.970955145197;5827.562932780059;5364.785408583613;5597.468240517144;5635.6618602883955;5640.576956728344;5651.039323314964;4481.731096134243;4595.012072404449;4778.665493415567;5511.338639363142;5557.194206840067;4665.32352808834;4677.830996748544;4809.302651115639;5229.450907654642;5926.4666180044005;3160.3995240904155;3428.9657103428644;3537.363274610595;3541.4864844597905;3653.214558869856;5579.46995035471;5585.413531579125;5589.664620122806;5594.188842617879;5609.831705048855;5383.327084114486;5384.6769193848495;5402.756875940513;5412.269343638558;5430.918536222039;5039.496050395078;5285.339332583427;5295.682259064469;5330.148370621699;5425.782968681367;4861.635377346784;4990.900181996267;5103.5661968733075;5222.582193424593;5291.60312976536;5418.918716219338;5421.810236641699;5430.348358197041;5452.6183167177915;5484.451554844483;4827.986122914227;4957.355543779286;5157.948420515747;5318.835293000659;5341.23739166082 12:13:22 INFO - PROCESS | 1644 | |5;yui.html;658.8748137853808;749.8013026547966;798.9201079892015;817.0481389181606;852.4373913217274;12662.176958497692;14213.502527411543;14865.702685946275;15361.539153825375;15433.69132617347;13900.652483687887;14089.647758806035;14097.57707268781;14110.082844615094;14878.256087195625;851.0935853316214;879.5997820991465;882.2765332427412;883.2889523933231;884.8539990901526;698.3923986132072;720.3588805962671;721.3904250907974;721.9566825990457;723.847991921697;755.4334249313015;850.8723691446302;902.6208992223281;937.3298091864316;939.8073394954018;859.3941271403677;924.366808736018;925.5048549026238;925.5511077127587;926.8517037274071;681.3629256645053;683.3132701634875;683.7538486144983;684.2575805251308;684.6131935456451;14240.359183836752;14529.200893950829;14589.562313130516;14657.340419681033;14687.26563671812;13377;13421.463141474329;13446.193228406328;13568.321583920764;13801.309934503335;9995.550200240934;12323.445444954908;12468.43892024861;12715;12946.611601651966;3800.7339486235974;4451.710638808499;4593;4594.586487216133;4603.171429142786;88291;94641.52679236559;95138.6215344615;96845.51577242068;98475.50762246143;10676.039156475954;10716.785664286826;10906.836397454044;10938.015578597964;11418.771624567627;20951.476213094793;20961.05675244587;21002.78997210039;21213.363599092052;21218.045187966578;7577.242275772379;7861.764147075597;8052.637631306605;8201.933748612642;8230.176982301722;4367.352641769315;4422.248217802981;4548.226801443762;4594.632429405639;4678.929816052762;3475.09647491654;3559.8220088995445;3560.0565850049757;3602.8018458985007;3610.837512311952;554.2351554854275;646.8518379875758;659.7427003468651;659.986800263992;665.8335416145964;487.3493885662609;590.822753174046;655.1123228026051;659.4691273524762;666.9133012708414;8974.506402147945;9291.488968106683;9469.763255918657;9502.287328450393;9519;562.7861412663244;596.1921596237123;612.9724162412613;661.6832503318458;681.0023315842315;4374.19077470669;4557.680962332605;4567.474740404829;4613.192691279013;4613.284940834176;117376.23935640973;118075.40962295134;119343;121967.3901630504;122388;101997;104547;105490;106101.46949265205;107365;91389.54305228431;92582;92780.53609732044;93704;95040;8400.705975290835;8600.09698981598;8748.956255218684;8913.465192088495;9058.320625953213;55044;55317.766213250674;57190.7140464295;57774;59227.51931201582;73541.8968715459;76746;80416.79374809499;83214;83592;11118.944405277922;11394.113224083005;11547.249428787101;11692.064634829023;12036.458359374024;11570;11926.642200733992;12389.946854517468;12427.689307767378;12492.500299987898;11940.52237910474;11980.224505365097;12151.210171338835;12360.381980901098;12577.182483138567;11472.31166130035;11999.20310787934;12005.63983080509;12183.147179697691;12205.69485762863;11521.193516453768;11943.462544185706;11950.34273114987;12016.63950081464;12037.699057523281;9966.750831229278;10073.69778906634;10087.949560252446;10161.542730576994;11336.376499292619;10871.619493317696;11209.159313051718;11621.418929053683;11663.24188927717;11671.183017188716 12:13:22 INFO - PROCESS | 1644 | __end_tp_report 12:13:22 INFO - PROCESS | 1644 | __start_cc_report 12:13:22 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1514 12:13:22 INFO - PROCESS | 1644 | __end_cc_report 12:13:22 INFO - PROCESS | 1644 | __startTimestamp1486498402545__endTimestamp 12:13:22 INFO - PROCESS | 1644 | 12:13:22 INFO - PROCESS | 1644 | ------- Summary: start ------- 12:13:22 INFO - PROCESS | 1644 | Number of tests: 6 12:13:22 INFO - PROCESS | 1644 | 12:13:22 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5759.03 Median:6014.79 stddev:611.81 (10.2%) stddev-sans-first:587.04 12:13:22 INFO - PROCESS | 1644 | Values: 3482.4 3497.6 3504.2 3520.9 3575.0 5704.0 5725.7 5764.8 5801.3 5820.8 5685.7 5754.9 5759.1 5773.2 5789.8 5219.3 5255.5 5259.5 5286.8 5351.4 5203.7 5210.4 5217.5 5346.1 5357.2 5226.5 5310.5 5315.7 5317.1 5319.4 5246.8 5260.9 5267.6 5296.3 5340.5 5218.8 5257.9 5265.3 5274.0 5298.7 4636.9 5577.3 5628.4 5663.7 5751.7 6136.0 6187.5 6199.8 6217.7 6224.2 6195.9 6201.9 6210.4 6281.8 6285.7 5718.4 5774.5 5813.0 5901.2 5934.9 6288.9 6314.2 6316.1 6320.2 6324.1 6136.1 6137.0 6143.1 6148.4 6164.0 6114.0 6119.7 6131.5 6141.5 6189.1 6118.7 6150.3 6154.7 6164.7 6177.5 6174.0 6200.3 6219.4 6233.7 6237.2 4923.1 4967.4 4972.8 4983.0 4992.8 4452.3 4481.4 4513.2 4519.6 4529.5 5768.0 5827.4 5845.8 5913.4 5956.5 6130.6 6164.7 6166.4 6182.5 6184.0 5643.7 5811.3 5885.6 5896.7 5903.3 4576.4 5372.5 5389.4 5415.5 5488.2 6333.0 6379.6 6391.8 6415.8 6418.3 6162.1 6173.3 6184.6 6189.1 6205.0 6121.2 6131.5 6254.0 6257.4 6296.6 6150.7 6185.9 6189.2 6223.1 6238.1 6164.2 6166.6 6179.8 6183.6 6195.6 6010.8 6082.7 6089.3 6100.4 6237.6 5703.6 6094.1 6147.4 6171.5 6205.5 6014.8 6016.0 6024.4 6026.6 6033.5 5890.9 6012.9 6095.9 6148.3 6151.9 5914.5 5942.3 5943.0 6035.9 6057.3 12:13:22 INFO - PROCESS | 1644 | 12:13:22 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:69897.17 Median:38352.93 stddev:158761.68 (413.9%) stddev-sans-first:159121.37 12:13:22 INFO - PROCESS | 1644 | Values: 429.3 500.9 527.0 534.8 535.2 30445.0 39904.8 41063.0 41246.6 43225.8 42596.0 42711.8 42909.0 42977.4 43125.0 9585.0 9756.9 9768.5 9778.7 9781.3 9575.5 9686.7 9692.0 9696.0 9696.6 9702.5 9746.5 9754.8 9764.8 9776.8 9653.9 9721.6 9725.1 9735.4 9736.5 9581.5 9600.7 9688.1 9690.8 9704.9 40495.0 40888.0 40909.6 40926.6 40969.8 3230.4 3393.9 3409.9 3736.1 3983.4 29380.4 29968.9 31957.7 32067.5 32801.8 3299.6 3355.0 3373.9 3388.5 3423.4 523040.4 527782.0 528231.0 529416.0 529840.0 35892.9 67866.3 68790.0 68961.0 68973.3 36668.8 37339.1 37591.0 37622.8 37669.4 15467.4 15629.1 15654.5 15704.4 15719.9 13069.7 13101.1 13159.9 13178.7 13188.1 8211.2 8226.0 8271.9 8296.1 8304.8 2879.3 3468.0 3470.4 3497.7 3615.0 919.9 933.5 1014.1 1027.5 1032.2 29652.1 29798.7 29918.4 30009.8 30766.7 929.8 999.6 1021.7 1023.8 1086.2 13715.1 14234.4 14373.8 14428.6 14551.2 676117.0 709903.0 717417.0 719407.0 721422.0 55564.0 55608.4 55781.2 55822.7 55847.2 1251.6 1310.0 1370.0 1429.1 1431.0 29210.9 29713.9 29720.7 29777.6 30269.2 45994.3 46511.3 46603.8 46654.5 46700.5 469180.0 471683.0 473049.0 473484.0 673903.0 22014.9 23058.2 26051.0 26822.7 26861.3 43452.6 43739.6 43789.0 43853.0 44004.8 36025.5 36183.3 36913.4 38309.0 38396.8 36411.0 36786.1 36927.0 37479.3 37523.6 36377.1 37024.8 37112.3 37142.0 37276.4 32439.7 32568.0 33327.7 33359.5 33511.5 24849.4 24929.6 24962.0 25069.5 25277.1 12:13:22 INFO - PROCESS | 1644 | 12:13:22 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:33207.46 Median:2462.88 stddev:93290.50 (3787.9%) stddev-sans-first:93519.58 12:13:22 INFO - PROCESS | 1644 | Values: 348.5 381.8 392.9 396.8 411.2 19498.8 20230.4 20794.7 21131.6 21263.8 12188.7 12366.6 14792.1 20474.4 21137.3 4978.8 5346.7 5586.6 5587.2 5590.9 5422.8 6158.1 6225.8 6235.1 6240.8 4922.8 6053.7 6197.7 6206.6 6207.4 6107.7 6149.1 6155.6 6158.4 6161.0 4071.6 4951.5 5185.6 5422.9 5428.4 13464.7 13496.3 13550.2 13706.4 13714.5 2295.4 2304.1 2395.4 2454.1 2471.7 8265.0 9801.0 10675.9 10689.6 10911.6 1618.6 1716.4 1740.8 1803.3 1842.0 98422.0 106235.0 108347.0 108861.0 120522.0 11253.3 11680.1 11720.4 11756.9 11823.6 12455.9 15206.7 15211.3 15211.8 15214.4 8548.5 8797.3 8828.7 8959.3 8960.4 7138.6 8763.3 8785.6 8787.3 8935.2 4233.3 4370.6 4550.6 4611.8 4685.0 1788.4 1865.5 1905.3 1944.6 1958.9 864.9 899.3 937.0 953.7 988.4 20399.5 21991.7 22006.8 22049.9 22082.0 918.4 944.6 949.3 984.3 990.8 10700.9 11653.6 11654.5 11686.8 11689.5 553755.2 554090.0 556881.0 561362.0 563797.2 91284.0 119466.0 127430.0 133543.0 137592.0 962.9 984.1 993.8 1000.3 1000.9 18985.4 19559.8 20210.6 20255.9 20334.1 48776.3 48892.0 50685.0 57472.0 58113.0 73730.9 81438.2 81971.0 85746.3 85854.0 7868.7 8092.2 8099.8 8354.8 8565.7 9548.1 11874.9 11968.6 12506.7 12829.5 10986.9 11005.7 11497.9 11683.2 11709.4 10314.1 10532.8 10702.7 10762.1 11416.5 11222.8 11511.8 11577.7 11606.2 11927.0 8106.8 8191.4 8360.0 8366.7 8421.2 10738.7 11304.8 11312.5 11395.0 11648.4 12:13:22 INFO - PROCESS | 1644 | 12:13:22 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5552.92 Median:4959.28 stddev:3082.48 (62.2%) stddev-sans-first:3075.95 12:13:22 INFO - PROCESS | 1644 | Values: 1483.1 1523.8 1646.4 1819.8 1858.3 8247.5 8703.7 8711.3 8714.7 8758.9 6812.3 7654.1 7858.7 7867.1 8506.2 2356.9 2403.5 2403.8 2404.0 2407.7 2390.3 2408.1 2430.5 2434.5 2436.0 2374.3 2381.7 2404.0 2409.0 2411.5 2367.2 2370.4 2392.7 2394.9 2395.5 1997.5 2389.5 2391.0 2416.5 2418.0 8522.1 8558.3 8629.8 8644.2 8695.9 5182.3 5321.8 5336.0 5350.5 5358.4 3095.9 3526.7 3549.0 3605.9 3624.5 1050.4 1078.4 1090.7 1125.7 1128.0 11243.3 11331.9 11352.5 11356.4 11384.9 4558.2 4718.8 4816.6 4837.0 4881.1 9560.9 9747.2 9753.1 9762.9 9774.4 5354.9 5356.2 5358.9 5365.1 5375.1 4402.0 4446.8 4655.8 4893.5 4937.3 3199.5 3279.7 3937.4 4035.5 4051.7 1280.2 1283.2 1289.9 1296.9 1304.4 760.3 857.9 897.3 897.4 920.2 5582.6 5612.0 5676.2 5798.2 5953.8 448.6 448.6 454.1 464.1 466.2 3773.7 3774.3 3797.7 3848.5 3902.2 9867.9 9946.8 10308.8 10450.7 10473.6 10076.8 10357.2 10362.0 10384.4 10393.7 7955.5 7991.0 8068.3 8176.6 8200.6 5502.3 5684.1 5740.0 5741.7 5834.6 9234.1 9407.5 9498.6 9505.9 9605.8 9464.1 9728.4 9747.7 9837.7 9852.0 6819.0 7052.5 7296.3 7405.6 7564.9 8052.3 8308.6 8317.8 8331.3 8334.1 7280.2 7360.5 7394.7 7531.2 7549.2 5976.9 7224.6 7285.6 7298.1 7363.9 5913.5 6510.1 6576.4 6750.4 6754.3 4837.9 4889.1 4911.6 4940.1 4978.5 4869.6 4870.4 4879.0 4913.4 5040.2 12:13:22 INFO - PROCESS | 1644 | 12:13:22 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4330.29 Median:4822.81 stddev:1337.69 (27.7%) stddev-sans-first:1306.86 12:13:22 INFO - PROCESS | 1644 | Values: 304.4 309.0 317.0 323.0 325.2 4936.7 5014.8 5153.8 5174.5 5194.9 4134.7 4992.5 5036.6 5110.6 5111.4 3275.4 3719.5 3905.0 3999.3 4026.7 2918.4 3479.1 3751.5 3823.0 4013.9 3827.9 3985.8 3999.2 4005.9 4018.6 3968.5 3984.2 3989.6 3992.2 4009.1 3470.7 3492.1 3498.8 3503.5 3553.6 4247.9 4720.8 4925.7 4971.8 5001.8 4501.3 4502.2 4539.9 4540.6 4546.2 5331.9 5349.4 5353.4 5361.3 5381.4 3326.7 3478.4 3869.2 3876.1 3887.7 4790.7 4840.3 5608.8 5620.4 5645.2 3479.9 3770.2 3793.9 3813.6 3816.3 3238.6 3463.3 3681.1 3901.8 3910.5 3686.7 4163.1 4467.8 4477.5 4479.2 4650.7 5059.0 5456.5 5456.7 5533.5 1069.1 1215.4 1236.9 1236.9 1243.7 652.0 804.5 860.0 873.7 873.7 3973.2 4651.3 4780.5 4828.2 4907.6 4846.7 4938.8 5078.8 5322.4 5324.4 4305.2 4438.8 4649.8 4794.3 4839.6 2453.5 2531.8 2704.8 2747.8 2758.3 5447.6 5453.3 5480.6 5490.2 5509.8 4817.6 5446.3 5770.4 5777.2 5797.7 4462.4 4520.7 5656.2 5809.0 5827.6 5364.8 5597.5 5635.7 5640.6 5651.0 4481.7 4595.0 4778.7 5511.3 5557.2 4665.3 4677.8 4809.3 5229.5 5926.5 3160.4 3429.0 3537.4 3541.5 3653.2 5579.5 5585.4 5589.7 5594.2 5609.8 5383.3 5384.7 5402.8 5412.3 5430.9 5039.5 5285.3 5295.7 5330.1 5425.8 4861.6 4990.9 5103.6 5222.6 5291.6 5418.9 5421.8 5430.3 5452.6 5484.5 4828.0 4957.4 5157.9 5318.8 5341.2 12:13:22 INFO - PROCESS | 1644 | 12:13:22 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:21704.17 Median:4580.24 stddev:32773.82 (715.5%) stddev-sans-first:32827.66 12:13:22 INFO - PROCESS | 1644 | Values: 658.9 749.8 798.9 817.0 852.4 12662.2 14213.5 14865.7 15361.5 15433.7 13900.7 14089.6 14097.6 14110.1 14878.3 851.1 879.6 882.3 883.3 884.9 698.4 720.4 721.4 722.0 723.8 755.4 850.9 902.6 937.3 939.8 859.4 924.4 925.5 925.6 926.9 681.4 683.3 683.8 684.3 684.6 14240.4 14529.2 14589.6 14657.3 14687.3 13377.0 13421.5 13446.2 13568.3 13801.3 9995.6 12323.4 12468.4 12715.0 12946.6 3800.7 4451.7 4593.0 4594.6 4603.2 88291.0 94641.5 95138.6 96845.5 98475.5 10676.0 10716.8 10906.8 10938.0 11418.8 20951.5 20961.1 21002.8 21213.4 21218.0 7577.2 7861.8 8052.6 8201.9 8230.2 4367.4 4422.2 4548.2 4594.6 4678.9 3475.1 3559.8 3560.1 3602.8 3610.8 554.2 646.9 659.7 660.0 665.8 487.3 590.8 655.1 659.5 666.9 8974.5 9291.5 9469.8 9502.3 9519.0 562.8 596.2 613.0 661.7 681.0 4374.2 4557.7 4567.5 4613.2 4613.3 117376.2 118075.4 119343.0 121967.4 122388.0 101997.0 104547.0 105490.0 106101.5 107365.0 91389.5 92582.0 92780.5 93704.0 95040.0 8400.7 8600.1 8749.0 8913.5 9058.3 55044.0 55317.8 57190.7 57774.0 59227.5 73541.9 76746.0 80416.8 83214.0 83592.0 11118.9 11394.1 11547.2 11692.1 12036.5 11570.0 11926.6 12389.9 12427.7 12492.5 11940.5 11980.2 12151.2 12360.4 12577.2 11472.3 11999.2 12005.6 12183.1 12205.7 11521.2 11943.5 11950.3 12016.6 12037.7 9966.8 10073.7 10087.9 10161.5 11336.4 10871.6 11209.2 11621.4 11663.2 11671.2 12:13:22 INFO - PROCESS | 1644 | -------- Summary: end -------- 12:13:22 INFO - PROCESS | 1644 | 12:13:23 INFO - TEST-INFO | 1644: exit 0 12:13:23 INFO - TEST-OK | dromaeo_css | took 1118454ms 12:13:23 INFO - TEST-START | kraken 12:13:23 INFO - operating with platform_type : mac_ 12:13:23 INFO - Initialising browser for kraken test... 12:13:23 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpHh5Hfe/profile http://localhost:49246/getInfo.html) 12:13:25 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 12:13:25 INFO - PROCESS | 1654 | colorDepth:24 12:13:25 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 12:13:25 INFO - PROCESS | 1654 | __metrics 12:13:25 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:13:25 INFO - PROCESS | 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:13:26 INFO - TEST-INFO | 1654: exit 0 12:13:26 INFO - Browser initialized. 12:13:26 INFO - Running cycle 1/1 for kraken test... 12:13:26 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpHh5Hfe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:38 INFO - PROCESS | 1656 | RSS: Main: 167612416 12:13:38 INFO - PROCESS | 1656 | 12:13:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 12:13:42 INFO - PROCESS | 1656 | RSS: Main: 217546752 12:13:42 INFO - PROCESS | 1656 | 12:13:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 12:13:45 INFO - PROCESS | 1656 | RSS: Main: 230998016 12:13:45 INFO - PROCESS | 1656 | 12:13:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 12:13:49 INFO - PROCESS | 1656 | RSS: Main: 328470528 12:13:49 INFO - PROCESS | 1656 | 12:13:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 12:13:51 INFO - PROCESS | 1656 | RSS: Main: 232308736 12:13:51 INFO - PROCESS | 1656 | 12:13:53 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:13:54 INFO - PROCESS | 1656 | RSS: Main: 233443328 12:13:54 INFO - PROCESS | 1656 | 12:13:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 12:13:57 INFO - PROCESS | 1656 | RSS: Main: 271962112 12:13:57 INFO - PROCESS | 1656 | 12:14:00 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 12:14:01 INFO - PROCESS | 1656 | RSS: Main: 272355328 12:14:01 INFO - PROCESS | 1656 | 12:14:03 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 12:14:04 INFO - PROCESS | 1656 | RSS: Main: 271347712 12:14:04 INFO - PROCESS | 1656 | 12:14:06 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:14:06 INFO - PROCESS | 1656 | RSS: Main: 247054336 12:14:06 INFO - PROCESS | 1656 | 12:14:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:14:09 INFO - PROCESS | 1656 | RSS: Main: 249323520 12:14:09 INFO - PROCESS | 1656 | 12:14:11 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:14:12 INFO - PROCESS | 1656 | RSS: Main: 251465728 12:14:12 INFO - PROCESS | 1656 | 12:14:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:14:15 INFO - PROCESS | 1656 | RSS: Main: 262811648 12:14:15 INFO - PROCESS | 1656 | 12:14:18 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:14:19 INFO - PROCESS | 1656 | RSS: Main: 263114752 12:14:19 INFO - PROCESS | 1656 | 12:14:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 12:14:21 INFO - PROCESS | 1656 | RSS: Main: 306810880 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | __start_tp_report 12:14:21 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 12:14:21 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 12:14:21 INFO - PROCESS | 1656 | |i|pagename|runs| 12:14:21 INFO - PROCESS | 1656 | |0;ai-astar;102;113;113;112;111;113;111;112;111;111 12:14:21 INFO - PROCESS | 1656 | |1;audio-beat-detection;142;107;108;141;108;107;107;108;171;135 12:14:21 INFO - PROCESS | 1656 | |2;audio-dft;181;182;182;181;182;184;182;183;183;181 12:14:21 INFO - PROCESS | 1656 | |3;audio-fft;80;57;57;87;60;58;57;58;80;58 12:14:21 INFO - PROCESS | 1656 | |4;audio-oscillator;88;71;92;69;67;69;87;68;68;90 12:14:21 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;87;85;87;88;94;130;117;84;88;85 12:14:21 INFO - PROCESS | 1656 | |6;imaging-darkroom;109;151;94;93;93;93;93;93;93;94 12:14:21 INFO - PROCESS | 1656 | |7;imaging-desaturate;82;80;83;80;83;82;84;84;80;82 12:14:21 INFO - PROCESS | 1656 | |8;json-parse-financial;52;51;52;51;55;55;89;54;54;55 12:14:21 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;63;73;67;66;74;70;69;71;68;71 12:14:21 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;82;81;90;104;100;99;82;81;86;82 12:14:21 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;135;135;138;133;137;141;148;158;221;175 12:14:21 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;164;163;163;162;164;163;164;160;161;163 12:14:21 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;67;66;66;66;64;66;65;66;66;66 12:14:21 INFO - PROCESS | 1656 | __end_tp_report 12:14:21 INFO - PROCESS | 1656 | __start_cc_report 12:14:21 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1863 12:14:21 INFO - PROCESS | 1656 | __end_cc_report 12:14:21 INFO - PROCESS | 1656 | __startTimestamp1486498461018__endTimestamp 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | ------- Summary: start ------- 12:14:21 INFO - PROCESS | 1656 | Number of tests: 14 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:3.25 (2.9%) stddev-sans-first:0.93 12:14:21 INFO - PROCESS | 1656 | Values: 102.0 113.0 113.0 112.0 111.0 113.0 111.0 112.0 111.0 111.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:123.40 Median:121.50 stddev:22.54 (18.6%) stddev-sans-first:22.89 12:14:21 INFO - PROCESS | 1656 | Values: 142.0 107.0 108.0 141.0 108.0 107.0 107.0 108.0 171.0 135.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:182.10 Median:182.00 stddev:0.99 (0.5%) stddev-sans-first:0.97 12:14:21 INFO - PROCESS | 1656 | Values: 181.0 182.0 182.0 181.0 182.0 184.0 182.0 183.0 183.0 181.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:65.20 Median:59.00 stddev:12.01 (20.4%) stddev-sans-first:11.48 12:14:21 INFO - PROCESS | 1656 | Values: 80.0 57.0 57.0 87.0 60.0 58.0 57.0 58.0 80.0 58.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:79.00 stddev:10.75 (13.6%) stddev-sans-first:10.63 12:14:21 INFO - PROCESS | 1656 | Values: 88.0 71.0 92.0 69.0 67.0 69.0 87.0 68.0 68.0 90.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:87.00 stddev:15.83 (18.2%) stddev-sans-first:16.55 12:14:21 INFO - PROCESS | 1656 | Values: 87.0 85.0 87.0 88.0 94.0 130.0 117.0 84.0 88.0 85.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:100.60 Median:93.00 stddev:18.39 (19.8%) stddev-sans-first:19.25 12:14:21 INFO - PROCESS | 1656 | Values: 109.0 151.0 94.0 93.0 93.0 93.0 93.0 93.0 93.0 94.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:82.00 Median:82.50 stddev:1.56 (1.9%) stddev-sans-first:1.66 12:14:21 INFO - PROCESS | 1656 | Values: 82.0 80.0 83.0 80.0 83.0 82.0 84.0 84.0 80.0 82.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:54.50 stddev:11.43 (21.0%) stddev-sans-first:11.99 12:14:21 INFO - PROCESS | 1656 | Values: 52.0 51.0 52.0 51.0 55.0 55.0 89.0 54.0 54.0 55.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:70.50 stddev:3.33 (4.7%) stddev-sans-first:2.67 12:14:21 INFO - PROCESS | 1656 | Values: 63.0 73.0 67.0 66.0 74.0 70.0 69.0 71.0 68.0 71.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:82.00 stddev:9.01 (11.0%) stddev-sans-first:9.22 12:14:21 INFO - PROCESS | 1656 | Values: 82.0 81.0 90.0 104.0 100.0 99.0 82.0 81.0 86.0 82.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:152.10 Median:144.50 stddev:27.53 (19.1%) stddev-sans-first:28.50 12:14:21 INFO - PROCESS | 1656 | Values: 135.0 135.0 138.0 133.0 137.0 141.0 148.0 158.0 221.0 175.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:163.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 12:14:21 INFO - PROCESS | 1656 | Values: 164.0 163.0 163.0 162.0 164.0 163.0 164.0 160.0 161.0 163.0 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 12:14:21 INFO - PROCESS | 1656 | Values: 67.0 66.0 66.0 66.0 64.0 66.0 65.0 66.0 66.0 66.0 12:14:21 INFO - PROCESS | 1656 | -------- Summary: end -------- 12:14:21 INFO - PROCESS | 1656 | 12:14:21 INFO - TEST-INFO | 1656: exit 0 12:14:22 INFO - TEST-OK | kraken | took 58898ms 12:14:22 INFO - SUITE-END | took 1177s 12:14:22 INFO - Completed test suite (00:19:37) 12:14:22 INFO - javascript benchmark 12:14:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3482.3557641836264, 3497.615262321146, 3504.176518518148, 3520.9471857922126, 3574.982125089374, 5704.030314846475, 5725.713714314288, 5764.7982320618785, 5801.332846722628, 5820.8253752387445, 5685.687287199203, 5754.884902301951, 5759.136129580565, 5773.191753154561, 5789.797357092502, 5219.321488206538, 5255.474452554752, 5259.526642602165, 5286.841394758163, 5351.384590772052, 5203.739813009353, 5210.374755029383, 5217.452167522412, 5346.117890548055, 5357.1696387060065, 5226.477352264781, 5310.548603368699, 5315.734213289339, 5317.096093664087, 5319.361676598814, 5246.842594722164, 5260.921086183691, 5267.604929630254, 5296.311479507678, 5340.465953404629, 5218.7912483500995, 5257.921131183035, 5265.341832270966, 5274.0, 5298.682079075268, 4636.930446043312, 5577.330720313588, 5628.380878103405, 5663.7168141593165, 5751.712414379264, 6135.967692822223, 6187.4740647045055, 6199.783007594758, 6217.720202590849, 6224.190855188796, 6195.87608247837, 6201.937980620181, 6210.378962103753, 6281.811545653592, 6285.654289014103, 5718.399568045378, 5774.48029677331, 5813.040848260074, 5901.23283973085, 5934.851628709317, 6288.937110628926, 6314.242290925118, 6316.115743795872, 6320.209973753281, 6324.114623952651, 6136.140940268366, 6137.0, 6143.109249158936, 6148.385161483905, 6164.013757798731, 6113.962834745899, 6119.694015299217, 6131.541266919159, 6141.547378150805, 6189.133521307021, 6118.663473509, 6150.323464418911, 6154.692265386713, 6164.660943648142, 6177.4749146322165, 6174.0, 6200.286966998763, 6219.378062193744, 6233.657148856766, 6237.1891654084675, 4923.113839508923, 4967.379077615298, 4972.801087956441, 4982.950170498249, 4992.775325110379, 4452.287633978548, 4481.439820022497, 4513.210188217049, 4519.570640789186, 4529.456465224194, 5767.971160144172, 5827.388124246978, 5845.824625261249, 5913.408659134052, 5956.493698035629, 6130.601510901866, 6164.660943648053, 6166.445019948226, 6182.474489668339, 6184.0, 5643.746031428595, 5811.3026436827, 5885.5585831062845, 5896.675682837399, 5903.321118071391, 4576.405067341224, 5372.516473517324, 5389.434109418533, 5415.53967912724, 5488.17677348401, 6332.968335158294, 6379.617222966544, 6391.840203994937, 6415.807525774234, 6418.261899881573, 6162.106494558354, 6173.290071641639, 6184.5980011299125, 6189.071639254148, 6205.0, 6121.178620693132, 6131.499004853578, 6254.030625253093, 6257.374262573706, 6296.622202667854, 6150.661713605616, 6185.907211391923, 6189.195404597373, 6223.128761973237, 6238.064290356301, 6164.198654174928, 6166.568340216142, 6179.84550386244, 6183.628982261079, 6195.628262304276, 6010.789622363196, 6082.695865206811, 6089.269287685506, 6100.389961004042, 6237.625742455467, 5703.62926409782, 6094.14681944537, 6147.3709466990385, 6171.506279497719, 6205.472534834409, 6014.789482368096, 6016.0, 6024.427679370453, 6026.578139530191, 6033.456988871023, 5890.852728681817, 6012.9098063529955, 6095.908561371494, 6148.262208535004, 6151.907721384094, 5914.467697907209, 5942.316633587193, 5942.97028514872, 6035.879282414415, 6057.333693293646], "value": 5722.227395928003, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.29595463439955, 500.8780332056193, 526.9920951185733, 534.7727215933228, 535.2265975665163, 30445.0, 39904.80047599762, 41062.97342566437, 41246.587534124614, 43225.78387108068, 42596.0, 42711.78644106783, 42909.0, 42977.35533966993, 43125.0, 9585.041495850412, 9756.902430975706, 9768.511574421285, 9778.657746978857, 9781.266405019616, 9575.473348965805, 9686.70939871805, 9691.95154024229, 9696.030396960317, 9696.612135514606, 9702.466364349957, 9746.46394448305, 9754.804903901953, 9764.804703905918, 9776.755581110494, 9653.855192172088, 9721.562529686182, 9725.076117768871, 9735.36720113194, 9736.513174341255, 9581.520923953774, 9600.711978640651, 9688.079632434907, 9690.806183876353, 9704.90295097047, 40495.0, 40888.0, 40909.59090409117, 40926.59073409258, 40969.79515102435, 3230.402375560529, 3393.9490907636405, 3409.9488507672404, 3736.1220113273357, 3983.4423180754716, 29380.41239175226, 29968.8501557493, 31957.680423195936, 32067.51898721521, 32801.83599082013, 3299.5710557627594, 3355.0, 3373.881914133018, 3388.457846744509, 3423.3666771647327, 523040.3847980774, 527782.0, 528231.0, 529415.9999999962, 529840.0, 35892.92321230367, 67866.32133678699, 68790.0, 68961.0, 68973.3102668977, 36668.81665591655, 37339.06652333713, 37591.0, 37622.8118859404, 37669.43495847564, 15467.381304747909, 15629.140397278032, 15654.452094176877, 15704.371825127095, 15719.899607027626, 13069.738605227842, 13101.082924195405, 13159.94720422383, 13178.736425271632, 13188.142770719873, 8211.21993410625, 8225.95887020573, 8271.917280827234, 8296.087430382653, 8304.792380190424, 2879.294572829628, 3467.9826600866836, 3470.392681280766, 3497.720182385403, 3615.023943535231, 919.9402038867452, 933.4632586262926, 1014.1177175856905, 1027.4811220333684, 1032.2464600841429, 29652.0831564699, 29798.702012979593, 29918.401631967237, 30009.849950750107, 30766.69233307683, 929.818685356349, 999.5551979369111, 1021.6628512590827, 1023.7542989682422, 1086.163653986426, 13715.1085179463, 14234.399632815133, 14373.78439323411, 14428.567142985727, 14551.199684017269, 676117.0, 709903.0, 717417.0, 719407.0, 721422.0, 55564.0, 55608.443915560325, 55781.16328255079, 55822.72088639612, 55847.16229256564, 1251.555697727312, 1309.9672508187182, 1369.9931500342434, 1429.106808244847, 1430.9856901430853, 29210.853945730134, 29713.851430742707, 29720.702792971795, 29777.5533367004, 30269.243268917573, 45994.31008534808, 46511.30233046575, 46603.766981164874, 46654.53345466638, 46700.532994670975, 469180.0, 471683.0, 473049.0, 473484.0, 673903.0, 22014.88992555027, 23058.192963246205, 26051.0, 26822.731772682804, 26861.328466788487, 43452.56547434612, 43739.56260437355, 43789.0, 43853.0, 44004.77997609991, 36025.459618105226, 36183.27633447369, 36913.44629830609, 38309.04227394226, 38396.808015959745, 36411.0, 36786.08034799151, 36927.0, 37479.25041499209, 37523.624763753105, 36377.09057273589, 37024.814875926524, 37112.25775484421, 37142.0, 37276.44085338668, 32439.67560324461, 32568.0, 33327.666723332455, 33359.49960750542, 33511.497327540594, 24849.378765531008, 24929.626055608816, 24962.001519939, 25069.498610028062, 25277.11530096438], "value": 18679.802284194484, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.4668457260392, 381.77856843031026, 392.8840991907387, 396.75797763364363, 411.17559293616296, 19498.8300701958, 20230.39308820734, 20794.688079678817, 21131.57736845262, 21263.787362126375, 12188.695282617939, 12366.629001129959, 14792.112473251585, 20474.385768426935, 21137.26019589315, 4978.7801988512865, 5346.705931173774, 5586.581006424514, 5587.217789509452, 5590.944090559104, 5422.810201642943, 6158.137860699483, 6225.750969961219, 6235.095911092889, 6240.750369985195, 4922.827701030465, 6053.697315134248, 6197.69011549423, 6206.565540412173, 6207.441330280274, 6107.664078475682, 6149.077638354238, 6155.630662160263, 6158.445739883432, 6161.0, 4071.5928407159345, 4951.480094590052, 5185.637005409585, 5422.915416916632, 5428.4028756836715, 13464.663383415394, 13496.325183740773, 13550.186988780704, 13706.38321275545, 13714.51999180024, 2295.414669259345, 2304.147465437782, 2395.4490467192645, 2454.0674543673467, 2471.6910386201725, 8264.958675206586, 9800.970898055673, 10675.893241067568, 10689.572417103307, 10911.56353745857, 1618.5872602486409, 1716.373523663866, 1740.8346207110305, 1803.323753592403, 1842.0, 98422.0, 106235.0, 108347.0, 108861.0, 120522.0, 11253.324800511995, 11680.123990700731, 11720.355380453986, 11756.94121529387, 11823.586174483851, 12455.875441245471, 15206.695866082837, 15211.315490802941, 15211.771823422658, 15214.391424343125, 8548.48709077445, 8797.340199485065, 8828.690995815115, 8959.328050396247, 8960.417572857874, 7138.571685698875, 8763.255123314462, 8785.648574057093, 8787.34094942869, 8935.151160639729, 4233.322668373045, 4370.562943705604, 4550.635949124062, 4611.792469338888, 4685.0, 1788.3830078622855, 1865.5056410051347, 1905.3426567834076, 1944.6402415553168, 1958.8530860185542, 864.8659457783928, 899.2940541674753, 936.990630093704, 953.7424895278375, 988.4415305352453, 20399.478550129756, 21991.676397496907, 22006.84093576018, 22049.889750551465, 22081.971711527363, 918.4443411735937, 944.579662050381, 949.3070058856935, 984.2618036472645, 990.7820279538635, 10700.892991070144, 11653.59212427561, 11654.53381864733, 11686.824697629543, 11689.532418703157, 553755.2312238413, 554090.0, 556881.0, 561362.0, 563797.1810141006, 91284.0, 119466.0, 127430.0, 133543.0, 137592.0, 962.8603852441357, 984.1290457944771, 993.7714325705128, 1000.2797985450464, 1000.9199264058858, 18985.43043708691, 19559.804401955796, 20210.59578808386, 20255.898720506302, 20334.084966176262, 48776.2683559754, 48892.022159557324, 50684.986300274526, 57472.0, 58113.0, 73730.89403658842, 81438.18561814306, 81971.0, 85746.28507429692, 85854.0, 7868.72459463916, 8092.231238032377, 8099.8380032397845, 8354.832903342021, 8565.657373704982, 9548.140667339972, 11874.940625296818, 11968.640940771791, 12506.68733281639, 12829.486820527447, 10986.890131098588, 11005.669829905115, 11497.94251028773, 11683.240589361665, 11709.414529273672, 10314.071733544017, 10532.842007369742, 10702.732431688959, 10762.085222756154, 11416.543338266376, 11222.831657525307, 11511.827322590336, 11577.710557236136, 11606.245594036698, 11927.0, 8106.797330066795, 8191.426600137933, 8360.0, 8366.665333386596, 8421.15788421153, 10738.677839664822, 11304.773904522028, 11312.547498100314, 11395.031422329195, 11648.41757912084], "value": 9336.071480789922, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.1471903655397, 1523.801905752252, 1646.3990643415157, 1819.7998220195784, 1858.3495776478226, 8247.463914845532, 8703.695370662028, 8711.346649001318, 8714.694985675502, 8758.948926128858, 6812.284710105429, 7654.081510218768, 7858.685652573905, 7867.134615192324, 8506.234438900497, 2356.9057237710513, 2403.4952659941346, 2403.7596240375997, 2404.014354114813, 2407.7471865454136, 2390.282915125464, 2408.1451084864884, 2430.4774473488196, 2434.4887573609476, 2436.049940523197, 2374.299581623425, 2381.714194296687, 2404.002339029301, 2408.952105833968, 2411.5176964607062, 2367.2188177901253, 2370.383700237933, 2392.6650268962358, 2394.8563086214795, 2395.5448464791807, 1997.4806550296883, 2389.5220955808736, 2390.9880450597634, 2416.5287768885073, 2417.9516409671883, 8522.14778522149, 8558.315334773204, 8629.784255393603, 8644.178803013767, 8695.869561956575, 5182.326297581328, 5321.813736519203, 5336.039512887679, 5350.5452036576935, 5358.410574836765, 3095.860686269101, 3526.690018038189, 3548.964510354889, 3605.94591081134, 3624.474451204587, 1050.4327663061938, 1078.412265315405, 1090.650991682662, 1125.724197571592, 1128.0298942909092, 11243.269187502787, 11331.943340283327, 11352.48913798881, 11356.375399353032, 11384.886151138548, 4558.1795276849825, 4718.811247550128, 4816.614670826326, 4837.032593481318, 4881.072596206709, 9560.90439095614, 9747.220222382193, 9753.073458021476, 9762.90237097634, 9774.413535187912, 5354.892902141935, 5356.196570514454, 5358.946410535923, 5365.061114305059, 5375.086235340002, 4402.0, 4446.755428451402, 4655.790489427984, 4893.535114164149, 4937.333459982929, 3199.472087105648, 3279.6884295991845, 3937.3503371943307, 4035.5270326331265, 4051.655609273245, 1280.180684362009, 1283.1980012492193, 1289.9097063205486, 1296.941637626309, 1304.4325718312564, 760.2701406649568, 857.9404435522125, 897.3359713811732, 897.3628723606182, 920.1764420843441, 5582.581306402036, 5611.9719401403545, 5676.2337084493065, 5798.217240672539, 5953.791617293374, 448.5805771603496, 448.6276390595863, 454.07368967306326, 464.1042787420244, 466.2260647325491, 3773.6792372648083, 3774.3206222879594, 3797.6582107610448, 3848.4804551385764, 3902.2195560887935, 9867.851982220272, 9946.751331216778, 10308.814486334168, 10450.68647940563, 10473.581056757797, 10076.84884726715, 10357.223208259411, 10362.0, 10384.37693738378, 10393.740156495996, 7955.4828936118965, 7991.0410750709125, 8068.273855353046, 8176.632051557575, 8200.630971606173, 5502.339719233718, 5684.090545512699, 5740.0, 5741.712914354349, 5834.620749651259, 9234.076592340713, 9407.4825884577, 9498.572564234488, 9505.857412138685, 9605.759856003655, 9464.1009104135, 9728.367656102331, 9747.707568772948, 9837.704868853945, 9851.950740246253, 6818.965905170442, 7052.471064670068, 7296.306850849161, 7405.555666660018, 7564.886526701994, 8052.315553177811, 8308.584570771316, 8317.750467485985, 8331.250187483156, 8334.08325084228, 7280.199178090512, 7360.521566098187, 7394.741184058532, 7531.246875312425, 7549.1695913448375, 5976.850578735392, 7224.602646854473, 7285.635718214174, 7298.087739032621, 7363.926360736324, 5913.46778789911, 6510.0885875976455, 6576.408123268929, 6750.426213771688, 6754.257031726408, 4837.854864354075, 4889.095517329305, 4911.63162762787, 4940.110780059624, 4978.452370239198, 4869.586085182799, 4870.391201099863, 4879.0, 4913.361263035782, 5040.168372218543], "value": 4423.576796932401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.3517308133676, 308.9830059346736, 316.966718494558, 322.9644739078701, 325.1935200702257, 4936.728479933602, 5014.774335154918, 5153.81961631343, 5174.508421699942, 5194.92207616886, 4134.689898257628, 4992.480301387523, 5036.597072234222, 5110.616703747215, 5111.361079865017, 3275.4431746603013, 3719.4978677878544, 3904.9804750976205, 3999.3401088820383, 4026.71812973092, 2918.401727645838, 3479.1038883808387, 3751.4865040422983, 3823.0, 4013.9197216055663, 3827.8660246891363, 3985.80070996449, 3999.2201520703475, 4005.9198816023663, 4018.5780493048246, 3968.5436174839974, 3984.203159368109, 3989.620986006339, 3992.2215168042244, 4009.1380353223904, 3470.670286322795, 3492.0920560654413, 3498.772579782306, 3503.5095086687884, 3553.6446355364515, 4247.851325203634, 4720.763961801897, 4925.704457732548, 4971.776270067856, 5001.774920128603, 4501.279795232747, 4502.212112880233, 4539.931901021488, 4540.616176507327, 4546.249868771649, 5331.893362132736, 5349.358077030743, 5353.420740881449, 5361.329833770778, 5381.408045115034, 3326.700596946262, 3478.4260597001467, 3869.187470631171, 3876.1432374786987, 3887.688984881203, 4790.712557246577, 4840.346553215306, 5608.831010479066, 5620.3865202680545, 5645.1532270159805, 3479.860805567749, 3770.1517158639085, 3793.886183414502, 3813.618638136164, 3816.2939856126704, 3238.5588413156393, 3463.3246516928957, 3681.0613293610495, 3901.8244179012013, 3910.452536644872, 3686.668199862025, 4163.10493243954, 4467.843625473158, 4477.500037487478, 4479.200499687695, 4650.720956742539, 5059.038782631288, 5456.481634244819, 5456.727163641882, 5533.529649979716, 1069.1340014588052, 1215.4442313838301, 1236.9281453565243, 1236.9443375048145, 1243.664210663116, 651.9674016299166, 804.4851295171095, 859.9828003439897, 873.702941000063, 873.7422460374205, 3973.1854969731135, 4651.2557990721325, 4780.4741478437345, 4828.233977497557, 4907.631927605444, 4846.684965477232, 4938.753062346868, 5078.771455284521, 5322.4411436799355, 5324.444266751981, 4305.182015417061, 4438.800253988578, 4649.790759415834, 4794.2808578713475, 4839.596517010028, 2453.4970331082086, 2531.784798292129, 2704.7971402144917, 2747.7801775857884, 2758.2828464599347, 5447.591430642718, 5453.345598528202, 5480.615932069562, 5490.203920431515, 5509.752061157257, 4817.626976311734, 5446.2647542582035, 5770.422957704196, 5777.24895763548, 5797.652140871562, 4462.41988541494, 4520.706154099973, 5656.190019193818, 5808.970955145197, 5827.562932780059, 5364.785408583613, 5597.468240517144, 5635.6618602883955, 5640.576956728344, 5651.039323314964, 4481.731096134243, 4595.012072404449, 4778.665493415567, 5511.338639363142, 5557.194206840067, 4665.32352808834, 4677.830996748544, 4809.302651115639, 5229.450907654642, 5926.4666180044005, 3160.3995240904155, 3428.9657103428644, 3537.363274610595, 3541.4864844597905, 3653.214558869856, 5579.46995035471, 5585.413531579125, 5589.664620122806, 5594.188842617879, 5609.831705048855, 5383.327084114486, 5384.6769193848495, 5402.756875940513, 5412.269343638558, 5430.918536222039, 5039.496050395078, 5285.339332583427, 5295.682259064469, 5330.148370621699, 5425.782968681367, 4861.635377346784, 4990.900181996267, 5103.5661968733075, 5222.582193424593, 5291.60312976536, 5418.918716219338, 5421.810236641699, 5430.348358197041, 5452.6183167177915, 5484.451554844483, 4827.986122914227, 4957.355543779286, 5157.948420515747, 5318.835293000659, 5341.23739166082], "value": 3905.439287314344, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.8748137853808, 749.8013026547966, 798.9201079892015, 817.0481389181606, 852.4373913217274, 12662.176958497692, 14213.502527411543, 14865.702685946275, 15361.539153825375, 15433.69132617347, 13900.652483687887, 14089.647758806035, 14097.57707268781, 14110.082844615094, 14878.256087195625, 851.0935853316214, 879.5997820991465, 882.2765332427412, 883.2889523933231, 884.8539990901526, 698.3923986132072, 720.3588805962671, 721.3904250907974, 721.9566825990457, 723.847991921697, 755.4334249313015, 850.8723691446302, 902.6208992223281, 937.3298091864316, 939.8073394954018, 859.3941271403677, 924.366808736018, 925.5048549026238, 925.5511077127587, 926.8517037274071, 681.3629256645053, 683.3132701634875, 683.7538486144983, 684.2575805251308, 684.6131935456451, 14240.359183836752, 14529.200893950829, 14589.562313130516, 14657.340419681033, 14687.26563671812, 13377.0, 13421.463141474329, 13446.193228406328, 13568.321583920764, 13801.309934503335, 9995.550200240934, 12323.445444954908, 12468.43892024861, 12715.0, 12946.611601651966, 3800.7339486235974, 4451.710638808499, 4593.0, 4594.586487216133, 4603.171429142786, 88291.0, 94641.52679236559, 95138.6215344615, 96845.51577242068, 98475.50762246143, 10676.039156475954, 10716.785664286826, 10906.836397454044, 10938.015578597964, 11418.771624567627, 20951.476213094793, 20961.05675244587, 21002.78997210039, 21213.363599092052, 21218.045187966578, 7577.242275772379, 7861.764147075597, 8052.637631306605, 8201.933748612642, 8230.176982301722, 4367.352641769315, 4422.248217802981, 4548.226801443762, 4594.632429405639, 4678.929816052762, 3475.09647491654, 3559.8220088995445, 3560.0565850049757, 3602.8018458985007, 3610.837512311952, 554.2351554854275, 646.8518379875758, 659.7427003468651, 659.986800263992, 665.8335416145964, 487.3493885662609, 590.822753174046, 655.1123228026051, 659.4691273524762, 666.9133012708414, 8974.506402147945, 9291.488968106683, 9469.763255918657, 9502.287328450393, 9519.0, 562.7861412663244, 596.1921596237123, 612.9724162412613, 661.6832503318458, 681.0023315842315, 4374.19077470669, 4557.680962332605, 4567.474740404829, 4613.192691279013, 4613.284940834176, 117376.23935640973, 118075.40962295134, 119343.0, 121967.3901630504, 122388.0, 101997.0, 104547.0, 105490.0, 106101.46949265205, 107365.0, 91389.54305228431, 92582.0, 92780.53609732044, 93704.0, 95040.0, 8400.705975290835, 8600.09698981598, 8748.956255218684, 8913.465192088495, 9058.320625953213, 55044.0, 55317.766213250674, 57190.7140464295, 57774.0, 59227.51931201582, 73541.8968715459, 76746.0, 80416.79374809499, 83214.0, 83592.0, 11118.944405277922, 11394.113224083005, 11547.249428787101, 11692.064634829023, 12036.458359374024, 11570.0, 11926.642200733992, 12389.946854517468, 12427.689307767378, 12492.500299987898, 11940.52237910474, 11980.224505365097, 12151.210171338835, 12360.381980901098, 12577.182483138567, 11472.31166130035, 11999.20310787934, 12005.63983080509, 12183.147179697691, 12205.69485762863, 11521.193516453768, 11943.462544185706, 11950.34273114987, 12016.63950081464, 12037.699057523281, 9966.750831229278, 10073.69778906634, 10087.949560252446, 10161.542730576994, 11336.376499292619, 10871.619493317696, 11209.159313051718, 11621.418929053683, 11663.24188927717, 11671.183017188716], "value": 7428.241757361007, "unit": "score"}], "name": "dromaeo_css", "value": 7099.80227143399, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 113.0, 112.0, 111.0, 113.0, 111.0, 112.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 107.0, 108.0, 141.0, 108.0, 107.0, 107.0, 108.0, 171.0, 135.0], "value": 123.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 182.0, 181.0, 182.0, 184.0, 182.0, 183.0, 183.0, 181.0], "value": 182.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 57.0, 87.0, 60.0, 58.0, 57.0, 58.0, 80.0, 58.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 92.0, 69.0, 67.0, 69.0, 87.0, 68.0, 68.0, 90.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 88.0, 94.0, 130.0, 117.0, 84.0, 88.0, 85.0], "value": 94.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 151.0, 94.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0], "value": 100.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 83.0, 80.0, 83.0, 82.0, 84.0, 84.0, 80.0, 82.0], "value": 82.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 51.0, 55.0, 55.0, 89.0, 54.0, 54.0, 55.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 73.0, 67.0, 66.0, 74.0, 70.0, 69.0, 71.0, 68.0, 71.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 90.0, 104.0, 100.0, 99.0, 82.0, 81.0, 86.0, 82.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 138.0, 133.0, 137.0, 141.0, 148.0, 158.0, 221.0, 175.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 162.0, 164.0, 163.0, 164.0, 160.0, 161.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 64.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1430.8999999999999, "alertThreshold": 2.0}]} 12:14:22 INFO - Return code: 0 12:14:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:14:22 INFO - # TBPL SUCCESS # 12:14:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:14:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:14:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:14:22 INFO - 2017-02-07 12:14:22.351 screenresolution[1660:9955] starting screenresolution argv=screenresolution get 12:14:22 INFO - 2017-02-07 12:14:22.353 screenresolution[1660:9955] Display 0: 1600x1200x32@60 12:14:22 INFO - 2017-02-07 12:14:22.360 screenresolution[1661:9959] starting screenresolution argv=screenresolution list 12:14:22 INFO - Available Modes on Display 0 12:14:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:14:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:14:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:14:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:14:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:14:22 INFO - Intel Iris: 12:14:22 INFO - Chipset Model: Intel Iris 12:14:22 INFO - Type: GPU 12:14:22 INFO - Bus: Built-In 12:14:22 INFO - VRAM (Dynamic, Max): 1536 MB 12:14:22 INFO - Vendor: Intel (0x8086) 12:14:22 INFO - Device ID: 0x0a2e 12:14:22 INFO - Revision ID: 0x0009 12:14:22 INFO - Displays: 12:14:22 INFO - Display: 12:14:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:14:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:14:22 INFO - Display Serial Number: 1600x1200 60 12:14:22 INFO - Main Display: Yes 12:14:22 INFO - Mirror: Off 12:14:22 INFO - Online: Yes 12:14:22 INFO - Rotation: Supported 12:14:22 INFO - Return code: 0 12:14:22 INFO - Running post-action listener: _resource_record_post_action 12:14:22 INFO - [mozharness: 2017-02-07 20:14:22.602280Z] Finished run-tests step (success) 12:14:22 INFO - Running post-run listener: _resource_record_post_run 12:14:22 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 37987328; Write bytes: 497194496; Read time: 254; Write time: 1580 12:14:22 INFO - TinderboxPrint: CPU usage
53.1% 12:14:22 INFO - TinderboxPrint: I/O read bytes / time
37,987,328 / 254 12:14:22 INFO - TinderboxPrint: I/O write bytes / time
497,194,496 / 1,580 12:14:22 INFO - TinderboxPrint: CPU idle
2,247.7 (46.8%) 12:14:22 INFO - TinderboxPrint: CPU system
954.5 (19.9%) 12:14:22 INFO - TinderboxPrint: CPU user
1,595.5 (33.3%) 12:14:22 INFO - TinderboxPrint: Swap in / out
229,195,776 / 0 12:14:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181150208; Write bytes: 176211968; Read time: 16663; Write time: 392 12:14:22 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 37057536; Write bytes: 303250944; Read time: 233; Write time: 1132 12:14:23 INFO - Running post-run listener: _upload_blobber_files 12:14:23 INFO - Blob upload gear active. 12:14:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:14:23 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 12:14:23 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'] 12:14:23 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 12:14:23 INFO - (blobuploader) - INFO - Open directory for files ... 12:14:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:14:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:14:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:24 INFO - (blobuploader) - INFO - Done attempting. 12:14:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:14:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:14:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:25 INFO - (blobuploader) - INFO - Done attempting. 12:14:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:14:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:14:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:27 INFO - (blobuploader) - INFO - Done attempting. 12:14:27 INFO - (blobuploader) - INFO - Iteration through files over. 12:14:27 INFO - Return code: 0 12:14:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:14:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:14:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac6151336c155cdf36fd4778e0147116111304a5d25372d758e5d66ae26696b1a52ff7502b93f69a7d88978f70772b4ff3fc12249e6996bc90b4b0e748032b8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ecda9031ef1dbe7e7da90cf9ce4f7eed1111f54b5ea8bb02e27bb98ac2f76ae76bf3fb3c9839d64d755508119004ecbfd7c564ad86b729c72826a8bdb3b4a901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b25094c5ce9b69b1573093264898c12b03712b8fe85444dfebdd45499cf98d91834d68d2ff9b0c98cb78d7e09ccdd8d90c11021bff6dabdd93419736c64927fd"} 12:14:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:14:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:14:27 INFO - Contents: 12:14:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac6151336c155cdf36fd4778e0147116111304a5d25372d758e5d66ae26696b1a52ff7502b93f69a7d88978f70772b4ff3fc12249e6996bc90b4b0e748032b8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ecda9031ef1dbe7e7da90cf9ce4f7eed1111f54b5ea8bb02e27bb98ac2f76ae76bf3fb3c9839d64d755508119004ecbfd7c564ad86b729c72826a8bdb3b4a901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b25094c5ce9b69b1573093264898c12b03712b8fe85444dfebdd45499cf98d91834d68d2ff9b0c98cb78d7e09ccdd8d90c11021bff6dabdd93419736c64927fd"} 12:14:27 INFO - Running post-run listener: copy_logs_to_upload_dir 12:14:27 INFO - Copying logs to upload dir... 12:14:27 INFO - mkdir: /builds/slave/test/build/upload/logs 12:14:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.584773 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-07 12:14:27.699242) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 12:14:27.707340) ========= 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.ugxbg7s9zS/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.lG7rslhXQV/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac6151336c155cdf36fd4778e0147116111304a5d25372d758e5d66ae26696b1a52ff7502b93f69a7d88978f70772b4ff3fc12249e6996bc90b4b0e748032b8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ecda9031ef1dbe7e7da90cf9ce4f7eed1111f54b5ea8bb02e27bb98ac2f76ae76bf3fb3c9839d64d755508119004ecbfd7c564ad86b729c72826a8bdb3b4a901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b25094c5ce9b69b1573093264898c12b03712b8fe85444dfebdd45499cf98d91834d68d2ff9b0c98cb78d7e09ccdd8d90c11021bff6dabdd93419736c64927fd"} build_url:https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010996 build_url: 'https://queue.taskcluster.net/v1/task/GLa_WVUuQBy4Na5gIbLTnQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac6151336c155cdf36fd4778e0147116111304a5d25372d758e5d66ae26696b1a52ff7502b93f69a7d88978f70772b4ff3fc12249e6996bc90b4b0e748032b8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ecda9031ef1dbe7e7da90cf9ce4f7eed1111f54b5ea8bb02e27bb98ac2f76ae76bf3fb3c9839d64d755508119004ecbfd7c564ad86b729c72826a8bdb3b4a901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b25094c5ce9b69b1573093264898c12b03712b8fe85444dfebdd45499cf98d91834d68d2ff9b0c98cb78d7e09ccdd8d90c11021bff6dabdd93419736c64927fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 12:14:27.741626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 12:14:27.741959) ========= 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.ugxbg7s9zS/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.lG7rslhXQV/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.005091 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 12:14:27.790115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 12:14:27.790450) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 12:14:27.790806) ========= ========= Total master_lag: 0.19 =========