builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1484558633.56 results: success (0) buildid: 20170115233322 builduid: f2e5fd11ce93424f9daa0fdac52c4b2c revision: 2e32d2060f1c47c64ac7ade5d9c7f2b23593e2ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:53.555586) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:53.556187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:53.556473) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:53.582318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:53.582596) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-16 01:23:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-01-16 01:23:54 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:53.720586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:53.721051) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017169 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:53.771097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 01:23:53.771498) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2e32d2060f1c47c64ac7ade5d9c7f2b23593e2ec --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 2e32d2060f1c47c64ac7ade5d9c7f2b23593e2ec --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-16 01:23:54,766 truncating revision to first 12 chars 2017-01-16 01:23:54,766 Setting DEBUG logging. 2017-01-16 01:23:54,766 attempt 1/10 2017-01-16 01:23:54,766 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2e32d2060f1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 01:23:55,916 unpacking tar archive at: mozilla-beta-2e32d2060f1c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.515479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 01:23:55.300878) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:55.301205) ========= script_repo_revision: 2e32d2060f1c47c64ac7ade5d9c7f2b23593e2ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:55.301616) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:55.301908) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 01:23:55.311166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-16 01:23:55.311474) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:23:56 INFO - MultiFileLogger online at 20170116 01:23:56 in /builds/slave/test 01:23:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:23:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:23:56 INFO - {'append_to_log': False, 01:23:56 INFO - 'base_work_dir': '/builds/slave/test', 01:23:56 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:23:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:23:56 INFO - 'branch': 'Mozilla-Beta', 01:23:56 INFO - 'buildbot_json_path': 'buildprops.json', 01:23:56 INFO - 'config_files': ('talos/linux_config.py',), 01:23:56 INFO - 'default_actions': ('clobber', 01:23:56 INFO - 'read-buildbot-config', 01:23:56 INFO - 'download-and-extract', 01:23:56 INFO - 'populate-webroot', 01:23:56 INFO - 'create-virtualenv', 01:23:56 INFO - 'install', 01:23:56 INFO - 'run-tests'), 01:23:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:23:56 INFO - 'download_minidump_stackwalk': True, 01:23:56 INFO - 'download_symbols': 'ondemand', 01:23:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:23:56 INFO - 'tooltool.py': '/tools/tooltool.py', 01:23:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:23:56 INFO - '/tools/misc-python/virtualenv.py')}, 01:23:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:23:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:23:56 INFO - 'installer_path': 'installer.exe', 01:23:56 INFO - 'log_level': 'info', 01:23:56 INFO - 'log_name': 'talos', 01:23:56 INFO - 'log_to_console': True, 01:23:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:23:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:23:56 INFO - 'opt_config_files': (), 01:23:56 INFO - 'pip_index': False, 01:23:56 INFO - 'sps_profile': False, 01:23:56 INFO - 'sps_profile_interval': 0, 01:23:56 INFO - 'suite': 'dromaeojs', 01:23:56 INFO - 'system_bits': '32', 01:23:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:23:56 INFO - 'title': 'talos-linux64-ix-027', 01:23:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:23:56 INFO - 'use_talos_json': True, 01:23:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:23:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:23:56 INFO - 'work_dir': 'build'} 01:23:56 INFO - [mozharness: 2017-01-16 09:23:56.405754Z] Running clobber step. 01:23:56 INFO - Running pre-action listener: _resource_record_pre_action 01:23:56 INFO - Running main action method: clobber 01:23:56 INFO - rmtree: /builds/slave/test/build 01:23:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:23:56 INFO - Running post-action listener: _resource_record_post_action 01:23:56 INFO - [mozharness: 2017-01-16 09:23:56.862325Z] Finished clobber step (success) 01:23:56 INFO - [mozharness: 2017-01-16 09:23:56.862426Z] Running read-buildbot-config step. 01:23:56 INFO - Running pre-action listener: _resource_record_pre_action 01:23:56 INFO - Running main action method: read_buildbot_config 01:23:56 INFO - Using buildbot properties: 01:23:56 INFO - { 01:23:56 INFO - "project": "", 01:23:56 INFO - "product": "firefox", 01:23:56 INFO - "script_repo_revision": "production", 01:23:56 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 01:23:56 INFO - "repository": "", 01:23:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 01:23:56 INFO - "buildid": "20170115233322", 01:23:56 INFO - "pgo_build": "True", 01:23:56 INFO - "basedir": "/builds/slave/test", 01:23:56 INFO - "buildnumber": 100, 01:23:56 INFO - "slavename": "talos-linux64-ix-027", 01:23:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:23:56 INFO - "platform": "ubuntu64_hw", 01:23:56 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 01:23:56 INFO - "branch": "mozilla-beta", 01:23:56 INFO - "repo_path": "releases/mozilla-beta", 01:23:56 INFO - "revision": "2e32d2060f1c47c64ac7ade5d9c7f2b23593e2ec", 01:23:56 INFO - "stage_platform": "linux64-pgo", 01:23:56 INFO - "builduid": "f2e5fd11ce93424f9daa0fdac52c4b2c", 01:23:56 INFO - "slavebuilddir": "test" 01:23:56 INFO - } 01:23:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 01:23:56 INFO - Running post-action listener: _resource_record_post_action 01:23:56 INFO - [mozharness: 2017-01-16 09:23:56.864869Z] Finished read-buildbot-config step (success) 01:23:56 INFO - [mozharness: 2017-01-16 09:23:56.864959Z] Running download-and-extract step. 01:23:56 INFO - Running pre-action listener: _resource_record_pre_action 01:23:56 INFO - Running main action method: download_and_extract 01:23:56 INFO - mkdir: /builds/slave/test/build/tests 01:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:23:56 INFO - trying https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 01:23:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 01:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:23:57 INFO - Downloaded 1327 bytes. 01:23:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 01:23:57 INFO - Using the following test package requirements: 01:23:57 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 01:23:57 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 01:23:57 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 01:23:57 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 01:23:57 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 01:23:57 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 01:23:57 INFO - u'jsshell-linux-x86_64.zip'], 01:23:57 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 01:23:57 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 01:23:57 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 01:23:57 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 01:23:57 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 01:23:57 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 01:23:57 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 01:23:57 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 01:23:57 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 01:23:57 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 01:23:57 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 01:23:57 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:23:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 01:23:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:23:57 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 01:23:58 INFO - Expected file size: 21972567 01:24:02 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:24:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 01:24:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:24:02 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 01:24:03 INFO - Expected file size: 21972567 01:24:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 01:24:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:24:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 01:24:08 INFO - Expected file size: 14414089 01:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:09 INFO - trying https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 01:24:09 INFO - Downloading https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 01:24:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:24:11 INFO - Downloaded 57069849 bytes. 01:24:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 01:24:11 INFO - mkdir: /builds/slave/test/properties 01:24:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:24:11 INFO - Writing to file /builds/slave/test/properties/build_url 01:24:11 INFO - Contents: 01:24:11 INFO - build_url:https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 01:24:12 INFO - Running post-action listener: _resource_record_post_action 01:24:12 INFO - Running post-action listener: set_extra_try_arguments 01:24:12 INFO - [mozharness: 2017-01-16 09:24:12.434936Z] Finished download-and-extract step (success) 01:24:12 INFO - [mozharness: 2017-01-16 09:24:12.435164Z] Running populate-webroot step. 01:24:12 INFO - Running pre-action listener: _resource_record_pre_action 01:24:12 INFO - Running main action method: populate_webroot 01:24:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:24:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:24:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:24:12 INFO - '--tppagecycles', 01:24:12 INFO - '7'], 01:24:12 INFO - 'tests': ['tsvgm']}}, 01:24:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:24:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:24:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:24:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:24:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:24:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:24:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:12 INFO - 'talos_options': ['--disable-e10s'], 01:24:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:12 INFO - 'talos_options': ['--disable-e10s'], 01:24:12 INFO - 'tests': ['damp', 'tps']}, 01:24:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:12 INFO - 'tests': ['damp', 'tps']}, 01:24:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:24:12 INFO - 'tests': ['dromaeo_dom']}, 01:24:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:24:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:24:12 INFO - 'tests': ['basic_compositor_video']}, 01:24:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:24:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:24:12 INFO - 'tests': ['a11yr', 01:24:12 INFO - 'ts_paint', 01:24:12 INFO - 'tpaint', 01:24:12 INFO - 'sessionrestore', 01:24:12 INFO - 'sessionrestore_no_auto_restore', 01:24:12 INFO - 'tabpaint']}, 01:24:12 INFO - 'other-e10s': {'tests': ['a11yr', 01:24:12 INFO - 'ts_paint', 01:24:12 INFO - 'tpaint', 01:24:12 INFO - 'sessionrestore', 01:24:12 INFO - 'sessionrestore_no_auto_restore', 01:24:12 INFO - 'tabpaint']}, 01:24:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:24:12 INFO - 'ts_paint', 01:24:12 INFO - 'tpaint', 01:24:12 INFO - 'sessionrestore', 01:24:12 INFO - 'sessionrestore_no_auto_restore', 01:24:12 INFO - 'tabpaint']}, 01:24:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:24:12 INFO - 'ts_paint', 01:24:12 INFO - 'tpaint', 01:24:12 INFO - 'sessionrestore', 01:24:12 INFO - 'sessionrestore_no_auto_restore', 01:24:12 INFO - 'tabpaint']}, 01:24:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:24:12 INFO - 'tests': ['a11yr', 01:24:12 INFO - 'ts_paint', 01:24:12 INFO - 'tpaint', 01:24:12 INFO - 'sessionrestore', 01:24:12 INFO - 'sessionrestore_no_auto_restore', 01:24:12 INFO - 'tabpaint']}, 01:24:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:24:12 INFO - 'tests': ['a11yr', 01:24:12 INFO - 'ts_paint', 01:24:12 INFO - 'tpaint', 01:24:12 INFO - 'sessionrestore', 01:24:12 INFO - 'sessionrestore_no_auto_restore', 01:24:12 INFO - 'tabpaint']}, 01:24:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:24:12 INFO - 'tests': ['tsvgx', 01:24:12 INFO - 'tsvgr_opacity', 01:24:12 INFO - 'tart', 01:24:12 INFO - 'tscrollx', 01:24:12 INFO - 'cart']}, 01:24:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:24:12 INFO - 'tsvgr_opacity', 01:24:12 INFO - 'tart', 01:24:12 INFO - 'tscrollx', 01:24:12 INFO - 'cart']}, 01:24:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:12 INFO - 'talos_options': ['--disable-e10s'], 01:24:12 INFO - 'tests': ['tp5o']}, 01:24:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:12 INFO - 'tests': ['tp5o']}, 01:24:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:12 INFO - 'talos_options': ['--disable-e10s', 01:24:12 INFO - '--xperf_path', 01:24:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:12 INFO - 'tests': ['tp5n']}, 01:24:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:12 INFO - 'talos_options': ['--xperf_path', 01:24:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:12 INFO - 'tests': ['tp5n']}}, 01:24:12 INFO - 'talos.zip': {'path': '', 01:24:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:24:12 INFO - Running post-action listener: _resource_record_post_action 01:24:12 INFO - [mozharness: 2017-01-16 09:24:12.456740Z] Finished populate-webroot step (success) 01:24:12 INFO - [mozharness: 2017-01-16 09:24:12.456835Z] Running create-virtualenv step. 01:24:12 INFO - Running pre-action listener: _resource_record_pre_action 01:24:12 INFO - Running main action method: create_virtualenv 01:24:12 INFO - Creating virtualenv /builds/slave/test/build/venv 01:24:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:24:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:24:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:24:12 INFO - Using real prefix '/usr' 01:24:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:24:13 INFO - Installing distribute.............................................................................................................................................................................................done. 01:24:15 INFO - Installing pip.................done. 01:24:15 INFO - Return code: 0 01:24:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f675fb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f60>, '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 0x10b2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:24:15 INFO - Using env: {'DISPLAY': ':0', 01:24:15 INFO - 'HOME': '/home/cltbld', 01:24:15 INFO - 'LANG': 'en_US.UTF-8', 01:24:15 INFO - 'LANGUAGE': 'en_US:en', 01:24:15 INFO - 'LOGNAME': 'cltbld', 01:24:15 INFO - 'MAIL': '/var/mail/cltbld', 01:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:15 INFO - 'MOZ_NO_REMOTE': '1', 01:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:15 INFO - 'NO_EM_RESTART': '1', 01:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:15 INFO - 'PWD': '/builds/slave/test', 01:24:15 INFO - 'SHELL': '/bin/bash', 01:24:15 INFO - 'SHLVL': '1', 01:24:15 INFO - 'TERM': 'linux', 01:24:15 INFO - 'TMOUT': '86400', 01:24:15 INFO - 'USER': 'cltbld', 01:24:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 01:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:15 INFO - '_': '/tools/buildbot/bin/python'} 01:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:15 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 01:24:15 INFO - Cleaning up... 01:24:15 INFO - Return code: 0 01:24:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f675fb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f60>, '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 0x10b2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:24:15 INFO - Using env: {'DISPLAY': ':0', 01:24:15 INFO - 'HOME': '/home/cltbld', 01:24:15 INFO - 'LANG': 'en_US.UTF-8', 01:24:15 INFO - 'LANGUAGE': 'en_US:en', 01:24:15 INFO - 'LOGNAME': 'cltbld', 01:24:15 INFO - 'MAIL': '/var/mail/cltbld', 01:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:15 INFO - 'MOZ_NO_REMOTE': '1', 01:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:15 INFO - 'NO_EM_RESTART': '1', 01:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:15 INFO - 'PWD': '/builds/slave/test', 01:24:15 INFO - 'SHELL': '/bin/bash', 01:24:15 INFO - 'SHLVL': '1', 01:24:15 INFO - 'TERM': 'linux', 01:24:15 INFO - 'TMOUT': '86400', 01:24:15 INFO - 'USER': 'cltbld', 01:24:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 01:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:15 INFO - '_': '/tools/buildbot/bin/python'} 01:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:15 INFO - Downloading/unpacking psutil>=3.1.1 01:24:15 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 01:24:15 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 01:24:15 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 01:24:15 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 01:24:15 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 01:24:15 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 01:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:24:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:17 INFO - Installing collected packages: psutil 01:24:17 INFO - Running setup.py install for psutil 01:24:17 INFO - building 'psutil._psutil_linux' extension 01:24:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:24:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:24:17 INFO - building 'psutil._psutil_posix' extension 01:24:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:24:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:24:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:18 INFO - Successfully installed psutil 01:24:18 INFO - Cleaning up... 01:24:18 INFO - Return code: 0 01:24:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:18 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 0x7f675fb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f60>, '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 0x10b2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:18 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 01:24:18 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 01:24:18 INFO - Using env: {'DISPLAY': ':0', 01:24:18 INFO - 'HOME': '/home/cltbld', 01:24:18 INFO - 'LANG': 'en_US.UTF-8', 01:24:18 INFO - 'LANGUAGE': 'en_US:en', 01:24:18 INFO - 'LOGNAME': 'cltbld', 01:24:18 INFO - 'MAIL': '/var/mail/cltbld', 01:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:18 INFO - 'MOZ_NO_REMOTE': '1', 01:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:18 INFO - 'NO_EM_RESTART': '1', 01:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:18 INFO - 'PWD': '/builds/slave/test', 01:24:18 INFO - 'SHELL': '/bin/bash', 01:24:18 INFO - 'SHLVL': '1', 01:24:18 INFO - 'TERM': 'linux', 01:24:18 INFO - 'TMOUT': '86400', 01:24:18 INFO - 'USER': 'cltbld', 01:24:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 01:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:18 INFO - '_': '/tools/buildbot/bin/python'} 01:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:24:20 INFO - Installing collected packages: mozsystemmonitor 01:24:20 INFO - Running setup.py install for mozsystemmonitor 01:24:20 INFO - Successfully installed mozsystemmonitor 01:24:20 INFO - Cleaning up... 01:24:20 INFO - Return code: 0 01:24:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:24:20 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')]} 01:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:20 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')]} 01:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:20 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 0x7f675fb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f60>, '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 0x10b2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:20 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 01:24:20 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 01:24:20 INFO - Using env: {'DISPLAY': ':0', 01:24:20 INFO - 'HOME': '/home/cltbld', 01:24:20 INFO - 'LANG': 'en_US.UTF-8', 01:24:20 INFO - 'LANGUAGE': 'en_US:en', 01:24:20 INFO - 'LOGNAME': 'cltbld', 01:24:20 INFO - 'MAIL': '/var/mail/cltbld', 01:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:20 INFO - 'MOZ_NO_REMOTE': '1', 01:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:20 INFO - 'NO_EM_RESTART': '1', 01:24:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:20 INFO - 'PWD': '/builds/slave/test', 01:24:20 INFO - 'SHELL': '/bin/bash', 01:24:20 INFO - 'SHLVL': '1', 01:24:20 INFO - 'TERM': 'linux', 01:24:20 INFO - 'TMOUT': '86400', 01:24:20 INFO - 'USER': 'cltbld', 01:24:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 01:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:20 INFO - '_': '/tools/buildbot/bin/python'} 01:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:20 INFO - Downloading/unpacking jsonschema==2.5.1 01:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:24:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:23 INFO - Downloading functools32-3.2.3-2.tar.gz 01:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:24:23 INFO - warning: no files found matching '*.txt' 01:24:23 INFO - no previously-included directories found matching 'build' 01:24:23 INFO - no previously-included directories found matching 'dist' 01:24:23 INFO - no previously-included directories found matching '.git*' 01:24:23 INFO - Installing collected packages: jsonschema, functools32 01:24:23 INFO - Running setup.py install for functools32 01:24:23 INFO - warning: no files found matching '*.txt' 01:24:23 INFO - no previously-included directories found matching 'build' 01:24:23 INFO - no previously-included directories found matching 'dist' 01:24:23 INFO - no previously-included directories found matching '.git*' 01:24:23 INFO - Successfully installed jsonschema functools32 01:24:23 INFO - Cleaning up... 01:24:23 INFO - Return code: 0 01:24:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:24:23 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')]} 01:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:23 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')]} 01:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:23 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 0x7f675fb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f60>, '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 0x10b2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:23 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 01:24:23 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 01:24:23 INFO - Using env: {'DISPLAY': ':0', 01:24:23 INFO - 'HOME': '/home/cltbld', 01:24:23 INFO - 'LANG': 'en_US.UTF-8', 01:24:23 INFO - 'LANGUAGE': 'en_US:en', 01:24:23 INFO - 'LOGNAME': 'cltbld', 01:24:23 INFO - 'MAIL': '/var/mail/cltbld', 01:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:23 INFO - 'MOZ_NO_REMOTE': '1', 01:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:23 INFO - 'NO_EM_RESTART': '1', 01:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:23 INFO - 'PWD': '/builds/slave/test', 01:24:23 INFO - 'SHELL': '/bin/bash', 01:24:23 INFO - 'SHLVL': '1', 01:24:23 INFO - 'TERM': 'linux', 01:24:23 INFO - 'TMOUT': '86400', 01:24:23 INFO - 'USER': 'cltbld', 01:24:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 01:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:23 INFO - '_': '/tools/buildbot/bin/python'} 01:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:24:23 INFO - Cleaning up... 01:24:23 INFO - Return code: 0 01:24:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:24:23 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')]} 01:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:23 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')]} 01:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:23 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 0x7f675fb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f60>, '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 0x10b2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:23 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 01:24:23 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 01:24:23 INFO - Using env: {'DISPLAY': ':0', 01:24:23 INFO - 'HOME': '/home/cltbld', 01:24:23 INFO - 'LANG': 'en_US.UTF-8', 01:24:23 INFO - 'LANGUAGE': 'en_US:en', 01:24:23 INFO - 'LOGNAME': 'cltbld', 01:24:23 INFO - 'MAIL': '/var/mail/cltbld', 01:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:23 INFO - 'MOZ_NO_REMOTE': '1', 01:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:23 INFO - 'NO_EM_RESTART': '1', 01:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:23 INFO - 'PWD': '/builds/slave/test', 01:24:23 INFO - 'SHELL': '/bin/bash', 01:24:23 INFO - 'SHLVL': '1', 01:24:23 INFO - 'TERM': 'linux', 01:24:23 INFO - 'TMOUT': '86400', 01:24:23 INFO - 'USER': 'cltbld', 01:24:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 01:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:23 INFO - '_': '/tools/buildbot/bin/python'} 01:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:23 INFO - Downloading/unpacking blobuploader==1.2.4 01:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:25 INFO - Downloading blobuploader-1.2.4.tar.gz 01:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:24:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:24:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:24:26 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 01:24:26 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 01:24:26 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 01:24:26 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 01:24:26 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 01:24:26 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 01:24:26 INFO - Downloading docopt-0.6.1.tar.gz 01:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:24:26 INFO - Installing collected packages: blobuploader, requests, docopt 01:24:26 INFO - Running setup.py install for blobuploader 01:24:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:24:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:24:26 INFO - Running setup.py install for requests 01:24:26 INFO - Running setup.py install for docopt 01:24:27 INFO - Successfully installed blobuploader requests docopt 01:24:27 INFO - Cleaning up... 01:24:27 INFO - Return code: 0 01:24:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:27 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 0x7f675fb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f60>, '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 0x10b2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:27 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 01:24:27 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 01:24:27 INFO - Using env: {'DISPLAY': ':0', 01:24:27 INFO - 'HOME': '/home/cltbld', 01:24:27 INFO - 'LANG': 'en_US.UTF-8', 01:24:27 INFO - 'LANGUAGE': 'en_US:en', 01:24:27 INFO - 'LOGNAME': 'cltbld', 01:24:27 INFO - 'MAIL': '/var/mail/cltbld', 01:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:27 INFO - 'MOZ_NO_REMOTE': '1', 01:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:27 INFO - 'NO_EM_RESTART': '1', 01:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:27 INFO - 'PWD': '/builds/slave/test', 01:24:27 INFO - 'SHELL': '/bin/bash', 01:24:27 INFO - 'SHLVL': '1', 01:24:27 INFO - 'TERM': 'linux', 01:24:27 INFO - 'TMOUT': '86400', 01:24:27 INFO - 'USER': 'cltbld', 01:24:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 01:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:27 INFO - '_': '/tools/buildbot/bin/python'} 01:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:27 INFO - Running setup.py (path:/tmp/pip-bZ__Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:27 INFO - Running setup.py (path:/tmp/pip-7c_Tcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:27 INFO - Running setup.py (path:/tmp/pip-lnzmzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:27 INFO - Running setup.py (path:/tmp/pip-XjcuYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:27 INFO - Running setup.py (path:/tmp/pip-WtFeZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:27 INFO - Running setup.py (path:/tmp/pip-4dIeKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:27 INFO - Running setup.py (path:/tmp/pip-6DvNut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:27 INFO - Running setup.py (path:/tmp/pip-yALv2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:27 INFO - Running setup.py (path:/tmp/pip-Ops4cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:28 INFO - Running setup.py (path:/tmp/pip-ZIuBBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:28 INFO - Running setup.py (path:/tmp/pip-RqXeG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:28 INFO - Running setup.py (path:/tmp/pip-puCLeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:28 INFO - Running setup.py (path:/tmp/pip-iDES6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:28 INFO - Running setup.py (path:/tmp/pip-2uh4d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:28 INFO - Running setup.py (path:/tmp/pip-A3FKMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:28 INFO - Running setup.py (path:/tmp/pip-kkL7Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:28 INFO - Running setup.py (path:/tmp/pip-LpcMbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:24:28 INFO - Running setup.py install for manifestparser 01:24:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:24:28 INFO - Running setup.py install for mozcrash 01:24:28 INFO - Running setup.py install for mozdebug 01:24:28 INFO - Running setup.py install for mozdevice 01:24:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Running setup.py install for mozfile 01:24:29 INFO - Running setup.py install for mozhttpd 01:24:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Running setup.py install for mozinfo 01:24:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Running setup.py install for mozInstall 01:24:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Running setup.py install for mozleak 01:24:29 INFO - Running setup.py install for mozlog 01:24:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Running setup.py install for moznetwork 01:24:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Running setup.py install for mozprocess 01:24:29 INFO - Running setup.py install for mozprofile 01:24:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:24:29 INFO - Running setup.py install for mozrunner 01:24:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:24:30 INFO - Running setup.py install for mozscreenshot 01:24:30 INFO - Running setup.py install for moztest 01:24:30 INFO - Running setup.py install for mozversion 01:24:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:24:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:24:30 INFO - Cleaning up... 01:24:30 INFO - Return code: 0 01:24:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24: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')]} 01:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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')]} 01:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:30 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 0x7f675fb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f60>, '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 0x10b2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:30 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 01:24:30 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 01:24:30 INFO - Using env: {'DISPLAY': ':0', 01:24:30 INFO - 'HOME': '/home/cltbld', 01:24:30 INFO - 'LANG': 'en_US.UTF-8', 01:24:30 INFO - 'LANGUAGE': 'en_US:en', 01:24:30 INFO - 'LOGNAME': 'cltbld', 01:24:30 INFO - 'MAIL': '/var/mail/cltbld', 01:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:30 INFO - 'MOZ_NO_REMOTE': '1', 01:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:30 INFO - 'NO_EM_RESTART': '1', 01:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:30 INFO - 'PWD': '/builds/slave/test', 01:24:30 INFO - 'SHELL': '/bin/bash', 01:24:30 INFO - 'SHLVL': '1', 01:24:30 INFO - 'TERM': 'linux', 01:24:30 INFO - 'TMOUT': '86400', 01:24:30 INFO - 'USER': 'cltbld', 01:24:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 01:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:30 INFO - '_': '/tools/buildbot/bin/python'} 01:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:30 INFO - Running setup.py (path:/tmp/pip-QxMIIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:30 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)) 01:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:30 INFO - Running setup.py (path:/tmp/pip-jkbGUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:30 INFO - Running setup.py (path:/tmp/pip-PY6ahz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:30 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)) 01:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:30 INFO - Running setup.py (path:/tmp/pip-2bib9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:30 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)) 01:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:30 INFO - Running setup.py (path:/tmp/pip-1HyaRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:31 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)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:31 INFO - Running setup.py (path:/tmp/pip-5_AwDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:31 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)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:31 INFO - Running setup.py (path:/tmp/pip-C5jOjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:31 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)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:31 INFO - Running setup.py (path:/tmp/pip-JaFsPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:31 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)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:31 INFO - Running setup.py (path:/tmp/pip-23onJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:31 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)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:31 INFO - Running setup.py (path:/tmp/pip-849utE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:31 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)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:31 INFO - Running setup.py (path:/tmp/pip-s3PTmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:31 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)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:31 INFO - Running setup.py (path:/tmp/pip-xXh3do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:31 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)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:31 INFO - Running setup.py (path:/tmp/pip-ZqlFEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:31 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)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:31 INFO - Running setup.py (path:/tmp/pip-45N9YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:31 INFO - Running setup.py (path:/tmp/pip-l5Cflj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:31 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)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:31 INFO - Running setup.py (path:/tmp/pip-UWpunl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:31 INFO - Running setup.py (path:/tmp/pip-y3tpJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:31 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)) 01:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:24:31 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)) 01:24:31 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)) 01:24:31 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)) 01:24:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:24:31 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 01:24:31 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 01:24:31 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 01:24:31 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 01:24:31 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 01:24:31 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 01:24:33 INFO - Downloading blessings-1.6.tar.gz 01:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:24:33 INFO - Installing collected packages: blessings 01:24:33 INFO - Running setup.py install for blessings 01:24:34 INFO - Successfully installed blessings 01:24:34 INFO - Cleaning up... 01:24:34 INFO - Return code: 0 01:24:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:34 INFO - Reading from file tmpfile_stdout 01:24:34 INFO - Current package versions: 01:24:34 INFO - argparse == 1.2.1 01:24:34 INFO - blessings == 1.6 01:24:34 INFO - blobuploader == 1.2.4 01:24:34 INFO - docopt == 0.6.1 01:24:34 INFO - functools32 == 3.2.3-2 01:24:34 INFO - jsonschema == 2.5.1 01:24:34 INFO - manifestparser == 1.1 01:24:34 INFO - mozInstall == 1.12 01:24:34 INFO - mozcrash == 0.17 01:24:34 INFO - mozdebug == 0.1 01:24:34 INFO - mozdevice == 0.48 01:24:34 INFO - mozfile == 1.2 01:24:34 INFO - mozhttpd == 0.7 01:24:34 INFO - mozinfo == 0.9 01:24:34 INFO - mozleak == 0.1 01:24:34 INFO - mozlog == 3.4 01:24:34 INFO - moznetwork == 0.27 01:24:34 INFO - mozprocess == 0.23 01:24:34 INFO - mozprofile == 0.28 01:24:34 INFO - mozrunner == 6.12 01:24:34 INFO - mozscreenshot == 0.1 01:24:34 INFO - mozsystemmonitor == 0.3 01:24:34 INFO - moztest == 0.7 01:24:34 INFO - mozversion == 1.4 01:24:34 INFO - psutil == 3.1.1 01:24:34 INFO - requests == 1.2.3 01:24:34 INFO - wsgiref == 0.1.2 01:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:34 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 0x7f675fb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f60>, '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 0x10b2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:34 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 01:24:34 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 01:24:34 INFO - Using env: {'DISPLAY': ':0', 01:24:34 INFO - 'HOME': '/home/cltbld', 01:24:34 INFO - 'LANG': 'en_US.UTF-8', 01:24:34 INFO - 'LANGUAGE': 'en_US:en', 01:24:34 INFO - 'LOGNAME': 'cltbld', 01:24:34 INFO - 'MAIL': '/var/mail/cltbld', 01:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:34 INFO - 'MOZ_NO_REMOTE': '1', 01:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:34 INFO - 'NO_EM_RESTART': '1', 01:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:34 INFO - 'PWD': '/builds/slave/test', 01:24:34 INFO - 'SHELL': '/bin/bash', 01:24:34 INFO - 'SHLVL': '1', 01:24:34 INFO - 'TERM': 'linux', 01:24:34 INFO - 'TMOUT': '86400', 01:24:34 INFO - 'USER': 'cltbld', 01:24:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 01:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:34 INFO - '_': '/tools/buildbot/bin/python'} 01:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:34 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)) 01:24:34 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)) 01:24:34 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)) 01:24:34 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)) 01:24:34 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)) 01:24:34 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)) 01:24:34 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)) 01:24:34 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)) 01:24:34 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)) 01:24:34 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)) 01:24:34 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)) 01:24:34 INFO - Cleaning up... 01:24:34 INFO - Return code: 0 01:24:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:34 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 0x7f675fb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f60>, '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 0x10b2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:34 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 01:24:34 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 01:24:34 INFO - Using env: {'DISPLAY': ':0', 01:24:34 INFO - 'HOME': '/home/cltbld', 01:24:34 INFO - 'LANG': 'en_US.UTF-8', 01:24:34 INFO - 'LANGUAGE': 'en_US:en', 01:24:34 INFO - 'LOGNAME': 'cltbld', 01:24:34 INFO - 'MAIL': '/var/mail/cltbld', 01:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:34 INFO - 'MOZ_NO_REMOTE': '1', 01:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:34 INFO - 'NO_EM_RESTART': '1', 01:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:34 INFO - 'PWD': '/builds/slave/test', 01:24:34 INFO - 'SHELL': '/bin/bash', 01:24:34 INFO - 'SHLVL': '1', 01:24:34 INFO - 'TERM': 'linux', 01:24:34 INFO - 'TMOUT': '86400', 01:24:34 INFO - 'USER': 'cltbld', 01:24:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 01:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:34 INFO - '_': '/tools/buildbot/bin/python'} 01:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:24:34 INFO - Cleaning up... 01:24:34 INFO - Return code: 0 01:24:34 INFO - Running post-action listener: _resource_record_post_action 01:24:34 INFO - Running post-action listener: _start_resource_monitoring 01:24:34 INFO - Starting resource monitoring. 01:24:34 INFO - [mozharness: 2017-01-16 09:24:34.818527Z] Finished create-virtualenv step (success) 01:24:34 INFO - [mozharness: 2017-01-16 09:24:34.819017Z] Running install step. 01:24:34 INFO - Running pre-action listener: _resource_record_pre_action 01:24:34 INFO - Running main action method: install 01:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:35 INFO - Reading from file tmpfile_stdout 01:24:35 INFO - Detecting whether we're running mozinstall >=1.0... 01:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:24:35 INFO - Reading from file tmpfile_stdout 01:24:35 INFO - Output received: 01:24:35 INFO - Usage: mozinstall [options] installer 01:24:35 INFO - Options: 01:24:35 INFO - -h, --help show this help message and exit 01:24:35 INFO - -d DEST, --destination=DEST 01:24:35 INFO - Directory to install application into. [default: 01:24:35 INFO - "/builds/slave/test"] 01:24:35 INFO - --app=APP Application being installed. [default: firefox] 01:24:35 INFO - mkdir: /builds/slave/test/build/application 01:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:24:48 INFO - Reading from file tmpfile_stdout 01:24:48 INFO - Output received: 01:24:48 INFO - /builds/slave/test/build/application/firefox/firefox 01:24:48 INFO - Running post-action listener: _resource_record_post_action 01:24:48 INFO - [mozharness: 2017-01-16 09:24:48.620808Z] Finished install step (success) 01:24:48 INFO - [mozharness: 2017-01-16 09:24:48.621051Z] Running run-tests step. 01:24:48 INFO - Running pre-action listener: _resource_record_pre_action 01:24:48 INFO - Running main action method: run_tests 01:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:24:48 INFO - Python 2.7.3 01:24:48 INFO - Return code: 0 01:24:48 INFO - grabbing minidump binary from tooltool 01:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:48 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/linux64/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 0x10b1f60>, '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 0x10b2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:24:48 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:24:48 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/linux64/releng.manifest -o -c /builds/tooltool_cache 01:24:48 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:24:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:24:48 INFO - Return code: 0 01:24:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:24:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:24:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:24:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:24:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:24:48 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/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 01:24:48 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/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 01:24:48 INFO - Using env: {'DISPLAY': ':0', 01:24:48 INFO - 'HOME': '/home/cltbld', 01:24:48 INFO - 'LANG': 'en_US.UTF-8', 01:24:48 INFO - 'LANGUAGE': 'en_US:en', 01:24:48 INFO - 'LOGNAME': 'cltbld', 01:24:48 INFO - 'MAIL': '/var/mail/cltbld', 01:24:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:24:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:48 INFO - 'MOZ_NO_REMOTE': '1', 01:24:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:48 INFO - 'NO_EM_RESTART': '1', 01:24:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:48 INFO - 'PWD': '/builds/slave/test', 01:24:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:24:48 INFO - 'SHELL': '/bin/bash', 01:24:48 INFO - 'SHLVL': '1', 01:24:48 INFO - 'TERM': 'linux', 01:24:48 INFO - 'TMOUT': '86400', 01:24:48 INFO - 'USER': 'cltbld', 01:24:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627', 01:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:48 INFO - '_': '/tools/buildbot/bin/python'} 01:24:48 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/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 01:24:48 INFO - mozversion application_buildid: 20170115233322 01:24:48 INFO - mozversion application_changeset: 2e32d2060f1c47c64ac7ade5d9c7f2b23593e2ec 01:24:48 INFO - mozversion application_display_name: Firefox 01:24:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:24:48 INFO - mozversion application_name: Firefox 01:24:48 INFO - mozversion application_remotingname: firefox 01:24:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:24:48 INFO - mozversion application_vendor: Mozilla 01:24:48 INFO - mozversion application_version: 51.0 01:24:48 INFO - mozversion platform_buildid: 20170115233322 01:24:48 INFO - mozversion platform_changeset: 2e32d2060f1c47c64ac7ade5d9c7f2b23593e2ec 01:24:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:24:48 INFO - mozversion platform_version: 51.0 01:24:48 INFO - using testdate: 1484558688 01:24:48 INFO - actual date: 1484558688 01:24:48 INFO - starting webserver on 'localhost:52256' 01:24:48 INFO - SUITE-START | Running 2 tests 01:24:48 INFO - TEST-START | dromaeo_css 01:24:48 INFO - operating with platform_type : linux_ 01:24:48 INFO - Initialising browser for dromaeo_css test... 01:24:48 INFO - TEST-INFO | started process 3401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaTTjj1/profile http://localhost:52256/getInfo.html) 01:24:52 INFO - PROCESS | 3401 | __metrics Screen width/height:1600/1200 01:24:52 INFO - PROCESS | 3401 | colorDepth:24 01:24:52 INFO - PROCESS | 3401 | Browser inner width/height: 1024/697 01:24:52 INFO - PROCESS | 3401 | __metrics 01:24:53 INFO - PROCESS | 3401 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:24:53 INFO - PROCESS | 3401 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:24:53 INFO - PROCESS | 3401 | console.error: PushService: 01:24:53 INFO - PROCESS | 3401 | stateChangeProcessEnqueue: Error transitioning state 01:24:53 INFO - PROCESS | 3401 | UnknownError 01:24:54 INFO - TEST-INFO | 3401: exit 0 01:24:54 INFO - Browser initialized. 01:24:54 INFO - Running cycle 1/1 for dromaeo_css test... 01:24:54 INFO - TEST-INFO | started process 3495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaTTjj1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:25:06 INFO - PROCESS | 3495 | RSS: Main: 143540224 01:25:06 INFO - PROCESS | 3495 | 01:25:57 INFO - PROCESS | 3495 | 1484558757150 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:28:05 INFO - PROCESS | 3495 | Cycle 1(1): loaded http://localhost:52256/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52256/tests/dromaeo/cssquery-ext.html) 01:28:07 INFO - PROCESS | 3495 | RSS: Main: 291254272 01:28:07 INFO - PROCESS | 3495 | 01:31:09 INFO - PROCESS | 3495 | Cycle 1(1): loaded http://localhost:52256/tests/dromaeo/cssquery-ext.html (next: http://localhost:52256/tests/dromaeo/cssquery-jquery.html) 01:31:10 INFO - PROCESS | 3495 | RSS: Main: 227164160 01:31:10 INFO - PROCESS | 3495 | 01:34:12 INFO - PROCESS | 3495 | Cycle 1(1): loaded http://localhost:52256/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52256/tests/dromaeo/cssquery-mootools.html) 01:34:12 INFO - PROCESS | 3495 | RSS: Main: 202125312 01:34:12 INFO - PROCESS | 3495 | 01:37:14 INFO - PROCESS | 3495 | Cycle 1(1): loaded http://localhost:52256/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52256/tests/dromaeo/cssquery-prototype.html) 01:37:15 INFO - PROCESS | 3495 | RSS: Main: 174432256 01:37:15 INFO - PROCESS | 3495 | 01:40:17 INFO - PROCESS | 3495 | Cycle 1(1): loaded http://localhost:52256/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52256/tests/dromaeo/cssquery-yui.html) 01:40:18 INFO - PROCESS | 3495 | RSS: Main: 175800320 01:40:18 INFO - PROCESS | 3495 | 01:43:20 INFO - PROCESS | 3495 | Cycle 1(1): loaded http://localhost:52256/tests/dromaeo/cssquery-yui.html (next: http://localhost:52256/tests/dromaeo/cssquery-dojo.html) 01:43:21 INFO - PROCESS | 3495 | RSS: Main: 257470464 01:43:21 INFO - PROCESS | 3495 | 01:43:21 INFO - PROCESS | 3495 | __start_tp_report 01:43:21 INFO - PROCESS | 3495 | _x_x_mozilla_page_load 01:43:21 INFO - PROCESS | 3495 | _x_x_mozilla_page_load_details 01:43:21 INFO - PROCESS | 3495 | |i|pagename|runs| 01:43:21 INFO - PROCESS | 3495 | |0;dojo.html;3099.5195744659577;3125.32805446829;3132.279575697591;3169.112648458431;3186.203449137716;5556.333240011194;5643.435656434354;5646.548276137909;5647.661140331583;5671.319441667;5591.692456914868;5641.661500309984;5644.520215781664;5649.604527683064;5653.1520271959225;5088.211327244265;5103.132467480537;5126.948730512703;5136.306598609196;5164.974175129119;4982.427020892589;5003.374578177728;5131.717755523445;5163.612729045318;5186.92219616706;5045.596352291808;5053.570446512051;5071.31537242473;5118.33461649985;5124.538791508763;5128.871778205556;5211.921821172686;5217.34783152106;5228.503292187236;5252.842414727565;4855.223164293696;5108;5128.5640720538795;5139.794408223666;5167.974160129213;5455.318085239345;5457.181422786574;5474.91787623186;5498;5570.777168913239;5869.383714709937;5902.704864756745;5972.193753843219;5989.101634754822;5998.040313549855;5833.358330583633;6005.729742161569;6012.338642749294;6020.157177995085;6024.1566180734735;5418.7019713915715;5465.398806131283;5546.084895992157;5577.665340079527;5669.206311116447;6151.815445536641;6167.259928808572;6170.228721409824;6179.876402471926;6186.566940314135;5894.970525147347;5914.053751399755;5922.49658779;5933.376995415506;5949.375315591887;5731.312242530839;5784.4504772046585;5898.911516327258;5975.163477113208;5984.3417224105315;6042.154098426224;6043.002904520705;6045.546584006129;6045.667488288098;6077.1491991121275;5963.254593175853;5991.221141251696;6040.818775436744;6060.848478788065;6063.818085457443;4482.7534485602955;4483.417155769729;4528.637708983273;4546.158960592301;4626.629869610423;4070.6946978976102;4088;4091.365838295069;4110.938335924963;4114.958850411517;5733.971330143323;5740.196372507852;5744.080947048452;5746.051901436216;5749.482546570745;5809.186713860063;5889.1755154278435;5937.435943585352;5966.194563733927;6063.897095088379;5706.9429305707245;5715.657060576379;5724.885502290014;5757.366689664133;5761.107028410603;5199.948000520022;5202.557782588447;5208.583313334924;5212.8957420851375;5214.270002199695;5909.2908850938165;6023.879522409615;6172.629642221391;6179.3820617938745;6193.071039344134;5960.821175364746;5996.67018313997;6035.18524999137;6114.938850611437;6116.602420842631;6213.937860621336;6214.8135555933395;6218.782342617987;6223.96888015557;6234.844128896814;5886.440788125121;5890.204822349099;5934.139549765174;5940.821775346573;5984.341722410619;5772.624779389326;5817.76728930838;5893.9115913260475;5894.823155305347;6077.149199112039;5859.5019423349495;5864;5880.647161170344;5904.498117660047;5907.350191478848;5824.679642619697;5827.038538641077;5839.270091238595;5839.386864379179;5851.64890106595;5635.380108188178;5698.202251684685;5717.42825717425;5762.7694892203845;5783.277090363705;5856.0630299151935;5949.25634295713;5950.5239580834295;5961.195238642727;5990.580659353804;5517.393086760533;5636.070048441961;5661.518770904519;5674.460926212003;5677.489025987681 01:43:21 INFO - PROCESS | 3495 | |1;ext.html;570.5264630356804;640.7757284950267;649.5388274325229;661.642712935015;666.0043235363133;34811.65188348116;35025.82487087567;44977.77511112448;46199.76900115503;46331.536684633145;42783.78608106955;47475;47502;47562;47574;9249.537523123834;9404.341696081243;9406;9412.858807117898;9413.152816246537;8586.742397728078;8820.514871682055;11141.665750027472;11417.25787823793;11430.085593152528;11362.37506937118;11445.084393248562;11447.484863181135;11452.71368215793;11460.541578336857;11136.719277283095;11224.719382015515;11239.494222759955;11240.606578769786;11245;10897.891021089767;11001.61494347694;11004.229703920728;11004.889951100467;11010.064144547723;44841;45064.774676126406;45089.77455112736;45126.323105153446;45129.32306015412;3803.069563484148;3806.980965095157;3856.7878766667823;3906.941395879064;4002.663142309176;33965.32069358624;34179.31641367183;34543.13642158941;35700.64299356999;35755.821220893726;4625.444946606395;4696.342512048316;4710.693804902705;4712.4816270210595;4802.375691160162;328671;328954;329440;329565.35217324;329628;37998.810005949796;39144.804275979004;39248.215035699126;59973;60624;40725.1854962905;40788.38817417741;40835;40919.795401022806;40936.38595421071;15141.091534507965;15203.543893683207;15251.847481525043;15258.08451492914;15278.847211527966;11564.884351156548;11825.172237943261;12478.937605311916;12540.310282934526;12552.184108032949;9145.77135571616;9166.49584272858;9558.617655293849;9571.856422153673;9682.75793105164;3632.8183590820354;3638.1268495560876;3647.8176091195332;3677.7057835373107;3689.465027571041;1074.167520171873;1130.2879186112862;1185.063799598325;1215.6292330839003;1232.580922486359;33877.322453551285;34626.30747385089;34878.5408925645;34980.321400600544;35284;1133.4955944604737;1179.7699448607611;1297.8767017133357;1312.9212247265004;1331.0749029424458;18300.90849545744;18399.908000459913;18469.815301847077;18565.628687426175;18566.535836604195;504938;511257;511919;512965;513779;62820.371796282365;63260.683696581225;63278.36721632725;63280.68359658172;63336;1285.5500574798746;1319.2743990805018;1438.022144941429;1518.9392424302905;1603.6552141289678;31218;35838.64161358457;36035.81982090178;36494;36506.26987460183;52800.20799688085;54176.45823541714;54235.45764542304;54277.45722542724;54278.18582721341;434296;441834;441912;442959;466925;39279.80360098295;45608.77195614001;45920;46305;49061.75469122631;51269.230961534864;51868.48131518788;51892.740536297075;52228.47771522236;52893;42253.36619950642;42550.361744574475;42735.6495392744;43092.35361469518;43897.561024389346;42006;42315.365269520364;42734.358984614635;43565.12869742651;43710.781446092566;42914;43260.567394325655;44152.558474414844;44678.10643787041;44768.55231447644;34981.65018349784;35784.821075894455;36934.63065369312;37895.81052094722;37950.810245948596;29631.85184074066;29689.25776855596;29758.378101179344;29825.850870745508;30000.849995749883 01:43:21 INFO - PROCESS | 3495 | |2;jquery.html;417.79945626099493;417.86628278950747;424.3189680562697;424.79609787302087;447.55915423308033;19002.71495927562;19293.903530482345;20521.384358469233;20650.277240296593;20656.793432065675;17790.644187116282;19568.510787230327;20034.398968030946;20271.290504832334;20402.38792836217;5891.351951285355;6149.354317796634;6155.507559395238;6157;6192;5856.297244330686;6022.578419510636;6110.388961103877;6123.693815309217;6126.142340072372;6223.2532096148525;6223.719932603044;6227.034809604518;6231.40801623845;6235.532335074865;6198.4731297839735;6229.813105606839;6531.24890637578;6556.344365563453;6570.244421891496;5778.219940308089;5932.614380065282;5937.990541607937;5942.613730107572;5943.791967281124;15096.471623493126;15466;15469.071855688695;15488.535343939588;19243.326483573146;2422.7092748870073;2498.8625625590585;2525.368657835541;2652.204338698383;2695.4743824954144;11667.183297169202;15232.771508427382;15473.613159670986;15723.92138039314;16003.359865605362;1936.9031548422663;1958.608278344337;1974.5458544534695;2048.037422411479;2104.316097268394;87920.56039719825;89277;89724;90490.5475472625;91542.08457915402;11751.764964700658;11808.225067109222;12044.759104817855;12066;12162.270263784201;17395.91302043507;17420.216090275968;17432.5641858952;17436;17474.30102795874;8138.419095598037;8155.79610509742;8172.141925097779;8335.374846886507;8399.454035487674;7690.923090769133;7720.845583088307;7751.573663448565;7911.090224624127;8021.157778433298;5137.51193636604;5141.665791723526;5146.845594632167;5318.335208098988;5330.147176451749;2035.7522159029063;2144.431725592719;2166.5017046079174;2186.9453263668534;2199.1093607089156;975.1223898491272;1019.7144799456164;1042.9061384475283;1048.66442738323;1091.2143256855052;19610.70583941242;21178.364649060553;21280.680789788166;21380.623684828708;21557;1033.1012019542895;1049.2602715085998;1056.6460235820932;1069.0645685025602;1084.9132069434427;11398.943005285086;11856.288622682494;11967.700807479883;12101.213421127775;12176.452059657337;535848;538354;541925;542726;546509;97929.51035244777;99257;100075.777970547;100792.49603751935;102122;964.6671898195111;998.2480746290214;1005.0853723111933;1017.4505766885947;1037.206536999181;18488.445346639623;18688.159032843283;18890.3388381406;19130.521736956132;19298.22807087701;45587.77206113948;45727.02774319659;46085.769571151926;46722.76638616785;46836.7658161707;57711;60168;60470.69764651325;62318.688406557674;62924.68537657282;6716.529842910949;8837.779055523662;9251.352405331561;9459.148676619137;9571.18644915162;10759.731006724895;13716.588502344946;14041.1575305482;14052;14150.150990940576;11808.586699465477;11939.701507462383;12118.454669539715;12361.443735032126;12570.308633025272;11788.764224715285;12017.158798884344;12255.571055013032;12311.815322770344;12703;11889.46497407636;12229.633111006684;12255.877441225473;12451.377431128227;12726.68183295388;9167.17495425415;9229.538523073954;9339.20616747557;9357.578908948977;9499.43003419797;9302.441853488812;11390.886091138982;11621.302721836379;12001.339926304137;12499.750004999667 01:43:21 INFO - PROCESS | 3495 | |3;mootools.html;1395.1838174667819;1499.6026053095927;1527.1066426140708;1692.1708362902175;1848.343837937533;7698.114716807569;9121.452712837226;9500.049995000496;9517;9769.511524423786;9462.716118516439;9527.094925982037;9531.80936381272;9535.28485363597;9540.713778586636;2330.2310237621627;2353.5292941411785;2355.3640517060385;2356.2460012795914;2359.0210062823908;2304.4008557774932;2316.664083707861;2364.0898254172093;2365.66880636711;2369.7511761265077;2352.223766157164;2365.207655435431;2370.9170179043736;2376.7504412036747;2396.628522579003;2297.977020229793;2321.7330007049154;2323.2101085630884;2328.0571368595574;2329.7903188712926;2344.788968992782;2350.21267875262;2350.917717879883;2352.023910077316;2354.9646755298513;9292.303077269233;9366.859497107549;9400;9463.858042129374;9477.668281610111;5490.450954904478;5628.605997580171;5665.263515742969;5690.5447564194765;5695.202671625976;3755.34281500739;3800.7909564973916;3839.308924393608;3853.2486165197797;3883.650471457582;1231.846019247594;1233.0135891286934;1249.9312537810417;1253.7713041219565;1292.1536393662166;13605.183688978594;13681.726365472734;13696.93151534246;13734.45062197511;13754.037217394687;4854.781534830941;4858.344123543347;4946.604271658259;5014.172661510883;5029.7736601853;10620.575176992834;10656.200784941006;10658;10663.360198388122;10666.73333166677;5721.313442386857;5722.713864306768;5728.255326807488;5729.312482502127;5731.283589551306;4419.535948725337;4455.398521199661;4465.709728867613;4623.121606894747;5344.706041167696;4035.959640403617;4138.979305103516;4177.811998460076;4192.622663960258;4197.454330936958;1234.4136535145733;1245.8504979402348;1247.3950134184913;1254.5483625894672;1276.1513593460245;963.5326866469757;998.7952469743685;1012.9898701013043;1013.0780989299702;1018.6943916824923;6468.223813142453;6605.834854128685;6618.073469714244;6673.766418175341;6765.05289259504;979.5591983607405;1001.6944831826218;1003.1473247739364;1028.5320179318392;1055.2613170780485;4454.487733910577;4617.399738034034;4671.906561868744;4714.6464015199;4834.468208497063;12137.271763694207;12161.452734626962;12287.877121228852;12311.56909508163;12318.692032699255;11249.775004499865;11847.466863991142;11852.94073529644;12147.453364598614;12177.330246836333;8761.824763504694;8848.247898928534;8862.734117976472;8864.512451815082;8948.68679596211;6468.579542329733;6563.379023976486;6573.638449885302;6656.600603963778;6701.53089283765;10354.326968747007;10701.090407315465;10923.344599324066;10981.121510279;11200.159988001096;9033.909660903308;9128.726138215865;11168.944155279172;11369.772604548029;11538.076953843505;8391;8733.432326898732;8857.291416686521;8863.379563430755;8874.334424918286;9320.673776417792;9321.114494123047;9349.672761453316;9390.389624674373;9422.387544809566;8392.244697977212;8493.57532123379;8547.145285471652;8609.870851937101;8821.426607270507;7999.120096789465;8100.797480063045;8169.183081691784;8328.3337333012;8561.957190214009;7475.327220550176;7526.435517336331;7733.149353570991;7857.371410287049;7864.449488535747;5549.278593782782;5604.103343465026;5757.251557297692;5780.566457515619;5787.102999035156;5570.359408668055;5687.146927960839;5771.971140144273;5839.328477225174;5906.468417842415 01:43:21 INFO - PROCESS | 3495 | |4;prototype.html;355.4951968205148;355.8576569372252;356.66829848241144;361.8299399282336;363.5110776006272;5605.859853503659;5622.746976386063;5667.291588551431;5673.829785106448;5695.601307908448;5523.392426833045;5556.916646250299;5568.916466253009;5615.58529832172;5639.407862174464;4151.571330771502;4346.695731298811;4353.172897149531;4363.258246098155;4363.585459381354;4311.1593239318345;4322.394864718942;4337.848175313865;4339.457567804025;4342.804573794171;4276.759739675506;4297.570242975708;4305.354196870463;4318.892027699317;4366.8253269869165;4212.262854000538;4300.784960751981;4311.590398912098;4311.784410779448;4378.8029538670835;3798.4682144499793;3801.8669346572738;3807.4859893914245;3821.8662346818005;3824.0631045394057;5426.593005524602;5441.700706461143;5455.727213639302;5473.01485732568;5480.835574932758;4723.740194289313;4895.339129217546;4956.107900577895;4963.652544321899;4999.450060493343;5700.37295897451;5734.4265573442735;5738.454846789548;5753.913691294592;5801.781625858533;4182.790860456965;4197.874063778061;4205.453291072172;4234.364845273234;4240.618344349024;5861.6189947653265;5922.7038648067855;5997.640141591475;6056.606320589148;6095.9695201524155;4275.5296917339065;4292.6995110342605;4292.905309146147;4299.355096735515;4347.152305300499;4395.978020109879;4403.471583410012;4403.647708183337;4406.361077643724;4407.559244075631;4666.5533684557895;4939.678351174942;4941.901161976741;4986.426560945465;5012.448630650625;5727.599068065196;5795.594308398372;5804.097951024488;5824.563157763185;5836.182934389189;1481.4148411377446;1516.8103987001625;1518.9924050379898;1520.5438368489408;1523.916184609835;973.9951300243454;989.5645915797027;1035.440861934562;1094.272308914563;1111.8943700348455;5493.862653433616;5493.862653433616;5532.778688852401;5539.584531160099;5558.694271815089;5874.941250587525;5885.470307672244;5909;5916.018133925098;5920.259967504062;5372.247885296062;5553.944460555343;5661.556303142672;5729.656220626775;5738.397468265855;3153.684631536828;3160.340821068957;3170.1757543038975;3191.6010498687665;3192.5051616999403;5908.438698323653;6144.38556144382;6179;6208.379162083846;6211.3478084801345;5811.360750317462;6091;6128.17269668598;6158.199434073542;6170.822026656276;5986.940130598726;6039.365866583946;6156.860980718581;6162.7226774795245;6167.660778657128;5976.641401515923;5980.880382392241;5987.880242395215;6011.849703757441;6026.879462410815;5563.7496312666835;5648.5481161507805;5835.387284335084;5870.765169393177;5920.437558431942;6148.661823599745;6182.752689892354;6184.134221208944;6189.288231853215;6216.564840461125;4056.472658554369;4237.491501019897;4283.357496375568;4339.175556644227;4354.455693038371;5843.561732870136;5850.824475265749;5944.4352786485215;5946.881062378815;5967.731452084753;5746.626469279484;5759.596828221985;5761.366249712612;5788.884222315614;5808.854778630568;5597.944020559742;5823.155642431909;5840.2991641003355;5842.568570700206;5851.132944857074;5827.59206855516;5828.854278643068;5831.883362332815;5838.357780644041;5839.299284085937;5700.800471983626;5887.558433117448;5897.5281977440845;5914.674692891932;5924.837434336522;5570.721463926869;5589.552835773047;5642.266505354278;5660.867826434647;5666.490015898589 01:43:21 INFO - PROCESS | 3495 | |5;yui.html;839.6095815445816;857.7855536115967;873.4191762477951;896.3546246702372;902.4359775140537;16803.579910502227;17713.82286177136;17835.46493605194;17844.910775446137;17976.64046719065;16128.596785080379;16253.593660158502;16260.75608865868;16468.341266349362;16927.83072169278;726.920038795732;862.9223369896723;882.3602887906248;883.4699180491685;883.7923088074298;740.7259314053807;839.9706010289641;863.7236084452977;868.7958329792493;874.4185116897256;933.7478880702206;934.9439033657968;935.1817159985013;935.4621092871593;935.6912218967758;934.028610245344;934.1919239857542;934.6448349627132;935.1536859142487;935.2144198872945;685.3112621815044;685.3694600967123;685.540687739216;685.6126288646948;686.0977814174395;16526.091064991422;16586.1706914655;16652.50042498727;16690.915090519076;16699.165041747863;14620.780688289684;15174.241287935669;15223.162726050063;16038.35846566136;16046.438374656831;13598.456061757517;13674.31628418575;14075.36660850254;14143.151410915378;14392.92803535986;4101.692373072032;4179.895502612459;4182.079942412664;4217.135487225111;4281.100968796525;94325;94769.01293288307;95548.52225738896;99017;99285;12564.937175314248;12685.23888566689;12764.297963611905;12790.68023299425;12988.740225195632;23140.884295578413;23256.3023109307;23276.883615581814;23644.52710945806;23675.289741307788;9058.184763371328;9338.299627527827;9368.250539956787;9430.528473576294;9556.856647150298;5112.207607820719;5133.255677926754;5168.793248270027;5332.9733351333;5403.351597808288;3743.1765011697926;3858.7105967052585;3862.9570016095495;3865.845366185321;3868.2843673920415;617.8795134948732;618.3229363846581;634.3814780588981;637.445422482434;640.8077576726963;658.6443320606819;660.2044536333707;740.899978502906;768.1857231334803;784.0278055211496;10309.432981185957;10527.263091583669;10614.25700200994;10682.359058456517;11008.724781880517;677.9932200678029;707.5895980331395;776.5185584937375;796.494226166377;805.806606414468;5133.871653208625;5195.7142357170715;5233.685978841206;5235.712035838065;5268.341457317835;75218.62390688012;75797.6210118957;104650;133642;135869.32065339808;91141;104995;105705.47147264215;106179.469102654;107399;90537;91393;91444.5427772857;92293.5385323069;96028.0397196033;10804.24370294072;11265.887341126483;11343.886561134283;11364.94317528407;11515.424228788695;50827.49172508228;53424;54046;54194;55148.448515515935;71742.64128679532;82735.586322068;83642;83663.16336836554;84667.57666211629;14076.859231407554;14233.359498822785;14257.42970281177;14481.493147739779;14622.268886555843;16026.919865401065;16242.837571624605;16477.505674829776;16931.407400740914;16968.321267149175;15021.849781502046;15114.319855606303;15269.694606108038;16343.427980020642;16696.66606667884;14840.62898427548;15013.699726005638;15171.924140379228;15315.846841531442;15918.204089795232;15199.468018619295;15324.846751532343;15356.232188390759;15588.220588970733;15651.29569169413;12102.636920892388;12306.200096993667;12663.556775512812;12666.746665066832;12981;12402;12407.193532420724;12440.315782632042;12621.432035558606;12645.367731613567 01:43:21 INFO - PROCESS | 3495 | __end_tp_report 01:43:21 INFO - PROCESS | 3495 | __start_cc_report 01:43:21 INFO - PROCESS | 3495 | _x_x_mozilla_cycle_collect,1243 01:43:21 INFO - PROCESS | 3495 | __end_cc_report 01:43:21 INFO - PROCESS | 3495 | __startTimestamp1484559801086__endTimestamp 01:43:21 INFO - PROCESS | 3495 | 01:43:21 INFO - PROCESS | 3495 | ------- Summary: start ------- 01:43:21 INFO - PROCESS | 3495 | Number of tests: 6 01:43:21 INFO - PROCESS | 3495 | 01:43:21 INFO - PROCESS | 3495 | [#0] dojo.html Cycles:165 Average:5558.63 Median:5757.37 stddev:639.83 (11.1%) stddev-sans-first:612.02 01:43:21 INFO - PROCESS | 3495 | Values: 3099.5 3125.3 3132.3 3169.1 3186.2 5556.3 5643.4 5646.5 5647.7 5671.3 5591.7 5641.7 5644.5 5649.6 5653.2 5088.2 5103.1 5126.9 5136.3 5165.0 4982.4 5003.4 5131.7 5163.6 5186.9 5045.6 5053.6 5071.3 5118.3 5124.5 5128.9 5211.9 5217.3 5228.5 5252.8 4855.2 5108.0 5128.6 5139.8 5168.0 5455.3 5457.2 5474.9 5498.0 5570.8 5869.4 5902.7 5972.2 5989.1 5998.0 5833.4 6005.7 6012.3 6020.2 6024.2 5418.7 5465.4 5546.1 5577.7 5669.2 6151.8 6167.3 6170.2 6179.9 6186.6 5895.0 5914.1 5922.5 5933.4 5949.4 5731.3 5784.5 5898.9 5975.2 5984.3 6042.2 6043.0 6045.5 6045.7 6077.1 5963.3 5991.2 6040.8 6060.8 6063.8 4482.8 4483.4 4528.6 4546.2 4626.6 4070.7 4088.0 4091.4 4110.9 4115.0 5734.0 5740.2 5744.1 5746.1 5749.5 5809.2 5889.2 5937.4 5966.2 6063.9 5706.9 5715.7 5724.9 5757.4 5761.1 5199.9 5202.6 5208.6 5212.9 5214.3 5909.3 6023.9 6172.6 6179.4 6193.1 5960.8 5996.7 6035.2 6114.9 6116.6 6213.9 6214.8 6218.8 6224.0 6234.8 5886.4 5890.2 5934.1 5940.8 5984.3 5772.6 5817.8 5893.9 5894.8 6077.1 5859.5 5864.0 5880.6 5904.5 5907.4 5824.7 5827.0 5839.3 5839.4 5851.6 5635.4 5698.2 5717.4 5762.8 5783.3 5856.1 5949.3 5950.5 5961.2 5990.6 5517.4 5636.1 5661.5 5674.5 5677.5 01:43:21 INFO - PROCESS | 3495 | 01:43:21 INFO - PROCESS | 3495 | [#1] ext.html Cycles:180 Average:59663.38 Median:39196.51 stddev:115142.04 (293.8%) stddev-sans-first:115379.57 01:43:21 INFO - PROCESS | 3495 | Values: 570.5 640.8 649.5 661.6 666.0 34811.7 35025.8 44977.8 46199.8 46331.5 42783.8 47475.0 47502.0 47562.0 47574.0 9249.5 9404.3 9406.0 9412.9 9413.2 8586.7 8820.5 11141.7 11417.3 11430.1 11362.4 11445.1 11447.5 11452.7 11460.5 11136.7 11224.7 11239.5 11240.6 11245.0 10897.9 11001.6 11004.2 11004.9 11010.1 44841.0 45064.8 45089.8 45126.3 45129.3 3803.1 3807.0 3856.8 3906.9 4002.7 33965.3 34179.3 34543.1 35700.6 35755.8 4625.4 4696.3 4710.7 4712.5 4802.4 328671.0 328954.0 329440.0 329565.4 329628.0 37998.8 39144.8 39248.2 59973.0 60624.0 40725.2 40788.4 40835.0 40919.8 40936.4 15141.1 15203.5 15251.8 15258.1 15278.8 11564.9 11825.2 12478.9 12540.3 12552.2 9145.8 9166.5 9558.6 9571.9 9682.8 3632.8 3638.1 3647.8 3677.7 3689.5 1074.2 1130.3 1185.1 1215.6 1232.6 33877.3 34626.3 34878.5 34980.3 35284.0 1133.5 1179.8 1297.9 1312.9 1331.1 18300.9 18399.9 18469.8 18565.6 18566.5 504938.0 511257.0 511919.0 512965.0 513779.0 62820.4 63260.7 63278.4 63280.7 63336.0 1285.6 1319.3 1438.0 1518.9 1603.7 31218.0 35838.6 36035.8 36494.0 36506.3 52800.2 54176.5 54235.5 54277.5 54278.2 434296.0 441834.0 441912.0 442959.0 466925.0 39279.8 45608.8 45920.0 46305.0 49061.8 51269.2 51868.5 51892.7 52228.5 52893.0 42253.4 42550.4 42735.6 43092.4 43897.6 42006.0 42315.4 42734.4 43565.1 43710.8 42914.0 43260.6 44152.6 44678.1 44768.6 34981.7 35784.8 36934.6 37895.8 37950.8 29631.9 29689.3 29758.4 29825.9 30000.8 01:43:21 INFO - PROCESS | 3495 | 01:43:21 INFO - PROCESS | 3495 | [#2] jquery.html Cycles:180 Average:31425.47 Median:11861.75 stddev:89234.08 (752.3%) stddev-sans-first:89454.03 01:43:21 INFO - PROCESS | 3495 | Values: 417.8 417.9 424.3 424.8 447.6 19002.7 19293.9 20521.4 20650.3 20656.8 17790.6 19568.5 20034.4 20271.3 20402.4 5891.4 6149.4 6155.5 6157.0 6192.0 5856.3 6022.6 6110.4 6123.7 6126.1 6223.3 6223.7 6227.0 6231.4 6235.5 6198.5 6229.8 6531.2 6556.3 6570.2 5778.2 5932.6 5938.0 5942.6 5943.8 15096.5 15466.0 15469.1 15488.5 19243.3 2422.7 2498.9 2525.4 2652.2 2695.5 11667.2 15232.8 15473.6 15723.9 16003.4 1936.9 1958.6 1974.5 2048.0 2104.3 87920.6 89277.0 89724.0 90490.5 91542.1 11751.8 11808.2 12044.8 12066.0 12162.3 17395.9 17420.2 17432.6 17436.0 17474.3 8138.4 8155.8 8172.1 8335.4 8399.5 7690.9 7720.8 7751.6 7911.1 8021.2 5137.5 5141.7 5146.8 5318.3 5330.1 2035.8 2144.4 2166.5 2186.9 2199.1 975.1 1019.7 1042.9 1048.7 1091.2 19610.7 21178.4 21280.7 21380.6 21557.0 1033.1 1049.3 1056.6 1069.1 1084.9 11398.9 11856.3 11967.7 12101.2 12176.5 535848.0 538354.0 541925.0 542726.0 546509.0 97929.5 99257.0 100075.8 100792.5 102122.0 964.7 998.2 1005.1 1017.5 1037.2 18488.4 18688.2 18890.3 19130.5 19298.2 45587.8 45727.0 46085.8 46722.8 46836.8 57711.0 60168.0 60470.7 62318.7 62924.7 6716.5 8837.8 9251.4 9459.1 9571.2 10759.7 13716.6 14041.2 14052.0 14150.2 11808.6 11939.7 12118.5 12361.4 12570.3 11788.8 12017.2 12255.6 12311.8 12703.0 11889.5 12229.6 12255.9 12451.4 12726.7 9167.2 9229.5 9339.2 9357.6 9499.4 9302.4 11390.9 11621.3 12001.3 12499.8 01:43:21 INFO - PROCESS | 3495 | 01:43:21 INFO - PROCESS | 3495 | [#3] mootools.html Cycles:180 Average:6259.45 Median:4647.51 stddev:3613.14 (77.7%) stddev-sans-first:3604.78 01:43:21 INFO - PROCESS | 3495 | Values: 1395.2 1499.6 1527.1 1692.2 1848.3 7698.1 9121.5 9500.0 9517.0 9769.5 9462.7 9527.1 9531.8 9535.3 9540.7 2330.2 2353.5 2355.4 2356.2 2359.0 2304.4 2316.7 2364.1 2365.7 2369.8 2352.2 2365.2 2370.9 2376.8 2396.6 2298.0 2321.7 2323.2 2328.1 2329.8 2344.8 2350.2 2350.9 2352.0 2355.0 9292.3 9366.9 9400.0 9463.9 9477.7 5490.5 5628.6 5665.3 5690.5 5695.2 3755.3 3800.8 3839.3 3853.2 3883.7 1231.8 1233.0 1249.9 1253.8 1292.2 13605.2 13681.7 13696.9 13734.5 13754.0 4854.8 4858.3 4946.6 5014.2 5029.8 10620.6 10656.2 10658.0 10663.4 10666.7 5721.3 5722.7 5728.3 5729.3 5731.3 4419.5 4455.4 4465.7 4623.1 5344.7 4036.0 4139.0 4177.8 4192.6 4197.5 1234.4 1245.9 1247.4 1254.5 1276.2 963.5 998.8 1013.0 1013.1 1018.7 6468.2 6605.8 6618.1 6673.8 6765.1 979.6 1001.7 1003.1 1028.5 1055.3 4454.5 4617.4 4671.9 4714.6 4834.5 12137.3 12161.5 12287.9 12311.6 12318.7 11249.8 11847.5 11852.9 12147.5 12177.3 8761.8 8848.2 8862.7 8864.5 8948.7 6468.6 6563.4 6573.6 6656.6 6701.5 10354.3 10701.1 10923.3 10981.1 11200.2 9033.9 9128.7 11168.9 11369.8 11538.1 8391.0 8733.4 8857.3 8863.4 8874.3 9320.7 9321.1 9349.7 9390.4 9422.4 8392.2 8493.6 8547.1 8609.9 8821.4 7999.1 8100.8 8169.2 8328.3 8562.0 7475.3 7526.4 7733.1 7857.4 7864.4 5549.3 5604.1 5757.3 5780.6 5787.1 5570.4 5687.1 5772.0 5839.3 5906.5 01:43:21 INFO - PROCESS | 3495 | 01:43:21 INFO - PROCESS | 3495 | [#4] prototype.html Cycles:180 Average:4901.56 Median:5593.75 stddev:1427.64 (25.5%) stddev-sans-first:1390.27 01:43:21 INFO - PROCESS | 3495 | Values: 355.5 355.9 356.7 361.8 363.5 5605.9 5622.7 5667.3 5673.8 5695.6 5523.4 5556.9 5568.9 5615.6 5639.4 4151.6 4346.7 4353.2 4363.3 4363.6 4311.2 4322.4 4337.8 4339.5 4342.8 4276.8 4297.6 4305.4 4318.9 4366.8 4212.3 4300.8 4311.6 4311.8 4378.8 3798.5 3801.9 3807.5 3821.9 3824.1 5426.6 5441.7 5455.7 5473.0 5480.8 4723.7 4895.3 4956.1 4963.7 4999.5 5700.4 5734.4 5738.5 5753.9 5801.8 4182.8 4197.9 4205.5 4234.4 4240.6 5861.6 5922.7 5997.6 6056.6 6096.0 4275.5 4292.7 4292.9 4299.4 4347.2 4396.0 4403.5 4403.6 4406.4 4407.6 4666.6 4939.7 4941.9 4986.4 5012.4 5727.6 5795.6 5804.1 5824.6 5836.2 1481.4 1516.8 1519.0 1520.5 1523.9 974.0 989.6 1035.4 1094.3 1111.9 5493.9 5493.9 5532.8 5539.6 5558.7 5874.9 5885.5 5909.0 5916.0 5920.3 5372.2 5553.9 5661.6 5729.7 5738.4 3153.7 3160.3 3170.2 3191.6 3192.5 5908.4 6144.4 6179.0 6208.4 6211.3 5811.4 6091.0 6128.2 6158.2 6170.8 5986.9 6039.4 6156.9 6162.7 6167.7 5976.6 5980.9 5987.9 6011.8 6026.9 5563.7 5648.5 5835.4 5870.8 5920.4 6148.7 6182.8 6184.1 6189.3 6216.6 4056.5 4237.5 4283.4 4339.2 4354.5 5843.6 5850.8 5944.4 5946.9 5967.7 5746.6 5759.6 5761.4 5788.9 5808.9 5597.9 5823.2 5840.3 5842.6 5851.1 5827.6 5828.9 5831.9 5838.4 5839.3 5700.8 5887.6 5897.5 5914.7 5924.8 5570.7 5589.6 5642.3 5660.9 5666.5 01:43:21 INFO - PROCESS | 3495 | 01:43:21 INFO - PROCESS | 3495 | [#5] yui.html Cycles:180 Average:22425.11 Median:3867.06 stddev:31528.84 (815.3%) stddev-sans-first:31575.62 01:43:21 INFO - PROCESS | 3495 | Values: 839.6 857.8 873.4 896.4 902.4 16803.6 17713.8 17835.5 17844.9 17976.6 16128.6 16253.6 16260.8 16468.3 16927.8 726.9 862.9 882.4 883.5 883.8 740.7 840.0 863.7 868.8 874.4 933.7 934.9 935.2 935.5 935.7 934.0 934.2 934.6 935.2 935.2 685.3 685.4 685.5 685.6 686.1 16526.1 16586.2 16652.5 16690.9 16699.2 14620.8 15174.2 15223.2 16038.4 16046.4 13598.5 13674.3 14075.4 14143.2 14392.9 4101.7 4179.9 4182.1 4217.1 4281.1 94325.0 94769.0 95548.5 99017.0 99285.0 12564.9 12685.2 12764.3 12790.7 12988.7 23140.9 23256.3 23276.9 23644.5 23675.3 9058.2 9338.3 9368.3 9430.5 9556.9 5112.2 5133.3 5168.8 5333.0 5403.4 3743.2 3858.7 3863.0 3865.8 3868.3 617.9 618.3 634.4 637.4 640.8 658.6 660.2 740.9 768.2 784.0 10309.4 10527.3 10614.3 10682.4 11008.7 678.0 707.6 776.5 796.5 805.8 5133.9 5195.7 5233.7 5235.7 5268.3 75218.6 75797.6 104650.0 133642.0 135869.3 91141.0 104995.0 105705.5 106179.5 107399.0 90537.0 91393.0 91444.5 92293.5 96028.0 10804.2 11265.9 11343.9 11364.9 11515.4 50827.5 53424.0 54046.0 54194.0 55148.4 71742.6 82735.6 83642.0 83663.2 84667.6 14076.9 14233.4 14257.4 14481.5 14622.3 16026.9 16242.8 16477.5 16931.4 16968.3 15021.8 15114.3 15269.7 16343.4 16696.7 14840.6 15013.7 15171.9 15315.8 15918.2 15199.5 15324.8 15356.2 15588.2 15651.3 12102.6 12306.2 12663.6 12666.7 12981.0 12402.0 12407.2 12440.3 12621.4 12645.4 01:43:21 INFO - PROCESS | 3495 | -------- Summary: end -------- 01:43:21 INFO - PROCESS | 3495 | 01:43:21 INFO - TEST-INFO | 3495: exit 0 01:43:21 INFO - TEST-OK | dromaeo_css | took 1112848ms 01:43:21 INFO - TEST-START | kraken 01:43:21 INFO - operating with platform_type : linux_ 01:43:21 INFO - Initialising browser for kraken test... 01:43:21 INFO - TEST-INFO | started process 3796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzRCyBY/profile http://localhost:52256/getInfo.html) 01:43:25 INFO - PROCESS | 3796 | __metrics Screen width/height:1600/1200 01:43:25 INFO - PROCESS | 3796 | colorDepth:24 01:43:25 INFO - PROCESS | 3796 | Browser inner width/height: 1024/697 01:43:25 INFO - PROCESS | 3796 | __metrics 01:43:26 INFO - PROCESS | 3796 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:43:26 INFO - PROCESS | 3796 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:43:26 INFO - PROCESS | 3796 | console.error: PushService: 01:43:26 INFO - PROCESS | 3796 | stateChangeProcessEnqueue: Error transitioning state 01:43:26 INFO - PROCESS | 3796 | UnknownError 01:43:26 INFO - TEST-INFO | 3796: exit 0 01:43:26 INFO - Browser initialized. 01:43:26 INFO - Running cycle 1/1 for kraken test... 01:43:26 INFO - TEST-INFO | started process 3891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzRCyBY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:43:38 INFO - PROCESS | 3891 | RSS: Main: 143446016 01:43:38 INFO - PROCESS | 3891 | 01:43:41 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52256/tests/kraken/driver.html?testName=audio-beat-detection) 01:43:42 INFO - PROCESS | 3891 | RSS: Main: 187187200 01:43:42 INFO - PROCESS | 3891 | 01:43:44 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52256/tests/kraken/driver.html?testName=audio-dft) 01:43:45 INFO - PROCESS | 3891 | RSS: Main: 174583808 01:43:45 INFO - PROCESS | 3891 | 01:43:47 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52256/tests/kraken/driver.html?testName=audio-fft) 01:43:48 INFO - PROCESS | 3891 | RSS: Main: 265838592 01:43:48 INFO - PROCESS | 3891 | 01:43:50 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52256/tests/kraken/driver.html?testName=audio-oscillator) 01:43:51 INFO - PROCESS | 3891 | RSS: Main: 172638208 01:43:51 INFO - PROCESS | 3891 | 01:43:53 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52256/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:43:53 INFO - PROCESS | 3891 | RSS: Main: 173887488 01:43:53 INFO - PROCESS | 3891 | 01:43:56 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52256/tests/kraken/driver.html?testName=imaging-darkroom) 01:43:57 INFO - PROCESS | 3891 | RSS: Main: 210214912 01:43:57 INFO - PROCESS | 3891 | 01:44:00 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52256/tests/kraken/driver.html?testName=imaging-desaturate) 01:44:01 INFO - PROCESS | 3891 | RSS: Main: 209170432 01:44:01 INFO - PROCESS | 3891 | 01:44:04 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52256/tests/kraken/driver.html?testName=json-parse-financial) 01:44:04 INFO - PROCESS | 3891 | RSS: Main: 208654336 01:44:04 INFO - PROCESS | 3891 | 01:44:06 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52256/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:44:06 INFO - PROCESS | 3891 | RSS: Main: 171008000 01:44:06 INFO - PROCESS | 3891 | 01:44:08 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52256/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:44:09 INFO - PROCESS | 3891 | RSS: Main: 177504256 01:44:09 INFO - PROCESS | 3891 | 01:44:11 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52256/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:44:11 INFO - PROCESS | 3891 | RSS: Main: 187666432 01:44:11 INFO - PROCESS | 3891 | 01:44:14 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:44:14 INFO - PROCESS | 3891 | RSS: Main: 196866048 01:44:14 INFO - PROCESS | 3891 | 01:44:17 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:44:18 INFO - PROCESS | 3891 | RSS: Main: 193318912 01:44:18 INFO - PROCESS | 3891 | 01:44:19 INFO - PROCESS | 3891 | Cycle 1(1): loaded http://localhost:52256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52256/tests/kraken/driver.html?testName=ai-astar) 01:44:20 INFO - PROCESS | 3891 | RSS: Main: 244162560 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | __start_tp_report 01:44:20 INFO - PROCESS | 3891 | _x_x_mozilla_page_load 01:44:20 INFO - PROCESS | 3891 | _x_x_mozilla_page_load_details 01:44:20 INFO - PROCESS | 3891 | |i|pagename|runs| 01:44:20 INFO - PROCESS | 3891 | |0;ai-astar;112;110;110;110;109;110;110;109;110;109 01:44:20 INFO - PROCESS | 3891 | |1;audio-beat-detection;156;119;119;149;121;117;118;123;153;116 01:44:20 INFO - PROCESS | 3891 | |2;audio-dft;160;161;161;160;160;162;161;159;160;161 01:44:20 INFO - PROCESS | 3891 | |3;audio-fft;75;75;75;108;76;75;76;75;99;75 01:44:20 INFO - PROCESS | 3891 | |4;audio-oscillator;81;81;117;81;81;81;98;80;80;106 01:44:20 INFO - PROCESS | 3891 | |5;imaging-gaussian-blur;116;117;117;117;117;118;117;116;117;117 01:44:20 INFO - PROCESS | 3891 | |6;imaging-darkroom;146;146;146;146;146;146;145;146;145;146 01:44:20 INFO - PROCESS | 3891 | |7;imaging-desaturate;96;94;95;96;95;95;95;94;96;94 01:44:20 INFO - PROCESS | 3891 | |8;json-parse-financial;51;51;56;48;49;48;49;49;49;55 01:44:20 INFO - PROCESS | 3891 | |9;json-stringify-tinderbox;58;59;58;58;58;58;58;58;58;59 01:44:20 INFO - PROCESS | 3891 | |10;stanford-crypto-aes;81;76;74;73;74;76;78;73;78;72 01:44:20 INFO - PROCESS | 3891 | |11;stanford-crypto-ccm;123;129;129;135;128;123;126;121;170;138 01:44:20 INFO - PROCESS | 3891 | |12;stanford-crypto-pbkdf2;156;153;153;156;153;155;153;157;152;152 01:44:20 INFO - PROCESS | 3891 | |13;stanford-crypto-sha256-iterative;62;65;64;61;64;62;62;62;61;64 01:44:20 INFO - PROCESS | 3891 | __end_tp_report 01:44:20 INFO - PROCESS | 3891 | __start_cc_report 01:44:20 INFO - PROCESS | 3891 | _x_x_mozilla_cycle_collect,1592 01:44:20 INFO - PROCESS | 3891 | __end_cc_report 01:44:20 INFO - PROCESS | 3891 | __startTimestamp1484559860012__endTimestamp 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | ------- Summary: start ------- 01:44:20 INFO - PROCESS | 3891 | Number of tests: 14 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:0.88 (0.8%) stddev-sans-first:0.50 01:44:20 INFO - PROCESS | 3891 | Values: 112.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:122.00 stddev:16.46 (13.5%) stddev-sans-first:14.30 01:44:20 INFO - PROCESS | 3891 | Values: 156.0 119.0 119.0 149.0 121.0 117.0 118.0 123.0 153.0 116.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 01:44:20 INFO - PROCESS | 3891 | Values: 160.0 161.0 161.0 160.0 160.0 162.0 161.0 159.0 160.0 161.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:12.11 (16.1%) stddev-sans-first:12.65 01:44:20 INFO - PROCESS | 3891 | Values: 75.0 75.0 75.0 108.0 76.0 75.0 76.0 75.0 99.0 75.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:81.00 stddev:13.48 (16.6%) stddev-sans-first:14.01 01:44:20 INFO - PROCESS | 3891 | Values: 81.0 81.0 117.0 81.0 81.0 81.0 98.0 80.0 80.0 106.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 01:44:20 INFO - PROCESS | 3891 | Values: 116.0 117.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 117.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 01:44:20 INFO - PROCESS | 3891 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 01:44:20 INFO - PROCESS | 3891 | Values: 96.0 94.0 95.0 96.0 95.0 95.0 95.0 94.0 96.0 94.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.00 stddev:2.84 (5.7%) stddev-sans-first:3.00 01:44:20 INFO - PROCESS | 3891 | Values: 51.0 51.0 56.0 48.0 49.0 48.0 49.0 49.0 49.0 55.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 01:44:20 INFO - PROCESS | 3891 | Values: 58.0 59.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 59.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:76.00 stddev:2.84 (3.7%) stddev-sans-first:2.20 01:44:20 INFO - PROCESS | 3891 | Values: 81.0 76.0 74.0 73.0 74.0 76.0 78.0 73.0 78.0 72.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:129.00 stddev:14.30 (11.1%) stddev-sans-first:14.78 01:44:20 INFO - PROCESS | 3891 | Values: 123.0 129.0 129.0 135.0 128.0 123.0 126.0 121.0 170.0 138.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:154.00 stddev:1.83 (1.2%) stddev-sans-first:1.79 01:44:20 INFO - PROCESS | 3891 | Values: 156.0 153.0 153.0 156.0 153.0 155.0 153.0 157.0 152.0 152.0 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - PROCESS | 3891 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.42 (2.3%) stddev-sans-first:1.48 01:44:20 INFO - PROCESS | 3891 | Values: 62.0 65.0 64.0 61.0 64.0 62.0 62.0 62.0 61.0 64.0 01:44:20 INFO - PROCESS | 3891 | -------- Summary: end -------- 01:44:20 INFO - PROCESS | 3891 | 01:44:20 INFO - TEST-INFO | 3891: exit 0 01:44:20 INFO - TEST-OK | kraken | took 59192ms 01:44:20 INFO - SUITE-END | took 1172s 01:44:21 INFO - Completed test suite (00:19:32) 01:44:21 INFO - javascript benchmark 01:44:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.5195744659577, 3125.32805446829, 3132.279575697591, 3169.112648458431, 3186.203449137716, 5556.333240011194, 5643.435656434354, 5646.548276137909, 5647.661140331583, 5671.319441667, 5591.692456914868, 5641.661500309984, 5644.520215781664, 5649.604527683064, 5653.1520271959225, 5088.211327244265, 5103.132467480537, 5126.948730512703, 5136.306598609196, 5164.974175129119, 4982.427020892589, 5003.374578177728, 5131.717755523445, 5163.612729045318, 5186.92219616706, 5045.596352291808, 5053.570446512051, 5071.31537242473, 5118.33461649985, 5124.538791508763, 5128.871778205556, 5211.921821172686, 5217.34783152106, 5228.503292187236, 5252.842414727565, 4855.223164293696, 5108.0, 5128.5640720538795, 5139.794408223666, 5167.974160129213, 5455.318085239345, 5457.181422786574, 5474.91787623186, 5498.0, 5570.777168913239, 5869.383714709937, 5902.704864756745, 5972.193753843219, 5989.101634754822, 5998.040313549855, 5833.358330583633, 6005.729742161569, 6012.338642749294, 6020.157177995085, 6024.1566180734735, 5418.7019713915715, 5465.398806131283, 5546.084895992157, 5577.665340079527, 5669.206311116447, 6151.815445536641, 6167.259928808572, 6170.228721409824, 6179.876402471926, 6186.566940314135, 5894.970525147347, 5914.053751399755, 5922.49658779, 5933.376995415506, 5949.375315591887, 5731.312242530839, 5784.4504772046585, 5898.911516327258, 5975.163477113208, 5984.3417224105315, 6042.154098426224, 6043.002904520705, 6045.546584006129, 6045.667488288098, 6077.1491991121275, 5963.254593175853, 5991.221141251696, 6040.818775436744, 6060.848478788065, 6063.818085457443, 4482.7534485602955, 4483.417155769729, 4528.637708983273, 4546.158960592301, 4626.629869610423, 4070.6946978976102, 4088.0, 4091.365838295069, 4110.938335924963, 4114.958850411517, 5733.971330143323, 5740.196372507852, 5744.080947048452, 5746.051901436216, 5749.482546570745, 5809.186713860063, 5889.1755154278435, 5937.435943585352, 5966.194563733927, 6063.897095088379, 5706.9429305707245, 5715.657060576379, 5724.885502290014, 5757.366689664133, 5761.107028410603, 5199.948000520022, 5202.557782588447, 5208.583313334924, 5212.8957420851375, 5214.270002199695, 5909.2908850938165, 6023.879522409615, 6172.629642221391, 6179.3820617938745, 6193.071039344134, 5960.821175364746, 5996.67018313997, 6035.18524999137, 6114.938850611437, 6116.602420842631, 6213.937860621336, 6214.8135555933395, 6218.782342617987, 6223.96888015557, 6234.844128896814, 5886.440788125121, 5890.204822349099, 5934.139549765174, 5940.821775346573, 5984.341722410619, 5772.624779389326, 5817.76728930838, 5893.9115913260475, 5894.823155305347, 6077.149199112039, 5859.5019423349495, 5864.0, 5880.647161170344, 5904.498117660047, 5907.350191478848, 5824.679642619697, 5827.038538641077, 5839.270091238595, 5839.386864379179, 5851.64890106595, 5635.380108188178, 5698.202251684685, 5717.42825717425, 5762.7694892203845, 5783.277090363705, 5856.0630299151935, 5949.25634295713, 5950.5239580834295, 5961.195238642727, 5990.580659353804, 5517.393086760533, 5636.070048441961, 5661.518770904519, 5674.460926212003, 5677.489025987681], "value": 5514.162754411914, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5264630356804, 640.7757284950267, 649.5388274325229, 661.642712935015, 666.0043235363133, 34811.65188348116, 35025.82487087567, 44977.77511112448, 46199.76900115503, 46331.536684633145, 42783.78608106955, 47475.0, 47502.0, 47562.0, 47574.0, 9249.537523123834, 9404.341696081243, 9406.0, 9412.858807117898, 9413.152816246537, 8586.742397728078, 8820.514871682055, 11141.665750027472, 11417.25787823793, 11430.085593152528, 11362.37506937118, 11445.084393248562, 11447.484863181135, 11452.71368215793, 11460.541578336857, 11136.719277283095, 11224.719382015515, 11239.494222759955, 11240.606578769786, 11245.0, 10897.891021089767, 11001.61494347694, 11004.229703920728, 11004.889951100467, 11010.064144547723, 44841.0, 45064.774676126406, 45089.77455112736, 45126.323105153446, 45129.32306015412, 3803.069563484148, 3806.980965095157, 3856.7878766667823, 3906.941395879064, 4002.663142309176, 33965.32069358624, 34179.31641367183, 34543.13642158941, 35700.64299356999, 35755.821220893726, 4625.444946606395, 4696.342512048316, 4710.693804902705, 4712.4816270210595, 4802.375691160162, 328671.0, 328954.0, 329440.0, 329565.35217324, 329628.0, 37998.810005949796, 39144.804275979004, 39248.215035699126, 59973.0, 60624.0, 40725.1854962905, 40788.38817417741, 40835.0, 40919.795401022806, 40936.38595421071, 15141.091534507965, 15203.543893683207, 15251.847481525043, 15258.08451492914, 15278.847211527966, 11564.884351156548, 11825.172237943261, 12478.937605311916, 12540.310282934526, 12552.184108032949, 9145.77135571616, 9166.49584272858, 9558.617655293849, 9571.856422153673, 9682.75793105164, 3632.8183590820354, 3638.1268495560876, 3647.8176091195332, 3677.7057835373107, 3689.465027571041, 1074.167520171873, 1130.2879186112862, 1185.063799598325, 1215.6292330839003, 1232.580922486359, 33877.322453551285, 34626.30747385089, 34878.5408925645, 34980.321400600544, 35284.0, 1133.4955944604737, 1179.7699448607611, 1297.8767017133357, 1312.9212247265004, 1331.0749029424458, 18300.90849545744, 18399.908000459913, 18469.815301847077, 18565.628687426175, 18566.535836604195, 504938.0, 511257.0, 511919.0, 512965.0, 513779.0, 62820.371796282365, 63260.683696581225, 63278.36721632725, 63280.68359658172, 63336.0, 1285.5500574798746, 1319.2743990805018, 1438.022144941429, 1518.9392424302905, 1603.6552141289678, 31218.0, 35838.64161358457, 36035.81982090178, 36494.0, 36506.26987460183, 52800.20799688085, 54176.45823541714, 54235.45764542304, 54277.45722542724, 54278.18582721341, 434296.0, 441834.0, 441912.0, 442959.0, 466925.0, 39279.80360098295, 45608.77195614001, 45920.0, 46305.0, 49061.75469122631, 51269.230961534864, 51868.48131518788, 51892.740536297075, 52228.47771522236, 52893.0, 42253.36619950642, 42550.361744574475, 42735.6495392744, 43092.35361469518, 43897.561024389346, 42006.0, 42315.365269520364, 42734.358984614635, 43565.12869742651, 43710.781446092566, 42914.0, 43260.567394325655, 44152.558474414844, 44678.10643787041, 44768.55231447644, 34981.65018349784, 35784.821075894455, 36934.63065369312, 37895.81052094722, 37950.810245948596, 29631.85184074066, 29689.25776855596, 29758.378101179344, 29825.850870745508, 30000.849995749883], "value": 20437.289215843357, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.79945626099493, 417.86628278950747, 424.3189680562697, 424.79609787302087, 447.55915423308033, 19002.71495927562, 19293.903530482345, 20521.384358469233, 20650.277240296593, 20656.793432065675, 17790.644187116282, 19568.510787230327, 20034.398968030946, 20271.290504832334, 20402.38792836217, 5891.351951285355, 6149.354317796634, 6155.507559395238, 6157.0, 6192.0, 5856.297244330686, 6022.578419510636, 6110.388961103877, 6123.693815309217, 6126.142340072372, 6223.2532096148525, 6223.719932603044, 6227.034809604518, 6231.40801623845, 6235.532335074865, 6198.4731297839735, 6229.813105606839, 6531.24890637578, 6556.344365563453, 6570.244421891496, 5778.219940308089, 5932.614380065282, 5937.990541607937, 5942.613730107572, 5943.791967281124, 15096.471623493126, 15466.0, 15469.071855688695, 15488.535343939588, 19243.326483573146, 2422.7092748870073, 2498.8625625590585, 2525.368657835541, 2652.204338698383, 2695.4743824954144, 11667.183297169202, 15232.771508427382, 15473.613159670986, 15723.92138039314, 16003.359865605362, 1936.9031548422663, 1958.608278344337, 1974.5458544534695, 2048.037422411479, 2104.316097268394, 87920.56039719825, 89277.0, 89724.0, 90490.5475472625, 91542.08457915402, 11751.764964700658, 11808.225067109222, 12044.759104817855, 12066.0, 12162.270263784201, 17395.91302043507, 17420.216090275968, 17432.5641858952, 17436.0, 17474.30102795874, 8138.419095598037, 8155.79610509742, 8172.141925097779, 8335.374846886507, 8399.454035487674, 7690.923090769133, 7720.845583088307, 7751.573663448565, 7911.090224624127, 8021.157778433298, 5137.51193636604, 5141.665791723526, 5146.845594632167, 5318.335208098988, 5330.147176451749, 2035.7522159029063, 2144.431725592719, 2166.5017046079174, 2186.9453263668534, 2199.1093607089156, 975.1223898491272, 1019.7144799456164, 1042.9061384475283, 1048.66442738323, 1091.2143256855052, 19610.70583941242, 21178.364649060553, 21280.680789788166, 21380.623684828708, 21557.0, 1033.1012019542895, 1049.2602715085998, 1056.6460235820932, 1069.0645685025602, 1084.9132069434427, 11398.943005285086, 11856.288622682494, 11967.700807479883, 12101.213421127775, 12176.452059657337, 535848.0, 538354.0, 541925.0, 542726.0, 546509.0, 97929.51035244777, 99257.0, 100075.777970547, 100792.49603751935, 102122.0, 964.6671898195111, 998.2480746290214, 1005.0853723111933, 1017.4505766885947, 1037.206536999181, 18488.445346639623, 18688.159032843283, 18890.3388381406, 19130.521736956132, 19298.22807087701, 45587.77206113948, 45727.02774319659, 46085.769571151926, 46722.76638616785, 46836.7658161707, 57711.0, 60168.0, 60470.69764651325, 62318.688406557674, 62924.68537657282, 6716.529842910949, 8837.779055523662, 9251.352405331561, 9459.148676619137, 9571.18644915162, 10759.731006724895, 13716.588502344946, 14041.1575305482, 14052.0, 14150.150990940576, 11808.586699465477, 11939.701507462383, 12118.454669539715, 12361.443735032126, 12570.308633025272, 11788.764224715285, 12017.158798884344, 12255.571055013032, 12311.815322770344, 12703.0, 11889.46497407636, 12229.633111006684, 12255.877441225473, 12451.377431128227, 12726.68183295388, 9167.17495425415, 9229.538523073954, 9339.20616747557, 9357.578908948977, 9499.43003419797, 9302.441853488812, 11390.886091138982, 11621.302721836379, 12001.339926304137, 12499.750004999667], "value": 9771.933917691702, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.1838174667819, 1499.6026053095927, 1527.1066426140708, 1692.1708362902175, 1848.343837937533, 7698.114716807569, 9121.452712837226, 9500.049995000496, 9517.0, 9769.511524423786, 9462.716118516439, 9527.094925982037, 9531.80936381272, 9535.28485363597, 9540.713778586636, 2330.2310237621627, 2353.5292941411785, 2355.3640517060385, 2356.2460012795914, 2359.0210062823908, 2304.4008557774932, 2316.664083707861, 2364.0898254172093, 2365.66880636711, 2369.7511761265077, 2352.223766157164, 2365.207655435431, 2370.9170179043736, 2376.7504412036747, 2396.628522579003, 2297.977020229793, 2321.7330007049154, 2323.2101085630884, 2328.0571368595574, 2329.7903188712926, 2344.788968992782, 2350.21267875262, 2350.917717879883, 2352.023910077316, 2354.9646755298513, 9292.303077269233, 9366.859497107549, 9400.0, 9463.858042129374, 9477.668281610111, 5490.450954904478, 5628.605997580171, 5665.263515742969, 5690.5447564194765, 5695.202671625976, 3755.34281500739, 3800.7909564973916, 3839.308924393608, 3853.2486165197797, 3883.650471457582, 1231.846019247594, 1233.0135891286934, 1249.9312537810417, 1253.7713041219565, 1292.1536393662166, 13605.183688978594, 13681.726365472734, 13696.93151534246, 13734.45062197511, 13754.037217394687, 4854.781534830941, 4858.344123543347, 4946.604271658259, 5014.172661510883, 5029.7736601853, 10620.575176992834, 10656.200784941006, 10658.0, 10663.360198388122, 10666.73333166677, 5721.313442386857, 5722.713864306768, 5728.255326807488, 5729.312482502127, 5731.283589551306, 4419.535948725337, 4455.398521199661, 4465.709728867613, 4623.121606894747, 5344.706041167696, 4035.959640403617, 4138.979305103516, 4177.811998460076, 4192.622663960258, 4197.454330936958, 1234.4136535145733, 1245.8504979402348, 1247.3950134184913, 1254.5483625894672, 1276.1513593460245, 963.5326866469757, 998.7952469743685, 1012.9898701013043, 1013.0780989299702, 1018.6943916824923, 6468.223813142453, 6605.834854128685, 6618.073469714244, 6673.766418175341, 6765.05289259504, 979.5591983607405, 1001.6944831826218, 1003.1473247739364, 1028.5320179318392, 1055.2613170780485, 4454.487733910577, 4617.399738034034, 4671.906561868744, 4714.6464015199, 4834.468208497063, 12137.271763694207, 12161.452734626962, 12287.877121228852, 12311.56909508163, 12318.692032699255, 11249.775004499865, 11847.466863991142, 11852.94073529644, 12147.453364598614, 12177.330246836333, 8761.824763504694, 8848.247898928534, 8862.734117976472, 8864.512451815082, 8948.68679596211, 6468.579542329733, 6563.379023976486, 6573.638449885302, 6656.600603963778, 6701.53089283765, 10354.326968747007, 10701.090407315465, 10923.344599324066, 10981.121510279, 11200.159988001096, 9033.909660903308, 9128.726138215865, 11168.944155279172, 11369.772604548029, 11538.076953843505, 8391.0, 8733.432326898732, 8857.291416686521, 8863.379563430755, 8874.334424918286, 9320.673776417792, 9321.114494123047, 9349.672761453316, 9390.389624674373, 9422.387544809566, 8392.244697977212, 8493.57532123379, 8547.145285471652, 8609.870851937101, 8821.426607270507, 7999.120096789465, 8100.797480063045, 8169.183081691784, 8328.3337333012, 8561.957190214009, 7475.327220550176, 7526.435517336331, 7733.149353570991, 7857.371410287049, 7864.449488535747, 5549.278593782782, 5604.103343465026, 5757.251557297692, 5780.566457515619, 5787.102999035156, 5570.359408668055, 5687.146927960839, 5771.971140144273, 5839.328477225174, 5906.468417842415], "value": 4960.913729332255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.4951968205148, 355.8576569372252, 356.66829848241144, 361.8299399282336, 363.5110776006272, 5605.859853503659, 5622.746976386063, 5667.291588551431, 5673.829785106448, 5695.601307908448, 5523.392426833045, 5556.916646250299, 5568.916466253009, 5615.58529832172, 5639.407862174464, 4151.571330771502, 4346.695731298811, 4353.172897149531, 4363.258246098155, 4363.585459381354, 4311.1593239318345, 4322.394864718942, 4337.848175313865, 4339.457567804025, 4342.804573794171, 4276.759739675506, 4297.570242975708, 4305.354196870463, 4318.892027699317, 4366.8253269869165, 4212.262854000538, 4300.784960751981, 4311.590398912098, 4311.784410779448, 4378.8029538670835, 3798.4682144499793, 3801.8669346572738, 3807.4859893914245, 3821.8662346818005, 3824.0631045394057, 5426.593005524602, 5441.700706461143, 5455.727213639302, 5473.01485732568, 5480.835574932758, 4723.740194289313, 4895.339129217546, 4956.107900577895, 4963.652544321899, 4999.450060493343, 5700.37295897451, 5734.4265573442735, 5738.454846789548, 5753.913691294592, 5801.781625858533, 4182.790860456965, 4197.874063778061, 4205.453291072172, 4234.364845273234, 4240.618344349024, 5861.6189947653265, 5922.7038648067855, 5997.640141591475, 6056.606320589148, 6095.9695201524155, 4275.5296917339065, 4292.6995110342605, 4292.905309146147, 4299.355096735515, 4347.152305300499, 4395.978020109879, 4403.471583410012, 4403.647708183337, 4406.361077643724, 4407.559244075631, 4666.5533684557895, 4939.678351174942, 4941.901161976741, 4986.426560945465, 5012.448630650625, 5727.599068065196, 5795.594308398372, 5804.097951024488, 5824.563157763185, 5836.182934389189, 1481.4148411377446, 1516.8103987001625, 1518.9924050379898, 1520.5438368489408, 1523.916184609835, 973.9951300243454, 989.5645915797027, 1035.440861934562, 1094.272308914563, 1111.8943700348455, 5493.862653433616, 5493.862653433616, 5532.778688852401, 5539.584531160099, 5558.694271815089, 5874.941250587525, 5885.470307672244, 5909.0, 5916.018133925098, 5920.259967504062, 5372.247885296062, 5553.944460555343, 5661.556303142672, 5729.656220626775, 5738.397468265855, 3153.684631536828, 3160.340821068957, 3170.1757543038975, 3191.6010498687665, 3192.5051616999403, 5908.438698323653, 6144.38556144382, 6179.0, 6208.379162083846, 6211.3478084801345, 5811.360750317462, 6091.0, 6128.17269668598, 6158.199434073542, 6170.822026656276, 5986.940130598726, 6039.365866583946, 6156.860980718581, 6162.7226774795245, 6167.660778657128, 5976.641401515923, 5980.880382392241, 5987.880242395215, 6011.849703757441, 6026.879462410815, 5563.7496312666835, 5648.5481161507805, 5835.387284335084, 5870.765169393177, 5920.437558431942, 6148.661823599745, 6182.752689892354, 6184.134221208944, 6189.288231853215, 6216.564840461125, 4056.472658554369, 4237.491501019897, 4283.357496375568, 4339.175556644227, 4354.455693038371, 5843.561732870136, 5850.824475265749, 5944.4352786485215, 5946.881062378815, 5967.731452084753, 5746.626469279484, 5759.596828221985, 5761.366249712612, 5788.884222315614, 5808.854778630568, 5597.944020559742, 5823.155642431909, 5840.2991641003355, 5842.568570700206, 5851.132944857074, 5827.59206855516, 5828.854278643068, 5831.883362332815, 5838.357780644041, 5839.299284085937, 5700.800471983626, 5887.558433117448, 5897.5281977440845, 5914.674692891932, 5924.837434336522, 5570.721463926869, 5589.552835773047, 5642.266505354278, 5660.867826434647, 5666.490015898589], "value": 4453.421757119402, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.6095815445816, 857.7855536115967, 873.4191762477951, 896.3546246702372, 902.4359775140537, 16803.579910502227, 17713.82286177136, 17835.46493605194, 17844.910775446137, 17976.64046719065, 16128.596785080379, 16253.593660158502, 16260.75608865868, 16468.341266349362, 16927.83072169278, 726.920038795732, 862.9223369896723, 882.3602887906248, 883.4699180491685, 883.7923088074298, 740.7259314053807, 839.9706010289641, 863.7236084452977, 868.7958329792493, 874.4185116897256, 933.7478880702206, 934.9439033657968, 935.1817159985013, 935.4621092871593, 935.6912218967758, 934.028610245344, 934.1919239857542, 934.6448349627132, 935.1536859142487, 935.2144198872945, 685.3112621815044, 685.3694600967123, 685.540687739216, 685.6126288646948, 686.0977814174395, 16526.091064991422, 16586.1706914655, 16652.50042498727, 16690.915090519076, 16699.165041747863, 14620.780688289684, 15174.241287935669, 15223.162726050063, 16038.35846566136, 16046.438374656831, 13598.456061757517, 13674.31628418575, 14075.36660850254, 14143.151410915378, 14392.92803535986, 4101.692373072032, 4179.895502612459, 4182.079942412664, 4217.135487225111, 4281.100968796525, 94325.0, 94769.01293288307, 95548.52225738896, 99017.0, 99285.0, 12564.937175314248, 12685.23888566689, 12764.297963611905, 12790.68023299425, 12988.740225195632, 23140.884295578413, 23256.3023109307, 23276.883615581814, 23644.52710945806, 23675.289741307788, 9058.184763371328, 9338.299627527827, 9368.250539956787, 9430.528473576294, 9556.856647150298, 5112.207607820719, 5133.255677926754, 5168.793248270027, 5332.9733351333, 5403.351597808288, 3743.1765011697926, 3858.7105967052585, 3862.9570016095495, 3865.845366185321, 3868.2843673920415, 617.8795134948732, 618.3229363846581, 634.3814780588981, 637.445422482434, 640.8077576726963, 658.6443320606819, 660.2044536333707, 740.899978502906, 768.1857231334803, 784.0278055211496, 10309.432981185957, 10527.263091583669, 10614.25700200994, 10682.359058456517, 11008.724781880517, 677.9932200678029, 707.5895980331395, 776.5185584937375, 796.494226166377, 805.806606414468, 5133.871653208625, 5195.7142357170715, 5233.685978841206, 5235.712035838065, 5268.341457317835, 75218.62390688012, 75797.6210118957, 104650.0, 133642.0, 135869.32065339808, 91141.0, 104995.0, 105705.47147264215, 106179.469102654, 107399.0, 90537.0, 91393.0, 91444.5427772857, 92293.5385323069, 96028.0397196033, 10804.24370294072, 11265.887341126483, 11343.886561134283, 11364.94317528407, 11515.424228788695, 50827.49172508228, 53424.0, 54046.0, 54194.0, 55148.448515515935, 71742.64128679532, 82735.586322068, 83642.0, 83663.16336836554, 84667.57666211629, 14076.859231407554, 14233.359498822785, 14257.42970281177, 14481.493147739779, 14622.268886555843, 16026.919865401065, 16242.837571624605, 16477.505674829776, 16931.407400740914, 16968.321267149175, 15021.849781502046, 15114.319855606303, 15269.694606108038, 16343.427980020642, 16696.66606667884, 14840.62898427548, 15013.699726005638, 15171.924140379228, 15315.846841531442, 15918.204089795232, 15199.468018619295, 15324.846751532343, 15356.232188390759, 15588.220588970733, 15651.29569169413, 12102.636920892388, 12306.200096993667, 12663.556775512812, 12666.746665066832, 12981.0, 12402.0, 12407.193532420724, 12440.315782632042, 12621.432035558606, 12645.367731613567], "value": 8281.410763593003, "unit": "score"}], "name": "dromaeo_css", "value": 7656.803019327411, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 119.0, 119.0, 149.0, 121.0, 117.0, 118.0, 123.0, 153.0, 116.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 159.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 108.0, 76.0, 75.0, 76.0, 75.0, 99.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 117.0, 81.0, 81.0, 81.0, 98.0, 80.0, 80.0, 106.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 96.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 56.0, 48.0, 49.0, 48.0, 49.0, 49.0, 49.0, 55.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 74.0, 73.0, 74.0, 76.0, 78.0, 73.0, 78.0, 72.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 129.0, 129.0, 135.0, 128.0, 123.0, 126.0, 121.0, 170.0, 138.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 153.0, 156.0, 153.0, 155.0, 153.0, 157.0, 152.0, 152.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 64.0, 61.0, 64.0, 62.0, 62.0, 62.0, 61.0, 64.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1459.8000000000002, "alertThreshold": 2.0}]} 01:44:21 INFO - Return code: 0 01:44:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:44:21 INFO - # TBPL SUCCESS # 01:44:21 INFO - Running post-action listener: _resource_record_post_action 01:44:21 INFO - [mozharness: 2017-01-16 09:44:21.319538Z] Finished run-tests step (success) 01:44:21 INFO - Running post-run listener: _resource_record_post_run 01:44:21 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 308424704; Read time: 56; Write time: 242168 01:44:21 INFO - TinderboxPrint: CPU usage
12.9% 01:44:21 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 56 01:44:21 INFO - TinderboxPrint: I/O write bytes / time
308,424,704 / 242,168 01:44:21 INFO - TinderboxPrint: CPU idle
8,245.2 (87.1%) 01:44:21 INFO - TinderboxPrint: CPU user
1,181.5 (12.5%) 01:44:21 INFO - TinderboxPrint: Swap in / out
0 / 0 01:44:21 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100388864; Read time: 0; Write time: 126800 01:44:21 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 208035840; Read time: 20; Write time: 115368 01:44:21 INFO - Running post-run listener: _upload_blobber_files 01:44:21 INFO - Blob upload gear active. 01:44:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:44:21 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 01:44:21 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'] 01:44:21 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 01:44:22 INFO - (blobuploader) - INFO - Open directory for files ... 01:44:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:44:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:44:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:44:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:44:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:44:28 INFO - (blobuploader) - INFO - Done attempting. 01:44:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:44:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:44:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:44:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:44:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:44:29 INFO - (blobuploader) - INFO - Done attempting. 01:44:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:44:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:44:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:44:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:44:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:44:30 INFO - (blobuploader) - INFO - Done attempting. 01:44:30 INFO - (blobuploader) - INFO - Iteration through files over. 01:44:30 INFO - Return code: 0 01:44:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:44:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:44:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c41b23f9f2796ddbc0f0a437ebcfbda3efaaccfacf350606666afc3ffc1df693629780e838036a07033fbba1e4a15dcb360ba5d9077bc7044b2bde05f29e6f89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0121b06d2e552dc02c86b5a2bba1ddfaf9a08540b7e320e71a6793d91010ba839efc6c1111540fc29ff7eafb85f7f5ac048360c131563b43fd8e5bdf46a3d294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d085e415f4f47aaaf784195f3ae2f1bc3d4cb68a46944c12939530c254a19c8960819d0afb6649458a6d4a2b4c36ec94f278e56676b5290910ac2e8ad9e2da43"} 01:44:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:44:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:44:30 INFO - Contents: 01:44:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c41b23f9f2796ddbc0f0a437ebcfbda3efaaccfacf350606666afc3ffc1df693629780e838036a07033fbba1e4a15dcb360ba5d9077bc7044b2bde05f29e6f89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0121b06d2e552dc02c86b5a2bba1ddfaf9a08540b7e320e71a6793d91010ba839efc6c1111540fc29ff7eafb85f7f5ac048360c131563b43fd8e5bdf46a3d294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d085e415f4f47aaaf784195f3ae2f1bc3d4cb68a46944c12939530c254a19c8960819d0afb6649458a6d4a2b4c36ec94f278e56676b5290910ac2e8ad9e2da43"} 01:44:30 INFO - Running post-run listener: copy_logs_to_upload_dir 01:44:30 INFO - Copying logs to upload dir... 01:44:30 INFO - mkdir: /builds/slave/test/build/upload/logs 01:44:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.032724 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-16 01:44:29.360546) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 01:44:29.363631) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c41b23f9f2796ddbc0f0a437ebcfbda3efaaccfacf350606666afc3ffc1df693629780e838036a07033fbba1e4a15dcb360ba5d9077bc7044b2bde05f29e6f89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0121b06d2e552dc02c86b5a2bba1ddfaf9a08540b7e320e71a6793d91010ba839efc6c1111540fc29ff7eafb85f7f5ac048360c131563b43fd8e5bdf46a3d294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d085e415f4f47aaaf784195f3ae2f1bc3d4cb68a46944c12939530c254a19c8960819d0afb6649458a6d4a2b4c36ec94f278e56676b5290910ac2e8ad9e2da43"} build_url:https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011853 build_url: 'https://queue.taskcluster.net/v1/task/ZPv_BYuORhShgeIlzDQNig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c41b23f9f2796ddbc0f0a437ebcfbda3efaaccfacf350606666afc3ffc1df693629780e838036a07033fbba1e4a15dcb360ba5d9077bc7044b2bde05f29e6f89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0121b06d2e552dc02c86b5a2bba1ddfaf9a08540b7e320e71a6793d91010ba839efc6c1111540fc29ff7eafb85f7f5ac048360c131563b43fd8e5bdf46a3d294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d085e415f4f47aaaf784195f3ae2f1bc3d4cb68a46944c12939530c254a19c8960819d0afb6649458a6d4a2b4c36ec94f278e56676b5290910ac2e8ad9e2da43"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 01:44:29.389845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 01:44:29.390181) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1484557872.42593-1886619627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 01:44:29.474054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 01:44:29.474380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 01:44:29.474662) ========= ========= Total master_lag: 0.17 =========