builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1481994353.59 results: success (0) buildid: 20161217073119 builduid: 71ec902f311e495e91ddf21c2ce16801 revision: 56a8ce2bf0876fc9315407676e2db35e238e510d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:53.585861) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:53.586410) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:53.586768) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:53.606418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:53.606843) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-17 09:05:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-12-17 09:05:54 (103 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149389 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:53.769762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:53.770052) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015850 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:53.819045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:53.819357) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 56a8ce2bf0876fc9315407676e2db35e238e510d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 56a8ce2bf0876fc9315407676e2db35e238e510d --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=7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-17 09:05:54,546 truncating revision to first 12 chars 2016-12-17 09:05:54,546 Setting DEBUG logging. 2016-12-17 09:05:54,546 attempt 1/10 2016-12-17 09:05:54,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/56a8ce2bf087?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-17 09:05:54,869 unpacking tar archive at: mozilla-central-56a8ce2bf087/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624604 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:54.457478) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:54.457766) ========= script_repo_revision: 56a8ce2bf0876fc9315407676e2db35e238e510d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:54.458152) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:54.458414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 09:05:54.466570) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-17 09:05:54.466858) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:05:55 INFO - MultiFileLogger online at 20161217 09:05:55 in /builds/slave/test 09:05:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:05:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:55 INFO - {'append_to_log': False, 09:05:55 INFO - 'base_work_dir': '/builds/slave/test', 09:05:55 INFO - 'blob_upload_branch': 'Firefox', 09:05:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:55 INFO - 'branch': 'Firefox', 09:05:55 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:55 INFO - 'config_files': ('talos/linux_config.py',), 09:05:55 INFO - 'default_actions': ('clobber', 09:05:55 INFO - 'read-buildbot-config', 09:05:55 INFO - 'download-and-extract', 09:05:55 INFO - 'populate-webroot', 09:05:55 INFO - 'create-virtualenv', 09:05:55 INFO - 'install', 09:05:55 INFO - 'run-tests'), 09:05:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:55 INFO - 'download_minidump_stackwalk': True, 09:05:55 INFO - 'download_symbols': 'ondemand', 09:05:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:55 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:55 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:55 INFO - 'installer_path': 'installer.exe', 09:05:55 INFO - 'log_level': 'info', 09:05:55 INFO - 'log_name': 'talos', 09:05:55 INFO - 'log_to_console': True, 09:05:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:05:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:05:55 INFO - 'opt_config_files': (), 09:05:55 INFO - 'pip_index': False, 09:05:55 INFO - 'sps_profile': False, 09:05:55 INFO - 'sps_profile_interval': 0, 09:05:55 INFO - 'suite': 'dromaeojs', 09:05:55 INFO - 'system_bits': '32', 09:05:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:55 INFO - 'title': 'talos-linux64-ix-005', 09:05:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:55 INFO - 'use_talos_json': True, 09:05:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:55 INFO - 'work_dir': 'build'} 09:05:55 INFO - [mozharness: 2016-12-17 17:05:55.287445Z] Running clobber step. 09:05:55 INFO - Running pre-action listener: _resource_record_pre_action 09:05:55 INFO - Running main action method: clobber 09:05:55 INFO - rmtree: /builds/slave/test/build 09:05:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:56 INFO - Running post-action listener: _resource_record_post_action 09:05:56 INFO - [mozharness: 2016-12-17 17:05:56.272820Z] Finished clobber step (success) 09:05:56 INFO - [mozharness: 2016-12-17 17:05:56.272918Z] Running read-buildbot-config step. 09:05:56 INFO - Running pre-action listener: _resource_record_pre_action 09:05:56 INFO - Running main action method: read_buildbot_config 09:05:56 INFO - Using buildbot properties: 09:05:56 INFO - { 09:05:56 INFO - "project": "", 09:05:56 INFO - "product": "firefox", 09:05:56 INFO - "script_repo_revision": "production", 09:05:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:05:56 INFO - "repository": "", 09:05:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:05:56 INFO - "buildid": "20161217073119", 09:05:56 INFO - "pgo_build": "True", 09:05:56 INFO - "basedir": "/builds/slave/test", 09:05:56 INFO - "buildnumber": 120, 09:05:56 INFO - "slavename": "talos-linux64-ix-005", 09:05:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:05:56 INFO - "platform": "ubuntu64_hw", 09:05:56 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:05:56 INFO - "branch": "mozilla-central", 09:05:56 INFO - "repo_path": "mozilla-central", 09:05:56 INFO - "revision": "56a8ce2bf0876fc9315407676e2db35e238e510d", 09:05:56 INFO - "stage_platform": "linux64-pgo", 09:05:56 INFO - "builduid": "71ec902f311e495e91ddf21c2ce16801", 09:05:56 INFO - "slavebuilddir": "test" 09:05:56 INFO - } 09:05:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 09:05:56 INFO - Running post-action listener: _resource_record_post_action 09:05:56 INFO - [mozharness: 2016-12-17 17:05:56.275335Z] Finished read-buildbot-config step (success) 09:05:56 INFO - [mozharness: 2016-12-17 17:05:56.275422Z] Running download-and-extract step. 09:05:56 INFO - Running pre-action listener: _resource_record_pre_action 09:05:56 INFO - Running main action method: download_and_extract 09:05:56 INFO - mkdir: /builds/slave/test/build/tests 09:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:56 INFO - trying https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:05:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/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:05:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/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:05:56 INFO - Downloaded 1361 bytes. 09:05:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:05:56 INFO - Using the following test package requirements: 09:05:56 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:05:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:05:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:05:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:56 INFO - u'jsshell-linux-x86_64.zip'], 09:05:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:05:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:05:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:05:56 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:05:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:05:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:05:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:05:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:05:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:05:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:05:57 INFO - Expected file size: 21777203 09:05:57 INFO - Obtained file size: 21777203 09:06:01 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:06:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:06:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:06:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:06:02 INFO - Expected file size: 21777203 09:06:02 INFO - Obtained file size: 21777203 09:06:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 09:06:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:06:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:06:08 INFO - Expected file size: 14409734 09:06:08 INFO - Obtained file size: 14409734 09:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:08 INFO - trying https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:06:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/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:06:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/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:06:09 INFO - Downloaded 59794830 bytes. 09:06:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:06:09 INFO - mkdir: /builds/slave/test/properties 09:06:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:06:09 INFO - Writing to file /builds/slave/test/properties/build_url 09:06:09 INFO - Contents: 09:06:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:06:10 INFO - Running post-action listener: _resource_record_post_action 09:06:10 INFO - Running post-action listener: set_extra_try_arguments 09:06:10 INFO - [mozharness: 2016-12-17 17:06:10.579394Z] Finished download-and-extract step (success) 09:06:10 INFO - [mozharness: 2016-12-17 17:06:10.579619Z] Running populate-webroot step. 09:06:10 INFO - Running pre-action listener: _resource_record_pre_action 09:06:10 INFO - Running main action method: populate_webroot 09:06:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:10 INFO - '--tppagecycles', 09:06:10 INFO - '7'], 09:06:10 INFO - 'tests': ['tsvgm']}}, 09:06:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:06:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:06:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:06:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:06:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:06:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:06:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:06:10 INFO - 'talos_options': ['--disable-e10s'], 09:06:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:06:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:06:10 INFO - 'talos_options': ['--disable-e10s'], 09:06:10 INFO - 'tests': ['damp', 'tps']}, 09:06:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:06:10 INFO - 'tests': ['damp', 'tps']}, 09:06:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:06:10 INFO - 'tests': ['dromaeo_dom']}, 09:06:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:06:10 INFO - 'tests': ['basic_compositor_video']}, 09:06:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:06:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:06:10 INFO - 'tests': ['a11yr', 09:06:10 INFO - 'ts_paint', 09:06:10 INFO - 'tpaint', 09:06:10 INFO - 'sessionrestore', 09:06:10 INFO - 'sessionrestore_no_auto_restore', 09:06:10 INFO - 'tabpaint']}, 09:06:10 INFO - 'other-e10s': {'tests': ['a11yr', 09:06:10 INFO - 'ts_paint', 09:06:10 INFO - 'tpaint', 09:06:10 INFO - 'sessionrestore', 09:06:10 INFO - 'sessionrestore_no_auto_restore', 09:06:10 INFO - 'tabpaint']}, 09:06:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:06:10 INFO - 'ts_paint', 09:06:10 INFO - 'tpaint', 09:06:10 INFO - 'sessionrestore', 09:06:10 INFO - 'sessionrestore_no_auto_restore', 09:06:10 INFO - 'tabpaint']}, 09:06:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:06:10 INFO - 'ts_paint', 09:06:10 INFO - 'tpaint', 09:06:10 INFO - 'sessionrestore', 09:06:10 INFO - 'sessionrestore_no_auto_restore', 09:06:10 INFO - 'tabpaint']}, 09:06:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:06:10 INFO - 'tests': ['a11yr', 09:06:10 INFO - 'ts_paint', 09:06:10 INFO - 'tpaint', 09:06:10 INFO - 'sessionrestore', 09:06:10 INFO - 'sessionrestore_no_auto_restore', 09:06:10 INFO - 'tabpaint']}, 09:06:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:06:10 INFO - 'tests': ['a11yr', 09:06:10 INFO - 'ts_paint', 09:06:10 INFO - 'tpaint', 09:06:10 INFO - 'sessionrestore', 09:06:10 INFO - 'sessionrestore_no_auto_restore', 09:06:10 INFO - 'tabpaint']}, 09:06:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:06:10 INFO - 'tests': ['tsvgx', 09:06:10 INFO - 'tsvgr_opacity', 09:06:10 INFO - 'tart', 09:06:10 INFO - 'tscrollx', 09:06:10 INFO - 'cart', 09:06:10 INFO - 'tsvg_static']}, 09:06:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:06:10 INFO - 'tsvgr_opacity', 09:06:10 INFO - 'tart', 09:06:10 INFO - 'tscrollx', 09:06:10 INFO - 'cart', 09:06:10 INFO - 'tsvg_static']}, 09:06:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:06:10 INFO - 'talos_options': ['--disable-e10s'], 09:06:10 INFO - 'tests': ['tp5o']}, 09:06:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:06:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:06:10 INFO - 'talos_options': ['--disable-e10s', 09:06:10 INFO - '--xperf_path', 09:06:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:10 INFO - 'tests': ['tp5n']}, 09:06:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:06:10 INFO - 'talos_options': ['--xperf_path', 09:06:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:10 INFO - 'tests': ['tp5n']}}, 09:06:10 INFO - 'talos.zip': {'path': '', 09:06:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:10 INFO - Running post-action listener: _resource_record_post_action 09:06:10 INFO - [mozharness: 2016-12-17 17:06:10.601487Z] Finished populate-webroot step (success) 09:06:10 INFO - [mozharness: 2016-12-17 17:06:10.601575Z] Running create-virtualenv step. 09:06:10 INFO - Running pre-action listener: _resource_record_pre_action 09:06:10 INFO - Running main action method: create_virtualenv 09:06:10 INFO - Creating virtualenv /builds/slave/test/build/venv 09:06:10 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:06:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:06:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:10 INFO - Using real prefix '/usr' 09:06:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:06:11 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:13 INFO - Installing pip.................done. 09:06:13 INFO - Return code: 0 09:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:06:13 INFO - Reading from file tmpfile_stdout 09:06:13 INFO - Output received: 09:06:13 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:06:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 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 0x7f109680ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef20>, '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 0x1babc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', '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:06:13 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:06:13 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:06:13 INFO - Using env: {'DISPLAY': ':0', 09:06:13 INFO - 'HOME': '/home/cltbld', 09:06:13 INFO - 'LANG': 'en_US.UTF-8', 09:06:13 INFO - 'LANGUAGE': 'en_US:en', 09:06:13 INFO - 'LOGNAME': 'cltbld', 09:06:13 INFO - 'MAIL': '/var/mail/cltbld', 09:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:13 INFO - 'MOZ_NO_REMOTE': '1', 09:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:13 INFO - 'NO_EM_RESTART': '1', 09:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:13 INFO - 'PWD': '/builds/slave/test', 09:06:13 INFO - 'SHELL': '/bin/bash', 09:06:13 INFO - 'SHLVL': '1', 09:06:13 INFO - 'TERM': 'linux', 09:06:13 INFO - 'TMOUT': '86400', 09:06:13 INFO - 'USER': 'cltbld', 09:06:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', 09:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:13 INFO - '_': '/tools/buildbot/bin/python'} 09:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:13 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:06:13 INFO - Cleaning up... 09:06:13 INFO - Return code: 0 09:06:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 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 0x7f109680ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef20>, '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 0x1babc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', '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:06:13 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:06:13 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:06:13 INFO - Using env: {'DISPLAY': ':0', 09:06:13 INFO - 'HOME': '/home/cltbld', 09:06:13 INFO - 'LANG': 'en_US.UTF-8', 09:06:13 INFO - 'LANGUAGE': 'en_US:en', 09:06:13 INFO - 'LOGNAME': 'cltbld', 09:06:13 INFO - 'MAIL': '/var/mail/cltbld', 09:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:13 INFO - 'MOZ_NO_REMOTE': '1', 09:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:13 INFO - 'NO_EM_RESTART': '1', 09:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:13 INFO - 'PWD': '/builds/slave/test', 09:06:13 INFO - 'SHELL': '/bin/bash', 09:06:13 INFO - 'SHLVL': '1', 09:06:13 INFO - 'TERM': 'linux', 09:06:13 INFO - 'TMOUT': '86400', 09:06:13 INFO - 'USER': 'cltbld', 09:06:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', 09:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:13 INFO - '_': '/tools/buildbot/bin/python'} 09:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:13 INFO - Downloading/unpacking psutil>=3.1.1 09:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:15 INFO - Installing collected packages: psutil 09:06:15 INFO - Running setup.py install for psutil 09:06:15 INFO - building 'psutil._psutil_linux' extension 09:06:15 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:06:16 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:06:16 INFO - building 'psutil._psutil_posix' extension 09:06:16 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:06:16 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:06:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:16 INFO - Successfully installed psutil 09:06:16 INFO - Cleaning up... 09:06:16 INFO - Return code: 0 09:06:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:16 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 0x7f109680ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef20>, '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 0x1babc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', '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:06:16 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:06:16 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:06:16 INFO - Using env: {'DISPLAY': ':0', 09:06:16 INFO - 'HOME': '/home/cltbld', 09:06:16 INFO - 'LANG': 'en_US.UTF-8', 09:06:16 INFO - 'LANGUAGE': 'en_US:en', 09:06:16 INFO - 'LOGNAME': 'cltbld', 09:06:16 INFO - 'MAIL': '/var/mail/cltbld', 09:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:16 INFO - 'MOZ_NO_REMOTE': '1', 09:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:16 INFO - 'NO_EM_RESTART': '1', 09:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:16 INFO - 'PWD': '/builds/slave/test', 09:06:16 INFO - 'SHELL': '/bin/bash', 09:06:16 INFO - 'SHLVL': '1', 09:06:16 INFO - 'TERM': 'linux', 09:06:16 INFO - 'TMOUT': '86400', 09:06:16 INFO - 'USER': 'cltbld', 09:06:16 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', 09:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:16 INFO - '_': '/tools/buildbot/bin/python'} 09:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:06:16 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:06:16 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:06:16 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:06:16 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:06:16 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:06:16 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:06:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:06:18 INFO - Installing collected packages: mozsystemmonitor 09:06:18 INFO - Running setup.py install for mozsystemmonitor 09:06:18 INFO - Successfully installed mozsystemmonitor 09:06:18 INFO - Cleaning up... 09:06:18 INFO - Return code: 0 09:06:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:06: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:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06: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:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06: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', '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 0x7f109680ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef20>, '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 0x1babc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', '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:06: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:06: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 jsonschema==2.5.1 09:06:18 INFO - Using env: {'DISPLAY': ':0', 09:06:18 INFO - 'HOME': '/home/cltbld', 09:06:18 INFO - 'LANG': 'en_US.UTF-8', 09:06:18 INFO - 'LANGUAGE': 'en_US:en', 09:06:18 INFO - 'LOGNAME': 'cltbld', 09:06:18 INFO - 'MAIL': '/var/mail/cltbld', 09:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:18 INFO - 'MOZ_NO_REMOTE': '1', 09:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:18 INFO - 'NO_EM_RESTART': '1', 09:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:18 INFO - 'PWD': '/builds/slave/test', 09:06:18 INFO - 'SHELL': '/bin/bash', 09:06:18 INFO - 'SHLVL': '1', 09:06:18 INFO - 'TERM': 'linux', 09:06:18 INFO - 'TMOUT': '86400', 09:06:18 INFO - 'USER': 'cltbld', 09:06:18 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', 09:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:18 INFO - '_': '/tools/buildbot/bin/python'} 09:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:19 INFO - Downloading/unpacking jsonschema==2.5.1 09:06: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:06: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:06: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:06: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:06: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:06: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:06:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:06:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:06: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:06: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:06: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:06: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:06: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:06: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:06:21 INFO - Downloading functools32-3.2.3-2.tar.gz 09:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:06:21 INFO - warning: no files found matching '*.txt' 09:06:21 INFO - no previously-included directories found matching 'build' 09:06:21 INFO - no previously-included directories found matching 'dist' 09:06:21 INFO - no previously-included directories found matching '.git*' 09:06:21 INFO - Installing collected packages: jsonschema, functools32 09:06:21 INFO - Running setup.py install for functools32 09:06:21 INFO - warning: no files found matching '*.txt' 09:06:21 INFO - no previously-included directories found matching 'build' 09:06:21 INFO - no previously-included directories found matching 'dist' 09:06:21 INFO - no previously-included directories found matching '.git*' 09:06:21 INFO - Successfully installed jsonschema functools32 09:06:21 INFO - Cleaning up... 09:06:21 INFO - Return code: 0 09:06:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:06: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:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06: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:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06: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', '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 0x7f109680ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef20>, '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 0x1babc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', '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:06: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:06: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 functools32==3.2.3-2 09:06:21 INFO - Using env: {'DISPLAY': ':0', 09:06:21 INFO - 'HOME': '/home/cltbld', 09:06:21 INFO - 'LANG': 'en_US.UTF-8', 09:06:21 INFO - 'LANGUAGE': 'en_US:en', 09:06:21 INFO - 'LOGNAME': 'cltbld', 09:06:21 INFO - 'MAIL': '/var/mail/cltbld', 09:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:21 INFO - 'MOZ_NO_REMOTE': '1', 09:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:21 INFO - 'NO_EM_RESTART': '1', 09:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:21 INFO - 'PWD': '/builds/slave/test', 09:06:21 INFO - 'SHELL': '/bin/bash', 09:06:21 INFO - 'SHLVL': '1', 09:06:21 INFO - 'TERM': 'linux', 09:06:21 INFO - 'TMOUT': '86400', 09:06:21 INFO - 'USER': 'cltbld', 09:06:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', 09:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:21 INFO - '_': '/tools/buildbot/bin/python'} 09:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:06:21 INFO - Cleaning up... 09:06:21 INFO - Return code: 0 09:06:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:06: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:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06: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:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06: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', '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 0x7f109680ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef20>, '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 0x1babc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', '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:06: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:06: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 blobuploader==1.2.4 09:06:21 INFO - Using env: {'DISPLAY': ':0', 09:06:21 INFO - 'HOME': '/home/cltbld', 09:06:21 INFO - 'LANG': 'en_US.UTF-8', 09:06:21 INFO - 'LANGUAGE': 'en_US:en', 09:06:21 INFO - 'LOGNAME': 'cltbld', 09:06:21 INFO - 'MAIL': '/var/mail/cltbld', 09:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:21 INFO - 'MOZ_NO_REMOTE': '1', 09:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:21 INFO - 'NO_EM_RESTART': '1', 09:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:21 INFO - 'PWD': '/builds/slave/test', 09:06:21 INFO - 'SHELL': '/bin/bash', 09:06:21 INFO - 'SHLVL': '1', 09:06:21 INFO - 'TERM': 'linux', 09:06:21 INFO - 'TMOUT': '86400', 09:06:21 INFO - 'USER': 'cltbld', 09:06:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', 09:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:21 INFO - '_': '/tools/buildbot/bin/python'} 09:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:21 INFO - Downloading/unpacking blobuploader==1.2.4 09:06: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:06: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:06: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:06: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:06: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:06: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:06:23 INFO - Downloading blobuploader-1.2.4.tar.gz 09:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:06:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:06: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:06: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:06: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:06: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:06: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:06: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:06:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:06:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:06: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:06: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:06: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:06: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:06: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:06: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:06:24 INFO - Downloading docopt-0.6.1.tar.gz 09:06:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:06:24 INFO - Installing collected packages: blobuploader, requests, docopt 09:06:24 INFO - Running setup.py install for blobuploader 09:06:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:06:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:06:24 INFO - Running setup.py install for requests 09:06:25 INFO - Running setup.py install for docopt 09:06:25 INFO - Successfully installed blobuploader requests docopt 09:06:25 INFO - Cleaning up... 09:06:25 INFO - Return code: 0 09:06:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:25 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 0x7f109680ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef20>, '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 0x1babc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', '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:06:25 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:06:25 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:06:25 INFO - Using env: {'DISPLAY': ':0', 09:06:25 INFO - 'HOME': '/home/cltbld', 09:06:25 INFO - 'LANG': 'en_US.UTF-8', 09:06:25 INFO - 'LANGUAGE': 'en_US:en', 09:06:25 INFO - 'LOGNAME': 'cltbld', 09:06:25 INFO - 'MAIL': '/var/mail/cltbld', 09:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:25 INFO - 'MOZ_NO_REMOTE': '1', 09:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:25 INFO - 'NO_EM_RESTART': '1', 09:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:25 INFO - 'PWD': '/builds/slave/test', 09:06:25 INFO - 'SHELL': '/bin/bash', 09:06:25 INFO - 'SHLVL': '1', 09:06:25 INFO - 'TERM': 'linux', 09:06:25 INFO - 'TMOUT': '86400', 09:06:25 INFO - 'USER': 'cltbld', 09:06:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', 09:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:25 INFO - '_': '/tools/buildbot/bin/python'} 09:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:25 INFO - Running setup.py (path:/tmp/pip-bStMfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:25 INFO - Running setup.py (path:/tmp/pip-4ibRG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:25 INFO - Running setup.py (path:/tmp/pip-zk0zf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:25 INFO - Running setup.py (path:/tmp/pip-_PoBXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:25 INFO - Running setup.py (path:/tmp/pip-S4uYq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:25 INFO - Running setup.py (path:/tmp/pip-2A9PCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:26 INFO - Running setup.py (path:/tmp/pip-opaFNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:26 INFO - Running setup.py (path:/tmp/pip-oBBFxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:26 INFO - Running setup.py (path:/tmp/pip-TRrUVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:26 INFO - Running setup.py (path:/tmp/pip-lH6moY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:26 INFO - Running setup.py (path:/tmp/pip-vTp9gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:26 INFO - Running setup.py (path:/tmp/pip-Qx8nBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:26 INFO - Running setup.py (path:/tmp/pip-4qZl0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:26 INFO - Running setup.py (path:/tmp/pip-f8baGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:26 INFO - Running setup.py (path:/tmp/pip-cWD20K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:26 INFO - Running setup.py (path:/tmp/pip-sb7LnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:26 INFO - Running setup.py (path:/tmp/pip-xcd7HN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:06:26 INFO - Running setup.py install for manifestparser 09:06:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:06:26 INFO - Running setup.py install for mozcrash 09:06:27 INFO - Running setup.py install for mozdebug 09:06:27 INFO - Running setup.py install for mozdevice 09:06:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:06:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:06:27 INFO - Running setup.py install for mozfile 09:06:27 INFO - Running setup.py install for mozhttpd 09:06:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:06:27 INFO - Running setup.py install for mozinfo 09:06:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:06:27 INFO - Running setup.py install for mozInstall 09:06:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:06:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:06:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:06:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:06:27 INFO - Running setup.py install for mozleak 09:06:27 INFO - Running setup.py install for mozlog 09:06:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:06:27 INFO - Running setup.py install for moznetwork 09:06:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:06:27 INFO - Running setup.py install for mozprocess 09:06:28 INFO - Running setup.py install for mozprofile 09:06:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:06:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:06:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:06:28 INFO - Running setup.py install for mozrunner 09:06:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:06:28 INFO - Running setup.py install for mozscreenshot 09:06:28 INFO - Running setup.py install for moztest 09:06:28 INFO - Running setup.py install for mozversion 09:06:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:06:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:06:28 INFO - Cleaning up... 09:06:28 INFO - Return code: 0 09:06:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:28 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 0x7f109680ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef20>, '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 0x1babc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', '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:06:28 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:06:28 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:06:28 INFO - Using env: {'DISPLAY': ':0', 09:06:28 INFO - 'HOME': '/home/cltbld', 09:06:28 INFO - 'LANG': 'en_US.UTF-8', 09:06:28 INFO - 'LANGUAGE': 'en_US:en', 09:06:28 INFO - 'LOGNAME': 'cltbld', 09:06:28 INFO - 'MAIL': '/var/mail/cltbld', 09:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:28 INFO - 'MOZ_NO_REMOTE': '1', 09:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:28 INFO - 'NO_EM_RESTART': '1', 09:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:28 INFO - 'PWD': '/builds/slave/test', 09:06:28 INFO - 'SHELL': '/bin/bash', 09:06:28 INFO - 'SHLVL': '1', 09:06:28 INFO - 'TERM': 'linux', 09:06:28 INFO - 'TMOUT': '86400', 09:06:28 INFO - 'USER': 'cltbld', 09:06:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', 09:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:28 INFO - '_': '/tools/buildbot/bin/python'} 09:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:28 INFO - Running setup.py (path:/tmp/pip-vHbhmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:28 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:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:28 INFO - Running setup.py (path:/tmp/pip-Hg708V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:28 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:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:28 INFO - Running setup.py (path:/tmp/pip-hcOc7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:29 INFO - Running setup.py (path:/tmp/pip-lR37nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:29 INFO - Running setup.py (path:/tmp/pip-eVADJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:29 INFO - Running setup.py (path:/tmp/pip-2NGZTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:29 INFO - Running setup.py (path:/tmp/pip-hZSQJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:29 INFO - Running setup.py (path:/tmp/pip-vKVCvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:29 INFO - Running setup.py (path:/tmp/pip-RpKgKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:29 INFO - Running setup.py (path:/tmp/pip-btFSK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:29 INFO - Running setup.py (path:/tmp/pip-ueilU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:29 INFO - Running setup.py (path:/tmp/pip-mShL6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:29 INFO - Running setup.py (path:/tmp/pip-jzaHK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:29 INFO - Running setup.py (path:/tmp/pip-BiwarA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:29 INFO - Running setup.py (path:/tmp/pip-zxzVRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:29 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:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:29 INFO - Running setup.py (path:/tmp/pip-pL_P_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:30 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:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:30 INFO - Running setup.py (path:/tmp/pip-JbIwG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:30 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:06:30 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:06:30 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:06:30 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:06:30 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:06:30 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:06:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:32 INFO - Downloading blessings-1.6.tar.gz 09:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:06:32 INFO - Installing collected packages: blessings 09:06:32 INFO - Running setup.py install for blessings 09:06:32 INFO - Successfully installed blessings 09:06:32 INFO - Cleaning up... 09:06:32 INFO - Return code: 0 09:06:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:06:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:32 INFO - Reading from file tmpfile_stdout 09:06:32 INFO - Current package versions: 09:06:32 INFO - argparse == 1.2.1 09:06:32 INFO - blessings == 1.6 09:06:32 INFO - blobuploader == 1.2.4 09:06:32 INFO - docopt == 0.6.1 09:06:32 INFO - functools32 == 3.2.3-2 09:06:32 INFO - jsonschema == 2.5.1 09:06:32 INFO - manifestparser == 1.1 09:06:32 INFO - mozInstall == 1.12 09:06:32 INFO - mozcrash == 1.0 09:06:32 INFO - mozdebug == 0.1 09:06:32 INFO - mozdevice == 0.49 09:06:32 INFO - mozfile == 1.2 09:06:32 INFO - mozhttpd == 0.7 09:06:32 INFO - mozinfo == 0.9 09:06:32 INFO - mozleak == 0.1 09:06:32 INFO - mozlog == 3.4 09:06:32 INFO - moznetwork == 0.27 09:06:32 INFO - mozprocess == 0.23 09:06:32 INFO - mozprofile == 0.28 09:06:32 INFO - mozrunner == 6.13 09:06:32 INFO - mozscreenshot == 0.1 09:06:32 INFO - mozsystemmonitor == 0.3 09:06:32 INFO - moztest == 0.7 09:06:32 INFO - mozversion == 1.4 09:06:32 INFO - psutil == 3.1.1 09:06:32 INFO - requests == 1.2.3 09:06:32 INFO - wsgiref == 0.1.2 09:06:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:32 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:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:32 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:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:32 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 0x7f109680ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef20>, '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 0x1babc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', '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:06:32 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:06:32 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:06:32 INFO - Using env: {'DISPLAY': ':0', 09:06:32 INFO - 'HOME': '/home/cltbld', 09:06:32 INFO - 'LANG': 'en_US.UTF-8', 09:06:32 INFO - 'LANGUAGE': 'en_US:en', 09:06:32 INFO - 'LOGNAME': 'cltbld', 09:06:32 INFO - 'MAIL': '/var/mail/cltbld', 09:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:32 INFO - 'MOZ_NO_REMOTE': '1', 09:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:32 INFO - 'NO_EM_RESTART': '1', 09:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:32 INFO - 'PWD': '/builds/slave/test', 09:06:32 INFO - 'SHELL': '/bin/bash', 09:06:32 INFO - 'SHLVL': '1', 09:06:32 INFO - 'TERM': 'linux', 09:06:32 INFO - 'TMOUT': '86400', 09:06:32 INFO - 'USER': 'cltbld', 09:06:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', 09:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:32 INFO - '_': '/tools/buildbot/bin/python'} 09:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:32 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:06:32 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:06:32 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:06:32 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:06:32 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:06:32 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:06:32 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:06:32 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:06:32 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:06:32 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:06:32 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:06:32 INFO - Cleaning up... 09:06:32 INFO - Return code: 0 09:06:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:06:32 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:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:32 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:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:32 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 0x7f109680ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ef20>, '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 0x1babc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', '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:06:32 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:06:32 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:06:32 INFO - Using env: {'DISPLAY': ':0', 09:06:32 INFO - 'HOME': '/home/cltbld', 09:06:32 INFO - 'LANG': 'en_US.UTF-8', 09:06:32 INFO - 'LANGUAGE': 'en_US:en', 09:06:32 INFO - 'LOGNAME': 'cltbld', 09:06:32 INFO - 'MAIL': '/var/mail/cltbld', 09:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:32 INFO - 'MOZ_NO_REMOTE': '1', 09:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:32 INFO - 'NO_EM_RESTART': '1', 09:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:32 INFO - 'PWD': '/builds/slave/test', 09:06:32 INFO - 'SHELL': '/bin/bash', 09:06:32 INFO - 'SHLVL': '1', 09:06:32 INFO - 'TERM': 'linux', 09:06:32 INFO - 'TMOUT': '86400', 09:06:32 INFO - 'USER': 'cltbld', 09:06:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', 09:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:32 INFO - '_': '/tools/buildbot/bin/python'} 09:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:06:32 INFO - Cleaning up... 09:06:32 INFO - Return code: 0 09:06:32 INFO - Running post-action listener: _resource_record_post_action 09:06:33 INFO - Running post-action listener: _start_resource_monitoring 09:06:33 INFO - Starting resource monitoring. 09:06:33 INFO - [mozharness: 2016-12-17 17:06:33.027617Z] Finished create-virtualenv step (success) 09:06:33 INFO - [mozharness: 2016-12-17 17:06:33.028088Z] Running install step. 09:06:33 INFO - Running pre-action listener: _resource_record_pre_action 09:06:33 INFO - Running main action method: install 09:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:33 INFO - Reading from file tmpfile_stdout 09:06:33 INFO - Detecting whether we're running mozinstall >=1.0... 09:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:06:33 INFO - Reading from file tmpfile_stdout 09:06:33 INFO - Output received: 09:06:33 INFO - Usage: mozinstall [options] installer 09:06:33 INFO - Options: 09:06:33 INFO - -h, --help show this help message and exit 09:06:33 INFO - -d DEST, --destination=DEST 09:06:33 INFO - Directory to install application into. [default: 09:06:33 INFO - "/builds/slave/test"] 09:06:33 INFO - --app=APP Application being installed. [default: firefox] 09:06:33 INFO - mkdir: /builds/slave/test/build/application 09:06:33 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:06:33 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:06:50 INFO - Reading from file tmpfile_stdout 09:06:50 INFO - Output received: 09:06:50 INFO - /builds/slave/test/build/application/firefox/firefox 09:06:50 INFO - Running post-action listener: _resource_record_post_action 09:06:50 INFO - [mozharness: 2016-12-17 17:06:50.303691Z] Finished install step (success) 09:06:50 INFO - [mozharness: 2016-12-17 17:06:50.303932Z] Running run-tests step. 09:06:50 INFO - Running pre-action listener: _resource_record_pre_action 09:06:50 INFO - Running main action method: run_tests 09:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:50 INFO - Python 2.7.3 09:06:50 INFO - Return code: 0 09:06:50 INFO - grabbing minidump binary from tooltool 09:06:50 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:06:50 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 0x1c3ef20>, '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 0x1babc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1babf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:50 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:06:50 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:06:50 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:06:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:50 INFO - Return code: 0 09:06:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:06:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:06:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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:06:50 INFO - Using env: {'DISPLAY': ':0', 09:06:50 INFO - 'HOME': '/home/cltbld', 09:06:50 INFO - 'LANG': 'en_US.UTF-8', 09:06:50 INFO - 'LANGUAGE': 'en_US:en', 09:06:50 INFO - 'LOGNAME': 'cltbld', 09:06:50 INFO - 'MAIL': '/var/mail/cltbld', 09:06:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:50 INFO - 'MOZ_NO_REMOTE': '1', 09:06:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:50 INFO - 'NO_EM_RESTART': '1', 09:06:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:50 INFO - 'PWD': '/builds/slave/test', 09:06:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:50 INFO - 'SHELL': '/bin/bash', 09:06:50 INFO - 'SHLVL': '1', 09:06:50 INFO - 'TERM': 'linux', 09:06:50 INFO - 'TMOUT': '86400', 09:06:50 INFO - 'USER': 'cltbld', 09:06:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883', 09:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:50 INFO - '_': '/tools/buildbot/bin/python'} 09:06:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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:06:50 INFO - mozversion application_buildid: 20161217073119 09:06:50 INFO - mozversion application_changeset: 56a8ce2bf0876fc9315407676e2db35e238e510d 09:06:50 INFO - mozversion application_display_name: Nightly 09:06:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:50 INFO - mozversion application_name: Firefox 09:06:50 INFO - mozversion application_remotingname: firefox 09:06:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:06:50 INFO - mozversion application_vendor: Mozilla 09:06:50 INFO - mozversion application_version: 53.0a1 09:06:50 INFO - mozversion platform_buildid: 20161217073119 09:06:50 INFO - mozversion platform_changeset: 56a8ce2bf0876fc9315407676e2db35e238e510d 09:06:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:06:50 INFO - mozversion platform_version: 53.0a1 09:06:50 INFO - using testdate: 1481994410 09:06:50 INFO - actual date: 1481994410 09:06:50 INFO - starting webserver on 'localhost:48782' 09:06:50 INFO - SUITE-START | Running 2 tests 09:06:50 INFO - TEST-START | dromaeo_css 09:06:50 INFO - operating with platform_type : linux_ 09:06:50 INFO - Initialising browser for dromaeo_css test... 09:06:50 INFO - TEST-INFO | started process 13213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQu3DvO/profile http://localhost:48782/getInfo.html) 09:06:54 INFO - PROCESS | 13213 | __metrics Screen width/height:1600/1200 09:06:54 INFO - PROCESS | 13213 | colorDepth:24 09:06:54 INFO - PROCESS | 13213 | Browser inner width/height: 1024/697 09:06:54 INFO - PROCESS | 13213 | __metrics 09:06:54 INFO - PROCESS | 13213 | 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:06:54 INFO - PROCESS | 13213 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:55 INFO - PROCESS | 13213 | console.error: PushService: 09:06:55 INFO - PROCESS | 13213 | stateChangeProcessEnqueue: Error transitioning state 09:06:55 INFO - PROCESS | 13213 | UnknownError 09:06:55 INFO - TEST-INFO | 13213: exit 0 09:06:55 INFO - Browser initialized. 09:06:55 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:55 INFO - TEST-INFO | started process 13298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQu3DvO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:07 INFO - PROCESS | 13298 | RSS: Main: 153915392 09:07:07 INFO - PROCESS | 13298 | 09:07:58 INFO - PROCESS | 13298 | 1481994478752 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:10:08 INFO - PROCESS | 13298 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48782/tests/dromaeo/cssquery-ext.html) 09:10:10 INFO - PROCESS | 13298 | RSS: Main: 338886656 09:10:10 INFO - PROCESS | 13298 | 09:13:13 INFO - PROCESS | 13298 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-ext.html (next: http://localhost:48782/tests/dromaeo/cssquery-jquery.html) 09:13:13 INFO - PROCESS | 13298 | RSS: Main: 257810432 09:13:13 INFO - PROCESS | 13298 | 09:16:16 INFO - PROCESS | 13298 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48782/tests/dromaeo/cssquery-mootools.html) 09:16:16 INFO - PROCESS | 13298 | RSS: Main: 225009664 09:16:16 INFO - PROCESS | 13298 | 09:19:18 INFO - PROCESS | 13298 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48782/tests/dromaeo/cssquery-prototype.html) 09:19:19 INFO - PROCESS | 13298 | RSS: Main: 190394368 09:19:19 INFO - PROCESS | 13298 | 09:22:22 INFO - PROCESS | 13298 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48782/tests/dromaeo/cssquery-yui.html) 09:22:22 INFO - PROCESS | 13298 | RSS: Main: 189493248 09:22:22 INFO - PROCESS | 13298 | 09:25:25 INFO - PROCESS | 13298 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-yui.html (next: http://localhost:48782/tests/dromaeo/cssquery-dojo.html) 09:25:26 INFO - PROCESS | 13298 | RSS: Main: 277716992 09:25:26 INFO - PROCESS | 13298 | 09:25:26 INFO - PROCESS | 13298 | __start_tp_report 09:25:26 INFO - PROCESS | 13298 | _x_x_mozilla_page_load 09:25:26 INFO - PROCESS | 13298 | _x_x_mozilla_page_load_details 09:25:26 INFO - PROCESS | 13298 | |i|pagename|runs| 09:25:26 INFO - PROCESS | 13298 | |0;dojo.html;2947.8083924544903;2973.7026297370257;2981.2248815308026;3002.339485313233;3024.6824083471233;5149.76826042828;5191.792328306863;5207.218917162428;5233.816816411427;5268.947310526898;5229.372475302959;5231.555317797992;5250.579953603712;5278.683279003262;5302.3106996090455;4696.694714843541;4697.600703940169;4737.431508219019;4810.086083644105;4821.807127714887;4750.643701722367;4825.300331451937;4865.221564549673;4883.047805677894;4898.755062246892;4822.132016237076;4858.927116093261;4882.365292511969;4890.828820991266;4923.532264434873;4721.645876559238;4761.40482439695;4766.833160839354;4772.069446457942;4779.044191161747;4728.148933192058;4731.432228132611;4734.337192793012;4739.052189562101;4746.02706445178;5120.411152717448;5193.350831146106;5195.038917800219;5201.24581935621;5210;5533.6956467394275;5621.80323688669;5643.068893632546;5661.377248502661;5683.431656834325;5643.407442218549;5664.0937450007805;5670.68811215383;5671.914921276184;5676.772929082832;5230.764615592231;5295.232191332235;5298.523132918056;5300.204969254604;5345.81289654868;5546.27898373217;5569.0254205513875;5661.065924122556;5670.149477578396;5700.230468886647;5532.75102620383;5534.584906132056;5535.723213839292;5539.639923404966;5576.330840299109;5597.608167428322;5602.915956260659;5617.38208797032;5620.437956204347;5624.606277560613;5475.260839786578;5505.229267902497;5508.944910550923;5551.555875529948;5650.830475085754;5574.163875418639;5668.433156684381;5673.319201695823;5712.65724056558;5714.771409143587;4332.4367832181615;4338.956610433918;4339.479262488521;4340.739555626673;4378.2994720845145;3742.0644838790304;3772.2832661794173;3841.2317536492815;3844.3464611016193;3862.806859657006;5280.6303558750515;5296.443873393316;5302.973485132549;5316.362036555638;5411.485908838733;5605;5643.774249030075;5648.802291919763;5651.15232715096;5654.915176272277;5317.335333083364;5368.32895888014;5377.946220537823;5379.865503362447;5421.918671219935;4806.158922188673;4842.176829938919;4849.563539281482;4905.068037072945;4907.092187945242;5679.119736440858;5692.117721753135;5720.685362305113;5805.651660900359;5818.679972601548;5588.804391846266;5604;5605.159226115952;5607.243022192115;5649.802256920988;5694.231278777312;5704.629199102045;5753.280839895013;5754.2519472469985;5761.740721667619;5434.429384914527;5467.4532546745;5471.8084867029465;5483.698396588066;5485.533729633026;5651.745671444713;5659.6887171204335;5661.348944871393;5698.373178950395;5716.742746576498;5510.944890551204;5517.558595312285;5520.420355862737;5520.66875987442;5521.475459831309;5412.107002344569;5442.2108794225405;5444.183372493999;5461.399246083007;5584.050711379156;5423.132298832168;5424.674519528841;5445.319335083114;5455.454454554513;5458.918116228339;5531.8893622126525;5537.5569954402745;5538.47384498472;5546.805861794818;5547.11246200606;5347.51872331492;5383.515483606494;5400.324959380077;5430;5502.697351645538 09:25:26 INFO - PROCESS | 13298 | |1;ext.html;539.8515408262729;549.8103154411726;555.0370107862857;561.668615516845;562.2269379603046;30924.38151236974;39619.20761584766;41437.792811035906;41535.79232103835;45055.77472112635;42380.364294535604;42993.35509967353;43028;43032.569674303246;43051.3542296865;8447.197516235963;8623.784405389853;8625.698100566482;8634.179752923494;8638.049814520398;7853.685852565891;8019.438639295252;9817.950910245474;10032.69901902944;10039.949800250988;10232.488375581228;10289.536970836292;10289.897101028968;10295.073443390093;10298.691039268797;10127.645532406368;10173.643922462677;10186.59253629854;10197.949010254939;10198;10016.198704103654;10085.394876307446;10089.495525223709;10091.89908100917;10093.293469457067;39357.21285574301;39601.80199098986;39631.20737585261;39680.60319396798;39705;3254.96745032549;3318.933621327584;3378.1048022274117;3404.8467818948207;3491.895243142684;29235;29515;29568.26079348012;29839;30536.404405625548;3926.70549708773;3951.920961580781;3996.9600303997167;4060.6548443382053;4161.396597493346;299713;300267;300407;300553;300674;53111.73444132755;53337.466625334026;53451;53488.46511534913;53506;56442.717786411624;56707;56787.43212567904;56805;56813.715931420076;14297.714045719027;14651.267436628126;14718.484853030093;14750.04124731889;14752.680646854373;10239.692809215736;10511.684649460529;11621.53513859453;11754.647360579196;11788.941055294668;14131.78802317966;14215.573532794033;14250;15240.314185861664;15544.922275388777;5581.302337207849;5682.829515114553;5684.261046064068;5831.679257640785;5864.32560255576;881.6517475597103;928.8513837786057;983.2183414185739;1048.9580416783242;1119.2780656476527;27904.581431278548;29737.553936690965;31196.532052019236;31215.90744323983;31766.841165794023;1044.5090807320548;1049.2393015064017;1074.6453670288786;1091.3942761767137;1103.0568863621488;13937.790933136012;14669.286182056141;14754.262286885612;15021.699566008838;15070.321835517429;458942;461854;462133;465056;692372;42185;42271.365929511085;42336.576634233264;42705.145897081886;46587.8070973614;1277.5720133755297;1285.1774864086992;1298.1691717300935;1313.3761463304854;1319.967000824968;26777.19668409951;27312.863435682695;28014.43971120607;28395;28460.573091403232;43066.1386772269;43445;43506.34740478959;43540.346894797236;43571.56428435675;348322;349951;350600;350781;351116;23916.16293429791;24361.26916192517;24376.87811560931;24384.146554870495;24398.146064887645;36227.81886090553;38277.23445531129;39347;39434.80282598684;40187.39718904277;33752.66247337495;34156.82921585376;34194;34304.65695343114;34481.65518344885;33633.15917102092;33687.98936031923;33721.49417758785;34081.31837363289;34309.656903430645;34136.82931585426;34664.82667586646;34726.82636586902;34774.47838282377;34851.65148348484;28977;31307.217319567193;31463.528047078853;31538.369232615678;31584.684153158174;24331.39171520726;24375.26874193777;24414;24765.87617061903;24852.875735621205 09:25:26 INFO - PROCESS | 13298 | |2;jquery.html;349.9650034996499;364.4809365575369;381.7881076002818;382.2050135717707;405.32715691951364;13996.160230386184;16977.83022169778;17196.91401542992;17381.65236695267;17808.1986310616;17301.653966920654;17636.64726705465;17699.55751106223;17842.10789460525;17850.64298714025;5215.921761173586;5545.473180047889;5568;5575.749091290902;5578.721063946807;4063.674906007527;4234.259004674185;4236.4704411948505;4269.996550810557;5471.042567550682;4243.151369726067;4276.3963513682365;6167.845803854894;6256.749730010794;6268.686565671721;6271.560990730651;6274.184356033732;6275.497960163176;6284.87430251397;6613.404793568554;6622.503312251552;6685.13093297873;6777.118974533329;6780.220274668427;6784.321567843176;24171.637425438632;24561.631575526382;24739.25782226536;25115.497690046097;25269.747302527107;2320.477892474197;2464.864432456214;2470.987645061781;2549.668543089405;3041.874506432634;14394.712105757932;14594.27028648574;14598.197099159543;14733.631659208606;15158.848411515854;2016.7277417548737;2079.949625439159;2093.1418118571314;2136.5513242219154;2136.871787692728;67943.3205667942;69340;74026.62986685032;78409.21590784076;88523.11476885277;16275.593110172103;16534.66930661404;16652.250648720594;16893.239804208595;17032.57418564521;29825;29833.254168645522;29892.804287828243;29914.401711966075;30065.398692026036;8894.777630559158;9320.627174913063;9467.337286389886;9484.352667193025;9740.561674724655;7575.24247575238;7645.15903250642;7647.541147531166;7760.844783104306;7834.725784597512;8367.330613550901;8423;8467.534285614227;8579.785505362292;8727.345449091217;2880.7551358134792;3170.7621928355466;3176.8729250829706;3433.3819912415506;3434.8797792077157;830.2486249943811;892.0410558649478;914.9176574108229;924.7272054743867;961.5240455974338;17087.658246835243;18255.81744182568;18417;18591.90704046471;18675.15961781723;861.8842882977989;947.1144479911305;975.1077763846143;982.2633025231077;984.0749695286407;9744;10166.796664066676;10219.13137383316;10244;10250.487475626189;441331;447172;449433;450505;451592;83869.58065209757;84686.57656711678;85527.57236213778;88533.51378515996;92737.536312318;973.0998826085843;992.8361820299714;1009.1018993096151;1016.6949915025463;1017.8931212222758;15515;15923.52229433119;15938.60153496172;16072.758908616614;16365.10669120817;38960.80519597384;39212.60787392204;40147.19705605813;40430.1913961725;40848.387274191504;57116.714416427654;57292.71353643205;59024.70487647534;59503;60111.09833352591;7232.819179520554;7288.672009759467;7391.2239214881665;7424.888626670496;7591.506552074097;9500.762480938032;12405.875941240833;12914.741705165656;12944;13072.869271307165;10523.736906577396;10919.672409827717;11002.449877506253;11396.829047564128;11445.198836081394;5938.792142275;8304.920360353115;10702.678919632424;10965.671029869116;11117.722056948642;10693.9465302673;11164.218504704593;11183.832242516532;11230.382328971986;11341.092712583139;7268.236835132235;7397.112346518452;7455.850882982201;7474.476786624884;7922.7227047053075;8597.828043439222;10536.157107431234;10763.3541987481;10886.346819190874;10978.780424391307 09:25:26 INFO - PROCESS | 13298 | |3;mootools.html;1389.7290028444454;1415.6673181802275;1507.2991059157496;1624.8131464881542;1697.058132736331;7619.238076192378;8011.319037881773;8016.799580010495;8019.5188288702575;8021.839563208732;7087.610181440019;7262.818429539264;7552.395808335334;7741.651625676844;7925.920740792591;2113.2497963223063;2143.47484866208;2148.9355319340366;2148.946276343096;2153.849230553862;2127.2235633993637;2159.730033745782;2188.5951099046647;2188.6935828983956;2190.3100523335097;1920.2606996306383;1987.1951859496855;2102.379797959598;2162.7837216278404;2173.402314363555;2150.064721846002;2156.816670583002;2179.705739725133;2180.1170525937023;2180.1170525937023;2134.562414704997;2166.2959538150008;2172.750133734625;2173.9891300543554;2207.415035015722;8018.839623207561;8090.797730056795;8114.715984940558;8124.106348301682;8134.064582572962;4760.880977975544;4868.537488938545;4884.487128851455;4899.706017638953;4900.485449027837;3016.788824782266;3157.605299337583;3338.432466480704;3342.348242092793;3348.196432856121;1009.9697009089739;1013.5844303835393;1022.3610243597751;1064.893510648929;1083.2742062817852;10269.589216431334;10387.169026477864;10397;10412.94793526035;10413.635522756744;3970.404439334123;4089.386592011222;4130.690198235145;4146.564610715892;4158.355454904495;8555.743327700178;8568.186022327869;8570;8571.357148213909;8584.442011269248;4819.132556139858;4824.614030877521;4825.445073816486;4827.565519103297;4828.227483602606;4460.620847227957;4525.728456292633;4537.137943790735;4576.199165146086;4583.129205450954;3371.443711787577;3410.3861304965344;3414.607320158164;3446.276281980762;3492.039689085522;1031.185363562792;1032.9380237185642;1039.589362201926;1039.896010398969;1056.3186744549876;611.4222060153113;764.7125658872957;845.8688903220011;868.4572142410993;898.2589363774912;5008.84973450797;5014.598832093424;5099.719515426613;5206.140986737146;5267.236250743697;878.5958459108754;881.5278484930182;893.4817805672694;896.6547879066607;906.40177482861;3259.576255086871;3494.423420135649;3505.158761897126;3523.788572685647;3573.3925232710503;9319.580618872167;9789.853152202722;9810.068043535854;9834.360766550151;9843.458609776531;9529.666461673809;9739.464329461947;9744.610215591298;9754.46350450718;9765.365251258645;7407.148177959496;7423.44324175689;7514.699412023567;7520.360769334558;7546.169921308542;4903.53416425439;4983.352164218629;4987.147550094798;5086.847394578169;5209.270702101633;8387.83224335522;8564.871526926976;8590.09803970599;8704.738857834274;8734.126587341216;8598.527081010605;8707.608157632794;8741.475511469333;8749;8872.778180545538;7043.7534686285735;7070.010198572101;7152.925651560989;7232.74685386009;7243.529170603894;7520.435967302584;7601.239876012354;7641;7655.885161722467;7664.501807382502;6932.688029038806;6934.271901450476;6962.825929351807;6997.895031574429;7247.311505406978;6834.043233947351;6853.0405743195;6905.965470172617;6912.274211207952;6928.064711263914;5993.9700301498215;6215.689215539114;6269.937300626935;6332.936670633235;6415.166028416276;4448.4884238311715;4566.794494247833;4584.106099310602;4619.69971951822;4704;4510.345999830072;4616.469106052713;4632.096741135446;4675.976620116878;4728.432588089451 09:25:26 INFO - PROCESS | 13298 | |4;prototype.html;313.1607292456217;315.5708236797954;320.36727463260064;322.6209204185082;325.1886543075028;5237.764300606473;5283.392409872856;5307.65500242484;5322.707251101193;5333.706646134461;5017.2474128880685;5250.133727934886;5255.369355677324;5257.316548848645;5257.421683614799;3951.308521008826;3997.2605068062358;4000.7799571023584;4040.393940908858;4078.7552746835136;4033.3143365627916;4041.7979101044975;4056.9391459128137;4060.7563546187325;4071.531773846016;3903.453516507677;4034.7579145251234;4053.6351728344443;4057.9391309130388;4077.55146933837;3967.7420967637013;4012.9799351003203;4039.3738970459626;4054.2904991626347;4078.653314468274;3558.5195998540125;3573.249617580311;3573.767705099186;3577.94633080504;3595.964040359589;5160.612954028463;5181.792728290864;5186.299849520305;5195.870103247411;5201.219817027439;4460.420145381112;4525.615322697575;4585.266357382836;4599.816007359702;4645.372874661911;5425.755840987125;5426.8914621707345;5449.3460784706085;5458.4541545845495;5468.699221542814;3883.4951456310782;3884.2231553689094;3893.980530097331;3901.902452438683;3904.8438062477467;5539.446055394428;5631.267935168443;5687.971560142256;5710.2576665033275;5733.340665823442;3944.6923549723733;3955.5253369595835;3956.624120708528;3962.821673024721;3963.147923196527;4010.6189911958318;4016.5180178378196;4018.2566225248424;4023.396490526386;4023.456833327522;4276.422682937826;4480.574345437179;4649.698084536335;4653.744044077541;4658.67389282747;5484.451554844483;5496.340439147328;5497;5508.20131080999;5510.201020851954;1285.7207078956499;1296.5267677297718;1297.4550688710765;1300.9284489352988;1306.5949555637783;835.6991483066091;842.7990114087401;865.8831057807241;875.9211670949518;880.4277219807049;5251.291075704731;5404.32445944257;5426.810061647823;5448.536874365724;5465.617406781487;5616.971915140398;5618.230257468884;5642.576806739511;5685.602007859493;5694.715264236772;5167.767450464738;5350.839474815762;5368.8389348319615;5369.543588794918;5395.62230643859;2909.7526710229445;2921.6055832462343;2922.225610213295;2927.8919178192095;2944.440556294297;5601.607887447921;5610.607257492018;5638.661680299113;5661.179129026268;5670.603057785998;5330.840074797762;5543.445655434424;5546.972265138729;5550.417206193372;5599.692016939108;5623.963059947582;5649.406812284733;5663.46197111282;5679.886402271932;5692.373838877803;5325.707086110301;5516.613837031369;5520.475554822286;5554.444555544414;5575;5342.225377320345;5360.249565060816;5503.569072041379;5511.448855114457;5538.861528461821;5530.446955304437;5574.331080270232;5709.971450142889;5771.220885180447;5793.188953546422;3461.913452163615;3665.7983810890655;3700.3154416433044;3765.4163604641326;3765.6046115157515;5444.8094316698725;5481.808136715196;5502.394736578893;5513.5037846594;5516.972415137899;5390.4879036491475;5419.945800542102;5423;5448.019356515865;5449.782008719607;5115.360579927509;5385.4076051635075;5427.213054107211;5434.266374039454;5434.2935418395355;5330.9733451332495;5346.732663366894;5351.3043304370185;5370.758315875873;5383.81156659515;5334.786608535615;5379.799019583342;5501.5323697486165;5504.724763761716;5518.420565840529;5403;5409.83770486886;5444.401115877171;5463.399026107046;5478.589105817 09:25:26 INFO - PROCESS | 13298 | |5;yui.html;705;737.9262073792621;738.9298016688413;740.2825444967674;761.7181642792166;14749.188794616291;15963.92018039911;15987.84012159878;16142.67714645708;16153.111578863172;14823.703525929503;14993.550193494213;15004;15004.174770387624;15038;668.0747165176217;685.5920727167328;779.4388040610779;785.4815821557773;803.1927912447982;790.8102055506665;791.2285521616435;791.3313250303513;791.5765065689857;803.1286054630733;853.3471894001094;854.2525290370926;854.406187699549;854.4958474500044;855.2388374346837;711.5943911970205;731.8755811512002;821.979450513736;853.8676505141682;854.133054949227;608.0666177417687;608.8447445901311;609.7225762278152;610.5909040942535;614.5268143529502;15952.601184970352;16026.519204423887;16051.839481605151;16072.116033618146;16076.75884861728;14177.362018709182;14280.357383917748;14787.630309242248;14839.03546269489;15004;12201.755964880742;12448.315342656151;12514.31171285579;12537.247765134121;12806.871931280753;4315.158544083905;4394.956050439487;4589.770511474447;4618.445786505641;4619.930701039487;81681;82525;82721.58639206826;82886.58556707238;83700.58149709273;11323.830142547868;11359.545618175345;11493.54025838957;11542.711432214262;12302.138850280573;22340;22559.774402256095;22618;22816.543669126524;22837.314880553276;7976.521408715495;8000.479968802009;8018.914982342105;8156.1028286888395;8324.62539185738;4377.409049778239;4447.555244475527;4465.531119232499;4473.843415480443;4481.663875209372;3190.457622204231;3267.7059064683817;3272.296456261915;3289.506574013917;3307.024427793807;548.1120584652888;549.4011527435115;552.5689961829779;556.910894256917;561.9522340601095;547.9807557942224;551.1759918921239;567.7558649780551;666.8499587592753;680.1667956752938;8306;8993.865092023625;9090.590923408463;9153.221976132103;9318.347715659975;570.0660780940963;676.5027704637088;689.8792711275607;701.1586096684;710.8258476673145;4093.5906409358827;4127.5666055064385;4261.190373828963;4297.527272000078;4337.240982827992;73570.63214684;74620.62689686517;77573.61213193898;84072;85333.57333213295;65852;65852.34147658559;65860.34139658637;66049;66833.6658316715;58454.12318815221;59491.40508594945;61191.38808611946;62263.68868155812;62730.68634656798;9257.259419246579;9365.250779937453;9631.133198012212;9658.75853103678;9677.758056048655;39624.603753963245;40775.79612101921;40862.59137408707;43592.34611480767;44794.93691135627;51110;56926.715366422904;58614.70692646509;59408.70295648494;60065.69967150136;12911.031672624404;13964.860351396763;14016.229107399191;14272.785908211592;14904.105753654816;14599.92700036493;14628;14771.704565908836;14795.778063329273;15116.244187790786;13985.720285594434;14253.64365890861;14409.567712968628;14415.846305144501;14526;11910.010146600986;12156.939215303866;12567.748645026866;12795.488180473048;12803.807942880678;13938.233397163254;14253.073550219202;14303.356348964113;14472;14619.122852628876;9945.589905612911;10329.586816527255;10406.635767748396;10675;11310.717232069264;11361.375124367909;11387.601433949772;11476.827847582459;11599.362035088152;11721.589744358907 09:25:26 INFO - PROCESS | 13298 | __end_tp_report 09:25:26 INFO - PROCESS | 13298 | __start_cc_report 09:25:26 INFO - PROCESS | 13298 | _x_x_mozilla_cycle_collect,1908 09:25:26 INFO - PROCESS | 13298 | __end_cc_report 09:25:26 INFO - PROCESS | 13298 | __startTimestamp1481995526183__endTimestamp 09:25:26 INFO - PROCESS | 13298 | 09:25:26 INFO - PROCESS | 13298 | ------- Summary: start ------- 09:25:26 INFO - PROCESS | 13298 | Number of tests: 6 09:25:26 INFO - PROCESS | 13298 | 09:25:26 INFO - PROCESS | 13298 | [#0] dojo.html Cycles:165 Average:5216.98 Median:5434.43 stddev:590.79 (10.9%) stddev-sans-first:565.14 09:25:26 INFO - PROCESS | 13298 | Values: 2947.8 2973.7 2981.2 3002.3 3024.7 5149.8 5191.8 5207.2 5233.8 5268.9 5229.4 5231.6 5250.6 5278.7 5302.3 4696.7 4697.6 4737.4 4810.1 4821.8 4750.6 4825.3 4865.2 4883.0 4898.8 4822.1 4858.9 4882.4 4890.8 4923.5 4721.6 4761.4 4766.8 4772.1 4779.0 4728.1 4731.4 4734.3 4739.1 4746.0 5120.4 5193.4 5195.0 5201.2 5210.0 5533.7 5621.8 5643.1 5661.4 5683.4 5643.4 5664.1 5670.7 5671.9 5676.8 5230.8 5295.2 5298.5 5300.2 5345.8 5546.3 5569.0 5661.1 5670.1 5700.2 5532.8 5534.6 5535.7 5539.6 5576.3 5597.6 5602.9 5617.4 5620.4 5624.6 5475.3 5505.2 5508.9 5551.6 5650.8 5574.2 5668.4 5673.3 5712.7 5714.8 4332.4 4339.0 4339.5 4340.7 4378.3 3742.1 3772.3 3841.2 3844.3 3862.8 5280.6 5296.4 5303.0 5316.4 5411.5 5605.0 5643.8 5648.8 5651.2 5654.9 5317.3 5368.3 5377.9 5379.9 5421.9 4806.2 4842.2 4849.6 4905.1 4907.1 5679.1 5692.1 5720.7 5805.7 5818.7 5588.8 5604.0 5605.2 5607.2 5649.8 5694.2 5704.6 5753.3 5754.3 5761.7 5434.4 5467.5 5471.8 5483.7 5485.5 5651.7 5659.7 5661.3 5698.4 5716.7 5510.9 5517.6 5520.4 5520.7 5521.5 5412.1 5442.2 5444.2 5461.4 5584.1 5423.1 5424.7 5445.3 5455.5 5458.9 5531.9 5537.6 5538.5 5546.8 5547.1 5347.5 5383.5 5400.3 5430.0 5502.7 09:25:26 INFO - PROCESS | 13298 | 09:25:26 INFO - PROCESS | 13298 | [#1] ext.html Cycles:180 Average:52974.53 Median:18565.38 stddev:106268.90 (572.4%) stddev-sans-first:106494.09 09:25:26 INFO - PROCESS | 13298 | Values: 539.9 549.8 555.0 561.7 562.2 30924.4 39619.2 41437.8 41535.8 45055.8 42380.4 42993.4 43028.0 43032.6 43051.4 8447.2 8623.8 8625.7 8634.2 8638.0 7853.7 8019.4 9818.0 10032.7 10039.9 10232.5 10289.5 10289.9 10295.1 10298.7 10127.6 10173.6 10186.6 10197.9 10198.0 10016.2 10085.4 10089.5 10091.9 10093.3 39357.2 39601.8 39631.2 39680.6 39705.0 3255.0 3318.9 3378.1 3404.8 3491.9 29235.0 29515.0 29568.3 29839.0 30536.4 3926.7 3951.9 3997.0 4060.7 4161.4 299713.0 300267.0 300407.0 300553.0 300674.0 53111.7 53337.5 53451.0 53488.5 53506.0 56442.7 56707.0 56787.4 56805.0 56813.7 14297.7 14651.3 14718.5 14750.0 14752.7 10239.7 10511.7 11621.5 11754.6 11788.9 14131.8 14215.6 14250.0 15240.3 15544.9 5581.3 5682.8 5684.3 5831.7 5864.3 881.7 928.9 983.2 1049.0 1119.3 27904.6 29737.6 31196.5 31215.9 31766.8 1044.5 1049.2 1074.6 1091.4 1103.1 13937.8 14669.3 14754.3 15021.7 15070.3 458942.0 461854.0 462133.0 465056.0 692372.0 42185.0 42271.4 42336.6 42705.1 46587.8 1277.6 1285.2 1298.2 1313.4 1320.0 26777.2 27312.9 28014.4 28395.0 28460.6 43066.1 43445.0 43506.3 43540.3 43571.6 348322.0 349951.0 350600.0 350781.0 351116.0 23916.2 24361.3 24376.9 24384.1 24398.1 36227.8 38277.2 39347.0 39434.8 40187.4 33752.7 34156.8 34194.0 34304.7 34481.7 33633.2 33688.0 33721.5 34081.3 34309.7 34136.8 34664.8 34726.8 34774.5 34851.7 28977.0 31307.2 31463.5 31538.4 31584.7 24331.4 24375.3 24414.0 24765.9 24852.9 09:25:26 INFO - PROCESS | 13298 | 09:25:26 INFO - PROCESS | 13298 | [#2] jquery.html Cycles:180 Average:28002.91 Median:20417.76 stddev:73859.13 (361.7%) stddev-sans-first:74037.14 09:25:26 INFO - PROCESS | 13298 | Values: 350.0 364.5 381.8 382.2 405.3 13996.2 16977.8 17196.9 17381.7 17808.2 17301.7 17636.6 17699.6 17842.1 17850.6 5215.9 5545.5 5568.0 5575.7 5578.7 4063.7 4234.3 4236.5 4270.0 5471.0 4243.2 4276.4 6167.8 6256.7 6268.7 6271.6 6274.2 6275.5 6284.9 6613.4 6622.5 6685.1 6777.1 6780.2 6784.3 24171.6 24561.6 24739.3 25115.5 25269.7 2320.5 2464.9 2471.0 2549.7 3041.9 14394.7 14594.3 14598.2 14733.6 15158.8 2016.7 2079.9 2093.1 2136.6 2136.9 67943.3 69340.0 74026.6 78409.2 88523.1 16275.6 16534.7 16652.3 16893.2 17032.6 29825.0 29833.3 29892.8 29914.4 30065.4 8894.8 9320.6 9467.3 9484.4 9740.6 7575.2 7645.2 7647.5 7760.8 7834.7 8367.3 8423.0 8467.5 8579.8 8727.3 2880.8 3170.8 3176.9 3433.4 3434.9 830.2 892.0 914.9 924.7 961.5 17087.7 18255.8 18417.0 18591.9 18675.2 861.9 947.1 975.1 982.3 984.1 9744.0 10166.8 10219.1 10244.0 10250.5 441331.0 447172.0 449433.0 450505.0 451592.0 83869.6 84686.6 85527.6 88533.5 92737.5 973.1 992.8 1009.1 1016.7 1017.9 15515.0 15923.5 15938.6 16072.8 16365.1 38960.8 39212.6 40147.2 40430.2 40848.4 57116.7 57292.7 59024.7 59503.0 60111.1 7232.8 7288.7 7391.2 7424.9 7591.5 9500.8 12405.9 12914.7 12944.0 13072.9 10523.7 10919.7 11002.4 11396.8 11445.2 5938.8 8304.9 10702.7 10965.7 11117.7 10693.9 11164.2 11183.8 11230.4 11341.1 7268.2 7397.1 7455.9 7474.5 7922.7 8597.8 10536.2 10763.4 10886.3 10978.8 09:25:26 INFO - PROCESS | 13298 | 09:25:26 INFO - PROCESS | 13298 | [#3] mootools.html Cycles:180 Average:5152.65 Median:4943.44 stddev:2855.26 (57.8%) stddev-sans-first:2849.26 09:25:26 INFO - PROCESS | 13298 | Values: 1389.7 1415.7 1507.3 1624.8 1697.1 7619.2 8011.3 8016.8 8019.5 8021.8 7087.6 7262.8 7552.4 7741.7 7925.9 2113.2 2143.5 2148.9 2148.9 2153.8 2127.2 2159.7 2188.6 2188.7 2190.3 1920.3 1987.2 2102.4 2162.8 2173.4 2150.1 2156.8 2179.7 2180.1 2180.1 2134.6 2166.3 2172.8 2174.0 2207.4 8018.8 8090.8 8114.7 8124.1 8134.1 4760.9 4868.5 4884.5 4899.7 4900.5 3016.8 3157.6 3338.4 3342.3 3348.2 1010.0 1013.6 1022.4 1064.9 1083.3 10269.6 10387.2 10397.0 10412.9 10413.6 3970.4 4089.4 4130.7 4146.6 4158.4 8555.7 8568.2 8570.0 8571.4 8584.4 4819.1 4824.6 4825.4 4827.6 4828.2 4460.6 4525.7 4537.1 4576.2 4583.1 3371.4 3410.4 3414.6 3446.3 3492.0 1031.2 1032.9 1039.6 1039.9 1056.3 611.4 764.7 845.9 868.5 898.3 5008.8 5014.6 5099.7 5206.1 5267.2 878.6 881.5 893.5 896.7 906.4 3259.6 3494.4 3505.2 3523.8 3573.4 9319.6 9789.9 9810.1 9834.4 9843.5 9529.7 9739.5 9744.6 9754.5 9765.4 7407.1 7423.4 7514.7 7520.4 7546.2 4903.5 4983.4 4987.1 5086.8 5209.3 8387.8 8564.9 8590.1 8704.7 8734.1 8598.5 8707.6 8741.5 8749.0 8872.8 7043.8 7070.0 7152.9 7232.7 7243.5 7520.4 7601.2 7641.0 7655.9 7664.5 6932.7 6934.3 6962.8 6997.9 7247.3 6834.0 6853.0 6906.0 6912.3 6928.1 5994.0 6215.7 6269.9 6332.9 6415.2 4448.5 4566.8 4584.1 4619.7 4704.0 4510.3 4616.5 4632.1 4676.0 4728.4 09:25:26 INFO - PROCESS | 13298 | 09:25:26 INFO - PROCESS | 13298 | [#4] prototype.html Cycles:180 Average:4566.25 Median:5334.25 stddev:1362.75 (25.5%) stddev-sans-first:1328.65 09:25:26 INFO - PROCESS | 13298 | Values: 313.2 315.6 320.4 322.6 325.2 5237.8 5283.4 5307.7 5322.7 5333.7 5017.2 5250.1 5255.4 5257.3 5257.4 3951.3 3997.3 4000.8 4040.4 4078.8 4033.3 4041.8 4056.9 4060.8 4071.5 3903.5 4034.8 4053.6 4057.9 4077.6 3967.7 4013.0 4039.4 4054.3 4078.7 3558.5 3573.2 3573.8 3577.9 3596.0 5160.6 5181.8 5186.3 5195.9 5201.2 4460.4 4525.6 4585.3 4599.8 4645.4 5425.8 5426.9 5449.3 5458.5 5468.7 3883.5 3884.2 3894.0 3901.9 3904.8 5539.4 5631.3 5688.0 5710.3 5733.3 3944.7 3955.5 3956.6 3962.8 3963.1 4010.6 4016.5 4018.3 4023.4 4023.5 4276.4 4480.6 4649.7 4653.7 4658.7 5484.5 5496.3 5497.0 5508.2 5510.2 1285.7 1296.5 1297.5 1300.9 1306.6 835.7 842.8 865.9 875.9 880.4 5251.3 5404.3 5426.8 5448.5 5465.6 5617.0 5618.2 5642.6 5685.6 5694.7 5167.8 5350.8 5368.8 5369.5 5395.6 2909.8 2921.6 2922.2 2927.9 2944.4 5601.6 5610.6 5638.7 5661.2 5670.6 5330.8 5543.4 5547.0 5550.4 5599.7 5624.0 5649.4 5663.5 5679.9 5692.4 5325.7 5516.6 5520.5 5554.4 5575.0 5342.2 5360.2 5503.6 5511.4 5538.9 5530.4 5574.3 5710.0 5771.2 5793.2 3461.9 3665.8 3700.3 3765.4 3765.6 5444.8 5481.8 5502.4 5513.5 5517.0 5390.5 5419.9 5423.0 5448.0 5449.8 5115.4 5385.4 5427.2 5434.3 5434.3 5331.0 5346.7 5351.3 5370.8 5383.8 5334.8 5379.8 5501.5 5504.7 5518.4 5403.0 5409.8 5444.4 5463.4 5478.6 09:25:26 INFO - PROCESS | 13298 | 09:25:26 INFO - PROCESS | 13298 | [#5] yui.html Cycles:180 Average:17702.42 Median:4535.72 stddev:22564.94 (497.5%) stddev-sans-first:22592.14 09:25:26 INFO - PROCESS | 13298 | Values: 705.0 737.9 738.9 740.3 761.7 14749.2 15963.9 15987.8 16142.7 16153.1 14823.7 14993.6 15004.0 15004.2 15038.0 668.1 685.6 779.4 785.5 803.2 790.8 791.2 791.3 791.6 803.1 853.3 854.3 854.4 854.5 855.2 711.6 731.9 822.0 853.9 854.1 608.1 608.8 609.7 610.6 614.5 15952.6 16026.5 16051.8 16072.1 16076.8 14177.4 14280.4 14787.6 14839.0 15004.0 12201.8 12448.3 12514.3 12537.2 12806.9 4315.2 4395.0 4589.8 4618.4 4619.9 81681.0 82525.0 82721.6 82886.6 83700.6 11323.8 11359.5 11493.5 11542.7 12302.1 22340.0 22559.8 22618.0 22816.5 22837.3 7976.5 8000.5 8018.9 8156.1 8324.6 4377.4 4447.6 4465.5 4473.8 4481.7 3190.5 3267.7 3272.3 3289.5 3307.0 548.1 549.4 552.6 556.9 562.0 548.0 551.2 567.8 666.8 680.2 8306.0 8993.9 9090.6 9153.2 9318.3 570.1 676.5 689.9 701.2 710.8 4093.6 4127.6 4261.2 4297.5 4337.2 73570.6 74620.6 77573.6 84072.0 85333.6 65852.0 65852.3 65860.3 66049.0 66833.7 58454.1 59491.4 61191.4 62263.7 62730.7 9257.3 9365.3 9631.1 9658.8 9677.8 39624.6 40775.8 40862.6 43592.3 44794.9 51110.0 56926.7 58614.7 59408.7 60065.7 12911.0 13964.9 14016.2 14272.8 14904.1 14599.9 14628.0 14771.7 14795.8 15116.2 13985.7 14253.6 14409.6 14415.8 14526.0 11910.0 12156.9 12567.7 12795.5 12803.8 13938.2 14253.1 14303.4 14472.0 14619.1 9945.6 10329.6 10406.6 10675.0 11310.7 11361.4 11387.6 11476.8 11599.4 11721.6 09:25:26 INFO - PROCESS | 13298 | -------- Summary: end -------- 09:25:26 INFO - PROCESS | 13298 | 09:25:26 INFO - TEST-INFO | 13298: exit 0 09:25:26 INFO - TEST-OK | dromaeo_css | took 1116387ms 09:25:26 INFO - TEST-START | kraken 09:25:26 INFO - operating with platform_type : linux_ 09:25:26 INFO - Initialising browser for kraken test... 09:25:26 INFO - TEST-INFO | started process 13603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpObs8ww/profile http://localhost:48782/getInfo.html) 09:25:30 INFO - PROCESS | 13603 | __metrics Screen width/height:1600/1200 09:25:30 INFO - PROCESS | 13603 | colorDepth:24 09:25:30 INFO - PROCESS | 13603 | Browser inner width/height: 1024/697 09:25:30 INFO - PROCESS | 13603 | __metrics 09:25:31 INFO - PROCESS | 13603 | 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:25:31 INFO - PROCESS | 13603 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:31 INFO - PROCESS | 13603 | console.error: PushService: 09:25:31 INFO - PROCESS | 13603 | stateChangeProcessEnqueue: Error transitioning state 09:25:31 INFO - PROCESS | 13603 | UnknownError 09:25:32 INFO - TEST-INFO | 13603: exit 0 09:25:32 INFO - Browser initialized. 09:25:32 INFO - Running cycle 1/1 for kraken test... 09:25:32 INFO - TEST-INFO | started process 13692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpObs8ww/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:44 INFO - PROCESS | 13692 | RSS: Main: 154689536 09:25:44 INFO - PROCESS | 13692 | 09:25:46 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:47 INFO - PROCESS | 13692 | RSS: Main: 208457728 09:25:47 INFO - PROCESS | 13692 | 09:25:50 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-dft) 09:25:50 INFO - PROCESS | 13692 | RSS: Main: 186953728 09:25:50 INFO - PROCESS | 13692 | 09:25:53 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-fft) 09:25:54 INFO - PROCESS | 13692 | RSS: Main: 268107776 09:25:54 INFO - PROCESS | 13692 | 09:25:56 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-oscillator) 09:25:57 INFO - PROCESS | 13692 | RSS: Main: 179113984 09:25:57 INFO - PROCESS | 13692 | 09:25:59 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48782/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:59 INFO - PROCESS | 13692 | RSS: Main: 183406592 09:25:59 INFO - PROCESS | 13692 | 09:26:03 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48782/tests/kraken/driver.html?testName=imaging-darkroom) 09:26:03 INFO - PROCESS | 13692 | RSS: Main: 222760960 09:26:03 INFO - PROCESS | 13692 | 09:26:07 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48782/tests/kraken/driver.html?testName=imaging-desaturate) 09:26:07 INFO - PROCESS | 13692 | RSS: Main: 223608832 09:26:07 INFO - PROCESS | 13692 | 09:26:10 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48782/tests/kraken/driver.html?testName=json-parse-financial) 09:26:10 INFO - PROCESS | 13692 | RSS: Main: 221179904 09:26:10 INFO - PROCESS | 13692 | 09:26:12 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48782/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:26:13 INFO - PROCESS | 13692 | RSS: Main: 183525376 09:26:13 INFO - PROCESS | 13692 | 09:26:14 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:26:15 INFO - PROCESS | 13692 | RSS: Main: 190951424 09:26:15 INFO - PROCESS | 13692 | 09:26:17 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:26:18 INFO - PROCESS | 13692 | RSS: Main: 199413760 09:26:18 INFO - PROCESS | 13692 | 09:26:20 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:21 INFO - PROCESS | 13692 | RSS: Main: 208928768 09:26:21 INFO - PROCESS | 13692 | 09:26:24 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:26:24 INFO - PROCESS | 13692 | RSS: Main: 204488704 09:26:24 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48782/tests/kraken/driver.html?testName=ai-astar) 09:26:26 INFO - PROCESS | 13692 | RSS: Main: 256143360 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | __start_tp_report 09:26:26 INFO - PROCESS | 13692 | _x_x_mozilla_page_load 09:26:26 INFO - PROCESS | 13692 | _x_x_mozilla_page_load_details 09:26:26 INFO - PROCESS | 13692 | |i|pagename|runs| 09:26:26 INFO - PROCESS | 13692 | |0;ai-astar;110;110;112;112;111;113;113;112;114;111 09:26:26 INFO - PROCESS | 13692 | |1;audio-beat-detection;147;121;122;163;121;120;120;117;147;119 09:26:26 INFO - PROCESS | 13692 | |2;audio-dft;160;162;160;160;159;160;161;159;160;161 09:26:26 INFO - PROCESS | 13692 | |3;audio-fft;75;75;75;111;76;76;76;75;94;76 09:26:26 INFO - PROCESS | 13692 | |4;audio-oscillator;83;84;108;83;83;85;95;84;85;110 09:26:26 INFO - PROCESS | 13692 | |5;imaging-gaussian-blur;127;127;127;126;127;127;127;128;128;127 09:26:26 INFO - PROCESS | 13692 | |6;imaging-darkroom;146;147;146;145;145;147;146;145;145;145 09:26:26 INFO - PROCESS | 13692 | |7;imaging-desaturate;95;95;95;95;96;96;96;95;96;96 09:26:26 INFO - PROCESS | 13692 | |8;json-parse-financial;54;52;53;54;54;55;53;54;54;55 09:26:26 INFO - PROCESS | 13692 | |9;json-stringify-tinderbox;64;63;64;64;64;64;63;63;63;63 09:26:26 INFO - PROCESS | 13692 | |10;stanford-crypto-aes;80;81;88;83;79;89;82;80;79;86 09:26:26 INFO - PROCESS | 13692 | |11;stanford-crypto-ccm;136;126;124;137;123;124;141;123;169;145 09:26:26 INFO - PROCESS | 13692 | |12;stanford-crypto-pbkdf2;166;170;169;167;176;168;165;163;165;168 09:26:26 INFO - PROCESS | 13692 | |13;stanford-crypto-sha256-iterative;67;63;63;64;63;63;63;62;70;61 09:26:26 INFO - PROCESS | 13692 | __end_tp_report 09:26:26 INFO - PROCESS | 13692 | __start_cc_report 09:26:26 INFO - PROCESS | 13692 | _x_x_mozilla_cycle_collect,1656 09:26:26 INFO - PROCESS | 13692 | __end_cc_report 09:26:26 INFO - PROCESS | 13692 | __startTimestamp1481995586868__endTimestamp 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | ------- Summary: start ------- 09:26:26 INFO - PROCESS | 13692 | Number of tests: 14 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.32 (1.2%) stddev-sans-first:1.22 09:26:26 INFO - PROCESS | 13692 | Values: 110.0 110.0 112.0 112.0 111.0 113.0 113.0 112.0 114.0 111.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:121.50 stddev:16.27 (13.4%) stddev-sans-first:16.01 09:26:26 INFO - PROCESS | 13692 | Values: 147.0 121.0 122.0 163.0 121.0 120.0 120.0 117.0 147.0 119.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 09:26:26 INFO - PROCESS | 13692 | Values: 160.0 162.0 160.0 160.0 159.0 160.0 161.0 159.0 160.0 161.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:12.08 (15.9%) stddev-sans-first:12.62 09:26:26 INFO - PROCESS | 13692 | Values: 75.0 75.0 75.0 111.0 76.0 76.0 76.0 75.0 94.0 76.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:84.00 stddev:10.64 (12.7%) stddev-sans-first:10.97 09:26:26 INFO - PROCESS | 13692 | Values: 83.0 84.0 108.0 83.0 83.0 85.0 95.0 84.0 85.0 110.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#5] imaging-gaussian-blur Cycles:10 Average:127.10 Median:127.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 09:26:26 INFO - PROCESS | 13692 | Values: 127.0 127.0 127.0 126.0 127.0 127.0 127.0 128.0 128.0 127.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 09:26:26 INFO - PROCESS | 13692 | Values: 146.0 147.0 146.0 145.0 145.0 147.0 146.0 145.0 145.0 145.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:26:26 INFO - PROCESS | 13692 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 09:26:26 INFO - PROCESS | 13692 | Values: 54.0 52.0 53.0 54.0 54.0 55.0 53.0 54.0 54.0 55.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 09:26:26 INFO - PROCESS | 13692 | Values: 64.0 63.0 64.0 64.0 64.0 64.0 63.0 63.0 63.0 63.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:3.71 (4.5%) stddev-sans-first:3.81 09:26:26 INFO - PROCESS | 13692 | Values: 80.0 81.0 88.0 83.0 79.0 89.0 82.0 80.0 79.0 86.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:136.50 stddev:14.56 (10.7%) stddev-sans-first:15.44 09:26:26 INFO - PROCESS | 13692 | Values: 136.0 126.0 124.0 137.0 123.0 124.0 141.0 123.0 169.0 145.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.00 stddev:3.59 (2.1%) stddev-sans-first:3.76 09:26:26 INFO - PROCESS | 13692 | Values: 166.0 170.0 169.0 167.0 176.0 168.0 165.0 163.0 165.0 168.0 09:26:26 INFO - PROCESS | 13692 | 09:26:26 INFO - PROCESS | 13692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.00 stddev:2.64 (4.2%) stddev-sans-first:2.55 09:26:26 INFO - PROCESS | 13692 | Values: 67.0 63.0 63.0 64.0 63.0 63.0 63.0 62.0 70.0 61.0 09:26:26 INFO - PROCESS | 13692 | -------- Summary: end -------- 09:26:26 INFO - PROCESS | 13692 | 09:26:27 INFO - TEST-INFO | 13692: exit 0 09:26:27 INFO - TEST-OK | kraken | took 60873ms 09:26:27 INFO - SUITE-END | took 1177s 09:26:28 INFO - Completed test suite (00:19:37) 09:26:28 INFO - javascript benchmark 09:26:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2947.8083924544903, 2973.7026297370257, 2981.2248815308026, 3002.339485313233, 3024.6824083471233, 5149.76826042828, 5191.792328306863, 5207.218917162428, 5233.816816411427, 5268.947310526898, 5229.372475302959, 5231.555317797992, 5250.579953603712, 5278.683279003262, 5302.3106996090455, 4696.694714843541, 4697.600703940169, 4737.431508219019, 4810.086083644105, 4821.807127714887, 4750.643701722367, 4825.300331451937, 4865.221564549673, 4883.047805677894, 4898.755062246892, 4822.132016237076, 4858.927116093261, 4882.365292511969, 4890.828820991266, 4923.532264434873, 4721.645876559238, 4761.40482439695, 4766.833160839354, 4772.069446457942, 4779.044191161747, 4728.148933192058, 4731.432228132611, 4734.337192793012, 4739.052189562101, 4746.02706445178, 5120.411152717448, 5193.350831146106, 5195.038917800219, 5201.24581935621, 5210.0, 5533.6956467394275, 5621.80323688669, 5643.068893632546, 5661.377248502661, 5683.431656834325, 5643.407442218549, 5664.0937450007805, 5670.68811215383, 5671.914921276184, 5676.772929082832, 5230.764615592231, 5295.232191332235, 5298.523132918056, 5300.204969254604, 5345.81289654868, 5546.27898373217, 5569.0254205513875, 5661.065924122556, 5670.149477578396, 5700.230468886647, 5532.75102620383, 5534.584906132056, 5535.723213839292, 5539.639923404966, 5576.330840299109, 5597.608167428322, 5602.915956260659, 5617.38208797032, 5620.437956204347, 5624.606277560613, 5475.260839786578, 5505.229267902497, 5508.944910550923, 5551.555875529948, 5650.830475085754, 5574.163875418639, 5668.433156684381, 5673.319201695823, 5712.65724056558, 5714.771409143587, 4332.4367832181615, 4338.956610433918, 4339.479262488521, 4340.739555626673, 4378.2994720845145, 3742.0644838790304, 3772.2832661794173, 3841.2317536492815, 3844.3464611016193, 3862.806859657006, 5280.6303558750515, 5296.443873393316, 5302.973485132549, 5316.362036555638, 5411.485908838733, 5605.0, 5643.774249030075, 5648.802291919763, 5651.15232715096, 5654.915176272277, 5317.335333083364, 5368.32895888014, 5377.946220537823, 5379.865503362447, 5421.918671219935, 4806.158922188673, 4842.176829938919, 4849.563539281482, 4905.068037072945, 4907.092187945242, 5679.119736440858, 5692.117721753135, 5720.685362305113, 5805.651660900359, 5818.679972601548, 5588.804391846266, 5604.0, 5605.159226115952, 5607.243022192115, 5649.802256920988, 5694.231278777312, 5704.629199102045, 5753.280839895013, 5754.2519472469985, 5761.740721667619, 5434.429384914527, 5467.4532546745, 5471.8084867029465, 5483.698396588066, 5485.533729633026, 5651.745671444713, 5659.6887171204335, 5661.348944871393, 5698.373178950395, 5716.742746576498, 5510.944890551204, 5517.558595312285, 5520.420355862737, 5520.66875987442, 5521.475459831309, 5412.107002344569, 5442.2108794225405, 5444.183372493999, 5461.399246083007, 5584.050711379156, 5423.132298832168, 5424.674519528841, 5445.319335083114, 5455.454454554513, 5458.918116228339, 5531.8893622126525, 5537.5569954402745, 5538.47384498472, 5546.805861794818, 5547.11246200606, 5347.51872331492, 5383.515483606494, 5400.324959380077, 5430.0, 5502.697351645538], "value": 5176.507998074675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.8515408262729, 549.8103154411726, 555.0370107862857, 561.668615516845, 562.2269379603046, 30924.38151236974, 39619.20761584766, 41437.792811035906, 41535.79232103835, 45055.77472112635, 42380.364294535604, 42993.35509967353, 43028.0, 43032.569674303246, 43051.3542296865, 8447.197516235963, 8623.784405389853, 8625.698100566482, 8634.179752923494, 8638.049814520398, 7853.685852565891, 8019.438639295252, 9817.950910245474, 10032.69901902944, 10039.949800250988, 10232.488375581228, 10289.536970836292, 10289.897101028968, 10295.073443390093, 10298.691039268797, 10127.645532406368, 10173.643922462677, 10186.59253629854, 10197.949010254939, 10198.0, 10016.198704103654, 10085.394876307446, 10089.495525223709, 10091.89908100917, 10093.293469457067, 39357.21285574301, 39601.80199098986, 39631.20737585261, 39680.60319396798, 39705.0, 3254.96745032549, 3318.933621327584, 3378.1048022274117, 3404.8467818948207, 3491.895243142684, 29235.0, 29515.0, 29568.26079348012, 29839.0, 30536.404405625548, 3926.70549708773, 3951.920961580781, 3996.9600303997167, 4060.6548443382053, 4161.396597493346, 299713.0, 300267.0, 300407.0, 300553.0, 300674.0, 53111.73444132755, 53337.466625334026, 53451.0, 53488.46511534913, 53506.0, 56442.717786411624, 56707.0, 56787.43212567904, 56805.0, 56813.715931420076, 14297.714045719027, 14651.267436628126, 14718.484853030093, 14750.04124731889, 14752.680646854373, 10239.692809215736, 10511.684649460529, 11621.53513859453, 11754.647360579196, 11788.941055294668, 14131.78802317966, 14215.573532794033, 14250.0, 15240.314185861664, 15544.922275388777, 5581.302337207849, 5682.829515114553, 5684.261046064068, 5831.679257640785, 5864.32560255576, 881.6517475597103, 928.8513837786057, 983.2183414185739, 1048.9580416783242, 1119.2780656476527, 27904.581431278548, 29737.553936690965, 31196.532052019236, 31215.90744323983, 31766.841165794023, 1044.5090807320548, 1049.2393015064017, 1074.6453670288786, 1091.3942761767137, 1103.0568863621488, 13937.790933136012, 14669.286182056141, 14754.262286885612, 15021.699566008838, 15070.321835517429, 458942.0, 461854.0, 462133.0, 465056.0, 692372.0, 42185.0, 42271.365929511085, 42336.576634233264, 42705.145897081886, 46587.8070973614, 1277.5720133755297, 1285.1774864086992, 1298.1691717300935, 1313.3761463304854, 1319.967000824968, 26777.19668409951, 27312.863435682695, 28014.43971120607, 28395.0, 28460.573091403232, 43066.1386772269, 43445.0, 43506.34740478959, 43540.346894797236, 43571.56428435675, 348322.0, 349951.0, 350600.0, 350781.0, 351116.0, 23916.16293429791, 24361.26916192517, 24376.87811560931, 24384.146554870495, 24398.146064887645, 36227.81886090553, 38277.23445531129, 39347.0, 39434.80282598684, 40187.39718904277, 33752.66247337495, 34156.82921585376, 34194.0, 34304.65695343114, 34481.65518344885, 33633.15917102092, 33687.98936031923, 33721.49417758785, 34081.31837363289, 34309.656903430645, 34136.82931585426, 34664.82667586646, 34726.82636586902, 34774.47838282377, 34851.65148348484, 28977.0, 31307.217319567193, 31463.528047078853, 31538.369232615678, 31584.684153158174, 24331.39171520726, 24375.26874193777, 24414.0, 24765.87617061903, 24852.875735621205], "value": 18255.476167184526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9650034996499, 364.4809365575369, 381.7881076002818, 382.2050135717707, 405.32715691951364, 13996.160230386184, 16977.83022169778, 17196.91401542992, 17381.65236695267, 17808.1986310616, 17301.653966920654, 17636.64726705465, 17699.55751106223, 17842.10789460525, 17850.64298714025, 5215.921761173586, 5545.473180047889, 5568.0, 5575.749091290902, 5578.721063946807, 4063.674906007527, 4234.259004674185, 4236.4704411948505, 4269.996550810557, 5471.042567550682, 4243.151369726067, 4276.3963513682365, 6167.845803854894, 6256.749730010794, 6268.686565671721, 6271.560990730651, 6274.184356033732, 6275.497960163176, 6284.87430251397, 6613.404793568554, 6622.503312251552, 6685.13093297873, 6777.118974533329, 6780.220274668427, 6784.321567843176, 24171.637425438632, 24561.631575526382, 24739.25782226536, 25115.497690046097, 25269.747302527107, 2320.477892474197, 2464.864432456214, 2470.987645061781, 2549.668543089405, 3041.874506432634, 14394.712105757932, 14594.27028648574, 14598.197099159543, 14733.631659208606, 15158.848411515854, 2016.7277417548737, 2079.949625439159, 2093.1418118571314, 2136.5513242219154, 2136.871787692728, 67943.3205667942, 69340.0, 74026.62986685032, 78409.21590784076, 88523.11476885277, 16275.593110172103, 16534.66930661404, 16652.250648720594, 16893.239804208595, 17032.57418564521, 29825.0, 29833.254168645522, 29892.804287828243, 29914.401711966075, 30065.398692026036, 8894.777630559158, 9320.627174913063, 9467.337286389886, 9484.352667193025, 9740.561674724655, 7575.24247575238, 7645.15903250642, 7647.541147531166, 7760.844783104306, 7834.725784597512, 8367.330613550901, 8423.0, 8467.534285614227, 8579.785505362292, 8727.345449091217, 2880.7551358134792, 3170.7621928355466, 3176.8729250829706, 3433.3819912415506, 3434.8797792077157, 830.2486249943811, 892.0410558649478, 914.9176574108229, 924.7272054743867, 961.5240455974338, 17087.658246835243, 18255.81744182568, 18417.0, 18591.90704046471, 18675.15961781723, 861.8842882977989, 947.1144479911305, 975.1077763846143, 982.2633025231077, 984.0749695286407, 9744.0, 10166.796664066676, 10219.13137383316, 10244.0, 10250.487475626189, 441331.0, 447172.0, 449433.0, 450505.0, 451592.0, 83869.58065209757, 84686.57656711678, 85527.57236213778, 88533.51378515996, 92737.536312318, 973.0998826085843, 992.8361820299714, 1009.1018993096151, 1016.6949915025463, 1017.8931212222758, 15515.0, 15923.52229433119, 15938.60153496172, 16072.758908616614, 16365.10669120817, 38960.80519597384, 39212.60787392204, 40147.19705605813, 40430.1913961725, 40848.387274191504, 57116.714416427654, 57292.71353643205, 59024.70487647534, 59503.0, 60111.09833352591, 7232.819179520554, 7288.672009759467, 7391.2239214881665, 7424.888626670496, 7591.506552074097, 9500.762480938032, 12405.875941240833, 12914.741705165656, 12944.0, 13072.869271307165, 10523.736906577396, 10919.672409827717, 11002.449877506253, 11396.829047564128, 11445.198836081394, 5938.792142275, 8304.920360353115, 10702.678919632424, 10965.671029869116, 11117.722056948642, 10693.9465302673, 11164.218504704593, 11183.832242516532, 11230.382328971986, 11341.092712583139, 7268.236835132235, 7397.112346518452, 7455.850882982201, 7474.476786624884, 7922.7227047053075, 8597.828043439222, 10536.157107431234, 10763.3541987481, 10886.346819190874, 10978.780424391307], "value": 9524.769519633088, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.7290028444454, 1415.6673181802275, 1507.2991059157496, 1624.8131464881542, 1697.058132736331, 7619.238076192378, 8011.319037881773, 8016.799580010495, 8019.5188288702575, 8021.839563208732, 7087.610181440019, 7262.818429539264, 7552.395808335334, 7741.651625676844, 7925.920740792591, 2113.2497963223063, 2143.47484866208, 2148.9355319340366, 2148.946276343096, 2153.849230553862, 2127.2235633993637, 2159.730033745782, 2188.5951099046647, 2188.6935828983956, 2190.3100523335097, 1920.2606996306383, 1987.1951859496855, 2102.379797959598, 2162.7837216278404, 2173.402314363555, 2150.064721846002, 2156.816670583002, 2179.705739725133, 2180.1170525937023, 2180.1170525937023, 2134.562414704997, 2166.2959538150008, 2172.750133734625, 2173.9891300543554, 2207.415035015722, 8018.839623207561, 8090.797730056795, 8114.715984940558, 8124.106348301682, 8134.064582572962, 4760.880977975544, 4868.537488938545, 4884.487128851455, 4899.706017638953, 4900.485449027837, 3016.788824782266, 3157.605299337583, 3338.432466480704, 3342.348242092793, 3348.196432856121, 1009.9697009089739, 1013.5844303835393, 1022.3610243597751, 1064.893510648929, 1083.2742062817852, 10269.589216431334, 10387.169026477864, 10397.0, 10412.94793526035, 10413.635522756744, 3970.404439334123, 4089.386592011222, 4130.690198235145, 4146.564610715892, 4158.355454904495, 8555.743327700178, 8568.186022327869, 8570.0, 8571.357148213909, 8584.442011269248, 4819.132556139858, 4824.614030877521, 4825.445073816486, 4827.565519103297, 4828.227483602606, 4460.620847227957, 4525.728456292633, 4537.137943790735, 4576.199165146086, 4583.129205450954, 3371.443711787577, 3410.3861304965344, 3414.607320158164, 3446.276281980762, 3492.039689085522, 1031.185363562792, 1032.9380237185642, 1039.589362201926, 1039.896010398969, 1056.3186744549876, 611.4222060153113, 764.7125658872957, 845.8688903220011, 868.4572142410993, 898.2589363774912, 5008.84973450797, 5014.598832093424, 5099.719515426613, 5206.140986737146, 5267.236250743697, 878.5958459108754, 881.5278484930182, 893.4817805672694, 896.6547879066607, 906.40177482861, 3259.576255086871, 3494.423420135649, 3505.158761897126, 3523.788572685647, 3573.3925232710503, 9319.580618872167, 9789.853152202722, 9810.068043535854, 9834.360766550151, 9843.458609776531, 9529.666461673809, 9739.464329461947, 9744.610215591298, 9754.46350450718, 9765.365251258645, 7407.148177959496, 7423.44324175689, 7514.699412023567, 7520.360769334558, 7546.169921308542, 4903.53416425439, 4983.352164218629, 4987.147550094798, 5086.847394578169, 5209.270702101633, 8387.83224335522, 8564.871526926976, 8590.09803970599, 8704.738857834274, 8734.126587341216, 8598.527081010605, 8707.608157632794, 8741.475511469333, 8749.0, 8872.778180545538, 7043.7534686285735, 7070.010198572101, 7152.925651560989, 7232.74685386009, 7243.529170603894, 7520.435967302584, 7601.239876012354, 7641.0, 7655.885161722467, 7664.501807382502, 6932.688029038806, 6934.271901450476, 6962.825929351807, 6997.895031574429, 7247.311505406978, 6834.043233947351, 6853.0405743195, 6905.965470172617, 6912.274211207952, 6928.064711263914, 5993.9700301498215, 6215.689215539114, 6269.937300626935, 6332.936670633235, 6415.166028416276, 4448.4884238311715, 4566.794494247833, 4584.106099310602, 4619.69971951822, 4704.0, 4510.345999830072, 4616.469106052713, 4632.096741135446, 4675.976620116878, 4728.432588089451], "value": 4153.698599082239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.1607292456217, 315.5708236797954, 320.36727463260064, 322.6209204185082, 325.1886543075028, 5237.764300606473, 5283.392409872856, 5307.65500242484, 5322.707251101193, 5333.706646134461, 5017.2474128880685, 5250.133727934886, 5255.369355677324, 5257.316548848645, 5257.421683614799, 3951.308521008826, 3997.2605068062358, 4000.7799571023584, 4040.393940908858, 4078.7552746835136, 4033.3143365627916, 4041.7979101044975, 4056.9391459128137, 4060.7563546187325, 4071.531773846016, 3903.453516507677, 4034.7579145251234, 4053.6351728344443, 4057.9391309130388, 4077.55146933837, 3967.7420967637013, 4012.9799351003203, 4039.3738970459626, 4054.2904991626347, 4078.653314468274, 3558.5195998540125, 3573.249617580311, 3573.767705099186, 3577.94633080504, 3595.964040359589, 5160.612954028463, 5181.792728290864, 5186.299849520305, 5195.870103247411, 5201.219817027439, 4460.420145381112, 4525.615322697575, 4585.266357382836, 4599.816007359702, 4645.372874661911, 5425.755840987125, 5426.8914621707345, 5449.3460784706085, 5458.4541545845495, 5468.699221542814, 3883.4951456310782, 3884.2231553689094, 3893.980530097331, 3901.902452438683, 3904.8438062477467, 5539.446055394428, 5631.267935168443, 5687.971560142256, 5710.2576665033275, 5733.340665823442, 3944.6923549723733, 3955.5253369595835, 3956.624120708528, 3962.821673024721, 3963.147923196527, 4010.6189911958318, 4016.5180178378196, 4018.2566225248424, 4023.396490526386, 4023.456833327522, 4276.422682937826, 4480.574345437179, 4649.698084536335, 4653.744044077541, 4658.67389282747, 5484.451554844483, 5496.340439147328, 5497.0, 5508.20131080999, 5510.201020851954, 1285.7207078956499, 1296.5267677297718, 1297.4550688710765, 1300.9284489352988, 1306.5949555637783, 835.6991483066091, 842.7990114087401, 865.8831057807241, 875.9211670949518, 880.4277219807049, 5251.291075704731, 5404.32445944257, 5426.810061647823, 5448.536874365724, 5465.617406781487, 5616.971915140398, 5618.230257468884, 5642.576806739511, 5685.602007859493, 5694.715264236772, 5167.767450464738, 5350.839474815762, 5368.8389348319615, 5369.543588794918, 5395.62230643859, 2909.7526710229445, 2921.6055832462343, 2922.225610213295, 2927.8919178192095, 2944.440556294297, 5601.607887447921, 5610.607257492018, 5638.661680299113, 5661.179129026268, 5670.603057785998, 5330.840074797762, 5543.445655434424, 5546.972265138729, 5550.417206193372, 5599.692016939108, 5623.963059947582, 5649.406812284733, 5663.46197111282, 5679.886402271932, 5692.373838877803, 5325.707086110301, 5516.613837031369, 5520.475554822286, 5554.444555544414, 5575.0, 5342.225377320345, 5360.249565060816, 5503.569072041379, 5511.448855114457, 5538.861528461821, 5530.446955304437, 5574.331080270232, 5709.971450142889, 5771.220885180447, 5793.188953546422, 3461.913452163615, 3665.7983810890655, 3700.3154416433044, 3765.4163604641326, 3765.6046115157515, 5444.8094316698725, 5481.808136715196, 5502.394736578893, 5513.5037846594, 5516.972415137899, 5390.4879036491475, 5419.945800542102, 5423.0, 5448.019356515865, 5449.782008719607, 5115.360579927509, 5385.4076051635075, 5427.213054107211, 5434.266374039454, 5434.2935418395355, 5330.9733451332495, 5346.732663366894, 5351.3043304370185, 5370.758315875873, 5383.81156659515, 5334.786608535615, 5379.799019583342, 5501.5323697486165, 5504.724763761716, 5518.420565840529, 5403.0, 5409.83770486886, 5444.401115877171, 5463.399026107046, 5478.589105817], "value": 4122.009912249243, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.0, 737.9262073792621, 738.9298016688413, 740.2825444967674, 761.7181642792166, 14749.188794616291, 15963.92018039911, 15987.84012159878, 16142.67714645708, 16153.111578863172, 14823.703525929503, 14993.550193494213, 15004.0, 15004.174770387624, 15038.0, 668.0747165176217, 685.5920727167328, 779.4388040610779, 785.4815821557773, 803.1927912447982, 790.8102055506665, 791.2285521616435, 791.3313250303513, 791.5765065689857, 803.1286054630733, 853.3471894001094, 854.2525290370926, 854.406187699549, 854.4958474500044, 855.2388374346837, 711.5943911970205, 731.8755811512002, 821.979450513736, 853.8676505141682, 854.133054949227, 608.0666177417687, 608.8447445901311, 609.7225762278152, 610.5909040942535, 614.5268143529502, 15952.601184970352, 16026.519204423887, 16051.839481605151, 16072.116033618146, 16076.75884861728, 14177.362018709182, 14280.357383917748, 14787.630309242248, 14839.03546269489, 15004.0, 12201.755964880742, 12448.315342656151, 12514.31171285579, 12537.247765134121, 12806.871931280753, 4315.158544083905, 4394.956050439487, 4589.770511474447, 4618.445786505641, 4619.930701039487, 81681.0, 82525.0, 82721.58639206826, 82886.58556707238, 83700.58149709273, 11323.830142547868, 11359.545618175345, 11493.54025838957, 11542.711432214262, 12302.138850280573, 22340.0, 22559.774402256095, 22618.0, 22816.543669126524, 22837.314880553276, 7976.521408715495, 8000.479968802009, 8018.914982342105, 8156.1028286888395, 8324.62539185738, 4377.409049778239, 4447.555244475527, 4465.531119232499, 4473.843415480443, 4481.663875209372, 3190.457622204231, 3267.7059064683817, 3272.296456261915, 3289.506574013917, 3307.024427793807, 548.1120584652888, 549.4011527435115, 552.5689961829779, 556.910894256917, 561.9522340601095, 547.9807557942224, 551.1759918921239, 567.7558649780551, 666.8499587592753, 680.1667956752938, 8306.0, 8993.865092023625, 9090.590923408463, 9153.221976132103, 9318.347715659975, 570.0660780940963, 676.5027704637088, 689.8792711275607, 701.1586096684, 710.8258476673145, 4093.5906409358827, 4127.5666055064385, 4261.190373828963, 4297.527272000078, 4337.240982827992, 73570.63214684, 74620.62689686517, 77573.61213193898, 84072.0, 85333.57333213295, 65852.0, 65852.34147658559, 65860.34139658637, 66049.0, 66833.6658316715, 58454.12318815221, 59491.40508594945, 61191.38808611946, 62263.68868155812, 62730.68634656798, 9257.259419246579, 9365.250779937453, 9631.133198012212, 9658.75853103678, 9677.758056048655, 39624.603753963245, 40775.79612101921, 40862.59137408707, 43592.34611480767, 44794.93691135627, 51110.0, 56926.715366422904, 58614.70692646509, 59408.70295648494, 60065.69967150136, 12911.031672624404, 13964.860351396763, 14016.229107399191, 14272.785908211592, 14904.105753654816, 14599.92700036493, 14628.0, 14771.704565908836, 14795.778063329273, 15116.244187790786, 13985.720285594434, 14253.64365890861, 14409.567712968628, 14415.846305144501, 14526.0, 11910.010146600986, 12156.939215303866, 12567.748645026866, 12795.488180473048, 12803.807942880678, 13938.233397163254, 14253.073550219202, 14303.356348964113, 14472.0, 14619.122852628876, 9945.589905612911, 10329.586816527255, 10406.635767748396, 10675.0, 11310.717232069264, 11361.375124367909, 11387.601433949772, 11476.827847582459, 11599.362035088152, 11721.589744358907], "value": 7151.461130947151, "unit": "score"}], "name": "dromaeo_css", "value": 6924.341624666274, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 112.0, 112.0, 111.0, 113.0, 113.0, 112.0, 114.0, 111.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 122.0, 163.0, 121.0, 120.0, 120.0, 117.0, 147.0, 119.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 160.0, 159.0, 160.0, 161.0, 159.0, 160.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 111.0, 76.0, 76.0, 76.0, 75.0, 94.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 108.0, 83.0, 83.0, 85.0, 95.0, 84.0, 85.0, 110.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 126.0, 127.0, 127.0, 127.0, 128.0, 128.0, 127.0], "value": 127.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 54.0, 54.0, 55.0, 53.0, 54.0, 54.0, 55.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 88.0, 83.0, 79.0, 89.0, 82.0, 80.0, 79.0, 86.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 126.0, 124.0, 137.0, 123.0, 124.0, 141.0, 123.0, 169.0, 145.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 169.0, 167.0, 176.0, 168.0, 165.0, 163.0, 165.0, 168.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 62.0, 70.0, 61.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1507.3000000000002, "alertThreshold": 2.0}]} 09:26:28 INFO - Return code: 0 09:26:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:26:28 INFO - # TBPL SUCCESS # 09:26:28 INFO - Running post-action listener: _resource_record_post_action 09:26:28 INFO - [mozharness: 2016-12-17 17:26:28.192107Z] Finished run-tests step (success) 09:26:28 INFO - Running post-run listener: _resource_record_post_run 09:26:28 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 413577216; Read time: 12; Write time: 233216 09:26:28 INFO - TinderboxPrint: CPU usage
13.2% 09:26:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:26:28 INFO - TinderboxPrint: I/O write bytes / time
413,577,216 / 233,216 09:26:28 INFO - TinderboxPrint: CPU idle
8,281.8 (86.8%) 09:26:28 INFO - TinderboxPrint: CPU user
1,211.4 (12.7%) 09:26:28 INFO - TinderboxPrint: Swap in / out
0 / 0 09:26:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120754176; Read time: 0; Write time: 69444 09:26:28 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 292823040; Read time: 0; Write time: 163772 09:26:28 INFO - Running post-run listener: _upload_blobber_files 09:26:28 INFO - Blob upload gear active. 09:26:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:26:28 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 09:26:28 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:26:28 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:26:29 INFO - (blobuploader) - INFO - Open directory for files ... 09:26:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:26:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:26:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:30 INFO - (blobuploader) - INFO - Done attempting. 09:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:26:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:30 INFO - (blobuploader) - INFO - Done attempting. 09:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:34 INFO - (blobuploader) - INFO - Done attempting. 09:26:34 INFO - (blobuploader) - INFO - Iteration through files over. 09:26:34 INFO - Return code: 0 09:26:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:26:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:26:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2824618ee9de95d075a796e0a65cf5f9a4b7138ce57680398bf5d68999b2250e1fe4c84f48bf7af731f8b22954c4b1227968ca631f18ddbe40a6060e6ab83466", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddae968b829565f51b918ab3f10e72873529d6b258ac07b25901d2129e1fadfc603ddc2a709d70ccddc8dafcb6dd4cbf6146eac7d75407b87a77c48be887c641", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f596bf45ee625b1b71c7a643009731981b632cf0a3c0ba66bb43de070580cc57a6c18d47867f530576052035a108fca2d7116899646b8cea4734978da6c1e706"} 09:26:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:26:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:26:34 INFO - Contents: 09:26:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2824618ee9de95d075a796e0a65cf5f9a4b7138ce57680398bf5d68999b2250e1fe4c84f48bf7af731f8b22954c4b1227968ca631f18ddbe40a6060e6ab83466", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddae968b829565f51b918ab3f10e72873529d6b258ac07b25901d2129e1fadfc603ddc2a709d70ccddc8dafcb6dd4cbf6146eac7d75407b87a77c48be887c641", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f596bf45ee625b1b71c7a643009731981b632cf0a3c0ba66bb43de070580cc57a6c18d47867f530576052035a108fca2d7116899646b8cea4734978da6c1e706"} 09:26:34 INFO - Running post-run listener: copy_logs_to_upload_dir 09:26:34 INFO - Copying logs to upload dir... 09:26:34 INFO - mkdir: /builds/slave/test/build/upload/logs 09:26:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.733795 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-17 09:26:34.212550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 09:26:34.216075) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2824618ee9de95d075a796e0a65cf5f9a4b7138ce57680398bf5d68999b2250e1fe4c84f48bf7af731f8b22954c4b1227968ca631f18ddbe40a6060e6ab83466", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddae968b829565f51b918ab3f10e72873529d6b258ac07b25901d2129e1fadfc603ddc2a709d70ccddc8dafcb6dd4cbf6146eac7d75407b87a77c48be887c641", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f596bf45ee625b1b71c7a643009731981b632cf0a3c0ba66bb43de070580cc57a6c18d47867f530576052035a108fca2d7116899646b8cea4734978da6c1e706"} build_url:https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011695 build_url: 'https://queue.taskcluster.net/v1/task/Psf0GM3_SGKvrVgHu3szHg/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/Firefox/sha512/2824618ee9de95d075a796e0a65cf5f9a4b7138ce57680398bf5d68999b2250e1fe4c84f48bf7af731f8b22954c4b1227968ca631f18ddbe40a6060e6ab83466", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddae968b829565f51b918ab3f10e72873529d6b258ac07b25901d2129e1fadfc603ddc2a709d70ccddc8dafcb6dd4cbf6146eac7d75407b87a77c48be887c641", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f596bf45ee625b1b71c7a643009731981b632cf0a3c0ba66bb43de070580cc57a6c18d47867f530576052035a108fca2d7116899646b8cea4734978da6c1e706"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 09:26:34.242153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 09:26:34.242507) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1481992787.481840-2021841883 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-17 09:26:34.326021) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 09:26:34.326348) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 09:26:34.326667) ========= ========= Total master_lag: 0.17 =========