builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1482429060.14 results: success (0) buildid: 20161222084453 builduid: cbb5bcbdb4984e95a2f7de3a7e54cce6 revision: 7b88f8d64a954843f065cbbd1876e8e1464948e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:00.137049) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:00.137473) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:00.137755) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:00.152741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:00.153107) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-22 09:51:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.0M=0s 2016-12-22 09:51:00 (38.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083851 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:00.250707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:00.251010) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013170 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:00.301144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:00.301513) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 7b88f8d64a954843f065cbbd1876e8e1464948e3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 7b88f8d64a954843f065cbbd1876e8e1464948e3 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-22 09:51:00,750 truncating revision to first 12 chars 2016-12-22 09:51:00,750 Setting DEBUG logging. 2016-12-22 09:51:00,750 attempt 1/10 2016-12-22 09:51:00,750 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/7b88f8d64a95?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 09:51:01,091 unpacking tar archive at: graphics-7b88f8d64a95/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696279 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:01.011093) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:01.011416) ========= script_repo_revision: 7b88f8d64a954843f065cbbd1876e8e1464948e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:01.011862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:01.012146) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 09:51:01.020575) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-12-22 09:51:01.020848) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:51:01 INFO - MultiFileLogger online at 20161222 09:51:01 in /builds/slave/test 09:51:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 09:51:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:51:01 INFO - {'append_to_log': False, 09:51:01 INFO - 'base_work_dir': '/builds/slave/test', 09:51:01 INFO - 'blob_upload_branch': 'Graphics', 09:51:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:51:01 INFO - 'branch': 'Graphics', 09:51:01 INFO - 'buildbot_json_path': 'buildprops.json', 09:51:01 INFO - 'config_files': ('talos/linux_config.py',), 09:51:01 INFO - 'default_actions': ('clobber', 09:51:01 INFO - 'read-buildbot-config', 09:51:01 INFO - 'download-and-extract', 09:51:01 INFO - 'populate-webroot', 09:51:01 INFO - 'create-virtualenv', 09:51:01 INFO - 'install', 09:51:01 INFO - 'run-tests'), 09:51:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:51:01 INFO - 'download_minidump_stackwalk': True, 09:51:01 INFO - 'download_symbols': 'ondemand', 09:51:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:51:01 INFO - 'tooltool.py': '/tools/tooltool.py', 09:51:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:51:01 INFO - '/tools/misc-python/virtualenv.py')}, 09:51:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:51:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:51:01 INFO - 'installer_path': 'installer.exe', 09:51:01 INFO - 'log_level': 'info', 09:51:01 INFO - 'log_name': 'talos', 09:51:01 INFO - 'log_to_console': True, 09:51:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:51:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:51:01 INFO - 'opt_config_files': (), 09:51:01 INFO - 'pip_index': False, 09:51:01 INFO - 'sps_profile': False, 09:51:01 INFO - 'sps_profile_interval': 0, 09:51:01 INFO - 'suite': 'dromaeojs', 09:51:01 INFO - 'system_bits': '32', 09:51:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:51:01 INFO - 'title': 'talos-linux64-ix-041', 09:51:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:51:01 INFO - 'use_talos_json': True, 09:51:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:51:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:51:01 INFO - 'work_dir': 'build'} 09:51:01 INFO - [mozharness: 2016-12-22 17:51:01.561403Z] Running clobber step. 09:51:01 INFO - Running pre-action listener: _resource_record_pre_action 09:51:01 INFO - Running main action method: clobber 09:51:01 INFO - rmtree: /builds/slave/test/build 09:51:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:51:02 INFO - Running post-action listener: _resource_record_post_action 09:51:02 INFO - [mozharness: 2016-12-22 17:51:02.026385Z] Finished clobber step (success) 09:51:02 INFO - [mozharness: 2016-12-22 17:51:02.026486Z] Running read-buildbot-config step. 09:51:02 INFO - Running pre-action listener: _resource_record_pre_action 09:51:02 INFO - Running main action method: read_buildbot_config 09:51:02 INFO - Using buildbot properties: 09:51:02 INFO - { 09:51:02 INFO - "project": "", 09:51:02 INFO - "product": "firefox", 09:51:02 INFO - "script_repo_revision": "default", 09:51:02 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 09:51:02 INFO - "repository": "", 09:51:02 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 09:51:02 INFO - "buildid": "20161222084453", 09:51:02 INFO - "pgo_build": "False", 09:51:02 INFO - "basedir": "/builds/slave/test", 09:51:02 INFO - "buildnumber": 33, 09:51:02 INFO - "slavename": "talos-linux64-ix-041", 09:51:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:51:02 INFO - "platform": "ubuntu64_hw", 09:51:02 INFO - "scheduler": "tests-graphics-linux64-talos", 09:51:02 INFO - "branch": "graphics", 09:51:02 INFO - "repo_path": "projects/graphics", 09:51:02 INFO - "revision": "7b88f8d64a954843f065cbbd1876e8e1464948e3", 09:51:02 INFO - "stage_platform": "linux64", 09:51:02 INFO - "builduid": "cbb5bcbdb4984e95a2f7de3a7e54cce6", 09:51:02 INFO - "slavebuilddir": "test" 09:51:02 INFO - } 09:51:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 09:51:02 INFO - Running post-action listener: _resource_record_post_action 09:51:02 INFO - [mozharness: 2016-12-22 17:51:02.028970Z] Finished read-buildbot-config step (success) 09:51:02 INFO - [mozharness: 2016-12-22 17:51:02.029060Z] Running download-and-extract step. 09:51:02 INFO - Running pre-action listener: _resource_record_pre_action 09:51:02 INFO - Running main action method: download_and_extract 09:51:02 INFO - mkdir: /builds/slave/test/build/tests 09:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:02 INFO - trying https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:51:02 INFO - Downloading https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:51:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:51:02 INFO - Downloaded 1361 bytes. 09:51:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:51:02 INFO - Using the following test package requirements: 09:51:02 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:51:02 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:51:02 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:51:02 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:02 INFO - u'jsshell-linux-x86_64.zip'], 09:51:02 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:51:02 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:51:02 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:51:02 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:51:02 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:51:02 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:51:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:51:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:51:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:51:02 INFO - Fetch https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:51:03 INFO - Expected file size: 20260924 09:51:03 INFO - Obtained file size: 20260924 09:51:07 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:51:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:51:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:51:07 INFO - Fetch https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:51:08 INFO - Expected file size: 20260924 09:51:08 INFO - Obtained file size: 20260924 09:51:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 09:51:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:51:12 INFO - Fetch https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:51:13 INFO - Expected file size: 14409734 09:51:13 INFO - Obtained file size: 14409734 09:51:14 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')]} 09:51:14 INFO - trying https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:51:14 INFO - Downloading https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:51:15 INFO - Downloaded 55658108 bytes. 09:51:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:51:15 INFO - mkdir: /builds/slave/test/properties 09:51:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:51:15 INFO - Writing to file /builds/slave/test/properties/build_url 09:51:15 INFO - Contents: 09:51:15 INFO - build_url:https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:51:15 INFO - Running post-action listener: _resource_record_post_action 09:51:15 INFO - Running post-action listener: set_extra_try_arguments 09:51:15 INFO - [mozharness: 2016-12-22 17:51:15.833127Z] Finished download-and-extract step (success) 09:51:15 INFO - [mozharness: 2016-12-22 17:51:15.833353Z] Running populate-webroot step. 09:51:15 INFO - Running pre-action listener: _resource_record_pre_action 09:51:15 INFO - Running main action method: populate_webroot 09:51:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:51:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:51:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:51:15 INFO - '--tppagecycles', 09:51:15 INFO - '7'], 09:51:15 INFO - 'tests': ['tsvgm']}}, 09:51:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:51:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:51:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:51:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:51:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:51:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:51:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:51:15 INFO - 'talos_options': ['--disable-e10s'], 09:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:51:15 INFO - 'talos_options': ['--disable-e10s'], 09:51:15 INFO - 'tests': ['damp', 'tps']}, 09:51:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:51:15 INFO - 'tests': ['damp', 'tps']}, 09:51:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:51:15 INFO - 'tests': ['dromaeo_dom']}, 09:51:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:51:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:51:15 INFO - 'tests': ['basic_compositor_video']}, 09:51:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:51:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:51:15 INFO - 'tests': ['a11yr', 09:51:15 INFO - 'ts_paint', 09:51:15 INFO - 'tpaint', 09:51:15 INFO - 'sessionrestore', 09:51:15 INFO - 'sessionrestore_no_auto_restore', 09:51:15 INFO - 'tabpaint']}, 09:51:15 INFO - 'other-e10s': {'tests': ['a11yr', 09:51:15 INFO - 'ts_paint', 09:51:15 INFO - 'tpaint', 09:51:15 INFO - 'sessionrestore', 09:51:15 INFO - 'sessionrestore_no_auto_restore', 09:51:15 INFO - 'tabpaint']}, 09:51:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:51:15 INFO - 'ts_paint', 09:51:15 INFO - 'tpaint', 09:51:15 INFO - 'sessionrestore', 09:51:15 INFO - 'sessionrestore_no_auto_restore', 09:51:15 INFO - 'tabpaint']}, 09:51:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:51:15 INFO - 'ts_paint', 09:51:15 INFO - 'tpaint', 09:51:15 INFO - 'sessionrestore', 09:51:15 INFO - 'sessionrestore_no_auto_restore', 09:51:15 INFO - 'tabpaint']}, 09:51:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:51:15 INFO - 'tests': ['a11yr', 09:51:15 INFO - 'ts_paint', 09:51:15 INFO - 'tpaint', 09:51:15 INFO - 'sessionrestore', 09:51:15 INFO - 'sessionrestore_no_auto_restore', 09:51:15 INFO - 'tabpaint']}, 09:51:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:51:15 INFO - 'tests': ['a11yr', 09:51:15 INFO - 'ts_paint', 09:51:15 INFO - 'tpaint', 09:51:15 INFO - 'sessionrestore', 09:51:15 INFO - 'sessionrestore_no_auto_restore', 09:51:15 INFO - 'tabpaint']}, 09:51:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:51:15 INFO - 'tests': ['tsvgx', 09:51:15 INFO - 'tsvgr_opacity', 09:51:15 INFO - 'tart', 09:51:15 INFO - 'tscrollx', 09:51:15 INFO - 'cart', 09:51:15 INFO - 'tsvg_static']}, 09:51:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:51:15 INFO - 'tsvgr_opacity', 09:51:15 INFO - 'tart', 09:51:15 INFO - 'tscrollx', 09:51:15 INFO - 'cart', 09:51:15 INFO - 'tsvg_static']}, 09:51:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:51:15 INFO - 'talos_options': ['--disable-e10s'], 09:51:15 INFO - 'tests': ['tp5o']}, 09:51:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:51:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:51:15 INFO - 'talos_options': ['--disable-e10s', 09:51:15 INFO - '--xperf_path', 09:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:15 INFO - 'tests': ['tp5n']}, 09:51:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:51:15 INFO - 'talos_options': ['--xperf_path', 09:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:15 INFO - 'tests': ['tp5n']}}, 09:51:15 INFO - 'talos.zip': {'path': '', 09:51:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:51:15 INFO - Running post-action listener: _resource_record_post_action 09:51:15 INFO - [mozharness: 2016-12-22 17:51:15.848600Z] Finished populate-webroot step (success) 09:51:15 INFO - [mozharness: 2016-12-22 17:51:15.848706Z] Running create-virtualenv step. 09:51:15 INFO - Running pre-action listener: _resource_record_pre_action 09:51:15 INFO - Running main action method: create_virtualenv 09:51:15 INFO - Creating virtualenv /builds/slave/test/build/venv 09:51:15 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 09:51:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:51:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:51:15 INFO - Using real prefix '/usr' 09:51:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:51:16 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:18 INFO - Installing pip.................done. 09:51:18 INFO - Return code: 0 09:51:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:51:18 INFO - Reading from file tmpfile_stdout 09:51:18 INFO - Output received: 09:51:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:51:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b63f0>, '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 0x24b6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b71a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', '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 09:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:51:18 INFO - Using env: {'DISPLAY': ':0', 09:51:18 INFO - 'HOME': '/home/cltbld', 09:51:18 INFO - 'LANG': 'en_US.UTF-8', 09:51:18 INFO - 'LANGUAGE': 'en_US:en', 09:51:18 INFO - 'LOGNAME': 'cltbld', 09:51:18 INFO - 'MAIL': '/var/mail/cltbld', 09:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:18 INFO - 'MOZ_NO_REMOTE': '1', 09:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:18 INFO - 'NO_EM_RESTART': '1', 09:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:18 INFO - 'PWD': '/builds/slave/test', 09:51:18 INFO - 'SHELL': '/bin/bash', 09:51:18 INFO - 'SHLVL': '1', 09:51:18 INFO - 'TERM': 'linux', 09:51:18 INFO - 'TMOUT': '86400', 09:51:18 INFO - 'USER': 'cltbld', 09:51:18 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', 09:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:18 INFO - '_': '/tools/buildbot/bin/python'} 09:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:18 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 09:51:18 INFO - Cleaning up... 09:51:18 INFO - Return code: 0 09:51:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b63f0>, '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 0x24b6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b71a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', '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 09:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:51:18 INFO - Using env: {'DISPLAY': ':0', 09:51:18 INFO - 'HOME': '/home/cltbld', 09:51:18 INFO - 'LANG': 'en_US.UTF-8', 09:51:18 INFO - 'LANGUAGE': 'en_US:en', 09:51:18 INFO - 'LOGNAME': 'cltbld', 09:51:18 INFO - 'MAIL': '/var/mail/cltbld', 09:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:18 INFO - 'MOZ_NO_REMOTE': '1', 09:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:18 INFO - 'NO_EM_RESTART': '1', 09:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:18 INFO - 'PWD': '/builds/slave/test', 09:51:18 INFO - 'SHELL': '/bin/bash', 09:51:18 INFO - 'SHLVL': '1', 09:51:18 INFO - 'TERM': 'linux', 09:51:18 INFO - 'TMOUT': '86400', 09:51:18 INFO - 'USER': 'cltbld', 09:51:18 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', 09:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:18 INFO - '_': '/tools/buildbot/bin/python'} 09:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:19 INFO - Downloading/unpacking psutil>=3.1.1 09:51:19 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 09:51:19 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 09:51:19 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 09:51:19 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 09:51:19 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 09:51:19 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 09:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:21 INFO - Installing collected packages: psutil 09:51:21 INFO - Running setup.py install for psutil 09:51:21 INFO - building 'psutil._psutil_linux' extension 09:51:21 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 09:51:21 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 09:51:21 INFO - building 'psutil._psutil_posix' extension 09:51:21 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 09:51:21 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 09:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:21 INFO - Successfully installed psutil 09:51:21 INFO - Cleaning up... 09:51:21 INFO - Return code: 0 09:51:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b63f0>, '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 0x24b6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b71a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', '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 09:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:51:21 INFO - Using env: {'DISPLAY': ':0', 09:51:21 INFO - 'HOME': '/home/cltbld', 09:51:21 INFO - 'LANG': 'en_US.UTF-8', 09:51:21 INFO - 'LANGUAGE': 'en_US:en', 09:51:21 INFO - 'LOGNAME': 'cltbld', 09:51:21 INFO - 'MAIL': '/var/mail/cltbld', 09:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:21 INFO - 'MOZ_NO_REMOTE': '1', 09:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:21 INFO - 'NO_EM_RESTART': '1', 09:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:21 INFO - 'PWD': '/builds/slave/test', 09:51:21 INFO - 'SHELL': '/bin/bash', 09:51:21 INFO - 'SHLVL': '1', 09:51:21 INFO - 'TERM': 'linux', 09:51:21 INFO - 'TMOUT': '86400', 09:51:21 INFO - 'USER': 'cltbld', 09:51:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', 09:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:21 INFO - '_': '/tools/buildbot/bin/python'} 09:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:51:21 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 09:51:21 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 09:51:21 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 09:51:21 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 09:51:21 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 09:51:21 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 09:51:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:51:24 INFO - Installing collected packages: mozsystemmonitor 09:51:24 INFO - Running setup.py install for mozsystemmonitor 09:51:24 INFO - Successfully installed mozsystemmonitor 09:51:24 INFO - Cleaning up... 09:51:24 INFO - Return code: 0 09:51:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b63f0>, '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 0x24b6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b71a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', '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 09:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:51:24 INFO - Using env: {'DISPLAY': ':0', 09:51:24 INFO - 'HOME': '/home/cltbld', 09:51:24 INFO - 'LANG': 'en_US.UTF-8', 09:51:24 INFO - 'LANGUAGE': 'en_US:en', 09:51:24 INFO - 'LOGNAME': 'cltbld', 09:51:24 INFO - 'MAIL': '/var/mail/cltbld', 09:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:24 INFO - 'MOZ_NO_REMOTE': '1', 09:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:24 INFO - 'NO_EM_RESTART': '1', 09:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:24 INFO - 'PWD': '/builds/slave/test', 09:51:24 INFO - 'SHELL': '/bin/bash', 09:51:24 INFO - 'SHLVL': '1', 09:51:24 INFO - 'TERM': 'linux', 09:51:24 INFO - 'TMOUT': '86400', 09:51:24 INFO - 'USER': 'cltbld', 09:51:24 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', 09:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:24 INFO - '_': '/tools/buildbot/bin/python'} 09:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:24 INFO - Downloading/unpacking jsonschema==2.5.1 09:51:24 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 09:51:24 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 09:51:24 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 09:51:24 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 09:51:24 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 09:51:24 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 09:51:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:26 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:26 INFO - warning: no files found matching '*.txt' 09:51:26 INFO - no previously-included directories found matching 'build' 09:51:26 INFO - no previously-included directories found matching 'dist' 09:51:26 INFO - no previously-included directories found matching '.git*' 09:51:26 INFO - Installing collected packages: jsonschema, functools32 09:51:26 INFO - Running setup.py install for functools32 09:51:26 INFO - warning: no files found matching '*.txt' 09:51:26 INFO - no previously-included directories found matching 'build' 09:51:26 INFO - no previously-included directories found matching 'dist' 09:51:26 INFO - no previously-included directories found matching '.git*' 09:51:26 INFO - Successfully installed jsonschema functools32 09:51:26 INFO - Cleaning up... 09:51:26 INFO - Return code: 0 09:51:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:51:26 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')]} 09:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:26 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')]} 09:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:26 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 0x21471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b63f0>, '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 0x24b6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b71a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', '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 09:51:26 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 09:51:26 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 09:51:26 INFO - Using env: {'DISPLAY': ':0', 09:51:26 INFO - 'HOME': '/home/cltbld', 09:51:26 INFO - 'LANG': 'en_US.UTF-8', 09:51:26 INFO - 'LANGUAGE': 'en_US:en', 09:51:26 INFO - 'LOGNAME': 'cltbld', 09:51:26 INFO - 'MAIL': '/var/mail/cltbld', 09:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:26 INFO - 'MOZ_NO_REMOTE': '1', 09:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:26 INFO - 'NO_EM_RESTART': '1', 09:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:26 INFO - 'PWD': '/builds/slave/test', 09:51:26 INFO - 'SHELL': '/bin/bash', 09:51:26 INFO - 'SHLVL': '1', 09:51:26 INFO - 'TERM': 'linux', 09:51:26 INFO - 'TMOUT': '86400', 09:51:26 INFO - 'USER': 'cltbld', 09:51:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', 09:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:26 INFO - '_': '/tools/buildbot/bin/python'} 09:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:51:27 INFO - Cleaning up... 09:51:27 INFO - Return code: 0 09:51:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:27 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 0x21471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b63f0>, '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 0x24b6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b71a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', '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 09:51:27 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 09:51:27 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 09:51:27 INFO - Using env: {'DISPLAY': ':0', 09:51:27 INFO - 'HOME': '/home/cltbld', 09:51:27 INFO - 'LANG': 'en_US.UTF-8', 09:51:27 INFO - 'LANGUAGE': 'en_US:en', 09:51:27 INFO - 'LOGNAME': 'cltbld', 09:51:27 INFO - 'MAIL': '/var/mail/cltbld', 09:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:27 INFO - 'MOZ_NO_REMOTE': '1', 09:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:27 INFO - 'NO_EM_RESTART': '1', 09:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:27 INFO - 'PWD': '/builds/slave/test', 09:51:27 INFO - 'SHELL': '/bin/bash', 09:51:27 INFO - 'SHLVL': '1', 09:51:27 INFO - 'TERM': 'linux', 09:51:27 INFO - 'TMOUT': '86400', 09:51:27 INFO - 'USER': 'cltbld', 09:51:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', 09:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:27 INFO - '_': '/tools/buildbot/bin/python'} 09:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:27 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:27 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 09:51:27 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 09:51:27 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 09:51:27 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 09:51:27 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 09:51:27 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 09:51:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:29 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 09:51:29 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 09:51:29 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 09:51:29 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 09:51:29 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 09:51:29 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 09:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:29 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 09:51:29 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 09:51:29 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 09:51:29 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 09:51:29 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 09:51:29 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 09:51:30 INFO - Downloading docopt-0.6.1.tar.gz 09:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:30 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:30 INFO - Running setup.py install for blobuploader 09:51:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:30 INFO - Running setup.py install for requests 09:51:30 INFO - Running setup.py install for docopt 09:51:30 INFO - Successfully installed blobuploader requests docopt 09:51:30 INFO - Cleaning up... 09:51:30 INFO - Return code: 0 09:51:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:30 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 0x21471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b63f0>, '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 0x24b6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b71a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', '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 09:51:30 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 09:51:30 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 09:51:30 INFO - Using env: {'DISPLAY': ':0', 09:51:30 INFO - 'HOME': '/home/cltbld', 09:51:30 INFO - 'LANG': 'en_US.UTF-8', 09:51:30 INFO - 'LANGUAGE': 'en_US:en', 09:51:30 INFO - 'LOGNAME': 'cltbld', 09:51:30 INFO - 'MAIL': '/var/mail/cltbld', 09:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:30 INFO - 'MOZ_NO_REMOTE': '1', 09:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:30 INFO - 'NO_EM_RESTART': '1', 09:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:30 INFO - 'PWD': '/builds/slave/test', 09:51:30 INFO - 'SHELL': '/bin/bash', 09:51:30 INFO - 'SHLVL': '1', 09:51:30 INFO - 'TERM': 'linux', 09:51:30 INFO - 'TMOUT': '86400', 09:51:30 INFO - 'USER': 'cltbld', 09:51:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', 09:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:30 INFO - '_': '/tools/buildbot/bin/python'} 09:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:30 INFO - Running setup.py (path:/tmp/pip-qjtXn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:31 INFO - Running setup.py (path:/tmp/pip-Vlswml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:31 INFO - Running setup.py (path:/tmp/pip-MqgDoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:31 INFO - Running setup.py (path:/tmp/pip-MXFAxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:31 INFO - Running setup.py (path:/tmp/pip-3My_yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:31 INFO - Running setup.py (path:/tmp/pip-0Swlfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:31 INFO - Running setup.py (path:/tmp/pip-KqdInK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:31 INFO - Running setup.py (path:/tmp/pip-sltHbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:31 INFO - Running setup.py (path:/tmp/pip-HL3Bo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:31 INFO - Running setup.py (path:/tmp/pip-OYx01v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:31 INFO - Running setup.py (path:/tmp/pip-wD8zbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:31 INFO - Running setup.py (path:/tmp/pip-dcksJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:31 INFO - Running setup.py (path:/tmp/pip-4bYABt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:31 INFO - Running setup.py (path:/tmp/pip-PBD2bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:31 INFO - Running setup.py (path:/tmp/pip-du5jT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:32 INFO - Running setup.py (path:/tmp/pip-_9IP34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:32 INFO - Running setup.py (path:/tmp/pip-fTA0LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:32 INFO - Running setup.py install for manifestparser 09:51:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozcrash 09:51:32 INFO - Running setup.py install for mozdebug 09:51:32 INFO - Running setup.py install for mozdevice 09:51:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozfile 09:51:32 INFO - Running setup.py install for mozhttpd 09:51:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozinfo 09:51:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozInstall 09:51:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozleak 09:51:33 INFO - Running setup.py install for mozlog 09:51:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Running setup.py install for moznetwork 09:51:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Running setup.py install for mozprocess 09:51:33 INFO - Running setup.py install for mozprofile 09:51:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Running setup.py install for mozrunner 09:51:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Running setup.py install for mozscreenshot 09:51:33 INFO - Running setup.py install for moztest 09:51:33 INFO - Running setup.py install for mozversion 09:51:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:33 INFO - Cleaning up... 09:51:33 INFO - Return code: 0 09:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:33 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')]} 09:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:33 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')]} 09:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:33 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 0x21471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b63f0>, '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 0x24b6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b71a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', '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 09:51:33 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 09:51:33 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 09:51:33 INFO - Using env: {'DISPLAY': ':0', 09:51:33 INFO - 'HOME': '/home/cltbld', 09:51:34 INFO - 'LANG': 'en_US.UTF-8', 09:51:34 INFO - 'LANGUAGE': 'en_US:en', 09:51:34 INFO - 'LOGNAME': 'cltbld', 09:51:34 INFO - 'MAIL': '/var/mail/cltbld', 09:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:34 INFO - 'MOZ_NO_REMOTE': '1', 09:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:34 INFO - 'NO_EM_RESTART': '1', 09:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:34 INFO - 'PWD': '/builds/slave/test', 09:51:34 INFO - 'SHELL': '/bin/bash', 09:51:34 INFO - 'SHLVL': '1', 09:51:34 INFO - 'TERM': 'linux', 09:51:34 INFO - 'TMOUT': '86400', 09:51:34 INFO - 'USER': 'cltbld', 09:51:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', 09:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:34 INFO - '_': '/tools/buildbot/bin/python'} 09:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:34 INFO - Running setup.py (path:/tmp/pip-S2pHxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:34 INFO - Running setup.py (path:/tmp/pip-5B1M5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:34 INFO - Running setup.py (path:/tmp/pip-gS8e2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:34 INFO - Running setup.py (path:/tmp/pip-lBX6vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:34 INFO - Running setup.py (path:/tmp/pip-htASNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:34 INFO - Running setup.py (path:/tmp/pip-LcA1pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:34 INFO - Running setup.py (path:/tmp/pip-yCah5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:34 INFO - Running setup.py (path:/tmp/pip-km3VSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:34 INFO - Running setup.py (path:/tmp/pip-KFcl71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:34 INFO - Running setup.py (path:/tmp/pip-UaZqD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:34 INFO - Running setup.py (path:/tmp/pip-v6E6K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:35 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)) 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:35 INFO - Running setup.py (path:/tmp/pip-GPzSgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:35 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)) 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:35 INFO - Running setup.py (path:/tmp/pip-fotZuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:35 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)) 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:35 INFO - Running setup.py (path:/tmp/pip-42GIDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:35 INFO - Running setup.py (path:/tmp/pip-T6QGQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:35 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)) 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:35 INFO - Running setup.py (path:/tmp/pip-GcqJ0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:35 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)) 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:35 INFO - Running setup.py (path:/tmp/pip-bAMC8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:35 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)) 09:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:35 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)) 09:51:35 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:35 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:35 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 09:51:35 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 09:51:35 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 09:51:35 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 09:51:35 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 09:51:35 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 09:51:37 INFO - Downloading blessings-1.6.tar.gz 09:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:37 INFO - Installing collected packages: blessings 09:51:37 INFO - Running setup.py install for blessings 09:51:37 INFO - Successfully installed blessings 09:51:37 INFO - Cleaning up... 09:51:37 INFO - Return code: 0 09:51:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:37 INFO - Reading from file tmpfile_stdout 09:51:37 INFO - Current package versions: 09:51:37 INFO - argparse == 1.2.1 09:51:37 INFO - blessings == 1.6 09:51:37 INFO - blobuploader == 1.2.4 09:51:37 INFO - docopt == 0.6.1 09:51:37 INFO - functools32 == 3.2.3-2 09:51:37 INFO - jsonschema == 2.5.1 09:51:37 INFO - manifestparser == 1.1 09:51:37 INFO - mozInstall == 1.12 09:51:37 INFO - mozcrash == 1.0 09:51:37 INFO - mozdebug == 0.1 09:51:37 INFO - mozdevice == 0.49 09:51:37 INFO - mozfile == 1.2 09:51:37 INFO - mozhttpd == 0.7 09:51:37 INFO - mozinfo == 0.9 09:51:37 INFO - mozleak == 0.1 09:51:37 INFO - mozlog == 3.4 09:51:37 INFO - moznetwork == 0.27 09:51:37 INFO - mozprocess == 0.23 09:51:37 INFO - mozprofile == 0.28 09:51:37 INFO - mozrunner == 6.13 09:51:37 INFO - mozscreenshot == 0.1 09:51:37 INFO - mozsystemmonitor == 0.3 09:51:37 INFO - moztest == 0.7 09:51:37 INFO - mozversion == 1.4 09:51:37 INFO - psutil == 3.1.1 09:51:37 INFO - requests == 1.2.3 09:51:37 INFO - wsgiref == 0.1.2 09:51:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:37 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 0x21471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b63f0>, '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 0x24b6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b71a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', '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 09:51:37 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 09:51:37 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 09:51:37 INFO - Using env: {'DISPLAY': ':0', 09:51:37 INFO - 'HOME': '/home/cltbld', 09:51:37 INFO - 'LANG': 'en_US.UTF-8', 09:51:37 INFO - 'LANGUAGE': 'en_US:en', 09:51:37 INFO - 'LOGNAME': 'cltbld', 09:51:37 INFO - 'MAIL': '/var/mail/cltbld', 09:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:37 INFO - 'MOZ_NO_REMOTE': '1', 09:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:37 INFO - 'NO_EM_RESTART': '1', 09:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:37 INFO - 'PWD': '/builds/slave/test', 09:51:37 INFO - 'SHELL': '/bin/bash', 09:51:37 INFO - 'SHLVL': '1', 09:51:37 INFO - 'TERM': 'linux', 09:51:37 INFO - 'TMOUT': '86400', 09:51:37 INFO - 'USER': 'cltbld', 09:51:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', 09:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:37 INFO - '_': '/tools/buildbot/bin/python'} 09:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 INFO - Cleaning up... 09:51:38 INFO - Return code: 0 09:51:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:38 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')]} 09:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:38 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')]} 09:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:38 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 0x21471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b63f0>, '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 0x24b6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b71a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', '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 09:51:38 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 09:51:38 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 09:51:38 INFO - Using env: {'DISPLAY': ':0', 09:51:38 INFO - 'HOME': '/home/cltbld', 09:51:38 INFO - 'LANG': 'en_US.UTF-8', 09:51:38 INFO - 'LANGUAGE': 'en_US:en', 09:51:38 INFO - 'LOGNAME': 'cltbld', 09:51:38 INFO - 'MAIL': '/var/mail/cltbld', 09:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:38 INFO - 'MOZ_NO_REMOTE': '1', 09:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:38 INFO - 'NO_EM_RESTART': '1', 09:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:38 INFO - 'PWD': '/builds/slave/test', 09:51:38 INFO - 'SHELL': '/bin/bash', 09:51:38 INFO - 'SHLVL': '1', 09:51:38 INFO - 'TERM': 'linux', 09:51:38 INFO - 'TMOUT': '86400', 09:51:38 INFO - 'USER': 'cltbld', 09:51:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', 09:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:38 INFO - '_': '/tools/buildbot/bin/python'} 09:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:51:38 INFO - Cleaning up... 09:51:38 INFO - Return code: 0 09:51:38 INFO - Running post-action listener: _resource_record_post_action 09:51:38 INFO - Running post-action listener: _start_resource_monitoring 09:51:38 INFO - Starting resource monitoring. 09:51:38 INFO - [mozharness: 2016-12-22 17:51:38.449935Z] Finished create-virtualenv step (success) 09:51:38 INFO - [mozharness: 2016-12-22 17:51:38.450416Z] Running install step. 09:51:38 INFO - Running pre-action listener: _resource_record_pre_action 09:51:38 INFO - Running main action method: install 09:51:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:38 INFO - Reading from file tmpfile_stdout 09:51:38 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:38 INFO - Reading from file tmpfile_stdout 09:51:38 INFO - Output received: 09:51:38 INFO - Usage: mozinstall [options] installer 09:51:38 INFO - Options: 09:51:38 INFO - -h, --help show this help message and exit 09:51:38 INFO - -d DEST, --destination=DEST 09:51:38 INFO - Directory to install application into. [default: 09:51:38 INFO - "/builds/slave/test"] 09:51:38 INFO - --app=APP Application being installed. [default: firefox] 09:51:38 INFO - mkdir: /builds/slave/test/build/application 09:51:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:51:54 INFO - Reading from file tmpfile_stdout 09:51:54 INFO - Output received: 09:51:54 INFO - /builds/slave/test/build/application/firefox/firefox 09:51:54 INFO - Running post-action listener: _resource_record_post_action 09:51:54 INFO - [mozharness: 2016-12-22 17:51:54.798517Z] Finished install step (success) 09:51:54 INFO - [mozharness: 2016-12-22 17:51:54.798762Z] Running run-tests step. 09:51:54 INFO - Running pre-action listener: _resource_record_pre_action 09:51:54 INFO - Running main action method: run_tests 09:51:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:51:54 INFO - Python 2.7.3 09:51:54 INFO - Return code: 0 09:51:54 INFO - grabbing minidump binary from tooltool 09:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:54 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 0x24b63f0>, '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 0x24b6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b71a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:51:54 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 09:51:54 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 09:51:54 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 09:51:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:51:54 INFO - Return code: 0 09:51:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:51:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:51:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:51:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:51:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:51:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 09:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 09:51:54 INFO - Using env: {'DISPLAY': ':0', 09:51:54 INFO - 'HOME': '/home/cltbld', 09:51:54 INFO - 'LANG': 'en_US.UTF-8', 09:51:54 INFO - 'LANGUAGE': 'en_US:en', 09:51:54 INFO - 'LOGNAME': 'cltbld', 09:51:54 INFO - 'MAIL': '/var/mail/cltbld', 09:51:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:51:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:54 INFO - 'MOZ_NO_REMOTE': '1', 09:51:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:54 INFO - 'NO_EM_RESTART': '1', 09:51:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:54 INFO - 'PWD': '/builds/slave/test', 09:51:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:51:54 INFO - 'SHELL': '/bin/bash', 09:51:54 INFO - 'SHLVL': '1', 09:51:54 INFO - 'TERM': 'linux', 09:51:54 INFO - 'TMOUT': '86400', 09:51:54 INFO - 'USER': 'cltbld', 09:51:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917', 09:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:54 INFO - '_': '/tools/buildbot/bin/python'} 09:51:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 09:51:55 INFO - mozversion application_buildid: 20161222084453 09:51:55 INFO - mozversion application_changeset: 7b88f8d64a954843f065cbbd1876e8e1464948e3 09:51:55 INFO - mozversion application_display_name: Nightly 09:51:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:51:55 INFO - mozversion application_name: Firefox 09:51:55 INFO - mozversion application_remotingname: firefox 09:51:55 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 09:51:55 INFO - mozversion application_vendor: Mozilla 09:51:55 INFO - mozversion application_version: 53.0a1 09:51:55 INFO - mozversion platform_buildid: 20161222084453 09:51:55 INFO - mozversion platform_changeset: 7b88f8d64a954843f065cbbd1876e8e1464948e3 09:51:55 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 09:51:55 INFO - mozversion platform_version: 53.0a1 09:51:55 INFO - using testdate: 1482429115 09:51:55 INFO - actual date: 1482429115 09:51:55 INFO - starting webserver on 'localhost:54810' 09:51:55 INFO - SUITE-START | Running 2 tests 09:51:55 INFO - TEST-START | dromaeo_css 09:51:55 INFO - operating with platform_type : linux_ 09:51:55 INFO - Initialising browser for dromaeo_css test... 09:51:55 INFO - TEST-INFO | started process 7399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuOCIEM/profile http://localhost:54810/getInfo.html) 09:51:59 INFO - PROCESS | 7399 | __metrics Screen width/height:1600/1200 09:51:59 INFO - PROCESS | 7399 | colorDepth:24 09:51:59 INFO - PROCESS | 7399 | Browser inner width/height: 1024/697 09:51:59 INFO - PROCESS | 7399 | __metrics 09:51:59 INFO - PROCESS | 7399 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:51:59 INFO - PROCESS | 7399 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:00 INFO - PROCESS | 7399 | console.error: PushService: 09:52:00 INFO - PROCESS | 7399 | stateChangeProcessEnqueue: Error transitioning state 09:52:00 INFO - PROCESS | 7399 | UnknownError 09:52:01 INFO - TEST-INFO | 7399: exit 0 09:52:01 INFO - Browser initialized. 09:52:01 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:01 INFO - TEST-INFO | started process 7482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuOCIEM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:13 INFO - PROCESS | 7482 | RSS: Main: 154632192 09:52:13 INFO - PROCESS | 7482 | 09:53:04 INFO - PROCESS | 7482 | 1482429184743 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] 09:55:18 INFO - PROCESS | 7482 | Cycle 1(1): loaded http://localhost:54810/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54810/tests/dromaeo/cssquery-ext.html) 09:55:20 INFO - PROCESS | 7482 | RSS: Main: 285204480 09:55:20 INFO - PROCESS | 7482 | 09:58:23 INFO - PROCESS | 7482 | Cycle 1(1): loaded http://localhost:54810/tests/dromaeo/cssquery-ext.html (next: http://localhost:54810/tests/dromaeo/cssquery-jquery.html) 09:58:23 INFO - PROCESS | 7482 | RSS: Main: 247033856 09:58:23 INFO - PROCESS | 7482 | 10:01:25 INFO - PROCESS | 7482 | Cycle 1(1): loaded http://localhost:54810/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54810/tests/dromaeo/cssquery-mootools.html) 10:01:26 INFO - PROCESS | 7482 | RSS: Main: 230780928 10:01:26 INFO - PROCESS | 7482 | 10:04:28 INFO - PROCESS | 7482 | Cycle 1(1): loaded http://localhost:54810/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54810/tests/dromaeo/cssquery-prototype.html) 10:04:29 INFO - PROCESS | 7482 | RSS: Main: 189698048 10:04:29 INFO - PROCESS | 7482 | 10:07:32 INFO - PROCESS | 7482 | Cycle 1(1): loaded http://localhost:54810/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54810/tests/dromaeo/cssquery-yui.html) 10:07:33 INFO - PROCESS | 7482 | RSS: Main: 190795776 10:07:33 INFO - PROCESS | 7482 | 10:10:36 INFO - PROCESS | 7482 | Cycle 1(1): loaded http://localhost:54810/tests/dromaeo/cssquery-yui.html (next: http://localhost:54810/tests/dromaeo/cssquery-dojo.html) 10:10:36 INFO - PROCESS | 7482 | RSS: Main: 291885056 10:10:36 INFO - PROCESS | 7482 | 10:10:36 INFO - PROCESS | 7482 | __start_tp_report 10:10:36 INFO - PROCESS | 7482 | _x_x_mozilla_page_load 10:10:36 INFO - PROCESS | 7482 | _x_x_mozilla_page_load_details 10:10:36 INFO - PROCESS | 7482 | |i|pagename|runs| 10:10:36 INFO - PROCESS | 7482 | |0;dojo.html;2604.739526047395;2628.3166376742065;2645;2646.8014898882584;2672.679278486582;4662.533746625336;4685.742284174369;4778.617710583154;4795;4805.014971930759;4752.952470475294;4755.072760811635;4758.714477131366;4766.332713420124;4779.139754844126;4346.282863327555;4371.213181627306;4384.21084204843;4415.403920470728;4448.555144485558;4427.358033085201;4434.379186913835;4447.822087116511;4457.064016556527;4459.331100334959;4320.956790432103;4358.4987726411555;4363.4327537420095;4385.298352263639;4449.888752781174;4439.1121775645;4451.933221001687;4452.5992660660695;4456.55434456555;4460.375547423363;4240.109576988836;4260.10537787062;4376.562343765598;4403.603675669206;4425.424694789656;4699.036697477009;4731.053789242131;4754.952450475485;4780.282957556359;4787.066522028206;5078.847634570969;5102.336696229467;5104.897902041976;5107.131787596118;5145.434002259748;5021.723805190713;5134.717590532519;5142.1772516397195;5147.22791581262;5148.176291793295;4694.530546945346;4711.246200607886;4751.738654374042;4758.857234282977;4762.095201911626;5213.40045894727;5220.504052115043;5224.425313215544;5227.26818245446;5256.789728410898;4997.400311962588;5002.499750025041;5013.699178049329;5016.072026675077;5068.467810879878;4990.151674215392;5021.271915572222;5023.120953833065;5030.119729047402;5068.290439338495;4962.851114466572;4992.201247800334;5052.747362631927;5054.368203974504;5079.288899554065;4984.40187177541;4997.700137991732;4998.175301075355;5015.423226328946;5031.949680503149;4194.853180138742;4251.617354438115;4291.54938731435;4321.286987647003;4352.695311328177;3736.1406876418578;3737.6449237322413;3749.2876353492748;3758.0792705787258;3809.942850857239;4379.3430985351815;4395.604395604411;4396.318570621559;4396.802143903532;4441.622462090759;5134.127198376285;5135.332406787168;5141.100307446182;5143.022825663112;5189.481051894781;4276.914461710749;4302.075053863435;4311.719738217006;4313.870583882489;4359.258925982527;4572.6799124061;4574;4604.8388306409115;4612.74629895359;4622.791974361162;4710.576048155683;4710.717356958594;4710.8351207707565;4715.198416269174;4759.738214398241;4987.700737955734;5018.548330650259;5027.824026159067;5046.19260918266;5065.392152941523;4702.717836929795;4720.834770783006;4736.905261894812;4791.353167322367;4801.18379875415;5044.798208071783;5045.217991211368;5046.747662616928;5055.7219352935945;5100.336956195671;5126.53861152498;5131.56381707559;5136.409312929061;5137.92293115611;5177.767000485062;4851.054044461437;4886;4895.828645997373;4953.851384458472;4976.029674213639;4910.337104490991;4934.161192597196;4956.207006878882;4964.652474326763;4968.677035992649;4818.903621927612;4859.416869975626;4859.781309840995;4869.269609558452;4918.0901533216465;4930.087933732271;4953.430355509163;4956.504349565014;4979.3526841510375;5010.599152067753;4821.108095002436;4855.635827313036;4859.659823812299;4875.146849301429;4912.606991440604 10:10:36 INFO - PROCESS | 7482 | |1;ext.html;501.32321366155685;524.394324555139;532.6564365983941;535.4377903201637;552.4144406928654;27728.44543109139;30766.077017689477;37304.25391492172;38999.22001559967;39066.60933390665;39670;40218.79890600543;40223;40248.59751402485;40255.396169057414;7496.137944136412;7650.885236721454;7662.310392064713;7667.616619169047;7670.27132422419;7246.8188295292775;7418.295261950133;7452.5901075440825;9602.75993100171;9876.061774131445;9794.363366381198;9857.260705447085;9859.26055545837;9865.1614612758;9870.753231169243;9558.426494410358;9596.568154433067;9602.279829012852;9607.855882161773;9610.135087842127;9595.952020239924;9679;9683.370580912218;9684;9685.176759975411;37041.81479092587;37305.25389492195;37325.44011839797;37358.81320593407;37394.439083413774;2915.7375836174633;2952.6161598991994;3011.8494075296367;3166.493361062242;3294.5552350432627;27164.32089197786;27789.583156252673;27802.443951121066;28370.432591348057;29007.129786106452;3416.7266618670446;3446.724262059029;3464.133966508373;3486.3027394521196;3499.212677147647;236973;238287;238401;239259;240838;45697.54302456933;46313;46336;46340.53659463429;46355.53644463512;52174.21738673923;52203;52283;52295.21557176646;52302.21546676803;14472.638184045272;14789.926050369895;14831.555053348417;14850.628734281729;14888.330025148678;11396.544138234543;11451.083913286917;11471;11481.483333249857;11510.36692981894;13200.933995330153;13575.728485430236;14645.92677036608;14971;15219.543413697607;6148.754049837957;6197.876042479215;6218.253809542884;6238.65687387189;6241.906371404432;750.107372227048;832.0930186097183;880.9515476648718;888.8800011998427;956.31623389277;25870.6119408209;26782;27169.592456113172;27500.449991000067;27529.587056194174;910.1274078794686;913;934.345957829522;948.4356807699407;1030.7577719235974;14268.574342361824;14564.49024284145;14627.976041677193;14725;14914.254287285592;359481;360437;360838;361603;361707;48570.27144592834;48794.75602621964;48843.755781221575;48867.511324887004;48875.266870996966;1073.4257172412722;1074.9140068794477;1079.924405291622;1158.530795028015;1222.046803493259;25992.22023339303;28219.57670634901;28923.276918077216;31169.688303117586;31179.376412472076;39728.2054358917;40159.1968160641;40182.19635607213;40220.79889600533;40274;320590;322495;322786;324402;325106;29869.551956720232;34361;34719.82640086783;35171.82414087913;35258.8237058813;31378.52932205973;34416.311673765886;34703.30593388068;35269.647303527665;40772;31671.52492712565;33965.32069358649;34987;36048.09879753027;36239.63760362468;34979;35187.47218791669;35270.11824704403;35484.29031419409;35754.64245357617;31541.36917261688;32592.674073259914;34349.65650343464;34362;34587.13532161716;26639;28353.71646283511;28708.40186163678;28924.781172047267;29287.7071229285;22393.44474996117;22841.20055798039;22945.196918107787;23027.309180724606;23203.419914502272 10:10:36 INFO - PROCESS | 7482 | |2;jquery.html;361.7341254178179;368.99262014759705;371.53372517490544;379.49716625471257;395.0952319189057;15478.922605386972;16200;16691.49925502237;16695.08177050263;16745.413910513103;15520.30158642861;16201.91899040503;16765.161741912885;16848.74726879098;16850.578735531617;4886.462489126193;5124.795008199668;5125.487451254863;5146.202338637517;5146.948530514703;3751.4560388743616;3940.9802950985204;5040.672356296829;5657.462541058593;5889.234399528055;5955.017422125344;5968.79109231177;5976.970115149418;5978.850528736794;5984.311804142514;5762.135679648044;5934.525237980973;5971.731272092767;5982.04287314032;5984.611000284967;5078.746062696888;5210.817621383233;5225.372955245357;5235.869103272411;5247.921281180786;19998.100085496186;20279.188832446685;20279.391618251477;20303.289384871605;20339.89830050855;1771.371163237058;1771.6722406354736;1784.50925995351;1786.9106544672713;1878.7651543557056;12073.154879158463;12745.61763147107;12958.546450874268;13403.128796628285;13471.528496502575;1690.3492155520091;1738.9565260868453;1741.9738703919452;1821.9908900455546;1848.879822811513;64805.67597162031;65383.67308163429;66372.3362766371;67162;68199.65900170516;8843.734687959372;9016.8647470288;9079.909200908038;9203.953980230055;9846.704598862045;11971.76056478883;11983.940080299542;12004.939975300067;12005.099617528545;12016.158868879094;7158.892616610755;7335;7349.77950661481;7519.135299440525;7536.660850261751;7316.890246646304;7317.195108538057;7511.586862722494;7528.661210245552;7552.471327007167;5939.4357536034;5968.507873031742;5988.490978266809;6148.1392605035335;6154.599951003171;1579.652476455178;1680.3952225624498;1707.6670049340507;1724.4567961092216;1771.1498480729322;740.3226048165868;790.8062524681375;806.6128258435983;882.6734108379941;893.7318804358796;16175.595610109605;16868.915655421646;17341;17580.912095439697;17864.91067544654;871.507598207011;943.155875491445;964.5900492290748;964.7009427077628;973.743870407181;9273.443593384418;9976.501174941224;10043.799124017478;10086.49567521621;10101.646442374482;338656;343610;360716;365224;366733;52667.73666131645;73382;75464.62267688627;77890;80453;921.083521895718;939.7838497145694;959.7552624080954;962.0475729028351;962.3744566031995;14816.925915370353;14955.850441495446;16154.838451615333;16370.672586547964;16452.917735411724;34585.48121778225;34865.825670872495;34918.30163396768;35270.47094293639;36009.81995090008;44425.77787111044;49565.50434495609;49687.25469118039;49773.75113124411;52904.47095528995;6933.1333583302085;7338.743143989935;7374.299441553044;7498.812529686801;7549.471536992358;11083.612073577386;11372.37451940118;11543.36511491876;11567.305961642329;11731.824022639837;9048.954755226445;9636.951815240878;9855.408675479493;9910.702678919644;10040.347377420736;5238.947610523998;7233.674484648098;10347.84478232812;10499.265051446326;10589.941005899349;10254.179665626882;10321.63874264397;10501.059703283094;10586.8411973822;10870.130389568658;7264.491485595958;7417.443691723034;7503.437242206747;7545.358644515278;7703.152653208031;9541.809163816546;10044.146247568746;10327.070563649308;10364.844527331945;10685.412302323135 10:10:36 INFO - PROCESS | 7482 | |3;mootools.html;1317.3084130831314;1323.8146659467673;1416.1998470863962;1649.3155340533679;1686.0558087471009;6886.965565172173;7303.926960730391;7307.2327405622445;7308.342249197571;7310.415166786657;6301.558890877641;6535.771248006321;6861.451083913287;7170.820729481766;7187.82030449239;2035.2469586253108;2100.0339843671927;2100.5693832764323;2112.1656945506516;2114.68279758036;2105.577391910044;2123.288698286076;2127;2135.679648052797;2140.240214723774;1849.0662215581112;1916.587933594277;2032.573159636478;2099.9055042523046;2102.7161333219974;2086.235737647608;2094.581083783242;2102.547952190271;2108.114591871418;2121.5862906733114;2092.95814083719;2104.084723145437;2130.2118216260083;2131.637621604331;2132.4135862637745;7051.89422158668;7107.395871350941;7119.89320160198;7123;7125.608091554963;4287.228298906196;4408.272635015219;4409.691321607489;4412.735235885857;4425.557444255581;2705.9323516912036;2849.5440729483184;2858.5997960285576;2869.813462124976;2909.432660631178;841.045413455726;870.9869351959662;889.9288056955428;892.0900681305033;925.3383830561181;9355.719328420158;9489.762755931088;9554.570044348022;9565.808683826353;9587.328886977913;3789.943150852684;3977.980110099431;4044.8179831907637;4049.7772622505454;4058.9594104058583;8158.143394943446;8170.795730106676;8175.345972322319;8179;8179.5501247430775;4375.234333991539;4440.444944381952;4450.132224216247;4465.508794032654;4472.396226509444;3891.2412079644764;4084.0606660468256;4084.3465045593157;4084.611961863618;4088.5707000765087;3192.4892017277125;3228.7255583275214;3310.9337813244083;3319.1204330852343;3336.7987524491164;1012.4988130875264;1016.3038318751532;1025.887152413234;1025.9025392587691;1026.0560284538242;555.5167004705851;605.5186127029023;757.6628400361786;781.5857595474407;804.3886646148969;4515.909681806345;4601.263797792337;4747.691400058985;4805.087033463631;4838.806447742051;805.6253841963515;837.1544739812833;846.7003150164591;852.7441767469734;886.2511178054533;2968.1540760883045;3255.2187475005826;3265.689759472846;3273.5759944423776;3363.293708321231;8226.876596851052;8674.826503469896;8690.217880390795;8692.130786921258;8696.652133914698;8644;8661.220490155916;8670.4364216327;8674.08922063187;8677.522736249566;6606.504512161607;6729.899051514231;6833.248342682301;6849.828754281183;6856.348646878539;4477.350784136217;4547.136044151601;4629.259318509023;4671.626269898332;4724.314974328772;7835.49069310493;7934.761957141295;8041.597920104088;8074.232947869943;8087.676492940216;7598.278163574451;8016.398770092383;8023.117457079833;8122.796930076795;8137.186281372053;5891.293044834647;6231.2522497300615;6239.847252697812;6240.968795155995;6242.5942313749465;6642.667866606747;6686.83282917931;6707.530472867048;6709.295523969913;6881.862362752817;5937.198478205387;6291.685415729286;6331.746730130743;6337.714802833976;6459.289478157305;6112.602680825732;6129;6205.379462053758;6205.596636218631;6265.8120256392385;5475.288212532345;5720.628159169641;5919.230500034968;5973.880522389615;5980.222571065734;4016.477857878574;4098.118904435561;4196.517400498981;4201.054762678373;4236.173946080485;3991.3015222335393;4079.7960101995377;4094.467719196485;4221.324588065895;4242.575742425856 10:10:36 INFO - PROCESS | 7482 | |4;prototype.html;338.92543640399117;346.07597714103343;351.9778870389611;356.6077314953553;359.6313778377163;4858.2712593111055;4866.685994781411;4879.26810978353;4890.361728820849;4893.755312234383;4816.397950256218;4825.975870120645;4843.927341089887;4857.441394239663;4859.975700121495;3629.510016147826;3757.2673328700916;3790.753601015939;3819.618038196186;3851;3855.4024126260474;3867;3872.7289089763726;3879.631435013669;3890.8832735017854;3837.328467518187;3840.1183420124216;3848.749831260959;3859.4789703390106;3869.6517313441786;3548.591911930135;3617.5658920929527;3722.9069273268115;3741.185525020363;3846.9807650961848;3391.16916355492;3401.744869134825;3441.587009558844;3449.223924616941;3472.9581125662453;4646.907061858744;4661.510541393172;4663.88340291492;4670.369500117508;4677.836275730333;3986.043349596105;4318.078455087456;4342.630876375511;4364.607185353301;4368.9417407814335;4933.679310844784;4965.0566392385335;4982.800687972477;4986.4265609455015;4987;3518.5074089627474;3518.648135186461;3520.7677312940523;3523.4714792781033;3528.8059156746367;5217.530422262014;5241.135212689902;5275;5278.2346559749;5298.311219541435;3429.9142521437166;3591.174029973121;3652.2878038782715;3658.5243918290985;3661.3043521730788;3700.518932538753;3707.1288247261873;3708.38811596089;3714.4985426967555;3715.9442608360896;4221.430106935586;4249.660027197817;4260.25445547028;4266.935995960063;4268.487781466244;4746.359241502422;4987.376577927759;5064.82273120439;5124.615653825978;5126.615503837227;1326.4561529772748;1341.7655756703855;1342.7717288061053;1347.4879545772544;1347.5110003446248;911.3392790227032;960.4813400763649;966.3911735606523;968.1480297338438;968.719071469266;4261.488621365456;4336.284513055373;4336.349547567827;4407.493138289074;4459.9331010034875;5203.947960520422;5208.374995000549;5217.0870097733505;5222.164453687392;5226.268322434862;4460.353248778909;4462.799174037176;4476.395686582335;4477.552244775497;4478.462584489882;2571.5756900111646;2673.3717576369536;2675.17069708391;2710.8915643374044;2715.416185520123;4717.956917788008;4727.929081063787;4745.9050818984115;4760.262159365304;4764.212935432742;5149.2791009258735;5155.226715992556;5161.4322424533275;5162.845114646567;5186.196139598368;4546.840860569864;4687.789049492781;4850.490698476679;4869.758211656005;4869.829555965595;5144.30551875507;5149.845504634867;5156.8341296656245;5183.859550898796;5239.397469290928;5119.718415487184;5131.820386286462;5132.714183656689;5140.177571588528;5156.9742151289;4671.43942726875;4816.614670826255;4843.564079232886;4852.986010805476;4859.198232291632;3627.6009638940222;3642.908927276839;3647.8905632831056;3657.908552286214;3662.9816850915577;5199.2980947573105;5203.427622961395;5241.790328386822;5264.552513036435;5277.498637629419;4803.270822503826;5029.59763218949;5035.899282014266;5061.13960626687;5105;5044.989233559256;5045.823396181116;5079.6952182869145;5084.5932325414615;5100.979804039132;4991.450940396481;4993.950060499348;4995.550400463976;4996.200607902718;5029.170186919117;4850.248211527219;4947.678400903929;5015.448300686994;5068.949310506995;5072.909324495251;4798.4001999750035;4964.776585053609;4980.526849949249;4986.825461108844;4987.202047672355 10:10:36 INFO - PROCESS | 7482 | |5;yui.html;595.7587177193237;644.9137041670199;674.1135406939877;698.8462538241587;721.9061522002139;11849.822252666207;12608.621741347752;13143.737125257489;13156.407961641726;13162.473501059958;11987.640370788868;12192.634220973363;13936.233507157127;14448.927755361236;14567.490137845178;621.1738387944024;635.605924326918;783.6630248992931;803.7869964459423;804.7143264141233;769.6536558548647;785.512981951191;797.5055465611329;799.604195923016;800.1038836503095;832.4505826154739;832.883396324515;833.125218520554;834.6160766047625;835.0980940584185;644.7711062572813;666.0808084842886;825.4469505431346;826.8181000179951;827.1067247372853;495.86859482237236;495.9950400496021;496.31012892080037;585.3151812379526;597.8654802669408;12475;12484.625461236177;12520.874791252061;12551.309677967709;12602.117851750381;12305.938470307681;12484.687882802911;12784.105112642119;12812;12835.486580536768;11895.52417903283;11915.285082895054;11961.162718609701;12093.395330233454;12105.515779368903;3947.46709194258;3966.5835087315704;4015.738976966488;4029.1135950090934;4044.2518134144984;65241.45447636957;65641.67179164122;65649.99999999952;66061.66969165171;66964.66517667429;10026.598936042623;10100.848487272697;10313.329633573794;10387.169026477864;10447.84328235077;18209.908950455163;18321.267149313877;18331.54171145732;18344.174512146987;18348.266069357076;6486.351364863476;6507.154069970874;6555.934440655627;6613.107230523914;6702.355778516184;3471.288385880888;3541.1501239702284;3541.6281290464644;3547.130952916552;3621.149029977953;2840.9431811363656;2884.22126025976;2920.941581168365;2929.033418971734;2932.2376182192356;477.4294717812181;491.38576779026215;498.7755510020505;501.6563653897092;509.5032343465166;420.9957900420957;459.9632029437637;494.91091603510995;519.6154845414366;523.5523627298605;7420.9628951855975;7517.849643007109;7741.61291935401;7909.288164065261;7974.441789074709;423.7097588152126;455.7538928978381;457.7185031205851;466.4728856392255;500.43450900482225;3751.7748935063437;3779.527559055118;3820.140468394589;3994.500687414073;3995.84016639337;52895.735521322145;61412;67256;70772;70812;57550.7122464385;57772.42227577754;60025.399746002855;60215;60437.39562604317;53181.734091329294;53321.20018199808;53423.732881335345;53771.19343209855;53869.191962120596;7299.8540029200185;7544.924550754422;7716.691332346643;7795.610219489116;7893.684252629831;37666;38229.23541529098;38463.423048654855;38810.22379552449;38813.611863881;44364.11271774611;48301.27548086711;49402.50597493979;49556.50443495663;49914;8472.915270847212;8571.614277357408;8650.653973840976;8673.95663021706;8690.391672582859;9613.182879455324;9615.855762163434;9637.18083962871;9699.74605387647;9851.211903047883;9289.72130836076;9451.102145296185;9512.714618561455;9518.23854091657;9567.37812042215;9252.121048500381;9408.764780880532;9430.669926552539;9460.95269523648;9505.572249248939;10358.585656573652;10418.322809017389;10449.477526123816;10508.159347252049;11523.53905843757;9961.800763984535;10334.376658614427;10611.681649550526;10821.891781082088;10926;10490.895091049297;10649.9467502662;10736.51685674131;10760.40817755031;10807.891921080689 10:10:36 INFO - PROCESS | 7482 | __end_tp_report 10:10:36 INFO - PROCESS | 7482 | __start_cc_report 10:10:36 INFO - PROCESS | 7482 | _x_x_mozilla_cycle_collect,1451 10:10:36 INFO - PROCESS | 7482 | __end_cc_report 10:10:36 INFO - PROCESS | 7482 | __startTimestamp1482430236298__endTimestamp 10:10:36 INFO - PROCESS | 7482 | 10:10:36 INFO - PROCESS | 7482 | ------- Summary: start ------- 10:10:36 INFO - PROCESS | 7482 | Number of tests: 6 10:10:36 INFO - PROCESS | 7482 | 10:10:36 INFO - PROCESS | 7482 | [#0] dojo.html Cycles:165 Average:4694.97 Median:4795.00 stddev:492.45 (10.3%) stddev-sans-first:465.86 10:10:36 INFO - PROCESS | 7482 | Values: 2604.7 2628.3 2645.0 2646.8 2672.7 4662.5 4685.7 4778.6 4795.0 4805.0 4753.0 4755.1 4758.7 4766.3 4779.1 4346.3 4371.2 4384.2 4415.4 4448.6 4427.4 4434.4 4447.8 4457.1 4459.3 4321.0 4358.5 4363.4 4385.3 4449.9 4439.1 4451.9 4452.6 4456.6 4460.4 4240.1 4260.1 4376.6 4403.6 4425.4 4699.0 4731.1 4755.0 4780.3 4787.1 5078.8 5102.3 5104.9 5107.1 5145.4 5021.7 5134.7 5142.2 5147.2 5148.2 4694.5 4711.2 4751.7 4758.9 4762.1 5213.4 5220.5 5224.4 5227.3 5256.8 4997.4 5002.5 5013.7 5016.1 5068.5 4990.2 5021.3 5023.1 5030.1 5068.3 4962.9 4992.2 5052.7 5054.4 5079.3 4984.4 4997.7 4998.2 5015.4 5031.9 4194.9 4251.6 4291.5 4321.3 4352.7 3736.1 3737.6 3749.3 3758.1 3809.9 4379.3 4395.6 4396.3 4396.8 4441.6 5134.1 5135.3 5141.1 5143.0 5189.5 4276.9 4302.1 4311.7 4313.9 4359.3 4572.7 4574.0 4604.8 4612.7 4622.8 4710.6 4710.7 4710.8 4715.2 4759.7 4987.7 5018.5 5027.8 5046.2 5065.4 4702.7 4720.8 4736.9 4791.4 4801.2 5044.8 5045.2 5046.7 5055.7 5100.3 5126.5 5131.6 5136.4 5137.9 5177.8 4851.1 4886.0 4895.8 4953.9 4976.0 4910.3 4934.2 4956.2 4964.7 4968.7 4818.9 4859.4 4859.8 4869.3 4918.1 4930.1 4953.4 4956.5 4979.4 5010.6 4821.1 4855.6 4859.7 4875.1 4912.6 10:10:36 INFO - PROCESS | 7482 | 10:10:36 INFO - PROCESS | 7482 | [#1] ext.html Cycles:180 Average:45737.84 Median:35264.24 stddev:81922.20 (232.3%) stddev-sans-first:82081.60 10:10:36 INFO - PROCESS | 7482 | Values: 501.3 524.4 532.7 535.4 552.4 27728.4 30766.1 37304.3 38999.2 39066.6 39670.0 40218.8 40223.0 40248.6 40255.4 7496.1 7650.9 7662.3 7667.6 7670.3 7246.8 7418.3 7452.6 9602.8 9876.1 9794.4 9857.3 9859.3 9865.2 9870.8 9558.4 9596.6 9602.3 9607.9 9610.1 9596.0 9679.0 9683.4 9684.0 9685.2 37041.8 37305.3 37325.4 37358.8 37394.4 2915.7 2952.6 3011.8 3166.5 3294.6 27164.3 27789.6 27802.4 28370.4 29007.1 3416.7 3446.7 3464.1 3486.3 3499.2 236973.0 238287.0 238401.0 239259.0 240838.0 45697.5 46313.0 46336.0 46340.5 46355.5 52174.2 52203.0 52283.0 52295.2 52302.2 14472.6 14789.9 14831.6 14850.6 14888.3 11396.5 11451.1 11471.0 11481.5 11510.4 13200.9 13575.7 14645.9 14971.0 15219.5 6148.8 6197.9 6218.3 6238.7 6241.9 750.1 832.1 881.0 888.9 956.3 25870.6 26782.0 27169.6 27500.4 27529.6 910.1 913.0 934.3 948.4 1030.8 14268.6 14564.5 14628.0 14725.0 14914.3 359481.0 360437.0 360838.0 361603.0 361707.0 48570.3 48794.8 48843.8 48867.5 48875.3 1073.4 1074.9 1079.9 1158.5 1222.0 25992.2 28219.6 28923.3 31169.7 31179.4 39728.2 40159.2 40182.2 40220.8 40274.0 320590.0 322495.0 322786.0 324402.0 325106.0 29869.6 34361.0 34719.8 35171.8 35258.8 31378.5 34416.3 34703.3 35269.6 40772.0 31671.5 33965.3 34987.0 36048.1 36239.6 34979.0 35187.5 35270.1 35484.3 35754.6 31541.4 32592.7 34349.7 34362.0 34587.1 26639.0 28353.7 28708.4 28924.8 29287.7 22393.4 22841.2 22945.2 23027.3 23203.4 10:10:36 INFO - PROCESS | 7482 | 10:10:36 INFO - PROCESS | 7482 | [#2] jquery.html Cycles:180 Average:23040.14 Median:49626.38 stddev:58691.67 (118.3%) stddev-sans-first:58831.61 10:10:36 INFO - PROCESS | 7482 | Values: 361.7 369.0 371.5 379.5 395.1 15478.9 16200.0 16691.5 16695.1 16745.4 15520.3 16201.9 16765.2 16848.7 16850.6 4886.5 5124.8 5125.5 5146.2 5146.9 3751.5 3941.0 5040.7 5657.5 5889.2 5955.0 5968.8 5977.0 5978.9 5984.3 5762.1 5934.5 5971.7 5982.0 5984.6 5078.7 5210.8 5225.4 5235.9 5247.9 19998.1 20279.2 20279.4 20303.3 20339.9 1771.4 1771.7 1784.5 1786.9 1878.8 12073.2 12745.6 12958.5 13403.1 13471.5 1690.3 1739.0 1742.0 1822.0 1848.9 64805.7 65383.7 66372.3 67162.0 68199.7 8843.7 9016.9 9079.9 9204.0 9846.7 11971.8 11983.9 12004.9 12005.1 12016.2 7158.9 7335.0 7349.8 7519.1 7536.7 7316.9 7317.2 7511.6 7528.7 7552.5 5939.4 5968.5 5988.5 6148.1 6154.6 1579.7 1680.4 1707.7 1724.5 1771.1 740.3 790.8 806.6 882.7 893.7 16175.6 16868.9 17341.0 17580.9 17864.9 871.5 943.2 964.6 964.7 973.7 9273.4 9976.5 10043.8 10086.5 10101.6 338656.0 343610.0 360716.0 365224.0 366733.0 52667.7 73382.0 75464.6 77890.0 80453.0 921.1 939.8 959.8 962.0 962.4 14816.9 14955.9 16154.8 16370.7 16452.9 34585.5 34865.8 34918.3 35270.5 36009.8 44425.8 49565.5 49687.3 49773.8 52904.5 6933.1 7338.7 7374.3 7498.8 7549.5 11083.6 11372.4 11543.4 11567.3 11731.8 9049.0 9637.0 9855.4 9910.7 10040.3 5238.9 7233.7 10347.8 10499.3 10589.9 10254.2 10321.6 10501.1 10586.8 10870.1 7264.5 7417.4 7503.4 7545.4 7703.2 9541.8 10044.1 10327.1 10364.8 10685.4 10:10:36 INFO - PROCESS | 7482 | 10:10:36 INFO - PROCESS | 7482 | [#3] mootools.html Cycles:180 Average:4698.83 Median:3015.40 stddev:2557.39 (84.8%) stddev-sans-first:2551.94 10:10:36 INFO - PROCESS | 7482 | Values: 1317.3 1323.8 1416.2 1649.3 1686.1 6887.0 7303.9 7307.2 7308.3 7310.4 6301.6 6535.8 6861.5 7170.8 7187.8 2035.2 2100.0 2100.6 2112.2 2114.7 2105.6 2123.3 2127.0 2135.7 2140.2 1849.1 1916.6 2032.6 2099.9 2102.7 2086.2 2094.6 2102.5 2108.1 2121.6 2093.0 2104.1 2130.2 2131.6 2132.4 7051.9 7107.4 7119.9 7123.0 7125.6 4287.2 4408.3 4409.7 4412.7 4425.6 2705.9 2849.5 2858.6 2869.8 2909.4 841.0 871.0 889.9 892.1 925.3 9355.7 9489.8 9554.6 9565.8 9587.3 3789.9 3978.0 4044.8 4049.8 4059.0 8158.1 8170.8 8175.3 8179.0 8179.6 4375.2 4440.4 4450.1 4465.5 4472.4 3891.2 4084.1 4084.3 4084.6 4088.6 3192.5 3228.7 3310.9 3319.1 3336.8 1012.5 1016.3 1025.9 1025.9 1026.1 555.5 605.5 757.7 781.6 804.4 4515.9 4601.3 4747.7 4805.1 4838.8 805.6 837.2 846.7 852.7 886.3 2968.2 3255.2 3265.7 3273.6 3363.3 8226.9 8674.8 8690.2 8692.1 8696.7 8644.0 8661.2 8670.4 8674.1 8677.5 6606.5 6729.9 6833.2 6849.8 6856.3 4477.4 4547.1 4629.3 4671.6 4724.3 7835.5 7934.8 8041.6 8074.2 8087.7 7598.3 8016.4 8023.1 8122.8 8137.2 5891.3 6231.3 6239.8 6241.0 6242.6 6642.7 6686.8 6707.5 6709.3 6881.9 5937.2 6291.7 6331.7 6337.7 6459.3 6112.6 6129.0 6205.4 6205.6 6265.8 5475.3 5720.6 5919.2 5973.9 5980.2 4016.5 4098.1 4196.5 4201.1 4236.2 3991.3 4079.8 4094.5 4221.3 4242.6 10:10:36 INFO - PROCESS | 7482 | 10:10:36 INFO - PROCESS | 7482 | [#4] prototype.html Cycles:180 Average:4184.97 Median:4746.13 stddev:1196.55 (25.2%) stddev-sans-first:1164.56 10:10:36 INFO - PROCESS | 7482 | Values: 338.9 346.1 352.0 356.6 359.6 4858.3 4866.7 4879.3 4890.4 4893.8 4816.4 4826.0 4843.9 4857.4 4860.0 3629.5 3757.3 3790.8 3819.6 3851.0 3855.4 3867.0 3872.7 3879.6 3890.9 3837.3 3840.1 3848.7 3859.5 3869.7 3548.6 3617.6 3722.9 3741.2 3847.0 3391.2 3401.7 3441.6 3449.2 3473.0 4646.9 4661.5 4663.9 4670.4 4677.8 3986.0 4318.1 4342.6 4364.6 4368.9 4933.7 4965.1 4982.8 4986.4 4987.0 3518.5 3518.6 3520.8 3523.5 3528.8 5217.5 5241.1 5275.0 5278.2 5298.3 3429.9 3591.2 3652.3 3658.5 3661.3 3700.5 3707.1 3708.4 3714.5 3715.9 4221.4 4249.7 4260.3 4266.9 4268.5 4746.4 4987.4 5064.8 5124.6 5126.6 1326.5 1341.8 1342.8 1347.5 1347.5 911.3 960.5 966.4 968.1 968.7 4261.5 4336.3 4336.3 4407.5 4459.9 5203.9 5208.4 5217.1 5222.2 5226.3 4460.4 4462.8 4476.4 4477.6 4478.5 2571.6 2673.4 2675.2 2710.9 2715.4 4718.0 4727.9 4745.9 4760.3 4764.2 5149.3 5155.2 5161.4 5162.8 5186.2 4546.8 4687.8 4850.5 4869.8 4869.8 5144.3 5149.8 5156.8 5183.9 5239.4 5119.7 5131.8 5132.7 5140.2 5157.0 4671.4 4816.6 4843.6 4853.0 4859.2 3627.6 3642.9 3647.9 3657.9 3663.0 5199.3 5203.4 5241.8 5264.6 5277.5 4803.3 5029.6 5035.9 5061.1 5105.0 5045.0 5045.8 5079.7 5084.6 5101.0 4991.5 4994.0 4995.6 4996.2 5029.2 4850.2 4947.7 5015.4 5068.9 5072.9 4798.4 4964.8 4980.5 4986.8 4987.2 10:10:36 INFO - PROCESS | 7482 | 10:10:36 INFO - PROCESS | 7482 | [#5] yui.html Cycles:180 Average:14804.25 Median:25206.39 stddev:19062.46 (75.6%) stddev-sans-first:19086.08 10:10:36 INFO - PROCESS | 7482 | Values: 595.8 644.9 674.1 698.8 721.9 11849.8 12608.6 13143.7 13156.4 13162.5 11987.6 12192.6 13936.2 14448.9 14567.5 621.2 635.6 783.7 803.8 804.7 769.7 785.5 797.5 799.6 800.1 832.5 832.9 833.1 834.6 835.1 644.8 666.1 825.4 826.8 827.1 495.9 496.0 496.3 585.3 597.9 12475.0 12484.6 12520.9 12551.3 12602.1 12305.9 12484.7 12784.1 12812.0 12835.5 11895.5 11915.3 11961.2 12093.4 12105.5 3947.5 3966.6 4015.7 4029.1 4044.3 65241.5 65641.7 65650.0 66061.7 66964.7 10026.6 10100.8 10313.3 10387.2 10447.8 18209.9 18321.3 18331.5 18344.2 18348.3 6486.4 6507.2 6555.9 6613.1 6702.4 3471.3 3541.2 3541.6 3547.1 3621.1 2840.9 2884.2 2920.9 2929.0 2932.2 477.4 491.4 498.8 501.7 509.5 421.0 460.0 494.9 519.6 523.6 7421.0 7517.8 7741.6 7909.3 7974.4 423.7 455.8 457.7 466.5 500.4 3751.8 3779.5 3820.1 3994.5 3995.8 52895.7 61412.0 67256.0 70772.0 70812.0 57550.7 57772.4 60025.4 60215.0 60437.4 53181.7 53321.2 53423.7 53771.2 53869.2 7299.9 7544.9 7716.7 7795.6 7893.7 37666.0 38229.2 38463.4 38810.2 38813.6 44364.1 48301.3 49402.5 49556.5 49914.0 8472.9 8571.6 8650.7 8674.0 8690.4 9613.2 9615.9 9637.2 9699.7 9851.2 9289.7 9451.1 9512.7 9518.2 9567.4 9252.1 9408.8 9430.7 9461.0 9505.6 10358.6 10418.3 10449.5 10508.2 11523.5 9961.8 10334.4 10611.7 10821.9 10926.0 10490.9 10649.9 10736.5 10760.4 10807.9 10:10:36 INFO - PROCESS | 7482 | -------- Summary: end -------- 10:10:36 INFO - PROCESS | 7482 | 10:10:37 INFO - TEST-INFO | 7482: exit 0 10:10:37 INFO - TEST-OK | dromaeo_css | took 1122081ms 10:10:37 INFO - TEST-START | kraken 10:10:37 INFO - operating with platform_type : linux_ 10:10:37 INFO - Initialising browser for kraken test... 10:10:37 INFO - TEST-INFO | started process 7787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpievlaS/profile http://localhost:54810/getInfo.html) 10:10:41 INFO - PROCESS | 7787 | __metrics Screen width/height:1600/1200 10:10:41 INFO - PROCESS | 7787 | colorDepth:24 10:10:41 INFO - PROCESS | 7787 | Browser inner width/height: 1024/697 10:10:41 INFO - PROCESS | 7787 | __metrics 10:10:41 INFO - PROCESS | 7787 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:10:41 INFO - PROCESS | 7787 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:42 INFO - PROCESS | 7787 | console.error: PushService: 10:10:42 INFO - PROCESS | 7787 | stateChangeProcessEnqueue: Error transitioning state 10:10:42 INFO - PROCESS | 7787 | UnknownError 10:10:43 INFO - TEST-INFO | 7787: exit 0 10:10:43 INFO - Browser initialized. 10:10:43 INFO - Running cycle 1/1 for kraken test... 10:10:43 INFO - TEST-INFO | started process 7869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpievlaS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:55 INFO - PROCESS | 7869 | RSS: Main: 154783744 10:10:55 INFO - PROCESS | 7869 | 10:10:57 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54810/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:58 INFO - PROCESS | 7869 | RSS: Main: 207278080 10:10:58 INFO - PROCESS | 7869 | 10:11:01 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54810/tests/kraken/driver.html?testName=audio-dft) 10:11:02 INFO - PROCESS | 7869 | RSS: Main: 186839040 10:11:02 INFO - PROCESS | 7869 | 10:11:05 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54810/tests/kraken/driver.html?testName=audio-fft) 10:11:05 INFO - PROCESS | 7869 | RSS: Main: 268939264 10:11:05 INFO - PROCESS | 7869 | 10:11:08 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54810/tests/kraken/driver.html?testName=audio-oscillator) 10:11:08 INFO - PROCESS | 7869 | RSS: Main: 180109312 10:11:08 INFO - PROCESS | 7869 | 10:11:10 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54810/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:11 INFO - PROCESS | 7869 | RSS: Main: 183541760 10:11:11 INFO - PROCESS | 7869 | 10:11:14 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54810/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:15 INFO - PROCESS | 7869 | RSS: Main: 223219712 10:11:15 INFO - PROCESS | 7869 | 10:11:18 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54810/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:19 INFO - PROCESS | 7869 | RSS: Main: 217804800 10:11:19 INFO - PROCESS | 7869 | 10:11:22 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54810/tests/kraken/driver.html?testName=json-parse-financial) 10:11:22 INFO - PROCESS | 7869 | RSS: Main: 219295744 10:11:22 INFO - PROCESS | 7869 | 10:11:24 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54810/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:25 INFO - PROCESS | 7869 | RSS: Main: 182501376 10:11:25 INFO - PROCESS | 7869 | 10:11:27 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54810/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:27 INFO - PROCESS | 7869 | RSS: Main: 189837312 10:11:27 INFO - PROCESS | 7869 | 10:11:30 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54810/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:30 INFO - PROCESS | 7869 | RSS: Main: 197984256 10:11:30 INFO - PROCESS | 7869 | 10:11:33 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:34 INFO - PROCESS | 7869 | RSS: Main: 207757312 10:11:34 INFO - PROCESS | 7869 | 10:11:37 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:38 INFO - PROCESS | 7869 | RSS: Main: 204001280 10:11:38 INFO - PROCESS | 7869 | 10:11:39 INFO - PROCESS | 7869 | Cycle 1(1): loaded http://localhost:54810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54810/tests/kraken/driver.html?testName=ai-astar) 10:11:40 INFO - PROCESS | 7869 | RSS: Main: 255217664 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | __start_tp_report 10:11:40 INFO - PROCESS | 7869 | _x_x_mozilla_page_load 10:11:40 INFO - PROCESS | 7869 | _x_x_mozilla_page_load_details 10:11:40 INFO - PROCESS | 7869 | |i|pagename|runs| 10:11:40 INFO - PROCESS | 7869 | |0;ai-astar;115;116;116;118;115;115;117;115;116;116 10:11:40 INFO - PROCESS | 7869 | |1;audio-beat-detection;157;128;127;176;128;128;131;125;145;132 10:11:40 INFO - PROCESS | 7869 | |2;audio-dft;164;161;162;161;162;163;162;162;160;161 10:11:40 INFO - PROCESS | 7869 | |3;audio-fft;76;78;77;104;78;77;77;78;91;78 10:11:40 INFO - PROCESS | 7869 | |4;audio-oscillator;85;85;110;86;86;85;111;85;85;109 10:11:40 INFO - PROCESS | 7869 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;117;117;117 10:11:40 INFO - PROCESS | 7869 | |6;imaging-darkroom;146;147;146;146;147;146;147;147;146;147 10:11:40 INFO - PROCESS | 7869 | |7;imaging-desaturate;96;95;95;95;95;95;96;96;96;95 10:11:40 INFO - PROCESS | 7869 | |8;json-parse-financial;67;65;66;67;67;67;67;73;66;67 10:11:40 INFO - PROCESS | 7869 | |9;json-stringify-tinderbox;67;66;67;68;67;66;66;67;66;66 10:11:40 INFO - PROCESS | 7869 | |10;stanford-crypto-aes;85;86;84;95;89;92;84;86;83;94 10:11:40 INFO - PROCESS | 7869 | |11;stanford-crypto-ccm;138;144;136;148;137;142;133;143;202;135 10:11:40 INFO - PROCESS | 7869 | |12;stanford-crypto-pbkdf2;184;184;189;184;183;180;187;181;183;186 10:11:40 INFO - PROCESS | 7869 | |13;stanford-crypto-sha256-iterative;70;70;69;70;69;68;70;68;68;69 10:11:40 INFO - PROCESS | 7869 | __end_tp_report 10:11:40 INFO - PROCESS | 7869 | __start_cc_report 10:11:40 INFO - PROCESS | 7869 | _x_x_mozilla_cycle_collect,1953 10:11:40 INFO - PROCESS | 7869 | __end_cc_report 10:11:40 INFO - PROCESS | 7869 | __startTimestamp1482430300043__endTimestamp 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | ------- Summary: start ------- 10:11:40 INFO - PROCESS | 7869 | Number of tests: 14 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.00 stddev:0.99 (0.9%) stddev-sans-first:1.00 10:11:40 INFO - PROCESS | 7869 | Values: 115.0 116.0 116.0 118.0 115.0 115.0 117.0 115.0 116.0 116.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:131.50 stddev:16.76 (12.7%) stddev-sans-first:16.26 10:11:40 INFO - PROCESS | 7869 | Values: 157.0 128.0 127.0 176.0 128.0 128.0 131.0 125.0 145.0 132.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:0.88 10:11:40 INFO - PROCESS | 7869 | Values: 164.0 161.0 162.0 161.0 162.0 163.0 162.0 162.0 160.0 161.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#3] audio-fft Cycles:10 Average:81.40 Median:78.00 stddev:9.05 (11.6%) stddev-sans-first:9.38 10:11:40 INFO - PROCESS | 7869 | Values: 76.0 78.0 77.0 104.0 78.0 77.0 77.0 78.0 91.0 78.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:85.00 stddev:11.95 (14.1%) stddev-sans-first:12.35 10:11:40 INFO - PROCESS | 7869 | Values: 85.0 85.0 110.0 86.0 86.0 85.0 111.0 85.0 85.0 109.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:11:40 INFO - PROCESS | 7869 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:11:40 INFO - PROCESS | 7869 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 146.0 147.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:11:40 INFO - PROCESS | 7869 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:67.00 stddev:2.15 (3.2%) stddev-sans-first:2.28 10:11:40 INFO - PROCESS | 7869 | Values: 67.0 65.0 66.0 67.0 67.0 67.0 67.0 73.0 66.0 67.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 10:11:40 INFO - PROCESS | 7869 | Values: 67.0 66.0 67.0 68.0 67.0 66.0 66.0 67.0 66.0 66.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.50 stddev:4.42 (5.0%) stddev-sans-first:4.57 10:11:40 INFO - PROCESS | 7869 | Values: 85.0 86.0 84.0 95.0 89.0 92.0 84.0 86.0 83.0 94.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:142.50 stddev:20.29 (14.2%) stddev-sans-first:21.32 10:11:40 INFO - PROCESS | 7869 | Values: 138.0 144.0 136.0 148.0 137.0 142.0 133.0 143.0 202.0 135.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.10 Median:184.00 stddev:2.69 (1.5%) stddev-sans-first:2.85 10:11:40 INFO - PROCESS | 7869 | Values: 184.0 184.0 189.0 184.0 183.0 180.0 187.0 181.0 183.0 186.0 10:11:40 INFO - PROCESS | 7869 | 10:11:40 INFO - PROCESS | 7869 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:0.88 (1.3%) stddev-sans-first:0.87 10:11:40 INFO - PROCESS | 7869 | Values: 70.0 70.0 69.0 70.0 69.0 68.0 70.0 68.0 68.0 69.0 10:11:40 INFO - PROCESS | 7869 | -------- Summary: end -------- 10:11:40 INFO - PROCESS | 7869 | 10:11:41 INFO - TEST-INFO | 7869: exit 0 10:11:41 INFO - TEST-OK | kraken | took 64064ms 10:11:41 INFO - SUITE-END | took 1186s 10:11:41 INFO - Completed test suite (00:19:46) 10:11:41 INFO - javascript benchmark 10:11:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.739526047395, 2628.3166376742065, 2645.0, 2646.8014898882584, 2672.679278486582, 4662.533746625336, 4685.742284174369, 4778.617710583154, 4795.0, 4805.014971930759, 4752.952470475294, 4755.072760811635, 4758.714477131366, 4766.332713420124, 4779.139754844126, 4346.282863327555, 4371.213181627306, 4384.21084204843, 4415.403920470728, 4448.555144485558, 4427.358033085201, 4434.379186913835, 4447.822087116511, 4457.064016556527, 4459.331100334959, 4320.956790432103, 4358.4987726411555, 4363.4327537420095, 4385.298352263639, 4449.888752781174, 4439.1121775645, 4451.933221001687, 4452.5992660660695, 4456.55434456555, 4460.375547423363, 4240.109576988836, 4260.10537787062, 4376.562343765598, 4403.603675669206, 4425.424694789656, 4699.036697477009, 4731.053789242131, 4754.952450475485, 4780.282957556359, 4787.066522028206, 5078.847634570969, 5102.336696229467, 5104.897902041976, 5107.131787596118, 5145.434002259748, 5021.723805190713, 5134.717590532519, 5142.1772516397195, 5147.22791581262, 5148.176291793295, 4694.530546945346, 4711.246200607886, 4751.738654374042, 4758.857234282977, 4762.095201911626, 5213.40045894727, 5220.504052115043, 5224.425313215544, 5227.26818245446, 5256.789728410898, 4997.400311962588, 5002.499750025041, 5013.699178049329, 5016.072026675077, 5068.467810879878, 4990.151674215392, 5021.271915572222, 5023.120953833065, 5030.119729047402, 5068.290439338495, 4962.851114466572, 4992.201247800334, 5052.747362631927, 5054.368203974504, 5079.288899554065, 4984.40187177541, 4997.700137991732, 4998.175301075355, 5015.423226328946, 5031.949680503149, 4194.853180138742, 4251.617354438115, 4291.54938731435, 4321.286987647003, 4352.695311328177, 3736.1406876418578, 3737.6449237322413, 3749.2876353492748, 3758.0792705787258, 3809.942850857239, 4379.3430985351815, 4395.604395604411, 4396.318570621559, 4396.802143903532, 4441.622462090759, 5134.127198376285, 5135.332406787168, 5141.100307446182, 5143.022825663112, 5189.481051894781, 4276.914461710749, 4302.075053863435, 4311.719738217006, 4313.870583882489, 4359.258925982527, 4572.6799124061, 4574.0, 4604.8388306409115, 4612.74629895359, 4622.791974361162, 4710.576048155683, 4710.717356958594, 4710.8351207707565, 4715.198416269174, 4759.738214398241, 4987.700737955734, 5018.548330650259, 5027.824026159067, 5046.19260918266, 5065.392152941523, 4702.717836929795, 4720.834770783006, 4736.905261894812, 4791.353167322367, 4801.18379875415, 5044.798208071783, 5045.217991211368, 5046.747662616928, 5055.7219352935945, 5100.336956195671, 5126.53861152498, 5131.56381707559, 5136.409312929061, 5137.92293115611, 5177.767000485062, 4851.054044461437, 4886.0, 4895.828645997373, 4953.851384458472, 4976.029674213639, 4910.337104490991, 4934.161192597196, 4956.207006878882, 4964.652474326763, 4968.677035992649, 4818.903621927612, 4859.416869975626, 4859.781309840995, 4869.269609558452, 4918.0901533216465, 4930.087933732271, 4953.430355509163, 4956.504349565014, 4979.3526841510375, 5010.599152067753, 4821.108095002436, 4855.635827313036, 4859.659823812299, 4875.146849301429, 4912.606991440604], "value": 4663.267695868028, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.32321366155685, 524.394324555139, 532.6564365983941, 535.4377903201637, 552.4144406928654, 27728.44543109139, 30766.077017689477, 37304.25391492172, 38999.22001559967, 39066.60933390665, 39670.0, 40218.79890600543, 40223.0, 40248.59751402485, 40255.396169057414, 7496.137944136412, 7650.885236721454, 7662.310392064713, 7667.616619169047, 7670.27132422419, 7246.8188295292775, 7418.295261950133, 7452.5901075440825, 9602.75993100171, 9876.061774131445, 9794.363366381198, 9857.260705447085, 9859.26055545837, 9865.1614612758, 9870.753231169243, 9558.426494410358, 9596.568154433067, 9602.279829012852, 9607.855882161773, 9610.135087842127, 9595.952020239924, 9679.0, 9683.370580912218, 9684.0, 9685.176759975411, 37041.81479092587, 37305.25389492195, 37325.44011839797, 37358.81320593407, 37394.439083413774, 2915.7375836174633, 2952.6161598991994, 3011.8494075296367, 3166.493361062242, 3294.5552350432627, 27164.32089197786, 27789.583156252673, 27802.443951121066, 28370.432591348057, 29007.129786106452, 3416.7266618670446, 3446.724262059029, 3464.133966508373, 3486.3027394521196, 3499.212677147647, 236973.0, 238287.0, 238401.0, 239259.0, 240838.0, 45697.54302456933, 46313.0, 46336.0, 46340.53659463429, 46355.53644463512, 52174.21738673923, 52203.0, 52283.0, 52295.21557176646, 52302.21546676803, 14472.638184045272, 14789.926050369895, 14831.555053348417, 14850.628734281729, 14888.330025148678, 11396.544138234543, 11451.083913286917, 11471.0, 11481.483333249857, 11510.36692981894, 13200.933995330153, 13575.728485430236, 14645.92677036608, 14971.0, 15219.543413697607, 6148.754049837957, 6197.876042479215, 6218.253809542884, 6238.65687387189, 6241.906371404432, 750.107372227048, 832.0930186097183, 880.9515476648718, 888.8800011998427, 956.31623389277, 25870.6119408209, 26782.0, 27169.592456113172, 27500.449991000067, 27529.587056194174, 910.1274078794686, 913.0, 934.345957829522, 948.4356807699407, 1030.7577719235974, 14268.574342361824, 14564.49024284145, 14627.976041677193, 14725.0, 14914.254287285592, 359481.0, 360437.0, 360838.0, 361603.0, 361707.0, 48570.27144592834, 48794.75602621964, 48843.755781221575, 48867.511324887004, 48875.266870996966, 1073.4257172412722, 1074.9140068794477, 1079.924405291622, 1158.530795028015, 1222.046803493259, 25992.22023339303, 28219.57670634901, 28923.276918077216, 31169.688303117586, 31179.376412472076, 39728.2054358917, 40159.1968160641, 40182.19635607213, 40220.79889600533, 40274.0, 320590.0, 322495.0, 322786.0, 324402.0, 325106.0, 29869.551956720232, 34361.0, 34719.82640086783, 35171.82414087913, 35258.8237058813, 31378.52932205973, 34416.311673765886, 34703.30593388068, 35269.647303527665, 40772.0, 31671.52492712565, 33965.32069358649, 34987.0, 36048.09879753027, 36239.63760362468, 34979.0, 35187.47218791669, 35270.11824704403, 35484.29031419409, 35754.64245357617, 31541.36917261688, 32592.674073259914, 34349.65650343464, 34362.0, 34587.13532161716, 26639.0, 28353.71646283511, 28708.40186163678, 28924.781172047267, 29287.7071229285, 22393.44474996117, 22841.20055798039, 22945.196918107787, 23027.309180724606, 23203.419914502272], "value": 17222.42224095259, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.7341254178179, 368.99262014759705, 371.53372517490544, 379.49716625471257, 395.0952319189057, 15478.922605386972, 16200.0, 16691.49925502237, 16695.08177050263, 16745.413910513103, 15520.30158642861, 16201.91899040503, 16765.161741912885, 16848.74726879098, 16850.578735531617, 4886.462489126193, 5124.795008199668, 5125.487451254863, 5146.202338637517, 5146.948530514703, 3751.4560388743616, 3940.9802950985204, 5040.672356296829, 5657.462541058593, 5889.234399528055, 5955.017422125344, 5968.79109231177, 5976.970115149418, 5978.850528736794, 5984.311804142514, 5762.135679648044, 5934.525237980973, 5971.731272092767, 5982.04287314032, 5984.611000284967, 5078.746062696888, 5210.817621383233, 5225.372955245357, 5235.869103272411, 5247.921281180786, 19998.100085496186, 20279.188832446685, 20279.391618251477, 20303.289384871605, 20339.89830050855, 1771.371163237058, 1771.6722406354736, 1784.50925995351, 1786.9106544672713, 1878.7651543557056, 12073.154879158463, 12745.61763147107, 12958.546450874268, 13403.128796628285, 13471.528496502575, 1690.3492155520091, 1738.9565260868453, 1741.9738703919452, 1821.9908900455546, 1848.879822811513, 64805.67597162031, 65383.67308163429, 66372.3362766371, 67162.0, 68199.65900170516, 8843.734687959372, 9016.8647470288, 9079.909200908038, 9203.953980230055, 9846.704598862045, 11971.76056478883, 11983.940080299542, 12004.939975300067, 12005.099617528545, 12016.158868879094, 7158.892616610755, 7335.0, 7349.77950661481, 7519.135299440525, 7536.660850261751, 7316.890246646304, 7317.195108538057, 7511.586862722494, 7528.661210245552, 7552.471327007167, 5939.4357536034, 5968.507873031742, 5988.490978266809, 6148.1392605035335, 6154.599951003171, 1579.652476455178, 1680.3952225624498, 1707.6670049340507, 1724.4567961092216, 1771.1498480729322, 740.3226048165868, 790.8062524681375, 806.6128258435983, 882.6734108379941, 893.7318804358796, 16175.595610109605, 16868.915655421646, 17341.0, 17580.912095439697, 17864.91067544654, 871.507598207011, 943.155875491445, 964.5900492290748, 964.7009427077628, 973.743870407181, 9273.443593384418, 9976.501174941224, 10043.799124017478, 10086.49567521621, 10101.646442374482, 338656.0, 343610.0, 360716.0, 365224.0, 366733.0, 52667.73666131645, 73382.0, 75464.62267688627, 77890.0, 80453.0, 921.083521895718, 939.7838497145694, 959.7552624080954, 962.0475729028351, 962.3744566031995, 14816.925915370353, 14955.850441495446, 16154.838451615333, 16370.672586547964, 16452.917735411724, 34585.48121778225, 34865.825670872495, 34918.30163396768, 35270.47094293639, 36009.81995090008, 44425.77787111044, 49565.50434495609, 49687.25469118039, 49773.75113124411, 52904.47095528995, 6933.1333583302085, 7338.743143989935, 7374.299441553044, 7498.812529686801, 7549.471536992358, 11083.612073577386, 11372.37451940118, 11543.36511491876, 11567.305961642329, 11731.824022639837, 9048.954755226445, 9636.951815240878, 9855.408675479493, 9910.702678919644, 10040.347377420736, 5238.947610523998, 7233.674484648098, 10347.84478232812, 10499.265051446326, 10589.941005899349, 10254.179665626882, 10321.63874264397, 10501.059703283094, 10586.8411973822, 10870.130389568658, 7264.491485595958, 7417.443691723034, 7503.437242206747, 7545.358644515278, 7703.152653208031, 9541.809163816546, 10044.146247568746, 10327.070563649308, 10364.844527331945, 10685.412302323135], "value": 8200.760497111562, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.3084130831314, 1323.8146659467673, 1416.1998470863962, 1649.3155340533679, 1686.0558087471009, 6886.965565172173, 7303.926960730391, 7307.2327405622445, 7308.342249197571, 7310.415166786657, 6301.558890877641, 6535.771248006321, 6861.451083913287, 7170.820729481766, 7187.82030449239, 2035.2469586253108, 2100.0339843671927, 2100.5693832764323, 2112.1656945506516, 2114.68279758036, 2105.577391910044, 2123.288698286076, 2127.0, 2135.679648052797, 2140.240214723774, 1849.0662215581112, 1916.587933594277, 2032.573159636478, 2099.9055042523046, 2102.7161333219974, 2086.235737647608, 2094.581083783242, 2102.547952190271, 2108.114591871418, 2121.5862906733114, 2092.95814083719, 2104.084723145437, 2130.2118216260083, 2131.637621604331, 2132.4135862637745, 7051.89422158668, 7107.395871350941, 7119.89320160198, 7123.0, 7125.608091554963, 4287.228298906196, 4408.272635015219, 4409.691321607489, 4412.735235885857, 4425.557444255581, 2705.9323516912036, 2849.5440729483184, 2858.5997960285576, 2869.813462124976, 2909.432660631178, 841.045413455726, 870.9869351959662, 889.9288056955428, 892.0900681305033, 925.3383830561181, 9355.719328420158, 9489.762755931088, 9554.570044348022, 9565.808683826353, 9587.328886977913, 3789.943150852684, 3977.980110099431, 4044.8179831907637, 4049.7772622505454, 4058.9594104058583, 8158.143394943446, 8170.795730106676, 8175.345972322319, 8179.0, 8179.5501247430775, 4375.234333991539, 4440.444944381952, 4450.132224216247, 4465.508794032654, 4472.396226509444, 3891.2412079644764, 4084.0606660468256, 4084.3465045593157, 4084.611961863618, 4088.5707000765087, 3192.4892017277125, 3228.7255583275214, 3310.9337813244083, 3319.1204330852343, 3336.7987524491164, 1012.4988130875264, 1016.3038318751532, 1025.887152413234, 1025.9025392587691, 1026.0560284538242, 555.5167004705851, 605.5186127029023, 757.6628400361786, 781.5857595474407, 804.3886646148969, 4515.909681806345, 4601.263797792337, 4747.691400058985, 4805.087033463631, 4838.806447742051, 805.6253841963515, 837.1544739812833, 846.7003150164591, 852.7441767469734, 886.2511178054533, 2968.1540760883045, 3255.2187475005826, 3265.689759472846, 3273.5759944423776, 3363.293708321231, 8226.876596851052, 8674.826503469896, 8690.217880390795, 8692.130786921258, 8696.652133914698, 8644.0, 8661.220490155916, 8670.4364216327, 8674.08922063187, 8677.522736249566, 6606.504512161607, 6729.899051514231, 6833.248342682301, 6849.828754281183, 6856.348646878539, 4477.350784136217, 4547.136044151601, 4629.259318509023, 4671.626269898332, 4724.314974328772, 7835.49069310493, 7934.761957141295, 8041.597920104088, 8074.232947869943, 8087.676492940216, 7598.278163574451, 8016.398770092383, 8023.117457079833, 8122.796930076795, 8137.186281372053, 5891.293044834647, 6231.2522497300615, 6239.847252697812, 6240.968795155995, 6242.5942313749465, 6642.667866606747, 6686.83282917931, 6707.530472867048, 6709.295523969913, 6881.862362752817, 5937.198478205387, 6291.685415729286, 6331.746730130743, 6337.714802833976, 6459.289478157305, 6112.602680825732, 6129.0, 6205.379462053758, 6205.596636218631, 6265.8120256392385, 5475.288212532345, 5720.628159169641, 5919.230500034968, 5973.880522389615, 5980.222571065734, 4016.477857878574, 4098.118904435561, 4196.517400498981, 4201.054762678373, 4236.173946080485, 3991.3015222335393, 4079.7960101995377, 4094.467719196485, 4221.324588065895, 4242.575742425856], "value": 3820.11672229071, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.92543640399117, 346.07597714103343, 351.9778870389611, 356.6077314953553, 359.6313778377163, 4858.2712593111055, 4866.685994781411, 4879.26810978353, 4890.361728820849, 4893.755312234383, 4816.397950256218, 4825.975870120645, 4843.927341089887, 4857.441394239663, 4859.975700121495, 3629.510016147826, 3757.2673328700916, 3790.753601015939, 3819.618038196186, 3851.0, 3855.4024126260474, 3867.0, 3872.7289089763726, 3879.631435013669, 3890.8832735017854, 3837.328467518187, 3840.1183420124216, 3848.749831260959, 3859.4789703390106, 3869.6517313441786, 3548.591911930135, 3617.5658920929527, 3722.9069273268115, 3741.185525020363, 3846.9807650961848, 3391.16916355492, 3401.744869134825, 3441.587009558844, 3449.223924616941, 3472.9581125662453, 4646.907061858744, 4661.510541393172, 4663.88340291492, 4670.369500117508, 4677.836275730333, 3986.043349596105, 4318.078455087456, 4342.630876375511, 4364.607185353301, 4368.9417407814335, 4933.679310844784, 4965.0566392385335, 4982.800687972477, 4986.4265609455015, 4987.0, 3518.5074089627474, 3518.648135186461, 3520.7677312940523, 3523.4714792781033, 3528.8059156746367, 5217.530422262014, 5241.135212689902, 5275.0, 5278.2346559749, 5298.311219541435, 3429.9142521437166, 3591.174029973121, 3652.2878038782715, 3658.5243918290985, 3661.3043521730788, 3700.518932538753, 3707.1288247261873, 3708.38811596089, 3714.4985426967555, 3715.9442608360896, 4221.430106935586, 4249.660027197817, 4260.25445547028, 4266.935995960063, 4268.487781466244, 4746.359241502422, 4987.376577927759, 5064.82273120439, 5124.615653825978, 5126.615503837227, 1326.4561529772748, 1341.7655756703855, 1342.7717288061053, 1347.4879545772544, 1347.5110003446248, 911.3392790227032, 960.4813400763649, 966.3911735606523, 968.1480297338438, 968.719071469266, 4261.488621365456, 4336.284513055373, 4336.349547567827, 4407.493138289074, 4459.9331010034875, 5203.947960520422, 5208.374995000549, 5217.0870097733505, 5222.164453687392, 5226.268322434862, 4460.353248778909, 4462.799174037176, 4476.395686582335, 4477.552244775497, 4478.462584489882, 2571.5756900111646, 2673.3717576369536, 2675.17069708391, 2710.8915643374044, 2715.416185520123, 4717.956917788008, 4727.929081063787, 4745.9050818984115, 4760.262159365304, 4764.212935432742, 5149.2791009258735, 5155.226715992556, 5161.4322424533275, 5162.845114646567, 5186.196139598368, 4546.840860569864, 4687.789049492781, 4850.490698476679, 4869.758211656005, 4869.829555965595, 5144.30551875507, 5149.845504634867, 5156.8341296656245, 5183.859550898796, 5239.397469290928, 5119.718415487184, 5131.820386286462, 5132.714183656689, 5140.177571588528, 5156.9742151289, 4671.43942726875, 4816.614670826255, 4843.564079232886, 4852.986010805476, 4859.198232291632, 3627.6009638940222, 3642.908927276839, 3647.8905632831056, 3657.908552286214, 3662.9816850915577, 5199.2980947573105, 5203.427622961395, 5241.790328386822, 5264.552513036435, 5277.498637629419, 4803.270822503826, 5029.59763218949, 5035.899282014266, 5061.13960626687, 5105.0, 5044.989233559256, 5045.823396181116, 5079.6952182869145, 5084.5932325414615, 5100.979804039132, 4991.450940396481, 4993.950060499348, 4995.550400463976, 4996.200607902718, 5029.170186919117, 4850.248211527219, 4947.678400903929, 5015.448300686994, 5068.949310506995, 5072.909324495251, 4798.4001999750035, 4964.776585053609, 4980.526849949249, 4986.825461108844, 4987.202047672355], "value": 3826.86811016049, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.7587177193237, 644.9137041670199, 674.1135406939877, 698.8462538241587, 721.9061522002139, 11849.822252666207, 12608.621741347752, 13143.737125257489, 13156.407961641726, 13162.473501059958, 11987.640370788868, 12192.634220973363, 13936.233507157127, 14448.927755361236, 14567.490137845178, 621.1738387944024, 635.605924326918, 783.6630248992931, 803.7869964459423, 804.7143264141233, 769.6536558548647, 785.512981951191, 797.5055465611329, 799.604195923016, 800.1038836503095, 832.4505826154739, 832.883396324515, 833.125218520554, 834.6160766047625, 835.0980940584185, 644.7711062572813, 666.0808084842886, 825.4469505431346, 826.8181000179951, 827.1067247372853, 495.86859482237236, 495.9950400496021, 496.31012892080037, 585.3151812379526, 597.8654802669408, 12475.0, 12484.625461236177, 12520.874791252061, 12551.309677967709, 12602.117851750381, 12305.938470307681, 12484.687882802911, 12784.105112642119, 12812.0, 12835.486580536768, 11895.52417903283, 11915.285082895054, 11961.162718609701, 12093.395330233454, 12105.515779368903, 3947.46709194258, 3966.5835087315704, 4015.738976966488, 4029.1135950090934, 4044.2518134144984, 65241.45447636957, 65641.67179164122, 65649.99999999952, 66061.66969165171, 66964.66517667429, 10026.598936042623, 10100.848487272697, 10313.329633573794, 10387.169026477864, 10447.84328235077, 18209.908950455163, 18321.267149313877, 18331.54171145732, 18344.174512146987, 18348.266069357076, 6486.351364863476, 6507.154069970874, 6555.934440655627, 6613.107230523914, 6702.355778516184, 3471.288385880888, 3541.1501239702284, 3541.6281290464644, 3547.130952916552, 3621.149029977953, 2840.9431811363656, 2884.22126025976, 2920.941581168365, 2929.033418971734, 2932.2376182192356, 477.4294717812181, 491.38576779026215, 498.7755510020505, 501.6563653897092, 509.5032343465166, 420.9957900420957, 459.9632029437637, 494.91091603510995, 519.6154845414366, 523.5523627298605, 7420.9628951855975, 7517.849643007109, 7741.61291935401, 7909.288164065261, 7974.441789074709, 423.7097588152126, 455.7538928978381, 457.7185031205851, 466.4728856392255, 500.43450900482225, 3751.7748935063437, 3779.527559055118, 3820.140468394589, 3994.500687414073, 3995.84016639337, 52895.735521322145, 61412.0, 67256.0, 70772.0, 70812.0, 57550.7122464385, 57772.42227577754, 60025.399746002855, 60215.0, 60437.39562604317, 53181.734091329294, 53321.20018199808, 53423.732881335345, 53771.19343209855, 53869.191962120596, 7299.8540029200185, 7544.924550754422, 7716.691332346643, 7795.610219489116, 7893.684252629831, 37666.0, 38229.23541529098, 38463.423048654855, 38810.22379552449, 38813.611863881, 44364.11271774611, 48301.27548086711, 49402.50597493979, 49556.50443495663, 49914.0, 8472.915270847212, 8571.614277357408, 8650.653973840976, 8673.95663021706, 8690.391672582859, 9613.182879455324, 9615.855762163434, 9637.18083962871, 9699.74605387647, 9851.211903047883, 9289.72130836076, 9451.102145296185, 9512.714618561455, 9518.23854091657, 9567.37812042215, 9252.121048500381, 9408.764780880532, 9430.669926552539, 9460.95269523648, 9505.572249248939, 10358.585656573652, 10418.322809017389, 10449.477526123816, 10508.159347252049, 11523.53905843757, 9961.800763984535, 10334.376658614427, 10611.681649550526, 10821.891781082088, 10926.0, 10490.895091049297, 10649.9467502662, 10736.51685674131, 10760.40817755031, 10807.891921080689], "value": 6028.721797242735, "unit": "score"}], "name": "dromaeo_css", "value": 6222.610775475479, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 116.0, 118.0, 115.0, 115.0, 117.0, 115.0, 116.0, 116.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 127.0, 176.0, 128.0, 128.0, 131.0, 125.0, 145.0, 132.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 161.0, 162.0, 163.0, 162.0, 162.0, 160.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 104.0, 78.0, 77.0, 77.0, 78.0, 91.0, 78.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 110.0, 86.0, 86.0, 85.0, 111.0, 85.0, 85.0, 109.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 67.0, 67.0, 67.0, 67.0, 73.0, 66.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 68.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 95.0, 89.0, 92.0, 84.0, 86.0, 83.0, 94.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 144.0, 136.0, 148.0, 137.0, 142.0, 133.0, 143.0, 202.0, 135.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 189.0, 184.0, 183.0, 180.0, 187.0, 181.0, 183.0, 186.0], "value": 184.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 70.0, 69.0, 68.0, 70.0, 68.0, 68.0, 69.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1568.7999999999997, "alertThreshold": 2.0}]} 10:11:41 INFO - Return code: 0 10:11:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:11:41 INFO - # TBPL SUCCESS # 10:11:41 INFO - Running post-action listener: _resource_record_post_action 10:11:41 INFO - [mozharness: 2016-12-22 18:11:41.846043Z] Finished run-tests step (success) 10:11:41 INFO - Running post-run listener: _resource_record_post_run 10:11:41 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394416128; Read time: 4; Write time: 261564 10:11:41 INFO - TinderboxPrint: CPU usage
13.1% 10:11:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 10:11:41 INFO - TinderboxPrint: I/O write bytes / time
394,416,128 / 261,564 10:11:41 INFO - TinderboxPrint: CPU idle
8,345.6 (86.9%) 10:11:41 INFO - TinderboxPrint: CPU user
1,211.0 (12.6%) 10:11:41 INFO - TinderboxPrint: Swap in / out
0 / 0 10:11:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99811328; Read time: 0; Write time: 84092 10:11:41 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 294604800; Read time: 0; Write time: 177472 10:11:42 INFO - Running post-run listener: _upload_blobber_files 10:11:42 INFO - Blob upload gear active. 10:11:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:42 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 10:11:42 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:11:42 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:11:42 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:11:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:46 INFO - (blobuploader) - INFO - Done attempting. 10:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:47 INFO - (blobuploader) - INFO - Done attempting. 10:11:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:47 INFO - (blobuploader) - INFO - Done attempting. 10:11:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:11:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:11:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:48 INFO - (blobuploader) - INFO - Done attempting. 10:11:48 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:48 INFO - Return code: 0 10:11:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/908f598617f20ee6f7d2413d838b598063511e9d716e20f3d480f86ae42e81fe65bf578d3804907072e6d946cfc9678a699e5d578fd0901fefcab090fabca242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8e9294d1f77f91cf2671fd7f2fbbc48c68ef0c1d81d62c0ba502106993ac977459b89b5196f5916351771b0e901c745f88a5b90656e6c30c9a2d0f8f632c6e12", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aef983f00c2e6eba233d8abbaa6ddddec98d335b28b5a5c4ccfc5d127516ceb856972bdd3ab0cb25559667c783344303e8693e29e14b273b42eceb329de168d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1ebb57176a31e0f7892b0441eeaf70f904efee391e3c963d26ff8ce2010216cba07e0e2141eb8aa58a08e5fc5cf789f858d8f2dce0d5144748f378e597eebc2a"} 10:11:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:48 INFO - Contents: 10:11:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/908f598617f20ee6f7d2413d838b598063511e9d716e20f3d480f86ae42e81fe65bf578d3804907072e6d946cfc9678a699e5d578fd0901fefcab090fabca242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8e9294d1f77f91cf2671fd7f2fbbc48c68ef0c1d81d62c0ba502106993ac977459b89b5196f5916351771b0e901c745f88a5b90656e6c30c9a2d0f8f632c6e12", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aef983f00c2e6eba233d8abbaa6ddddec98d335b28b5a5c4ccfc5d127516ceb856972bdd3ab0cb25559667c783344303e8693e29e14b273b42eceb329de168d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1ebb57176a31e0f7892b0441eeaf70f904efee391e3c963d26ff8ce2010216cba07e0e2141eb8aa58a08e5fc5cf789f858d8f2dce0d5144748f378e597eebc2a"} 10:11:48 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:48 INFO - Copying logs to upload dir... 10:11:48 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.364760 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-12-22 10:11:48.417932) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 10:11:48.422555) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/908f598617f20ee6f7d2413d838b598063511e9d716e20f3d480f86ae42e81fe65bf578d3804907072e6d946cfc9678a699e5d578fd0901fefcab090fabca242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8e9294d1f77f91cf2671fd7f2fbbc48c68ef0c1d81d62c0ba502106993ac977459b89b5196f5916351771b0e901c745f88a5b90656e6c30c9a2d0f8f632c6e12", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aef983f00c2e6eba233d8abbaa6ddddec98d335b28b5a5c4ccfc5d127516ceb856972bdd3ab0cb25559667c783344303e8693e29e14b273b42eceb329de168d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1ebb57176a31e0f7892b0441eeaf70f904efee391e3c963d26ff8ce2010216cba07e0e2141eb8aa58a08e5fc5cf789f858d8f2dce0d5144748f378e597eebc2a"} build_url:https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011604 build_url: 'https://queue.taskcluster.net/v1/task/E-VUnIdNRhaCtdIQGhIZhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/908f598617f20ee6f7d2413d838b598063511e9d716e20f3d480f86ae42e81fe65bf578d3804907072e6d946cfc9678a699e5d578fd0901fefcab090fabca242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8e9294d1f77f91cf2671fd7f2fbbc48c68ef0c1d81d62c0ba502106993ac977459b89b5196f5916351771b0e901c745f88a5b90656e6c30c9a2d0f8f632c6e12", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aef983f00c2e6eba233d8abbaa6ddddec98d335b28b5a5c4ccfc5d127516ceb856972bdd3ab0cb25559667c783344303e8693e29e14b273b42eceb329de168d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1ebb57176a31e0f7892b0441eeaf70f904efee391e3c963d26ff8ce2010216cba07e0e2141eb8aa58a08e5fc5cf789f858d8f2dce0d5144748f378e597eebc2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 10:11:48.455622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:11:48.456007) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1482429059.782730-149958917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:11:48.537038) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 10:11:48.537379) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 10:11:48.537688) ========= ========= Total master_lag: 0.19 =========