builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1480396324.7 results: success (0) buildid: 20161128182126 builduid: d27843b958774b969164c008d15e0f40 revision: a1b573be65538558843f9a6ab5cb05ddf1fc798e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:04.701719) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:04.702232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:04.702601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:04.722314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:04.722815) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-28 21:12:05-- 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% 45.8M=0s 2016-11-28 21:12:05 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128754 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:04.866662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:04.867040) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014488 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:04.926512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:04.926900) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a1b573be65538558843f9a6ab5cb05ddf1fc798e --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 a1b573be65538558843f9a6ab5cb05ddf1fc798e --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=74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-28 21:12:05,444 truncating revision to first 12 chars 2016-11-28 21:12:05,444 Setting DEBUG logging. 2016-11-28 21:12:05,444 attempt 1/10 2016-11-28 21:12:05,444 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a1b573be6553?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-28 21:12:05,754 unpacking tar archive at: mozilla-beta-a1b573be6553/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:05.605522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:05.605905) ========= script_repo_revision: a1b573be65538558843f9a6ab5cb05ddf1fc798e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:05.606357) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:05.606683) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 21:12:05.616380) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-11-28 21:12:05.616705) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:12:06 INFO - MultiFileLogger online at 20161128 21:12:06 in /builds/slave/test 21:12:06 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 21:12:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:12:06 INFO - {'append_to_log': False, 21:12:06 INFO - 'base_work_dir': '/builds/slave/test', 21:12:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:12:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:12:06 INFO - 'branch': 'Mozilla-Beta', 21:12:06 INFO - 'buildbot_json_path': 'buildprops.json', 21:12:06 INFO - 'config_files': ('talos/linux_config.py',), 21:12:06 INFO - 'default_actions': ('clobber', 21:12:06 INFO - 'read-buildbot-config', 21:12:06 INFO - 'download-and-extract', 21:12:06 INFO - 'populate-webroot', 21:12:06 INFO - 'create-virtualenv', 21:12:06 INFO - 'install', 21:12:06 INFO - 'run-tests'), 21:12:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:12:06 INFO - 'download_minidump_stackwalk': True, 21:12:06 INFO - 'download_symbols': 'ondemand', 21:12:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:12:06 INFO - 'tooltool.py': '/tools/tooltool.py', 21:12:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:12:06 INFO - '/tools/misc-python/virtualenv.py')}, 21:12:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:12:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:12:06 INFO - 'installer_path': 'installer.exe', 21:12:06 INFO - 'log_level': 'info', 21:12:06 INFO - 'log_name': 'talos', 21:12:06 INFO - 'log_to_console': True, 21:12:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:12:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:12:06 INFO - 'opt_config_files': (), 21:12:06 INFO - 'pip_index': False, 21:12:06 INFO - 'sps_profile': False, 21:12:06 INFO - 'sps_profile_interval': 0, 21:12:06 INFO - 'suite': 'dromaeojs', 21:12:06 INFO - 'system_bits': '32', 21:12:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:12:06 INFO - 'title': 'talos-linux64-ix-042', 21:12:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:12:06 INFO - 'use_talos_json': True, 21:12:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:12:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:12:06 INFO - 'work_dir': 'build'} 21:12:06 INFO - [mozharness: 2016-11-29 05:12:06.228822Z] Running clobber step. 21:12:06 INFO - Running pre-action listener: _resource_record_pre_action 21:12:06 INFO - Running main action method: clobber 21:12:06 INFO - rmtree: /builds/slave/test/build 21:12:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:12:06 INFO - Running post-action listener: _resource_record_post_action 21:12:06 INFO - [mozharness: 2016-11-29 05:12:06.688091Z] Finished clobber step (success) 21:12:06 INFO - [mozharness: 2016-11-29 05:12:06.688195Z] Running read-buildbot-config step. 21:12:06 INFO - Running pre-action listener: _resource_record_pre_action 21:12:06 INFO - Running main action method: read_buildbot_config 21:12:06 INFO - Using buildbot properties: 21:12:06 INFO - { 21:12:06 INFO - "project": "", 21:12:06 INFO - "product": "firefox", 21:12:06 INFO - "script_repo_revision": "production", 21:12:06 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 21:12:06 INFO - "repository": "", 21:12:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 21:12:06 INFO - "buildid": "20161128182126", 21:12:06 INFO - "pgo_build": "True", 21:12:06 INFO - "basedir": "/builds/slave/test", 21:12:06 INFO - "buildnumber": 480, 21:12:06 INFO - "slavename": "talos-linux64-ix-042", 21:12:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:12:06 INFO - "platform": "ubuntu64_hw", 21:12:06 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 21:12:06 INFO - "branch": "mozilla-beta", 21:12:06 INFO - "repo_path": "releases/mozilla-beta", 21:12:06 INFO - "revision": "a1b573be65538558843f9a6ab5cb05ddf1fc798e", 21:12:06 INFO - "stage_platform": "linux64-pgo", 21:12:06 INFO - "builduid": "d27843b958774b969164c008d15e0f40", 21:12:06 INFO - "slavebuilddir": "test" 21:12:06 INFO - } 21:12:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 21:12:06 INFO - Running post-action listener: _resource_record_post_action 21:12:06 INFO - [mozharness: 2016-11-29 05:12:06.690636Z] Finished read-buildbot-config step (success) 21:12:06 INFO - [mozharness: 2016-11-29 05:12:06.690726Z] Running download-and-extract step. 21:12:06 INFO - Running pre-action listener: _resource_record_pre_action 21:12:06 INFO - Running main action method: download_and_extract 21:12:06 INFO - mkdir: /builds/slave/test/build/tests 21:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:06 INFO - trying https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 21:12:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/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 21:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/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 21:12:07 INFO - Downloaded 1327 bytes. 21:12:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 21:12:07 INFO - Using the following test package requirements: 21:12:07 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 21:12:07 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:12:07 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 21:12:07 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:12:07 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 21:12:07 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:12:07 INFO - u'jsshell-linux-x86_64.zip'], 21:12:07 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:12:07 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 21:12:07 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 21:12:07 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:12:07 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 21:12:07 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:12:07 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 21:12:07 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:12:07 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 21:12:07 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:12:07 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 21:12:07 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:12:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 21:12:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:12:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 21:12:07 INFO - Expected file size: 21963841 21:12:12 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 21:12:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 21:12:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:12:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 21:12:12 INFO - Expected file size: 21963841 21:12:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 21:12:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:12:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 21:12:17 INFO - Expected file size: 14414089 21:12: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')]} 21:12:18 INFO - trying https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:12:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/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 21:12:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/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 21:12:19 INFO - Downloaded 56967880 bytes. 21:12:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:12:19 INFO - mkdir: /builds/slave/test/properties 21:12:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:12:19 INFO - Writing to file /builds/slave/test/properties/build_url 21:12:19 INFO - Contents: 21:12:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:12:20 INFO - Running post-action listener: _resource_record_post_action 21:12:20 INFO - Running post-action listener: set_extra_try_arguments 21:12:20 INFO - [mozharness: 2016-11-29 05:12:20.252113Z] Finished download-and-extract step (success) 21:12:20 INFO - [mozharness: 2016-11-29 05:12:20.252417Z] Running populate-webroot step. 21:12:20 INFO - Running pre-action listener: _resource_record_pre_action 21:12:20 INFO - Running main action method: populate_webroot 21:12:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:12:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:12:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:12:20 INFO - '--tppagecycles', 21:12:20 INFO - '7'], 21:12:20 INFO - 'tests': ['tsvgm']}}, 21:12:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:12:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:12:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:12:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:12:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:12:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:12:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:12:20 INFO - 'talos_options': ['--disable-e10s'], 21:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:12:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:12:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:12:20 INFO - 'talos_options': ['--disable-e10s'], 21:12:20 INFO - 'tests': ['damp', 'tps']}, 21:12:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:12:20 INFO - 'tests': ['damp', 'tps']}, 21:12:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:12:20 INFO - 'tests': ['dromaeo_dom']}, 21:12:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:12:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:12:20 INFO - 'tests': ['basic_compositor_video']}, 21:12:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:12:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:12:20 INFO - 'tests': ['a11yr', 21:12:20 INFO - 'ts_paint', 21:12:20 INFO - 'tpaint', 21:12:20 INFO - 'sessionrestore', 21:12:20 INFO - 'sessionrestore_no_auto_restore', 21:12:20 INFO - 'tabpaint']}, 21:12:20 INFO - 'other-e10s': {'tests': ['a11yr', 21:12:20 INFO - 'ts_paint', 21:12:20 INFO - 'tpaint', 21:12:20 INFO - 'sessionrestore', 21:12:20 INFO - 'sessionrestore_no_auto_restore', 21:12:20 INFO - 'tabpaint']}, 21:12:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:12:20 INFO - 'ts_paint', 21:12:20 INFO - 'tpaint', 21:12:20 INFO - 'sessionrestore', 21:12:20 INFO - 'sessionrestore_no_auto_restore', 21:12:20 INFO - 'tabpaint']}, 21:12:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:12:20 INFO - 'ts_paint', 21:12:20 INFO - 'tpaint', 21:12:20 INFO - 'sessionrestore', 21:12:20 INFO - 'sessionrestore_no_auto_restore', 21:12:20 INFO - 'tabpaint']}, 21:12:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:12:20 INFO - 'tests': ['a11yr', 21:12:20 INFO - 'ts_paint', 21:12:20 INFO - 'tpaint', 21:12:20 INFO - 'sessionrestore', 21:12:20 INFO - 'sessionrestore_no_auto_restore', 21:12:20 INFO - 'tabpaint']}, 21:12:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:12:20 INFO - 'tests': ['a11yr', 21:12:20 INFO - 'ts_paint', 21:12:20 INFO - 'tpaint', 21:12:20 INFO - 'sessionrestore', 21:12:20 INFO - 'sessionrestore_no_auto_restore', 21:12:20 INFO - 'tabpaint']}, 21:12:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:12:20 INFO - 'tests': ['tsvgx', 21:12:20 INFO - 'tsvgr_opacity', 21:12:20 INFO - 'tart', 21:12:20 INFO - 'tscrollx', 21:12:20 INFO - 'cart']}, 21:12:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:12:20 INFO - 'tsvgr_opacity', 21:12:20 INFO - 'tart', 21:12:20 INFO - 'tscrollx', 21:12:20 INFO - 'cart']}, 21:12:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:12:20 INFO - 'talos_options': ['--disable-e10s'], 21:12:20 INFO - 'tests': ['tp5o']}, 21:12:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:12:20 INFO - 'tests': ['tp5o']}, 21:12:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:12:20 INFO - 'talos_options': ['--disable-e10s', 21:12:20 INFO - '--xperf_path', 21:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:12:20 INFO - 'tests': ['tp5n']}, 21:12:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:12:20 INFO - 'talos_options': ['--xperf_path', 21:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:12:20 INFO - 'tests': ['tp5n']}}, 21:12:20 INFO - 'talos.zip': {'path': '', 21:12:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:12:20 INFO - Running post-action listener: _resource_record_post_action 21:12:20 INFO - [mozharness: 2016-11-29 05:12:20.269313Z] Finished populate-webroot step (success) 21:12:20 INFO - [mozharness: 2016-11-29 05:12:20.269412Z] Running create-virtualenv step. 21:12:20 INFO - Running pre-action listener: _resource_record_pre_action 21:12:20 INFO - Running main action method: create_virtualenv 21:12:20 INFO - Creating virtualenv /builds/slave/test/build/venv 21:12:20 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 21:12:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:12:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:12:20 INFO - Using real prefix '/usr' 21:12:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:12:20 INFO - Installing distribute.............................................................................................................................................................................................done. 21:12:22 INFO - Installing pip.................done. 21:12:22 INFO - Return code: 0 21:12:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:12:22 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')]} 21:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:22 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')]} 21:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:22 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 0x7f7721257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e28ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25f60>, '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 0x1e26d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e271d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', '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 21:12:22 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 21:12:22 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 21:12:22 INFO - Using env: {'DISPLAY': ':0', 21:12:22 INFO - 'HOME': '/home/cltbld', 21:12:22 INFO - 'LANG': 'en_US.UTF-8', 21:12:22 INFO - 'LANGUAGE': 'en_US:en', 21:12:22 INFO - 'LOGNAME': 'cltbld', 21:12:22 INFO - 'MAIL': '/var/mail/cltbld', 21:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:22 INFO - 'MOZ_NO_REMOTE': '1', 21:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:22 INFO - 'NO_EM_RESTART': '1', 21:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:22 INFO - 'PWD': '/builds/slave/test', 21:12:22 INFO - 'SHELL': '/bin/bash', 21:12:22 INFO - 'SHLVL': '1', 21:12:22 INFO - 'TERM': 'linux', 21:12:22 INFO - 'TMOUT': '86400', 21:12:22 INFO - 'USER': 'cltbld', 21:12:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', 21:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:22 INFO - '_': '/tools/buildbot/bin/python'} 21:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:23 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 21:12:23 INFO - Cleaning up... 21:12:23 INFO - Return code: 0 21:12:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:12: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')]} 21:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12: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')]} 21:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12: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', '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 0x7f7721257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e28ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25f60>, '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 0x1e26d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e271d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', '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 21:12: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:12: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 psutil>=3.1.1 21:12:23 INFO - Using env: {'DISPLAY': ':0', 21:12:23 INFO - 'HOME': '/home/cltbld', 21:12:23 INFO - 'LANG': 'en_US.UTF-8', 21:12:23 INFO - 'LANGUAGE': 'en_US:en', 21:12:23 INFO - 'LOGNAME': 'cltbld', 21:12:23 INFO - 'MAIL': '/var/mail/cltbld', 21:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:23 INFO - 'MOZ_NO_REMOTE': '1', 21:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:23 INFO - 'NO_EM_RESTART': '1', 21:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:23 INFO - 'PWD': '/builds/slave/test', 21:12:23 INFO - 'SHELL': '/bin/bash', 21:12:23 INFO - 'SHLVL': '1', 21:12:23 INFO - 'TERM': 'linux', 21:12:23 INFO - 'TMOUT': '86400', 21:12:23 INFO - 'USER': 'cltbld', 21:12:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', 21:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:23 INFO - '_': '/tools/buildbot/bin/python'} 21:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:23 INFO - Downloading/unpacking psutil>=3.1.1 21:12: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 21:12: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 21:12: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 21:12: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 21:12: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 21:12: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 21:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:12:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:12:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:12:25 INFO - Installing collected packages: psutil 21:12:25 INFO - Running setup.py install for psutil 21:12:25 INFO - building 'psutil._psutil_linux' extension 21:12:25 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 21:12:25 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 21:12:25 INFO - building 'psutil._psutil_posix' extension 21:12:25 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 21:12:25 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 21:12:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:12:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:12:25 INFO - Successfully installed psutil 21:12:25 INFO - Cleaning up... 21:12:25 INFO - Return code: 0 21:12:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:12:25 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')]} 21:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:25 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')]} 21:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:25 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 0x7f7721257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e28ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25f60>, '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 0x1e26d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e271d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', '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 21:12:25 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 21:12:25 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 21:12:25 INFO - Using env: {'DISPLAY': ':0', 21:12:25 INFO - 'HOME': '/home/cltbld', 21:12:25 INFO - 'LANG': 'en_US.UTF-8', 21:12:25 INFO - 'LANGUAGE': 'en_US:en', 21:12:25 INFO - 'LOGNAME': 'cltbld', 21:12:25 INFO - 'MAIL': '/var/mail/cltbld', 21:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:25 INFO - 'MOZ_NO_REMOTE': '1', 21:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:25 INFO - 'NO_EM_RESTART': '1', 21:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:25 INFO - 'PWD': '/builds/slave/test', 21:12:25 INFO - 'SHELL': '/bin/bash', 21:12:25 INFO - 'SHLVL': '1', 21:12:25 INFO - 'TERM': 'linux', 21:12:25 INFO - 'TMOUT': '86400', 21:12:25 INFO - 'USER': 'cltbld', 21:12:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', 21:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:25 INFO - '_': '/tools/buildbot/bin/python'} 21:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:12: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 21:12: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 21:12: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 21:12: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 21:12: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 21:12: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 21:12:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:12:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:12:28 INFO - Installing collected packages: mozsystemmonitor 21:12:28 INFO - Running setup.py install for mozsystemmonitor 21:12:28 INFO - Successfully installed mozsystemmonitor 21:12:28 INFO - Cleaning up... 21:12:28 INFO - Return code: 0 21:12:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:12:28 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')]} 21:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:28 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')]} 21:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:28 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 0x7f7721257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e28ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25f60>, '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 0x1e26d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e271d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', '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 21:12:28 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 21:12:28 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 21:12:28 INFO - Using env: {'DISPLAY': ':0', 21:12:28 INFO - 'HOME': '/home/cltbld', 21:12:28 INFO - 'LANG': 'en_US.UTF-8', 21:12:28 INFO - 'LANGUAGE': 'en_US:en', 21:12:28 INFO - 'LOGNAME': 'cltbld', 21:12:28 INFO - 'MAIL': '/var/mail/cltbld', 21:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:28 INFO - 'MOZ_NO_REMOTE': '1', 21:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:28 INFO - 'NO_EM_RESTART': '1', 21:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:28 INFO - 'PWD': '/builds/slave/test', 21:12:28 INFO - 'SHELL': '/bin/bash', 21:12:28 INFO - 'SHLVL': '1', 21:12:28 INFO - 'TERM': 'linux', 21:12:28 INFO - 'TMOUT': '86400', 21:12:28 INFO - 'USER': 'cltbld', 21:12:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', 21:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:28 INFO - '_': '/tools/buildbot/bin/python'} 21:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:28 INFO - Downloading/unpacking jsonschema==2.5.1 21:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:12:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:12:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:12:30 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 21:12:30 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 21:12:30 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 21:12:30 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 21:12:30 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 21:12:30 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 21:12:30 INFO - Downloading functools32-3.2.3-2.tar.gz 21:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:12:30 INFO - warning: no files found matching '*.txt' 21:12:30 INFO - no previously-included directories found matching 'build' 21:12:30 INFO - no previously-included directories found matching 'dist' 21:12:30 INFO - no previously-included directories found matching '.git*' 21:12:30 INFO - Installing collected packages: jsonschema, functools32 21:12:30 INFO - Running setup.py install for functools32 21:12:30 INFO - warning: no files found matching '*.txt' 21:12:30 INFO - no previously-included directories found matching 'build' 21:12:30 INFO - no previously-included directories found matching 'dist' 21:12:30 INFO - no previously-included directories found matching '.git*' 21:12:30 INFO - Successfully installed jsonschema functools32 21:12:30 INFO - Cleaning up... 21:12:30 INFO - Return code: 0 21:12:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:12: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')]} 21:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12: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')]} 21:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:30 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 0x7f7721257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e28ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25f60>, '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 0x1e26d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e271d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', '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 21:12:30 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 21:12:30 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 21:12:30 INFO - Using env: {'DISPLAY': ':0', 21:12:30 INFO - 'HOME': '/home/cltbld', 21:12:30 INFO - 'LANG': 'en_US.UTF-8', 21:12:30 INFO - 'LANGUAGE': 'en_US:en', 21:12:30 INFO - 'LOGNAME': 'cltbld', 21:12:30 INFO - 'MAIL': '/var/mail/cltbld', 21:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:30 INFO - 'MOZ_NO_REMOTE': '1', 21:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:30 INFO - 'NO_EM_RESTART': '1', 21:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:30 INFO - 'PWD': '/builds/slave/test', 21:12:30 INFO - 'SHELL': '/bin/bash', 21:12:30 INFO - 'SHLVL': '1', 21:12:30 INFO - 'TERM': 'linux', 21:12:30 INFO - 'TMOUT': '86400', 21:12:30 INFO - 'USER': 'cltbld', 21:12:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', 21:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:30 INFO - '_': '/tools/buildbot/bin/python'} 21:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:12:31 INFO - Cleaning up... 21:12:31 INFO - Return code: 0 21:12:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:31 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 0x7f7721257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e28ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25f60>, '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 0x1e26d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e271d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', '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 21:12:31 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 21:12:31 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 21:12:31 INFO - Using env: {'DISPLAY': ':0', 21:12:31 INFO - 'HOME': '/home/cltbld', 21:12:31 INFO - 'LANG': 'en_US.UTF-8', 21:12:31 INFO - 'LANGUAGE': 'en_US:en', 21:12:31 INFO - 'LOGNAME': 'cltbld', 21:12:31 INFO - 'MAIL': '/var/mail/cltbld', 21:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:31 INFO - 'MOZ_NO_REMOTE': '1', 21:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:31 INFO - 'NO_EM_RESTART': '1', 21:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:31 INFO - 'PWD': '/builds/slave/test', 21:12:31 INFO - 'SHELL': '/bin/bash', 21:12:31 INFO - 'SHLVL': '1', 21:12:31 INFO - 'TERM': 'linux', 21:12:31 INFO - 'TMOUT': '86400', 21:12:31 INFO - 'USER': 'cltbld', 21:12:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', 21:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:31 INFO - '_': '/tools/buildbot/bin/python'} 21:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:31 INFO - Downloading/unpacking blobuploader==1.2.4 21:12: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 21:12: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 21:12: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 21:12: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 21:12: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 21:12: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 21:12:33 INFO - Downloading blobuploader-1.2.4.tar.gz 21:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:12:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:12:33 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 21:12:33 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 21:12:33 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 21:12:33 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 21:12:33 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 21:12:33 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 21:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:12:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:12:33 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 21:12:33 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 21:12:33 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 21:12:33 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 21:12:33 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 21:12:33 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 21:12:34 INFO - Downloading docopt-0.6.1.tar.gz 21:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:12:34 INFO - Installing collected packages: blobuploader, requests, docopt 21:12:34 INFO - Running setup.py install for blobuploader 21:12:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:12:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:12:34 INFO - Running setup.py install for requests 21:12:34 INFO - Running setup.py install for docopt 21:12:34 INFO - Successfully installed blobuploader requests docopt 21:12:34 INFO - Cleaning up... 21:12:34 INFO - Return code: 0 21:12:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:12: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')]} 21:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12: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')]} 21:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:34 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 0x7f7721257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e28ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25f60>, '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 0x1e26d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e271d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', '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 21:12:34 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 21:12:34 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 21:12:34 INFO - Using env: {'DISPLAY': ':0', 21:12:34 INFO - 'HOME': '/home/cltbld', 21:12:34 INFO - 'LANG': 'en_US.UTF-8', 21:12:34 INFO - 'LANGUAGE': 'en_US:en', 21:12:34 INFO - 'LOGNAME': 'cltbld', 21:12:34 INFO - 'MAIL': '/var/mail/cltbld', 21:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:34 INFO - 'MOZ_NO_REMOTE': '1', 21:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:34 INFO - 'NO_EM_RESTART': '1', 21:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:34 INFO - 'PWD': '/builds/slave/test', 21:12:34 INFO - 'SHELL': '/bin/bash', 21:12:34 INFO - 'SHLVL': '1', 21:12:34 INFO - 'TERM': 'linux', 21:12:34 INFO - 'TMOUT': '86400', 21:12:34 INFO - 'USER': 'cltbld', 21:12:34 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', 21:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:34 INFO - '_': '/tools/buildbot/bin/python'} 21:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:12:34 INFO - Running setup.py (path:/tmp/pip-Ridsjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:12:35 INFO - Running setup.py (path:/tmp/pip-a5ZEXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:12:35 INFO - Running setup.py (path:/tmp/pip-EhyMFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:12:35 INFO - Running setup.py (path:/tmp/pip-_2AgkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:12:35 INFO - Running setup.py (path:/tmp/pip-48Au6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:12:35 INFO - Running setup.py (path:/tmp/pip-f75ImF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:12:35 INFO - Running setup.py (path:/tmp/pip-2A0Dzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:12:35 INFO - Running setup.py (path:/tmp/pip-iHCxVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:12:35 INFO - Running setup.py (path:/tmp/pip-awvlZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:12:35 INFO - Running setup.py (path:/tmp/pip-quuCFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:12:35 INFO - Running setup.py (path:/tmp/pip-GjqRFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:12:35 INFO - Running setup.py (path:/tmp/pip-PTjZGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:12:35 INFO - Running setup.py (path:/tmp/pip-YbaGRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:12:35 INFO - Running setup.py (path:/tmp/pip-4GaTlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:12:35 INFO - Running setup.py (path:/tmp/pip-UdndcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:12:36 INFO - Running setup.py (path:/tmp/pip-5l5Kwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:12:36 INFO - Running setup.py (path:/tmp/pip-X_vgYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:12:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:12:36 INFO - Running setup.py install for manifestparser 21:12:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:12:36 INFO - Running setup.py install for mozcrash 21:12:36 INFO - Running setup.py install for mozdebug 21:12:36 INFO - Running setup.py install for mozdevice 21:12:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:12:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:12:36 INFO - Running setup.py install for mozfile 21:12:36 INFO - Running setup.py install for mozhttpd 21:12:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:12:36 INFO - Running setup.py install for mozinfo 21:12:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:12:36 INFO - Running setup.py install for mozInstall 21:12:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:12:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:12:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:12:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:12:36 INFO - Running setup.py install for mozleak 21:12:37 INFO - Running setup.py install for mozlog 21:12:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:12:37 INFO - Running setup.py install for moznetwork 21:12:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:12:37 INFO - Running setup.py install for mozprocess 21:12:37 INFO - Running setup.py install for mozprofile 21:12:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:12:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:12:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:12:37 INFO - Running setup.py install for mozrunner 21:12:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:12:37 INFO - Running setup.py install for mozscreenshot 21:12:37 INFO - Running setup.py install for moztest 21:12:37 INFO - Running setup.py install for mozversion 21:12:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:12:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:12:37 INFO - Cleaning up... 21:12:37 INFO - Return code: 0 21:12:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:12:37 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')]} 21:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:37 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')]} 21:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:37 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 0x7f7721257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e28ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25f60>, '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 0x1e26d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e271d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', '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 21:12:37 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 21:12:37 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 21:12:37 INFO - Using env: {'DISPLAY': ':0', 21:12:37 INFO - 'HOME': '/home/cltbld', 21:12:37 INFO - 'LANG': 'en_US.UTF-8', 21:12:37 INFO - 'LANGUAGE': 'en_US:en', 21:12:37 INFO - 'LOGNAME': 'cltbld', 21:12:37 INFO - 'MAIL': '/var/mail/cltbld', 21:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:37 INFO - 'MOZ_NO_REMOTE': '1', 21:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:37 INFO - 'NO_EM_RESTART': '1', 21:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:37 INFO - 'PWD': '/builds/slave/test', 21:12:37 INFO - 'SHELL': '/bin/bash', 21:12:37 INFO - 'SHLVL': '1', 21:12:37 INFO - 'TERM': 'linux', 21:12:37 INFO - 'TMOUT': '86400', 21:12:37 INFO - 'USER': 'cltbld', 21:12:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', 21:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:37 INFO - '_': '/tools/buildbot/bin/python'} 21:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:12:38 INFO - Running setup.py (path:/tmp/pip-0VL4t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:12:38 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)) 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:12:38 INFO - Running setup.py (path:/tmp/pip-oI8xih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:12:38 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)) 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:12:38 INFO - Running setup.py (path:/tmp/pip-scBAKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:12:38 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)) 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:12:38 INFO - Running setup.py (path:/tmp/pip-cb7GNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:12:38 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)) 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:12:38 INFO - Running setup.py (path:/tmp/pip-B3R4Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:12:38 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)) 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:12:38 INFO - Running setup.py (path:/tmp/pip-tyL7SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:12:38 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)) 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:12:38 INFO - Running setup.py (path:/tmp/pip-SFWauE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:12:38 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)) 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:12:38 INFO - Running setup.py (path:/tmp/pip-tV3F59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:12:38 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)) 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:12:38 INFO - Running setup.py (path:/tmp/pip-lc4uyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:12:38 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)) 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:12:38 INFO - Running setup.py (path:/tmp/pip-HF9OgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:12:38 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)) 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:12:38 INFO - Running setup.py (path:/tmp/pip-X5fQXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:12:38 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)) 21:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:12:38 INFO - Running setup.py (path:/tmp/pip-sNIaPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:12:39 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)) 21:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:12:39 INFO - Running setup.py (path:/tmp/pip-wjNMTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:12:39 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)) 21:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:12:39 INFO - Running setup.py (path:/tmp/pip-gT8Tu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:12:39 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)) 21:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:12:39 INFO - Running setup.py (path:/tmp/pip-NkJixX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:12:39 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)) 21:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:12:39 INFO - Running setup.py (path:/tmp/pip-LNouGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:12:39 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)) 21:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:12:39 INFO - Running setup.py (path:/tmp/pip-YWT1LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:12:39 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)) 21:12:39 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)) 21:12:39 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)) 21:12:39 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)) 21:12:39 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)) 21:12:39 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)) 21:12:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:12:41 INFO - Downloading blessings-1.6.tar.gz 21:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:12:41 INFO - Installing collected packages: blessings 21:12:41 INFO - Running setup.py install for blessings 21:12:41 INFO - Successfully installed blessings 21:12:41 INFO - Cleaning up... 21:12:41 INFO - Return code: 0 21:12:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:12:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:12:41 INFO - Reading from file tmpfile_stdout 21:12:41 INFO - Current package versions: 21:12:41 INFO - argparse == 1.2.1 21:12:41 INFO - blessings == 1.6 21:12:41 INFO - blobuploader == 1.2.4 21:12:41 INFO - docopt == 0.6.1 21:12:41 INFO - functools32 == 3.2.3-2 21:12:41 INFO - jsonschema == 2.5.1 21:12:41 INFO - manifestparser == 1.1 21:12:41 INFO - mozInstall == 1.12 21:12:41 INFO - mozcrash == 0.17 21:12:41 INFO - mozdebug == 0.1 21:12:41 INFO - mozdevice == 0.48 21:12:41 INFO - mozfile == 1.2 21:12:41 INFO - mozhttpd == 0.7 21:12:41 INFO - mozinfo == 0.9 21:12:41 INFO - mozleak == 0.1 21:12:41 INFO - mozlog == 3.4 21:12:41 INFO - moznetwork == 0.27 21:12:41 INFO - mozprocess == 0.23 21:12:41 INFO - mozprofile == 0.28 21:12:41 INFO - mozrunner == 6.12 21:12:41 INFO - mozscreenshot == 0.1 21:12:41 INFO - mozsystemmonitor == 0.3 21:12:41 INFO - moztest == 0.7 21:12:41 INFO - mozversion == 1.4 21:12:41 INFO - psutil == 3.1.1 21:12:41 INFO - requests == 1.2.3 21:12:41 INFO - wsgiref == 0.1.2 21:12:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:41 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 0x7f7721257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e28ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25f60>, '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 0x1e26d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e271d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', '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 21:12:41 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 21:12:41 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 21:12:41 INFO - Using env: {'DISPLAY': ':0', 21:12:41 INFO - 'HOME': '/home/cltbld', 21:12:41 INFO - 'LANG': 'en_US.UTF-8', 21:12:41 INFO - 'LANGUAGE': 'en_US:en', 21:12:41 INFO - 'LOGNAME': 'cltbld', 21:12:41 INFO - 'MAIL': '/var/mail/cltbld', 21:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:41 INFO - 'MOZ_NO_REMOTE': '1', 21:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:41 INFO - 'NO_EM_RESTART': '1', 21:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:41 INFO - 'PWD': '/builds/slave/test', 21:12:41 INFO - 'SHELL': '/bin/bash', 21:12:41 INFO - 'SHLVL': '1', 21:12:41 INFO - 'TERM': 'linux', 21:12:41 INFO - 'TMOUT': '86400', 21:12:41 INFO - 'USER': 'cltbld', 21:12:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', 21:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:41 INFO - '_': '/tools/buildbot/bin/python'} 21:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:42 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)) 21:12:42 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)) 21:12:42 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)) 21:12:42 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)) 21:12:42 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)) 21:12:42 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)) 21:12:42 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)) 21:12:42 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)) 21:12:42 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)) 21:12:42 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)) 21:12:42 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)) 21:12:42 INFO - Cleaning up... 21:12:42 INFO - Return code: 0 21:12:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:12:42 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')]} 21:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:42 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')]} 21:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:12:42 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 0x7f7721257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e28ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25f60>, '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 0x1e26d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e271d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', '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 21:12:42 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 21:12:42 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 21:12:42 INFO - Using env: {'DISPLAY': ':0', 21:12:42 INFO - 'HOME': '/home/cltbld', 21:12:42 INFO - 'LANG': 'en_US.UTF-8', 21:12:42 INFO - 'LANGUAGE': 'en_US:en', 21:12:42 INFO - 'LOGNAME': 'cltbld', 21:12:42 INFO - 'MAIL': '/var/mail/cltbld', 21:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:42 INFO - 'MOZ_NO_REMOTE': '1', 21:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:42 INFO - 'NO_EM_RESTART': '1', 21:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:42 INFO - 'PWD': '/builds/slave/test', 21:12:42 INFO - 'SHELL': '/bin/bash', 21:12:42 INFO - 'SHLVL': '1', 21:12:42 INFO - 'TERM': 'linux', 21:12:42 INFO - 'TMOUT': '86400', 21:12:42 INFO - 'USER': 'cltbld', 21:12:42 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', 21:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:42 INFO - '_': '/tools/buildbot/bin/python'} 21:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:12:42 INFO - Cleaning up... 21:12:42 INFO - Return code: 0 21:12:42 INFO - Running post-action listener: _resource_record_post_action 21:12:42 INFO - Running post-action listener: _start_resource_monitoring 21:12:42 INFO - Starting resource monitoring. 21:12:42 INFO - [mozharness: 2016-11-29 05:12:42.328023Z] Finished create-virtualenv step (success) 21:12:42 INFO - [mozharness: 2016-11-29 05:12:42.328529Z] Running install step. 21:12:42 INFO - Running pre-action listener: _resource_record_pre_action 21:12:42 INFO - Running main action method: install 21:12:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:12:42 INFO - Reading from file tmpfile_stdout 21:12:42 INFO - Detecting whether we're running mozinstall >=1.0... 21:12:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:12:42 INFO - Reading from file tmpfile_stdout 21:12:42 INFO - Output received: 21:12:42 INFO - Usage: mozinstall [options] installer 21:12:42 INFO - Options: 21:12:42 INFO - -h, --help show this help message and exit 21:12:42 INFO - -d DEST, --destination=DEST 21:12:42 INFO - Directory to install application into. [default: 21:12:42 INFO - "/builds/slave/test"] 21:12:42 INFO - --app=APP Application being installed. [default: firefox] 21:12:42 INFO - mkdir: /builds/slave/test/build/application 21:12:42 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'] 21:12:42 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 21:12:56 INFO - Reading from file tmpfile_stdout 21:12:56 INFO - Output received: 21:12:56 INFO - /builds/slave/test/build/application/firefox/firefox 21:12:56 INFO - Running post-action listener: _resource_record_post_action 21:12:56 INFO - [mozharness: 2016-11-29 05:12:56.117591Z] Finished install step (success) 21:12:56 INFO - [mozharness: 2016-11-29 05:12:56.117836Z] Running run-tests step. 21:12:56 INFO - Running pre-action listener: _resource_record_pre_action 21:12:56 INFO - Running main action method: run_tests 21:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:12:56 INFO - Python 2.7.3 21:12:56 INFO - Return code: 0 21:12:56 INFO - grabbing minidump binary from tooltool 21:12: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')]} 21:12:56 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 0x1e25f60>, '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 0x1e26d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e271d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:12:56 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 21:12:56 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 21:12:56 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 21:12:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:12:56 INFO - Return code: 0 21:12:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:12:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:12:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:12:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:12:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:12:56 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/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 21:12:56 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/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 21:12:56 INFO - Using env: {'DISPLAY': ':0', 21:12:56 INFO - 'HOME': '/home/cltbld', 21:12:56 INFO - 'LANG': 'en_US.UTF-8', 21:12:56 INFO - 'LANGUAGE': 'en_US:en', 21:12:56 INFO - 'LOGNAME': 'cltbld', 21:12:56 INFO - 'MAIL': '/var/mail/cltbld', 21:12:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:12:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:56 INFO - 'MOZ_NO_REMOTE': '1', 21:12:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:56 INFO - 'NO_EM_RESTART': '1', 21:12:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:56 INFO - 'PWD': '/builds/slave/test', 21:12:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:12:56 INFO - 'SHELL': '/bin/bash', 21:12:56 INFO - 'SHLVL': '1', 21:12:56 INFO - 'TERM': 'linux', 21:12:56 INFO - 'TMOUT': '86400', 21:12:56 INFO - 'USER': 'cltbld', 21:12:56 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958', 21:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:56 INFO - '_': '/tools/buildbot/bin/python'} 21:12:56 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/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 21:12:56 INFO - mozversion application_buildid: 20161128182126 21:12:56 INFO - mozversion application_changeset: a1b573be65538558843f9a6ab5cb05ddf1fc798e 21:12:56 INFO - mozversion application_display_name: Firefox 21:12:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:12:56 INFO - mozversion application_name: Firefox 21:12:56 INFO - mozversion application_remotingname: firefox 21:12:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:12:56 INFO - mozversion application_vendor: Mozilla 21:12:56 INFO - mozversion application_version: 51.0 21:12:56 INFO - mozversion platform_buildid: 20161128182126 21:12:56 INFO - mozversion platform_changeset: a1b573be65538558843f9a6ab5cb05ddf1fc798e 21:12:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:12:56 INFO - mozversion platform_version: 51.0 21:12:56 INFO - using testdate: 1480396376 21:12:56 INFO - actual date: 1480396376 21:12:56 INFO - starting webserver on 'localhost:53705' 21:12:56 INFO - SUITE-START | Running 2 tests 21:12:56 INFO - TEST-START | dromaeo_css 21:12:56 INFO - operating with platform_type : linux_ 21:12:56 INFO - Initialising browser for dromaeo_css test... 21:12:56 INFO - TEST-INFO | started process 2695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi7D2FC/profile http://localhost:53705/getInfo.html) 21:13:00 INFO - PROCESS | 2695 | __metrics Screen width/height:1600/1200 21:13:00 INFO - PROCESS | 2695 | colorDepth:24 21:13:00 INFO - PROCESS | 2695 | Browser inner width/height: 1024/697 21:13:00 INFO - PROCESS | 2695 | __metrics 21:13:00 INFO - PROCESS | 2695 | 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" 21:13:00 INFO - PROCESS | 2695 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:13:01 INFO - PROCESS | 2695 | console.error: PushService: 21:13:01 INFO - PROCESS | 2695 | stateChangeProcessEnqueue: Error transitioning state 21:13:01 INFO - PROCESS | 2695 | UnknownError 21:13:01 INFO - TEST-INFO | 2695: exit 0 21:13:01 INFO - Browser initialized. 21:13:01 INFO - Running cycle 1/1 for dromaeo_css test... 21:13:01 INFO - TEST-INFO | started process 2866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi7D2FC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:13:13 INFO - PROCESS | 2866 | RSS: Main: 143286272 21:13:13 INFO - PROCESS | 2866 | 21:14:04 INFO - PROCESS | 2866 | 1480396444757 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] 21:16:14 INFO - PROCESS | 2866 | Cycle 1(1): loaded http://localhost:53705/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53705/tests/dromaeo/cssquery-ext.html) 21:16:15 INFO - PROCESS | 2866 | RSS: Main: 236744704 21:16:15 INFO - PROCESS | 2866 | 21:19:17 INFO - PROCESS | 2866 | Cycle 1(1): loaded http://localhost:53705/tests/dromaeo/cssquery-ext.html (next: http://localhost:53705/tests/dromaeo/cssquery-jquery.html) 21:19:17 INFO - PROCESS | 2866 | RSS: Main: 235282432 21:19:17 INFO - PROCESS | 2866 | 21:22:19 INFO - PROCESS | 2866 | Cycle 1(1): loaded http://localhost:53705/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53705/tests/dromaeo/cssquery-mootools.html) 21:22:20 INFO - PROCESS | 2866 | RSS: Main: 173899776 21:22:20 INFO - PROCESS | 2866 | 21:25:22 INFO - PROCESS | 2866 | Cycle 1(1): loaded http://localhost:53705/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53705/tests/dromaeo/cssquery-prototype.html) 21:25:22 INFO - PROCESS | 2866 | RSS: Main: 222769152 21:25:22 INFO - PROCESS | 2866 | 21:28:25 INFO - PROCESS | 2866 | Cycle 1(1): loaded http://localhost:53705/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53705/tests/dromaeo/cssquery-yui.html) 21:28:26 INFO - PROCESS | 2866 | RSS: Main: 181964800 21:28:26 INFO - PROCESS | 2866 | 21:31:28 INFO - PROCESS | 2866 | Cycle 1(1): loaded http://localhost:53705/tests/dromaeo/cssquery-yui.html (next: http://localhost:53705/tests/dromaeo/cssquery-dojo.html) 21:31:28 INFO - PROCESS | 2866 | RSS: Main: 263614464 21:31:28 INFO - PROCESS | 2866 | 21:31:28 INFO - PROCESS | 2866 | __start_tp_report 21:31:28 INFO - PROCESS | 2866 | _x_x_mozilla_page_load 21:31:28 INFO - PROCESS | 2866 | _x_x_mozilla_page_load_details 21:31:28 INFO - PROCESS | 2866 | |i|pagename|runs| 21:31:28 INFO - PROCESS | 2866 | |0;dojo.html;3109.54911537827;3136.1375621704024;3152.653208147103;3166.8891588794395;3181.888633897814;5431.402545719968;5514.751836167372;5515.862103447411;5525.861853453665;5544;5583.190437386576;5583.832485025446;5611.523020543259;5611.887762244753;5632.971835140818;5112.642115051948;5119.411267704215;5143.81996630118;5166.844994650167;5185.507376799198;5033.295338652591;5100.260462232974;5138.768755405997;5145.614078944075;5173.249878767595;5011.799528018875;5046.798128074891;5052.343195384595;5103.157978933472;5103.974480127594;5071.644984851062;5096.566791822663;5102.132637451624;5171.793128274864;5192.1432963560965;4976.825811096594;5079.644424890259;5122;5130.563902068328;5140.177571588565;5326.174442961347;5372.274742909696;5419.972900135514;5429.837104886859;5489.984352894728;5818.4763371296785;5839.182514447981;5844.620099693507;5903.026000709878;5937.554683398719;5973.940260597382;5982;5988.520918326523;5990.9700451497465;5994.1608174855555;5404.999999999961;5457.317835270591;5534.225208470777;5564.1931919871395;5597.048501754712;6120.603065298713;6158.137860699506;6162.7226774795245;6165.907511387333;6179.938200618026;5929.644221346733;5933.762649494059;5935.347111817697;5937.109433584997;5961.970190149108;5788.681622510802;5839;5850.414958504116;5853.1805547222575;5883.882322353529;5831.446012628793;5837.6497410155525;5844.064949608042;5876.970615146897;5884.529237660977;5784.855378615568;5838.737256823453;5840.2991641003355;5844;5875.529957603381;4504.797284122223;4518.051209246029;4535.7732113394195;4541.477730061019;4549.7042692224895;4062.857799977046;4080.657206870799;4093.4269202311702;4099.508059032935;4118.835246590163;5649.689267090267;5649.774009039675;5653.491185793298;5655.886882262332;5691.544676425876;5864.794732184353;5909.763609455659;5962.4633782959745;5964.552658550626;5965.612235204698;5568;5597.328320601554;5621.578381621313;5669.036263835158;5675.517581005578;5181.4300426953005;5185.870353241199;5186;5189.091908915924;5194.948050519522;6002.519798416203;6136.999999999911;6176.073588961602;6197.752089916353;6198.318184999646;5860.267466566679;5881.206037185097;5950.9702451487465;5972.970135149297;6048.4556389923355;6177.486670527338;6195.845103872439;6202;6205.968970155301;6207.81376558704;5916.852078697895;5920.555958303058;5922.111683247547;5924.644521328734;5960.254968128984;5705.030144875464;5728.198052272768;5866.882662346644;5919.260092488439;5935;5844.035734103825;5845.064789633639;5852.970735146468;5858.531317494675;5872.265966754156;5788.652680839163;5847.26909136358;5859.9121013183985;5861.9706901465215;5863.824085277449;5626.521745651666;5653.519450846724;5716.571257155647;5728.656280623176;5816.970915145397;5856.912146317723;5860.033094539353;5861.501772349227;5869.530437564899;5890.4698577128265;5684.658920464785;5693.430656934273;5697.943020569907;5699;5718.3423906249645 21:31:28 INFO - PROCESS | 2866 | |1;ext.html;596.9820905372841;639.3510586754445;652.0512654088302;656.4289068510395;665.3612531969309;35930;39169.8041509792;39199.41200881989;39224.41163382552;39248.41127383088;39089.41365879507;48436.51563484364;49534.256986145236;49628.75185624067;52662.21006684903;9209.861852072225;9270.582823772913;9354.298427617921;9377.390469619488;9382.483963382012;8568.700095496659;8779.912200878005;9238.399504032217;9331.486768227745;9331.813363732721;10961.671149865517;11188.496517656726;11198.496067676933;11575.363355015514;11594.768104637902;11210.159238057138;11269.605563805228;11283.435828208556;11290.491927863184;11295.49170287339;11073.114150867912;11138.665840024812;11139.108871290277;11142.944285278521;11147.554097836077;45967.31049034267;46361.5363846364;46464.535354646694;46599.30101048453;46674;3782.2246439480114;3876.0503676599133;3983.920321593581;4093.89765255868;4411.558844115562;35809.64190358115;35812.283754324766;35983.4602480963;36324;36881.44677829835;4500.504944456107;4514.593686568224;4612;4637.721736695776;4664.473028218161;268125;269649;269662;269888;270279;39975.20049598992;68665;68986;69103.3089669107;69115.65442172757;40358.39462408066;40442.39336409956;40459.19081618351;40485.39271910924;40675;17580.472585822445;17641.558961026076;17739.201735921913;17767.111644417728;17780.288788448575;15223.771643425358;15319.61700957485;15324.23378831054;15325.23373831304;15343.846561534465;9105.317101217435;9241.722748317561;9461.479618621042;9570.90429095714;9689.951550242204;3563.1626567756557;3581.552305961755;3590.281943611236;3634.527511423498;3646.9635303647156;1091.9617813376494;1127.2334812327697;1170.1107158559555;1205.879412058787;1217.141408164979;35047;35126.91664723796;35146.82426587902;35331.11672208215;35427.4685879712;1155.2837240910521;1171.1392126786805;1181.480148734554;1214.356391112694;1250.4998000799753;17839.46481605554;18402.723959140625;18423.631527369376;18437.446876593724;18630.16164272611;587911;588895;592018;593424;597224;63260;63633;63734;63742.36257637457;64055.67972160203;1339.2700977966836;1375.1748950629542;1423.7294913966314;1431.0912570517796;1439.5105664074265;33636;35451;35934;35953.46069809007;36187.81906090453;55075.44924550703;55547.44452555423;55696.72151639216;55720.44279557152;55775;429957;431396;432490;432577;432768;31642.841785790923;32203;32236.516452252767;32276.35447291088;33272.50091248585;52049.479505204465;53095.469045310594;53215;53550.73224633852;54346.72826635841;43106.56893431151;43402.348964766185;43809.56190438055;45027;45380;45757.54242457533;45765.77117114393;46099.76950115362;46244.53755462537;46470.53529464662;43531.347029795215;44198.55801441945;44628.55371446374;44674.3298850524;44770.77614612036;35868;38259.61740382561;38325.808370957966;38494.615053850226;39308.41037384384;28919.120257183215;29233.85383073071;29432;29500.557491637213;29659.851700741357 21:31:28 INFO - PROCESS | 2866 | |2;jquery.html;424.3846422687104;429.15242396267377;438.8643144730897;439.7515403796855;454.51367037270137;19100.90449547752;20420.285290014872;20709.689354659673;21566;21742.673859892115;20367.28714494993;20501.589968200627;20916.686249706265;20995.895020524913;21114.894425527888;5908.320543137541;6181.536384771161;6213.502919766431;6235.812925612239;6243.781467648633;5883.764649414018;6023.518118550527;6059.272887253535;6064.241969753781;6078.483328917047;6024.3674414186535;6025.126356678279;6025.276966763994;6027.306859711123;6030.819075427744;5835.124731290298;6047.425494578008;6066.363031881655;6082.695865206766;6090.208272924536;5498.257735205736;5512.862178445531;5517.062099443105;5519.254900588409;5563.109902415635;14752.55742327732;15485.303161357766;15490.380384784596;15530.767038494432;15538.61153471161;2473.8763061846835;2487.0797804812155;2515.710693270279;2516.3709072731817;2646.431017331264;10993.230473866832;11014.339139651647;11112.55549778016;11248.887511124865;11379.886201137966;2025.5948810237865;2141.4325203821;2227.142550118216;2268.4895898422888;2298.0348253733473;61859.690701546206;74837.62581187114;89720;92155.53922230346;93897;12051.397430128458;12062.51749929993;12112.152149349637;12267.877321226673;12369.62891113268;17596.472105836845;17609.7358539622;17628.559286017695;17670.91164544195;17689.911550442423;8114.229148230908;8833.734987950373;9069.86626671666;9253.074692530829;9305.348625596278;9204.4477331359;9205.401648892801;9220.308476864262;9415.717528474157;9415.717528474157;5221.295125158131;5222.616006758212;5247.553957913544;5368.677879327175;5416.647917885325;2068.6586713192455;2150.8817015064324;2157.1587081038406;2181.858179218346;2190.080166330145;902.3503077783985;975.6390135649855;998.2647545724662;1003.3227571389283;1023.8976102389851;18856.05719714009;20383.286584969454;20523.58952820965;20604.79395206029;21019;1027.686555600549;1036.6838114375037;1041.5000799616228;1046.5552140340326;1130.0789856267115;10747.677569672922;11575.76848463043;11648.126390520745;11674.533018679158;11679.824802627967;491656;498079;507862;527155;528296;99028;103121.48439257756;103343.48328258311;104762;105002;978.8433850584015;992.5731935267904;1017.898210178991;1019.0064686930184;1042.5725452564411;14181.574552763434;18327.450176494192;18961.525961851064;19186.520336991685;19219.03904804782;44528;44957;45693;46289.53710462852;46884.53115468802;60436.395636044836;60794.69602651958;61175;61358;61836.38163618486;9182.127697868691;9340.233630006347;9368.812623747623;9450.291228157777;9604.423734575948;13184.406701698255;13752.587422377344;13785.724285514434;14107.153570785786;14282.2144782038;12051.33717645538;12052.457639406073;12160;12195.268283902995;12290.324032178316;12137.575184868487;12189.634310970685;12266.815997759863;12274.263544187377;12445.564405245774;12042.63872083839;12205.572804951784;12269.325187114795;12349.814752778535;12362.072844536875;8373;8662.523561204194;9268.582913768762;9653.613855445985;9702;9020.413673111227;9245.214156796748;9509.239260859253;9797.363171393836;9847.359921605359 21:31:28 INFO - PROCESS | 2866 | |3;mootools.html;1490.917999510027;1513.3870782333156;1665.117487731502;1761.7357396390548;1793.6143729098242;8602.440841345317;9212.401193922391;9310.836145481815;9311;9322.067793220675;7766.766996990085;8053.355731541477;8671.523066231355;8906.554672266393;9249.167574918256;2546.363409147713;2565.6279839423273;2568.4863027394595;2578.6132080187936;2580.7419258074137;2509.6862892138483;2601.0636170978432;2601.0766178006725;2605.6091586262023;2613.3335999320147;2370.8221883358733;2382.916597919073;2433.926982190528;2439.7194322652854;2443.0472115874823;2487.9751202487923;2493.0277191895175;2506.586413241822;2563.9615405768927;2564.4614630927526;2416.093964763214;2455.1529722245796;2457.6559281700575;2465.0386349323776;2498.3129639349145;9014.459132452073;9046.185843274137;9097.863532047024;9112.316576256808;9122.81754364909;5615.775368985236;5771.826845194651;5782.537397008229;5783.074708046693;5800.651960882361;3478.165240342325;3581.08682286018;3621.7826930384;3622.7464077514583;3665.87169449068;1240.5161986825146;1243.4280231093708;1244.7821631214501;2238.8320875934205;2285.874276914769;12172.695682607917;12236.81644775329;12246.142770006103;12247.69380765488;12269.754604907852;4876.146674331978;4948.505149485023;4984.7258400788305;5063.493650634907;5076.44159142494;10101.494925253708;10113.64602238918;10119.089281964658;10139.340942838691;10144.746381340525;5708.0581704019205;5709.514691251207;5723.427657234243;5729.25519682447;5734;4710.4347478302825;4717.95282047182;5264.894702106013;5295.629305948547;5349.491798279158;3979.303621866162;4040.333344998101;4077.734947228421;4132.669386449077;4146.813393397304;1261.2180448122224;1271.313490715022;1284.4797856867983;1295.5077070713069;1296.3906963727222;986.3785814936545;1013.3717095400899;1016.1312078173204;1016.7559785651538;1019.898010198989;5862.325832529228;6048.546359023091;6199.814005579839;6255.749770009149;6385.042243663394;464.80710505140667;490.9239067944474;491.58706686383607;498.1307618206253;1033.3438266700548;3803.581606023335;3898.3567711327314;3989.2420440116866;4047.919041619151;4097.262492751273;10840.891591083988;11137.665870023913;11138.66584002465;11163.218574699855;11205.551777928955;10430.217733670004;10736;10874.510647020903;11043.668689939315;11043.668689939315;7748.186440423787;7930.365570754326;8166.918330816735;8326.750197494084;8329.33365330772;6065.211522502046;6093.421124993119;6180.412860778219;6189.164462797645;6342.112104305309;10005;10160.491975401053;10242.590296388062;10295.53670084863;10335.069843714102;10261.692149235534;10314.27800053989;10518;10607.257491975797;10622.73443163896;7175.354218120394;7369.336759691653;7422.331990120699;7625.428092892944;7654.846903062019;8479.32165426752;8806.251468624981;8809.64761409562;8810.911890881009;8816.206541411304;7888.2506161914525;7916.6437510311025;7934.2859142677435;8016.158303378062;8235.176482351717;7748.108967468813;7862.646180921986;7915.208479152038;7950.24472675095;8025.839483210187;6691.765788197585;6754.729810807513;6790.219124800711;6927.965360173167;6940.757073502403;5072.0870243355075;5110.64225504226;5224.50367215114;5243.921341179962;5473.726313684379;5401.351837779492;5473.808416705396;5501.614886958035;5511.200875873056;5514.503694667499 21:31:28 INFO - PROCESS | 2866 | |4;prototype.html;359.7589614957978;360.5313092979126;368.0981595092025;370.1874385723337;371.10378436076877;5320.733963301839;5447.237386765856;5482.451754824516;5548.611597188194;5576.944230557693;5323.680579165253;5445.237666726652;5447.291852059237;5467.726613669311;5473.917891231625;4406.294992801152;4411.64706823455;4417.182821178077;4417.911641767163;4427.845025424111;4251.574842515754;4353.825846966118;4413.955860441402;4416.97791511042;4420.8673739787855;4345.5654434556445;4347.3261644445165;4366.956330436687;4370.366296886949;4373.759443230621;4356.368326592658;4369.890752731176;4374.212641724473;4376.781160941972;4378.64970802335;3715.7584756990977;3803.8668646597234;3815.294170578424;3845.0771814764535;3851.5763266040713;5306.151015837486;5338.225957236179;5354.12605588045;5361.544268737162;5379.811706590251;4980.078685443168;4983.377077865267;4988.152014157566;4988.301637770715;4999.275105109775;5560.6941618210985;5741.569382296303;5765.711714414262;5779.537636989073;5783.334916484574;4229.97885010576;4234.407182994383;4235.449391579105;4237.559229861862;4240.766757828318;5727.856803579903;5935.821925342247;5961.076033214858;5994.880102397971;5998.550108741818;4173.290540608104;4188.246115699203;4204.726692764961;4204.810783514749;4213.557576454428;4261.786910654455;4262.509811371732;4262.978685106555;4265.3601959705675;4287.256156060124;4856.4415092264135;4866.002469493746;4873.488283730228;4876.195427754381;4878.975605121952;5475.972620136953;5638.407967163471;5716.542676585863;5722.628029178173;5758.683272420057;1445.169027809014;1510.6978604278968;1552.3712896277025;1569.2781320592655;1570.9239171167787;1070.983935240972;1088.8530048443517;1099.769048499824;1108.1744100645071;1113.2986218682179;4807.879803004953;4816.927746083811;4822.228443449031;4835.709857408567;4869;5103.157978933508;5109.802784802496;5122.974385128051;5128.410232823273;5139;4538.750368729751;4851.762800485853;4875.390576177978;4890.339804126468;4899.314096026559;2715.714849940767;2736.6031925370708;2742.245882382361;2751;2753;5218.739063046833;5251.927622340897;5262.947370526245;5272.815451459257;5275.736213189325;4809.519048095162;5184.948150518522;5204.76578553966;5212.947870521322;5233.712145832016;5196.298499702491;5225.686458812484;5228.869278267997;5245.527902488794;5266.710330931835;5072.28987941681;5104.438511763778;5109.97800439906;5123.436421993652;5132.692038477703;4731.668783185144;5041.294218809297;5053.772580233825;5064.569511591556;5091.949080509147;5144.5595233334725;5196.636235463481;5199.350081239845;5221.407470721315;5247.396549396715;3973.6821054315005;3977.4033894914837;3981.3231750603045;3993.6405723485027;3994.7403418777685;4967.230079337708;5070.543651071422;5093.784203871328;5103.897922041464;5173.508516690908;4965.677230979974;4984.8753781155765;4992.201247800334;5003.6982987826;5006.774695138801;4900.338454308765;4907.141250281115;4992.750362481934;4999.525045120708;5016.272640467038;4710.9764451177525;4897.583705385082;4934.7285899275885;4956.959038601934;5031.962055367582;4940.802367905388;4976.63609785349;4989.55094041538;4994.400671919393;5020.974895125647;4837.854864354075;4889.877753056202;4908.754562271801;4915.631327650369;4953.23224900141 21:31:28 INFO - PROCESS | 2866 | |5;yui.html;825.150095401736;833.5498830631461;848.1603212819307;883.4743327720005;940.5861420974767;16044.919775401122;16830.07434591097;16891.239894204744;16936.4072257471;16947.152642367895;14964.7007059859;15032;15050.774238386406;15126.168060756654;15132;712.6899798587605;730.014480451389;845.5814371885925;870.3081050564816;872.4590753732695;876.369014309696;878.4729162502512;879.8284334554764;881.4579033894141;881.7795551112222;918.2470374293082;919.0533750237266;919.1314208073373;919.6919032124247;922.1193759959223;920.6731610278322;921.1893533690343;921.5484412637826;921.6313474610142;921.9953900230523;681.8397676546008;682.0860047536326;682.9487788415839;683.3371629519359;683.8598087392073;15032.323545440371;15185.316660750183;15211.467598633995;15220.923895380563;15254;14276.785848212285;14404;14449.277536123152;14807.333669984877;16032.679346413122;13840.723185536333;13855.86144138566;13970.371333290026;14116.929415352857;14557.78163327551;4746.169420351459;4881.096997055556;4911.729854857981;4993.625478089158;5044.899102017976;86432;86752;87487.12512874854;87661.56169219177;89050;11674.299542027506;11887.940560297144;11978.64064078079;12158.939205304094;12224.388780561114;20645.89677051605;20842.1663133476;20878;20905.895470522853;21222.363329100153;8950.86573701395;9035.141661542142;9188.127127922837;9369.859452108223;9414.105659962293;5017.071841709296;5168.793248270103;5238.449962753933;5261.579073674096;5367.570594352443;3511.94732079019;3656.305301992613;3659.8536058557893;3661.7986010769664;4037.717359784787;694.4895501806168;702.8488874891821;703.4723957032226;706.0750416953807;708.9929100708927;746.5781833264189;750.223518658197;758.309937956457;773.1032002876636;781.3827076609415;10520.263581549218;10603.204759642904;10701.571937122584;10905.945470272756;10938.343699378063;656.4912193050328;666.8299583606149;700.4746440169872;778.2917545034105;799.8280369720538;4425.247707889666;4872.366592342973;4941.777620007037;5025.773195876274;5158;72463.63768181125;112431.4378428119;123982;126245.36877315739;129375.35312323378;68009;108022;109722;111906;112866.43566782113;95643.52178239064;99159;99174.5041274789;100745.49627251817;101212.49393752984;9977.653016842632;9995.500224988577;10038.397696138256;10071.496425178859;10154.898451015692;54404.18393724018;56320.47181127582;56601.150982736115;56694.14958775704;57716;72789.27210727824;76308.61845690737;86210;86507.56746216229;87318.56340718256;12178.512859485876;12783.360831958551;12805.743885122432;12874.16317939331;12924.483020679443;14631.341589628279;14789.630259243606;14810.851891480947;14892;15626.687466250383;13210.471581137032;13381.799273011107;13457.259850708306;13658.112222705493;13931.58205253844;13107.14803537767;13224.801627975781;13325.466981320638;13483.932580337036;13736.10715303502;13058.934705326412;13148.802767958297;13344.532941347006;13773.862261377259;13926.651833704238;10204.18366530661;10316.484175791331;10503.789924201626;10507.31702439339;11137.10903127764;10894.891051089387;11683.34795734756;11827.822582661094;11905.285682859056;11933.045356371296 21:31:28 INFO - PROCESS | 2866 | __end_tp_report 21:31:28 INFO - PROCESS | 2866 | __start_cc_report 21:31:28 INFO - PROCESS | 2866 | _x_x_mozilla_cycle_collect,937 21:31:28 INFO - PROCESS | 2866 | __end_cc_report 21:31:28 INFO - PROCESS | 2866 | __startTimestamp1480397488672__endTimestamp 21:31:28 INFO - PROCESS | 2866 | 21:31:28 INFO - PROCESS | 2866 | ------- Summary: start ------- 21:31:28 INFO - PROCESS | 2866 | Number of tests: 6 21:31:28 INFO - PROCESS | 2866 | 21:31:28 INFO - PROCESS | 2866 | [#0] dojo.html Cycles:165 Average:5522.87 Median:5716.57 stddev:624.96 (10.9%) stddev-sans-first:597.51 21:31:28 INFO - PROCESS | 2866 | Values: 3109.5 3136.1 3152.7 3166.9 3181.9 5431.4 5514.8 5515.9 5525.9 5544.0 5583.2 5583.8 5611.5 5611.9 5633.0 5112.6 5119.4 5143.8 5166.8 5185.5 5033.3 5100.3 5138.8 5145.6 5173.2 5011.8 5046.8 5052.3 5103.2 5104.0 5071.6 5096.6 5102.1 5171.8 5192.1 4976.8 5079.6 5122.0 5130.6 5140.2 5326.2 5372.3 5420.0 5429.8 5490.0 5818.5 5839.2 5844.6 5903.0 5937.6 5973.9 5982.0 5988.5 5991.0 5994.2 5405.0 5457.3 5534.2 5564.2 5597.0 6120.6 6158.1 6162.7 6165.9 6179.9 5929.6 5933.8 5935.3 5937.1 5962.0 5788.7 5839.0 5850.4 5853.2 5883.9 5831.4 5837.6 5844.1 5877.0 5884.5 5784.9 5838.7 5840.3 5844.0 5875.5 4504.8 4518.1 4535.8 4541.5 4549.7 4062.9 4080.7 4093.4 4099.5 4118.8 5649.7 5649.8 5653.5 5655.9 5691.5 5864.8 5909.8 5962.5 5964.6 5965.6 5568.0 5597.3 5621.6 5669.0 5675.5 5181.4 5185.9 5186.0 5189.1 5194.9 6002.5 6137.0 6176.1 6197.8 6198.3 5860.3 5881.2 5951.0 5973.0 6048.5 6177.5 6195.8 6202.0 6206.0 6207.8 5916.9 5920.6 5922.1 5924.6 5960.3 5705.0 5728.2 5866.9 5919.3 5935.0 5844.0 5845.1 5853.0 5858.5 5872.3 5788.7 5847.3 5859.9 5862.0 5863.8 5626.5 5653.5 5716.6 5728.7 5817.0 5856.9 5860.0 5861.5 5869.5 5890.5 5684.7 5693.4 5697.9 5699.0 5718.3 21:31:28 INFO - PROCESS | 2866 | 21:31:28 INFO - PROCESS | 2866 | [#1] ext.html Cycles:180 Average:60355.94 Median:39236.41 stddev:119917.27 (305.6%) stddev-sans-first:120169.73 21:31:28 INFO - PROCESS | 2866 | Values: 597.0 639.4 652.1 656.4 665.4 35930.0 39169.8 39199.4 39224.4 39248.4 39089.4 48436.5 49534.3 49628.8 52662.2 9209.9 9270.6 9354.3 9377.4 9382.5 8568.7 8779.9 9238.4 9331.5 9331.8 10961.7 11188.5 11198.5 11575.4 11594.8 11210.2 11269.6 11283.4 11290.5 11295.5 11073.1 11138.7 11139.1 11142.9 11147.6 45967.3 46361.5 46464.5 46599.3 46674.0 3782.2 3876.1 3983.9 4093.9 4411.6 35809.6 35812.3 35983.5 36324.0 36881.4 4500.5 4514.6 4612.0 4637.7 4664.5 268125.0 269649.0 269662.0 269888.0 270279.0 39975.2 68665.0 68986.0 69103.3 69115.7 40358.4 40442.4 40459.2 40485.4 40675.0 17580.5 17641.6 17739.2 17767.1 17780.3 15223.8 15319.6 15324.2 15325.2 15343.8 9105.3 9241.7 9461.5 9570.9 9690.0 3563.2 3581.6 3590.3 3634.5 3647.0 1092.0 1127.2 1170.1 1205.9 1217.1 35047.0 35126.9 35146.8 35331.1 35427.5 1155.3 1171.1 1181.5 1214.4 1250.5 17839.5 18402.7 18423.6 18437.4 18630.2 587911.0 588895.0 592018.0 593424.0 597224.0 63260.0 63633.0 63734.0 63742.4 64055.7 1339.3 1375.2 1423.7 1431.1 1439.5 33636.0 35451.0 35934.0 35953.5 36187.8 55075.4 55547.4 55696.7 55720.4 55775.0 429957.0 431396.0 432490.0 432577.0 432768.0 31642.8 32203.0 32236.5 32276.4 33272.5 52049.5 53095.5 53215.0 53550.7 54346.7 43106.6 43402.3 43809.6 45027.0 45380.0 45757.5 45765.8 46099.8 46244.5 46470.5 43531.3 44198.6 44628.6 44674.3 44770.8 35868.0 38259.6 38325.8 38494.6 39308.4 28919.1 29233.9 29432.0 29500.6 29659.9 21:31:28 INFO - PROCESS | 2866 | 21:31:28 INFO - PROCESS | 2866 | [#2] jquery.html Cycles:180 Average:30349.07 Median:2501.40 stddev:84402.71 (3374.2%) stddev-sans-first:84609.58 21:31:28 INFO - PROCESS | 2866 | Values: 424.4 429.2 438.9 439.8 454.5 19100.9 20420.3 20709.7 21566.0 21742.7 20367.3 20501.6 20916.7 20995.9 21114.9 5908.3 6181.5 6213.5 6235.8 6243.8 5883.8 6023.5 6059.3 6064.2 6078.5 6024.4 6025.1 6025.3 6027.3 6030.8 5835.1 6047.4 6066.4 6082.7 6090.2 5498.3 5512.9 5517.1 5519.3 5563.1 14752.6 15485.3 15490.4 15530.8 15538.6 2473.9 2487.1 2515.7 2516.4 2646.4 10993.2 11014.3 11112.6 11248.9 11379.9 2025.6 2141.4 2227.1 2268.5 2298.0 61859.7 74837.6 89720.0 92155.5 93897.0 12051.4 12062.5 12112.2 12267.9 12369.6 17596.5 17609.7 17628.6 17670.9 17689.9 8114.2 8833.7 9069.9 9253.1 9305.3 9204.4 9205.4 9220.3 9415.7 9415.7 5221.3 5222.6 5247.6 5368.7 5416.6 2068.7 2150.9 2157.2 2181.9 2190.1 902.4 975.6 998.3 1003.3 1023.9 18856.1 20383.3 20523.6 20604.8 21019.0 1027.7 1036.7 1041.5 1046.6 1130.1 10747.7 11575.8 11648.1 11674.5 11679.8 491656.0 498079.0 507862.0 527155.0 528296.0 99028.0 103121.5 103343.5 104762.0 105002.0 978.8 992.6 1017.9 1019.0 1042.6 14181.6 18327.5 18961.5 19186.5 19219.0 44528.0 44957.0 45693.0 46289.5 46884.5 60436.4 60794.7 61175.0 61358.0 61836.4 9182.1 9340.2 9368.8 9450.3 9604.4 13184.4 13752.6 13785.7 14107.2 14282.2 12051.3 12052.5 12160.0 12195.3 12290.3 12137.6 12189.6 12266.8 12274.3 12445.6 12042.6 12205.6 12269.3 12349.8 12362.1 8373.0 8662.5 9268.6 9653.6 9702.0 9020.4 9245.2 9509.2 9797.4 9847.4 21:31:28 INFO - PROCESS | 2866 | 21:31:28 INFO - PROCESS | 2866 | [#3] mootools.html Cycles:180 Average:5934.90 Median:2587.62 stddev:3273.48 (126.5%) stddev-sans-first:3265.63 21:31:28 INFO - PROCESS | 2866 | Values: 1490.9 1513.4 1665.1 1761.7 1793.6 8602.4 9212.4 9310.8 9311.0 9322.1 7766.8 8053.4 8671.5 8906.6 9249.2 2546.4 2565.6 2568.5 2578.6 2580.7 2509.7 2601.1 2601.1 2605.6 2613.3 2370.8 2382.9 2433.9 2439.7 2443.0 2488.0 2493.0 2506.6 2564.0 2564.5 2416.1 2455.2 2457.7 2465.0 2498.3 9014.5 9046.2 9097.9 9112.3 9122.8 5615.8 5771.8 5782.5 5783.1 5800.7 3478.2 3581.1 3621.8 3622.7 3665.9 1240.5 1243.4 1244.8 2238.8 2285.9 12172.7 12236.8 12246.1 12247.7 12269.8 4876.1 4948.5 4984.7 5063.5 5076.4 10101.5 10113.6 10119.1 10139.3 10144.7 5708.1 5709.5 5723.4 5729.3 5734.0 4710.4 4718.0 5264.9 5295.6 5349.5 3979.3 4040.3 4077.7 4132.7 4146.8 1261.2 1271.3 1284.5 1295.5 1296.4 986.4 1013.4 1016.1 1016.8 1019.9 5862.3 6048.5 6199.8 6255.7 6385.0 464.8 490.9 491.6 498.1 1033.3 3803.6 3898.4 3989.2 4047.9 4097.3 10840.9 11137.7 11138.7 11163.2 11205.6 10430.2 10736.0 10874.5 11043.7 11043.7 7748.2 7930.4 8166.9 8326.8 8329.3 6065.2 6093.4 6180.4 6189.2 6342.1 10005.0 10160.5 10242.6 10295.5 10335.1 10261.7 10314.3 10518.0 10607.3 10622.7 7175.4 7369.3 7422.3 7625.4 7654.8 8479.3 8806.3 8809.6 8810.9 8816.2 7888.3 7916.6 7934.3 8016.2 8235.2 7748.1 7862.6 7915.2 7950.2 8025.8 6691.8 6754.7 6790.2 6928.0 6940.8 5072.1 5110.6 5224.5 5243.9 5473.7 5401.4 5473.8 5501.6 5511.2 5514.5 21:31:28 INFO - PROCESS | 2866 | 21:31:28 INFO - PROCESS | 2866 | [#4] prototype.html Cycles:180 Average:4518.95 Median:4937.77 stddev:1229.26 (24.9%) stddev-sans-first:1192.41 21:31:28 INFO - PROCESS | 2866 | Values: 359.8 360.5 368.1 370.2 371.1 5320.7 5447.2 5482.5 5548.6 5576.9 5323.7 5445.2 5447.3 5467.7 5473.9 4406.3 4411.6 4417.2 4417.9 4427.8 4251.6 4353.8 4414.0 4417.0 4420.9 4345.6 4347.3 4367.0 4370.4 4373.8 4356.4 4369.9 4374.2 4376.8 4378.6 3715.8 3803.9 3815.3 3845.1 3851.6 5306.2 5338.2 5354.1 5361.5 5379.8 4980.1 4983.4 4988.2 4988.3 4999.3 5560.7 5741.6 5765.7 5779.5 5783.3 4230.0 4234.4 4235.4 4237.6 4240.8 5727.9 5935.8 5961.1 5994.9 5998.6 4173.3 4188.2 4204.7 4204.8 4213.6 4261.8 4262.5 4263.0 4265.4 4287.3 4856.4 4866.0 4873.5 4876.2 4879.0 5476.0 5638.4 5716.5 5722.6 5758.7 1445.2 1510.7 1552.4 1569.3 1570.9 1071.0 1088.9 1099.8 1108.2 1113.3 4807.9 4816.9 4822.2 4835.7 4869.0 5103.2 5109.8 5123.0 5128.4 5139.0 4538.8 4851.8 4875.4 4890.3 4899.3 2715.7 2736.6 2742.2 2751.0 2753.0 5218.7 5251.9 5262.9 5272.8 5275.7 4809.5 5184.9 5204.8 5212.9 5233.7 5196.3 5225.7 5228.9 5245.5 5266.7 5072.3 5104.4 5110.0 5123.4 5132.7 4731.7 5041.3 5053.8 5064.6 5091.9 5144.6 5196.6 5199.4 5221.4 5247.4 3973.7 3977.4 3981.3 3993.6 3994.7 4967.2 5070.5 5093.8 5103.9 5173.5 4965.7 4984.9 4992.2 5003.7 5006.8 4900.3 4907.1 4992.8 4999.5 5016.3 4711.0 4897.6 4934.7 4957.0 5032.0 4940.8 4976.6 4989.6 4994.4 5021.0 4837.9 4889.9 4908.8 4915.6 4953.2 21:31:28 INFO - PROCESS | 2866 | 21:31:28 INFO - PROCESS | 2866 | [#5] yui.html Cycles:180 Average:22075.30 Median:3660.83 stddev:32179.95 (879.0%) stddev-sans-first:32230.66 21:31:28 INFO - PROCESS | 2866 | Values: 825.2 833.5 848.2 883.5 940.6 16044.9 16830.1 16891.2 16936.4 16947.2 14964.7 15032.0 15050.8 15126.2 15132.0 712.7 730.0 845.6 870.3 872.5 876.4 878.5 879.8 881.5 881.8 918.2 919.1 919.1 919.7 922.1 920.7 921.2 921.5 921.6 922.0 681.8 682.1 682.9 683.3 683.9 15032.3 15185.3 15211.5 15220.9 15254.0 14276.8 14404.0 14449.3 14807.3 16032.7 13840.7 13855.9 13970.4 14116.9 14557.8 4746.2 4881.1 4911.7 4993.6 5044.9 86432.0 86752.0 87487.1 87661.6 89050.0 11674.3 11887.9 11978.6 12158.9 12224.4 20645.9 20842.2 20878.0 20905.9 21222.4 8950.9 9035.1 9188.1 9369.9 9414.1 5017.1 5168.8 5238.4 5261.6 5367.6 3511.9 3656.3 3659.9 3661.8 4037.7 694.5 702.8 703.5 706.1 709.0 746.6 750.2 758.3 773.1 781.4 10520.3 10603.2 10701.6 10905.9 10938.3 656.5 666.8 700.5 778.3 799.8 4425.2 4872.4 4941.8 5025.8 5158.0 72463.6 112431.4 123982.0 126245.4 129375.4 68009.0 108022.0 109722.0 111906.0 112866.4 95643.5 99159.0 99174.5 100745.5 101212.5 9977.7 9995.5 10038.4 10071.5 10154.9 54404.2 56320.5 56601.2 56694.1 57716.0 72789.3 76308.6 86210.0 86507.6 87318.6 12178.5 12783.4 12805.7 12874.2 12924.5 14631.3 14789.6 14810.9 14892.0 15626.7 13210.5 13381.8 13457.3 13658.1 13931.6 13107.1 13224.8 13325.5 13483.9 13736.1 13058.9 13148.8 13344.5 13773.9 13926.7 10204.2 10316.5 10503.8 10507.3 11137.1 10894.9 11683.3 11827.8 11905.3 11933.0 21:31:28 INFO - PROCESS | 2866 | -------- Summary: end -------- 21:31:28 INFO - PROCESS | 2866 | 21:31:29 INFO - TEST-INFO | 2866: exit 0 21:31:29 INFO - TEST-OK | dromaeo_css | took 1113012ms 21:31:29 INFO - TEST-START | kraken 21:31:29 INFO - operating with platform_type : linux_ 21:31:29 INFO - Initialising browser for kraken test... 21:31:29 INFO - TEST-INFO | started process 3203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmmpVk5/profile http://localhost:53705/getInfo.html) 21:31:33 INFO - PROCESS | 3203 | __metrics Screen width/height:1600/1200 21:31:33 INFO - PROCESS | 3203 | colorDepth:24 21:31:33 INFO - PROCESS | 3203 | Browser inner width/height: 1024/697 21:31:33 INFO - PROCESS | 3203 | __metrics 21:31:33 INFO - PROCESS | 3203 | 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" 21:31:33 INFO - PROCESS | 3203 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:31:34 INFO - PROCESS | 3203 | console.error: PushService: 21:31:34 INFO - PROCESS | 3203 | stateChangeProcessEnqueue: Error transitioning state 21:31:34 INFO - PROCESS | 3203 | UnknownError 21:31:34 INFO - TEST-INFO | 3203: exit 0 21:31:34 INFO - Browser initialized. 21:31:34 INFO - Running cycle 1/1 for kraken test... 21:31:34 INFO - TEST-INFO | started process 3296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmmpVk5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:31:46 INFO - PROCESS | 3296 | RSS: Main: 143622144 21:31:46 INFO - PROCESS | 3296 | 21:31:49 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53705/tests/kraken/driver.html?testName=audio-beat-detection) 21:31:50 INFO - PROCESS | 3296 | RSS: Main: 187805696 21:31:50 INFO - PROCESS | 3296 | 21:31:52 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53705/tests/kraken/driver.html?testName=audio-dft) 21:31:53 INFO - PROCESS | 3296 | RSS: Main: 175394816 21:31:53 INFO - PROCESS | 3296 | 21:31:55 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53705/tests/kraken/driver.html?testName=audio-fft) 21:31:56 INFO - PROCESS | 3296 | RSS: Main: 265850880 21:31:56 INFO - PROCESS | 3296 | 21:31:58 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53705/tests/kraken/driver.html?testName=audio-oscillator) 21:31:59 INFO - PROCESS | 3296 | RSS: Main: 172544000 21:31:59 INFO - PROCESS | 3296 | 21:32:01 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53705/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:32:01 INFO - PROCESS | 3296 | RSS: Main: 174338048 21:32:01 INFO - PROCESS | 3296 | 21:32:04 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53705/tests/kraken/driver.html?testName=imaging-darkroom) 21:32:05 INFO - PROCESS | 3296 | RSS: Main: 210124800 21:32:05 INFO - PROCESS | 3296 | 21:32:08 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53705/tests/kraken/driver.html?testName=imaging-desaturate) 21:32:09 INFO - PROCESS | 3296 | RSS: Main: 209375232 21:32:09 INFO - PROCESS | 3296 | 21:32:12 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53705/tests/kraken/driver.html?testName=json-parse-financial) 21:32:12 INFO - PROCESS | 3296 | RSS: Main: 208699392 21:32:12 INFO - PROCESS | 3296 | 21:32:14 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53705/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:32:14 INFO - PROCESS | 3296 | RSS: Main: 170090496 21:32:14 INFO - PROCESS | 3296 | 21:32:16 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53705/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:32:17 INFO - PROCESS | 3296 | RSS: Main: 177770496 21:32:17 INFO - PROCESS | 3296 | 21:32:19 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53705/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:32:19 INFO - PROCESS | 3296 | RSS: Main: 186986496 21:32:19 INFO - PROCESS | 3296 | 21:32:22 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:32:22 INFO - PROCESS | 3296 | RSS: Main: 196272128 21:32:22 INFO - PROCESS | 3296 | 21:32:25 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:32:26 INFO - PROCESS | 3296 | RSS: Main: 193470464 21:32:26 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | Cycle 1(1): loaded http://localhost:53705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53705/tests/kraken/driver.html?testName=ai-astar) 21:32:27 INFO - PROCESS | 3296 | RSS: Main: 244224000 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | __start_tp_report 21:32:27 INFO - PROCESS | 3296 | _x_x_mozilla_page_load 21:32:27 INFO - PROCESS | 3296 | _x_x_mozilla_page_load_details 21:32:27 INFO - PROCESS | 3296 | |i|pagename|runs| 21:32:27 INFO - PROCESS | 3296 | |0;ai-astar;110;108;109;110;110;110;109;110;109;110 21:32:27 INFO - PROCESS | 3296 | |1;audio-beat-detection;141;119;118;152;117;117;116;115;147;118 21:32:27 INFO - PROCESS | 3296 | |2;audio-dft;160;160;160;161;160;161;160;161;160;160 21:32:27 INFO - PROCESS | 3296 | |3;audio-fft;74;75;75;120;75;75;77;74;97;77 21:32:27 INFO - PROCESS | 3296 | |4;audio-oscillator;83;81;124;83;83;82;110;82;82;113 21:32:27 INFO - PROCESS | 3296 | |5;imaging-gaussian-blur;117;116;117;117;117;116;116;117;116;117 21:32:27 INFO - PROCESS | 3296 | |6;imaging-darkroom;145;145;146;145;145;146;145;145;146;146 21:32:27 INFO - PROCESS | 3296 | |7;imaging-desaturate;95;94;95;95;95;96;94;95;95;95 21:32:27 INFO - PROCESS | 3296 | |8;json-parse-financial;51;51;52;61;49;49;50;50;49;49 21:32:27 INFO - PROCESS | 3296 | |9;json-stringify-tinderbox;58;58;57;59;59;58;58;58;58;59 21:32:27 INFO - PROCESS | 3296 | |10;stanford-crypto-aes;74;73;73;74;82;74;81;72;73;72 21:32:27 INFO - PROCESS | 3296 | |11;stanford-crypto-ccm;119;120;121;120;119;126;118;118;161;120 21:32:27 INFO - PROCESS | 3296 | |12;stanford-crypto-pbkdf2;151;151;156;152;153;159;150;151;156;156 21:32:27 INFO - PROCESS | 3296 | |13;stanford-crypto-sha256-iterative;62;61;61;61;61;63;59;61;62;61 21:32:27 INFO - PROCESS | 3296 | __end_tp_report 21:32:27 INFO - PROCESS | 3296 | __start_cc_report 21:32:27 INFO - PROCESS | 3296 | _x_x_mozilla_cycle_collect,1611 21:32:27 INFO - PROCESS | 3296 | __end_cc_report 21:32:27 INFO - PROCESS | 3296 | __startTimestamp1480397547915__endTimestamp 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | ------- Summary: start ------- 21:32:27 INFO - PROCESS | 3296 | Number of tests: 14 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:0.71 (0.6%) stddev-sans-first:0.73 21:32:27 INFO - PROCESS | 3296 | Values: 110.0 108.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 110.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:118.50 stddev:14.54 (12.3%) stddev-sans-first:14.37 21:32:27 INFO - PROCESS | 3296 | Values: 141.0 119.0 118.0 152.0 117.0 117.0 116.0 115.0 147.0 118.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 21:32:27 INFO - PROCESS | 3296 | Values: 160.0 160.0 160.0 161.0 160.0 161.0 160.0 161.0 160.0 160.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:15.07 (20.1%) stddev-sans-first:15.71 21:32:27 INFO - PROCESS | 3296 | Values: 74.0 75.0 75.0 120.0 75.0 75.0 77.0 74.0 97.0 77.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:82.00 stddev:16.51 (20.1%) stddev-sans-first:17.16 21:32:27 INFO - PROCESS | 3296 | Values: 83.0 81.0 124.0 83.0 83.0 82.0 110.0 82.0 82.0 113.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 21:32:27 INFO - PROCESS | 3296 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 21:32:27 INFO - PROCESS | 3296 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:32:27 INFO - PROCESS | 3296 | Values: 95.0 94.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:50.50 stddev:3.63 (7.2%) stddev-sans-first:3.86 21:32:27 INFO - PROCESS | 3296 | Values: 51.0 51.0 52.0 61.0 49.0 49.0 50.0 50.0 49.0 49.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 21:32:27 INFO - PROCESS | 3296 | Values: 58.0 58.0 57.0 59.0 59.0 58.0 58.0 58.0 58.0 59.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:74.00 stddev:3.61 (4.9%) stddev-sans-first:3.82 21:32:27 INFO - PROCESS | 3296 | Values: 74.0 73.0 73.0 74.0 82.0 74.0 81.0 72.0 73.0 72.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:120.00 stddev:13.13 (10.9%) stddev-sans-first:13.79 21:32:27 INFO - PROCESS | 3296 | Values: 119.0 120.0 121.0 120.0 119.0 126.0 118.0 118.0 161.0 120.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:154.50 stddev:3.03 (2.0%) stddev-sans-first:3.07 21:32:27 INFO - PROCESS | 3296 | Values: 151.0 151.0 156.0 152.0 153.0 159.0 150.0 151.0 156.0 156.0 21:32:27 INFO - PROCESS | 3296 | 21:32:27 INFO - PROCESS | 3296 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:1.03 (1.7%) stddev-sans-first:1.05 21:32:27 INFO - PROCESS | 3296 | Values: 62.0 61.0 61.0 61.0 61.0 63.0 59.0 61.0 62.0 61.0 21:32:27 INFO - PROCESS | 3296 | -------- Summary: end -------- 21:32:27 INFO - PROCESS | 3296 | 21:32:28 INFO - TEST-INFO | 3296: exit 0 21:32:28 INFO - TEST-OK | kraken | took 59493ms 21:32:28 INFO - SUITE-END | took 1172s 21:32:29 INFO - Completed test suite (00:19:32) 21:32:29 INFO - javascript benchmark 21:32:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.54911537827, 3136.1375621704024, 3152.653208147103, 3166.8891588794395, 3181.888633897814, 5431.402545719968, 5514.751836167372, 5515.862103447411, 5525.861853453665, 5544.0, 5583.190437386576, 5583.832485025446, 5611.523020543259, 5611.887762244753, 5632.971835140818, 5112.642115051948, 5119.411267704215, 5143.81996630118, 5166.844994650167, 5185.507376799198, 5033.295338652591, 5100.260462232974, 5138.768755405997, 5145.614078944075, 5173.249878767595, 5011.799528018875, 5046.798128074891, 5052.343195384595, 5103.157978933472, 5103.974480127594, 5071.644984851062, 5096.566791822663, 5102.132637451624, 5171.793128274864, 5192.1432963560965, 4976.825811096594, 5079.644424890259, 5122.0, 5130.563902068328, 5140.177571588565, 5326.174442961347, 5372.274742909696, 5419.972900135514, 5429.837104886859, 5489.984352894728, 5818.4763371296785, 5839.182514447981, 5844.620099693507, 5903.026000709878, 5937.554683398719, 5973.940260597382, 5982.0, 5988.520918326523, 5990.9700451497465, 5994.1608174855555, 5404.999999999961, 5457.317835270591, 5534.225208470777, 5564.1931919871395, 5597.048501754712, 6120.603065298713, 6158.137860699506, 6162.7226774795245, 6165.907511387333, 6179.938200618026, 5929.644221346733, 5933.762649494059, 5935.347111817697, 5937.109433584997, 5961.970190149108, 5788.681622510802, 5839.0, 5850.414958504116, 5853.1805547222575, 5883.882322353529, 5831.446012628793, 5837.6497410155525, 5844.064949608042, 5876.970615146897, 5884.529237660977, 5784.855378615568, 5838.737256823453, 5840.2991641003355, 5844.0, 5875.529957603381, 4504.797284122223, 4518.051209246029, 4535.7732113394195, 4541.477730061019, 4549.7042692224895, 4062.857799977046, 4080.657206870799, 4093.4269202311702, 4099.508059032935, 4118.835246590163, 5649.689267090267, 5649.774009039675, 5653.491185793298, 5655.886882262332, 5691.544676425876, 5864.794732184353, 5909.763609455659, 5962.4633782959745, 5964.552658550626, 5965.612235204698, 5568.0, 5597.328320601554, 5621.578381621313, 5669.036263835158, 5675.517581005578, 5181.4300426953005, 5185.870353241199, 5186.0, 5189.091908915924, 5194.948050519522, 6002.519798416203, 6136.999999999911, 6176.073588961602, 6197.752089916353, 6198.318184999646, 5860.267466566679, 5881.206037185097, 5950.9702451487465, 5972.970135149297, 6048.4556389923355, 6177.486670527338, 6195.845103872439, 6202.0, 6205.968970155301, 6207.81376558704, 5916.852078697895, 5920.555958303058, 5922.111683247547, 5924.644521328734, 5960.254968128984, 5705.030144875464, 5728.198052272768, 5866.882662346644, 5919.260092488439, 5935.0, 5844.035734103825, 5845.064789633639, 5852.970735146468, 5858.531317494675, 5872.265966754156, 5788.652680839163, 5847.26909136358, 5859.9121013183985, 5861.9706901465215, 5863.824085277449, 5626.521745651666, 5653.519450846724, 5716.571257155647, 5728.656280623176, 5816.970915145397, 5856.912146317723, 5860.033094539353, 5861.501772349227, 5869.530437564899, 5890.4698577128265, 5684.658920464785, 5693.430656934273, 5697.943020569907, 5699.0, 5718.3423906249645], "value": 5480.158164442128, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.9820905372841, 639.3510586754445, 652.0512654088302, 656.4289068510395, 665.3612531969309, 35930.0, 39169.8041509792, 39199.41200881989, 39224.41163382552, 39248.41127383088, 39089.41365879507, 48436.51563484364, 49534.256986145236, 49628.75185624067, 52662.21006684903, 9209.861852072225, 9270.582823772913, 9354.298427617921, 9377.390469619488, 9382.483963382012, 8568.700095496659, 8779.912200878005, 9238.399504032217, 9331.486768227745, 9331.813363732721, 10961.671149865517, 11188.496517656726, 11198.496067676933, 11575.363355015514, 11594.768104637902, 11210.159238057138, 11269.605563805228, 11283.435828208556, 11290.491927863184, 11295.49170287339, 11073.114150867912, 11138.665840024812, 11139.108871290277, 11142.944285278521, 11147.554097836077, 45967.31049034267, 46361.5363846364, 46464.535354646694, 46599.30101048453, 46674.0, 3782.2246439480114, 3876.0503676599133, 3983.920321593581, 4093.89765255868, 4411.558844115562, 35809.64190358115, 35812.283754324766, 35983.4602480963, 36324.0, 36881.44677829835, 4500.504944456107, 4514.593686568224, 4612.0, 4637.721736695776, 4664.473028218161, 268125.0, 269649.0, 269662.0, 269888.0, 270279.0, 39975.20049598992, 68665.0, 68986.0, 69103.3089669107, 69115.65442172757, 40358.39462408066, 40442.39336409956, 40459.19081618351, 40485.39271910924, 40675.0, 17580.472585822445, 17641.558961026076, 17739.201735921913, 17767.111644417728, 17780.288788448575, 15223.771643425358, 15319.61700957485, 15324.23378831054, 15325.23373831304, 15343.846561534465, 9105.317101217435, 9241.722748317561, 9461.479618621042, 9570.90429095714, 9689.951550242204, 3563.1626567756557, 3581.552305961755, 3590.281943611236, 3634.527511423498, 3646.9635303647156, 1091.9617813376494, 1127.2334812327697, 1170.1107158559555, 1205.879412058787, 1217.141408164979, 35047.0, 35126.91664723796, 35146.82426587902, 35331.11672208215, 35427.4685879712, 1155.2837240910521, 1171.1392126786805, 1181.480148734554, 1214.356391112694, 1250.4998000799753, 17839.46481605554, 18402.723959140625, 18423.631527369376, 18437.446876593724, 18630.16164272611, 587911.0, 588895.0, 592018.0, 593424.0, 597224.0, 63260.0, 63633.0, 63734.0, 63742.36257637457, 64055.67972160203, 1339.2700977966836, 1375.1748950629542, 1423.7294913966314, 1431.0912570517796, 1439.5105664074265, 33636.0, 35451.0, 35934.0, 35953.46069809007, 36187.81906090453, 55075.44924550703, 55547.44452555423, 55696.72151639216, 55720.44279557152, 55775.0, 429957.0, 431396.0, 432490.0, 432577.0, 432768.0, 31642.841785790923, 32203.0, 32236.516452252767, 32276.35447291088, 33272.50091248585, 52049.479505204465, 53095.469045310594, 53215.0, 53550.73224633852, 54346.72826635841, 43106.56893431151, 43402.348964766185, 43809.56190438055, 45027.0, 45380.0, 45757.54242457533, 45765.77117114393, 46099.76950115362, 46244.53755462537, 46470.53529464662, 43531.347029795215, 44198.55801441945, 44628.55371446374, 44674.3298850524, 44770.77614612036, 35868.0, 38259.61740382561, 38325.808370957966, 38494.615053850226, 39308.41037384384, 28919.120257183215, 29233.85383073071, 29432.0, 29500.557491637213, 29659.851700741357], "value": 20589.025516220336, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.3846422687104, 429.15242396267377, 438.8643144730897, 439.7515403796855, 454.51367037270137, 19100.90449547752, 20420.285290014872, 20709.689354659673, 21566.0, 21742.673859892115, 20367.28714494993, 20501.589968200627, 20916.686249706265, 20995.895020524913, 21114.894425527888, 5908.320543137541, 6181.536384771161, 6213.502919766431, 6235.812925612239, 6243.781467648633, 5883.764649414018, 6023.518118550527, 6059.272887253535, 6064.241969753781, 6078.483328917047, 6024.3674414186535, 6025.126356678279, 6025.276966763994, 6027.306859711123, 6030.819075427744, 5835.124731290298, 6047.425494578008, 6066.363031881655, 6082.695865206766, 6090.208272924536, 5498.257735205736, 5512.862178445531, 5517.062099443105, 5519.254900588409, 5563.109902415635, 14752.55742327732, 15485.303161357766, 15490.380384784596, 15530.767038494432, 15538.61153471161, 2473.8763061846835, 2487.0797804812155, 2515.710693270279, 2516.3709072731817, 2646.431017331264, 10993.230473866832, 11014.339139651647, 11112.55549778016, 11248.887511124865, 11379.886201137966, 2025.5948810237865, 2141.4325203821, 2227.142550118216, 2268.4895898422888, 2298.0348253733473, 61859.690701546206, 74837.62581187114, 89720.0, 92155.53922230346, 93897.0, 12051.397430128458, 12062.51749929993, 12112.152149349637, 12267.877321226673, 12369.62891113268, 17596.472105836845, 17609.7358539622, 17628.559286017695, 17670.91164544195, 17689.911550442423, 8114.229148230908, 8833.734987950373, 9069.86626671666, 9253.074692530829, 9305.348625596278, 9204.4477331359, 9205.401648892801, 9220.308476864262, 9415.717528474157, 9415.717528474157, 5221.295125158131, 5222.616006758212, 5247.553957913544, 5368.677879327175, 5416.647917885325, 2068.6586713192455, 2150.8817015064324, 2157.1587081038406, 2181.858179218346, 2190.080166330145, 902.3503077783985, 975.6390135649855, 998.2647545724662, 1003.3227571389283, 1023.8976102389851, 18856.05719714009, 20383.286584969454, 20523.58952820965, 20604.79395206029, 21019.0, 1027.686555600549, 1036.6838114375037, 1041.5000799616228, 1046.5552140340326, 1130.0789856267115, 10747.677569672922, 11575.76848463043, 11648.126390520745, 11674.533018679158, 11679.824802627967, 491656.0, 498079.0, 507862.0, 527155.0, 528296.0, 99028.0, 103121.48439257756, 103343.48328258311, 104762.0, 105002.0, 978.8433850584015, 992.5731935267904, 1017.898210178991, 1019.0064686930184, 1042.5725452564411, 14181.574552763434, 18327.450176494192, 18961.525961851064, 19186.520336991685, 19219.03904804782, 44528.0, 44957.0, 45693.0, 46289.53710462852, 46884.53115468802, 60436.395636044836, 60794.69602651958, 61175.0, 61358.0, 61836.38163618486, 9182.127697868691, 9340.233630006347, 9368.812623747623, 9450.291228157777, 9604.423734575948, 13184.406701698255, 13752.587422377344, 13785.724285514434, 14107.153570785786, 14282.2144782038, 12051.33717645538, 12052.457639406073, 12160.0, 12195.268283902995, 12290.324032178316, 12137.575184868487, 12189.634310970685, 12266.815997759863, 12274.263544187377, 12445.564405245774, 12042.63872083839, 12205.572804951784, 12269.325187114795, 12349.814752778535, 12362.072844536875, 8373.0, 8662.523561204194, 9268.582913768762, 9653.613855445985, 9702.0, 9020.413673111227, 9245.214156796748, 9509.239260859253, 9797.363171393836, 9847.359921605359], "value": 9665.393865721326, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.917999510027, 1513.3870782333156, 1665.117487731502, 1761.7357396390548, 1793.6143729098242, 8602.440841345317, 9212.401193922391, 9310.836145481815, 9311.0, 9322.067793220675, 7766.766996990085, 8053.355731541477, 8671.523066231355, 8906.554672266393, 9249.167574918256, 2546.363409147713, 2565.6279839423273, 2568.4863027394595, 2578.6132080187936, 2580.7419258074137, 2509.6862892138483, 2601.0636170978432, 2601.0766178006725, 2605.6091586262023, 2613.3335999320147, 2370.8221883358733, 2382.916597919073, 2433.926982190528, 2439.7194322652854, 2443.0472115874823, 2487.9751202487923, 2493.0277191895175, 2506.586413241822, 2563.9615405768927, 2564.4614630927526, 2416.093964763214, 2455.1529722245796, 2457.6559281700575, 2465.0386349323776, 2498.3129639349145, 9014.459132452073, 9046.185843274137, 9097.863532047024, 9112.316576256808, 9122.81754364909, 5615.775368985236, 5771.826845194651, 5782.537397008229, 5783.074708046693, 5800.651960882361, 3478.165240342325, 3581.08682286018, 3621.7826930384, 3622.7464077514583, 3665.87169449068, 1240.5161986825146, 1243.4280231093708, 1244.7821631214501, 2238.8320875934205, 2285.874276914769, 12172.695682607917, 12236.81644775329, 12246.142770006103, 12247.69380765488, 12269.754604907852, 4876.146674331978, 4948.505149485023, 4984.7258400788305, 5063.493650634907, 5076.44159142494, 10101.494925253708, 10113.64602238918, 10119.089281964658, 10139.340942838691, 10144.746381340525, 5708.0581704019205, 5709.514691251207, 5723.427657234243, 5729.25519682447, 5734.0, 4710.4347478302825, 4717.95282047182, 5264.894702106013, 5295.629305948547, 5349.491798279158, 3979.303621866162, 4040.333344998101, 4077.734947228421, 4132.669386449077, 4146.813393397304, 1261.2180448122224, 1271.313490715022, 1284.4797856867983, 1295.5077070713069, 1296.3906963727222, 986.3785814936545, 1013.3717095400899, 1016.1312078173204, 1016.7559785651538, 1019.898010198989, 5862.325832529228, 6048.546359023091, 6199.814005579839, 6255.749770009149, 6385.042243663394, 464.80710505140667, 490.9239067944474, 491.58706686383607, 498.1307618206253, 1033.3438266700548, 3803.581606023335, 3898.3567711327314, 3989.2420440116866, 4047.919041619151, 4097.262492751273, 10840.891591083988, 11137.665870023913, 11138.66584002465, 11163.218574699855, 11205.551777928955, 10430.217733670004, 10736.0, 10874.510647020903, 11043.668689939315, 11043.668689939315, 7748.186440423787, 7930.365570754326, 8166.918330816735, 8326.750197494084, 8329.33365330772, 6065.211522502046, 6093.421124993119, 6180.412860778219, 6189.164462797645, 6342.112104305309, 10005.0, 10160.491975401053, 10242.590296388062, 10295.53670084863, 10335.069843714102, 10261.692149235534, 10314.27800053989, 10518.0, 10607.257491975797, 10622.73443163896, 7175.354218120394, 7369.336759691653, 7422.331990120699, 7625.428092892944, 7654.846903062019, 8479.32165426752, 8806.251468624981, 8809.64761409562, 8810.911890881009, 8816.206541411304, 7888.2506161914525, 7916.6437510311025, 7934.2859142677435, 8016.158303378062, 8235.176482351717, 7748.108967468813, 7862.646180921986, 7915.208479152038, 7950.24472675095, 8025.839483210187, 6691.765788197585, 6754.729810807513, 6790.219124800711, 6927.965360173167, 6940.757073502403, 5072.0870243355075, 5110.64225504226, 5224.50367215114, 5243.921341179962, 5473.726313684379, 5401.351837779492, 5473.808416705396, 5501.614886958035, 5511.200875873056, 5514.503694667499], "value": 4776.9411805912005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.7589614957978, 360.5313092979126, 368.0981595092025, 370.1874385723337, 371.10378436076877, 5320.733963301839, 5447.237386765856, 5482.451754824516, 5548.611597188194, 5576.944230557693, 5323.680579165253, 5445.237666726652, 5447.291852059237, 5467.726613669311, 5473.917891231625, 4406.294992801152, 4411.64706823455, 4417.182821178077, 4417.911641767163, 4427.845025424111, 4251.574842515754, 4353.825846966118, 4413.955860441402, 4416.97791511042, 4420.8673739787855, 4345.5654434556445, 4347.3261644445165, 4366.956330436687, 4370.366296886949, 4373.759443230621, 4356.368326592658, 4369.890752731176, 4374.212641724473, 4376.781160941972, 4378.64970802335, 3715.7584756990977, 3803.8668646597234, 3815.294170578424, 3845.0771814764535, 3851.5763266040713, 5306.151015837486, 5338.225957236179, 5354.12605588045, 5361.544268737162, 5379.811706590251, 4980.078685443168, 4983.377077865267, 4988.152014157566, 4988.301637770715, 4999.275105109775, 5560.6941618210985, 5741.569382296303, 5765.711714414262, 5779.537636989073, 5783.334916484574, 4229.97885010576, 4234.407182994383, 4235.449391579105, 4237.559229861862, 4240.766757828318, 5727.856803579903, 5935.821925342247, 5961.076033214858, 5994.880102397971, 5998.550108741818, 4173.290540608104, 4188.246115699203, 4204.726692764961, 4204.810783514749, 4213.557576454428, 4261.786910654455, 4262.509811371732, 4262.978685106555, 4265.3601959705675, 4287.256156060124, 4856.4415092264135, 4866.002469493746, 4873.488283730228, 4876.195427754381, 4878.975605121952, 5475.972620136953, 5638.407967163471, 5716.542676585863, 5722.628029178173, 5758.683272420057, 1445.169027809014, 1510.6978604278968, 1552.3712896277025, 1569.2781320592655, 1570.9239171167787, 1070.983935240972, 1088.8530048443517, 1099.769048499824, 1108.1744100645071, 1113.2986218682179, 4807.879803004953, 4816.927746083811, 4822.228443449031, 4835.709857408567, 4869.0, 5103.157978933508, 5109.802784802496, 5122.974385128051, 5128.410232823273, 5139.0, 4538.750368729751, 4851.762800485853, 4875.390576177978, 4890.339804126468, 4899.314096026559, 2715.714849940767, 2736.6031925370708, 2742.245882382361, 2751.0, 2753.0, 5218.739063046833, 5251.927622340897, 5262.947370526245, 5272.815451459257, 5275.736213189325, 4809.519048095162, 5184.948150518522, 5204.76578553966, 5212.947870521322, 5233.712145832016, 5196.298499702491, 5225.686458812484, 5228.869278267997, 5245.527902488794, 5266.710330931835, 5072.28987941681, 5104.438511763778, 5109.97800439906, 5123.436421993652, 5132.692038477703, 4731.668783185144, 5041.294218809297, 5053.772580233825, 5064.569511591556, 5091.949080509147, 5144.5595233334725, 5196.636235463481, 5199.350081239845, 5221.407470721315, 5247.396549396715, 3973.6821054315005, 3977.4033894914837, 3981.3231750603045, 3993.6405723485027, 3994.7403418777685, 4967.230079337708, 5070.543651071422, 5093.784203871328, 5103.897922041464, 5173.508516690908, 4965.677230979974, 4984.8753781155765, 4992.201247800334, 5003.6982987826, 5006.774695138801, 4900.338454308765, 4907.141250281115, 4992.750362481934, 4999.525045120708, 5016.272640467038, 4710.9764451177525, 4897.583705385082, 4934.7285899275885, 4956.959038601934, 5031.962055367582, 4940.802367905388, 4976.63609785349, 4989.55094041538, 4994.400671919393, 5020.974895125647, 4837.854864354075, 4889.877753056202, 4908.754562271801, 4915.631327650369, 4953.23224900141], "value": 4150.2490891416855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.150095401736, 833.5498830631461, 848.1603212819307, 883.4743327720005, 940.5861420974767, 16044.919775401122, 16830.07434591097, 16891.239894204744, 16936.4072257471, 16947.152642367895, 14964.7007059859, 15032.0, 15050.774238386406, 15126.168060756654, 15132.0, 712.6899798587605, 730.014480451389, 845.5814371885925, 870.3081050564816, 872.4590753732695, 876.369014309696, 878.4729162502512, 879.8284334554764, 881.4579033894141, 881.7795551112222, 918.2470374293082, 919.0533750237266, 919.1314208073373, 919.6919032124247, 922.1193759959223, 920.6731610278322, 921.1893533690343, 921.5484412637826, 921.6313474610142, 921.9953900230523, 681.8397676546008, 682.0860047536326, 682.9487788415839, 683.3371629519359, 683.8598087392073, 15032.323545440371, 15185.316660750183, 15211.467598633995, 15220.923895380563, 15254.0, 14276.785848212285, 14404.0, 14449.277536123152, 14807.333669984877, 16032.679346413122, 13840.723185536333, 13855.86144138566, 13970.371333290026, 14116.929415352857, 14557.78163327551, 4746.169420351459, 4881.096997055556, 4911.729854857981, 4993.625478089158, 5044.899102017976, 86432.0, 86752.0, 87487.12512874854, 87661.56169219177, 89050.0, 11674.299542027506, 11887.940560297144, 11978.64064078079, 12158.939205304094, 12224.388780561114, 20645.89677051605, 20842.1663133476, 20878.0, 20905.895470522853, 21222.363329100153, 8950.86573701395, 9035.141661542142, 9188.127127922837, 9369.859452108223, 9414.105659962293, 5017.071841709296, 5168.793248270103, 5238.449962753933, 5261.579073674096, 5367.570594352443, 3511.94732079019, 3656.305301992613, 3659.8536058557893, 3661.7986010769664, 4037.717359784787, 694.4895501806168, 702.8488874891821, 703.4723957032226, 706.0750416953807, 708.9929100708927, 746.5781833264189, 750.223518658197, 758.309937956457, 773.1032002876636, 781.3827076609415, 10520.263581549218, 10603.204759642904, 10701.571937122584, 10905.945470272756, 10938.343699378063, 656.4912193050328, 666.8299583606149, 700.4746440169872, 778.2917545034105, 799.8280369720538, 4425.247707889666, 4872.366592342973, 4941.777620007037, 5025.773195876274, 5158.0, 72463.63768181125, 112431.4378428119, 123982.0, 126245.36877315739, 129375.35312323378, 68009.0, 108022.0, 109722.0, 111906.0, 112866.43566782113, 95643.52178239064, 99159.0, 99174.5041274789, 100745.49627251817, 101212.49393752984, 9977.653016842632, 9995.500224988577, 10038.397696138256, 10071.496425178859, 10154.898451015692, 54404.18393724018, 56320.47181127582, 56601.150982736115, 56694.14958775704, 57716.0, 72789.27210727824, 76308.61845690737, 86210.0, 86507.56746216229, 87318.56340718256, 12178.512859485876, 12783.360831958551, 12805.743885122432, 12874.16317939331, 12924.483020679443, 14631.341589628279, 14789.630259243606, 14810.851891480947, 14892.0, 15626.687466250383, 13210.471581137032, 13381.799273011107, 13457.259850708306, 13658.112222705493, 13931.58205253844, 13107.14803537767, 13224.801627975781, 13325.466981320638, 13483.932580337036, 13736.10715303502, 13058.934705326412, 13148.802767958297, 13344.532941347006, 13773.862261377259, 13926.651833704238, 10204.18366530661, 10316.484175791331, 10503.789924201626, 10507.31702439339, 11137.10903127764, 10894.891051089387, 11683.34795734756, 11827.822582661094, 11905.285682859056, 11933.045356371296], "value": 8005.078607093184, "unit": "score"}], "name": "dromaeo_css", "value": 7465.301522581326, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 119.0, 118.0, 152.0, 117.0, 117.0, 116.0, 115.0, 147.0, 118.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 160.0, 161.0, 160.0, 161.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 120.0, 75.0, 75.0, 77.0, 74.0, 97.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 124.0, 83.0, 83.0, 82.0, 110.0, 82.0, 82.0, 113.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 61.0, 49.0, 49.0, 50.0, 50.0, 49.0, 49.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 59.0, 59.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": [74.0, 73.0, 73.0, 74.0, 82.0, 74.0, 81.0, 72.0, 73.0, 72.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 121.0, 120.0, 119.0, 126.0, 118.0, 118.0, 161.0, 120.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 156.0, 152.0, 153.0, 159.0, 150.0, 151.0, 156.0, 156.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 61.0, 63.0, 59.0, 61.0, 62.0, 61.0], "value": 61.2, "unit": "score"}], "name": "kraken", "value": 1449.9, "alertThreshold": 2.0}]} 21:32:29 INFO - Return code: 0 21:32:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:32:29 INFO - # TBPL SUCCESS # 21:32:29 INFO - Running post-action listener: _resource_record_post_action 21:32:29 INFO - [mozharness: 2016-11-29 05:32:29.213280Z] Finished run-tests step (success) 21:32:29 INFO - Running post-run listener: _resource_record_post_run 21:32:29 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 319905792; Read time: 56; Write time: 182696 21:32:29 INFO - TinderboxPrint: CPU usage
13.0% 21:32:29 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 56 21:32:29 INFO - TinderboxPrint: I/O write bytes / time
319,905,792 / 182,696 21:32:29 INFO - TinderboxPrint: CPU idle
8,232.3 (86.9%) 21:32:29 INFO - TinderboxPrint: CPU user
1,190.6 (12.6%) 21:32:29 INFO - TinderboxPrint: Swap in / out
0 / 0 21:32:29 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 111792128; Read time: 0; Write time: 67040 21:32:29 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 208113664; Read time: 12; Write time: 115656 21:32:29 INFO - Running post-run listener: _upload_blobber_files 21:32:29 INFO - Blob upload gear active. 21:32:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:32:29 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 21:32:29 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'] 21:32:29 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 21:32:30 INFO - (blobuploader) - INFO - Open directory for files ... 21:32:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:32:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:32:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:32:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:32:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:32:31 INFO - (blobuploader) - INFO - Done attempting. 21:32:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:32:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:32:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:32:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:32:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:32:32 INFO - (blobuploader) - INFO - Done attempting. 21:32:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:32:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:32:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:32:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:32:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:32:35 INFO - (blobuploader) - INFO - Done attempting. 21:32:35 INFO - (blobuploader) - INFO - Iteration through files over. 21:32:35 INFO - Return code: 0 21:32:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:32:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:32:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e052ec88119261519b9b25c5d3f6a6e342e7811b23a2eebb5d7d7285a3e2164b53123731f13184bac80004c4974f0a8fae243cebd7aa902bdaaa8dd22e636bea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b088783f22dff745fe1f9c3cf5017ad856b42f3170f6492181847a3158e23a6f162cafef3021d28fe61e1146ae054cc6b684dc023f864afbbd4b4d154436202b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bda79c2301313af9c58878a28af61a6782fd57bf865eeddd93d8781e7e06d44dbbdd56b921996c5581e09b93d70eab21cb4807da71c8b163121f1734b1916795"} 21:32:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:32:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:32:35 INFO - Contents: 21:32:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e052ec88119261519b9b25c5d3f6a6e342e7811b23a2eebb5d7d7285a3e2164b53123731f13184bac80004c4974f0a8fae243cebd7aa902bdaaa8dd22e636bea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b088783f22dff745fe1f9c3cf5017ad856b42f3170f6492181847a3158e23a6f162cafef3021d28fe61e1146ae054cc6b684dc023f864afbbd4b4d154436202b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bda79c2301313af9c58878a28af61a6782fd57bf865eeddd93d8781e7e06d44dbbdd56b921996c5581e09b93d70eab21cb4807da71c8b163121f1734b1916795"} 21:32:35 INFO - Running post-run listener: copy_logs_to_upload_dir 21:32:35 INFO - Copying logs to upload dir... 21:32:35 INFO - mkdir: /builds/slave/test/build/upload/logs 21:32:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.721033 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-11-28 21:32:35.347860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 21:32:35.351207) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958 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/e052ec88119261519b9b25c5d3f6a6e342e7811b23a2eebb5d7d7285a3e2164b53123731f13184bac80004c4974f0a8fae243cebd7aa902bdaaa8dd22e636bea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b088783f22dff745fe1f9c3cf5017ad856b42f3170f6492181847a3158e23a6f162cafef3021d28fe61e1146ae054cc6b684dc023f864afbbd4b4d154436202b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bda79c2301313af9c58878a28af61a6782fd57bf865eeddd93d8781e7e06d44dbbdd56b921996c5581e09b93d70eab21cb4807da71c8b163121f1734b1916795"} build_url:https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011526 build_url: 'https://queue.taskcluster.net/v1/task/Czt_6k23Rj2odttlomRI2A/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/e052ec88119261519b9b25c5d3f6a6e342e7811b23a2eebb5d7d7285a3e2164b53123731f13184bac80004c4974f0a8fae243cebd7aa902bdaaa8dd22e636bea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b088783f22dff745fe1f9c3cf5017ad856b42f3170f6492181847a3158e23a6f162cafef3021d28fe61e1146ae054cc6b684dc023f864afbbd4b4d154436202b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bda79c2301313af9c58878a28af61a6782fd57bf865eeddd93d8781e7e06d44dbbdd56b921996c5581e09b93d70eab21cb4807da71c8b163121f1734b1916795"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 21:32:35.381921) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:32:35.382305) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1480391076.286947-1424182958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:32:35.463709) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 21:32:35.464081) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 21:32:35.464423) ========= ========= Total master_lag: 0.18 =========