builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1465236467.66 results: success (0) buildid: 20160606053329 builduid: d7acf4330f0b47b6844d82d15649fe74 revision: 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:47.663210) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:47.663851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:47.664172) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:47.679004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:47.679342) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 11:07:47-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-06-06 11:07:47 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.067263 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:47.760875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:47.761231) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:47.813958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:47.814835) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 --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=78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 11:07:47,954 truncating revision to first 12 chars 2016-06-06 11:07:47,954 Setting DEBUG logging. 2016-06-06 11:07:47,954 attempt 1/10 2016-06-06 11:07:47,954 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5c8f37e61ac7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 11:07:48,504 unpacking tar archive at: mozilla-aurora-5c8f37e61ac7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.904235 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:48.734719) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:48.735084) ========= script_repo_revision: 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:48.735894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:48.736332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:07:48.747479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-06 11:07:48.747811) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:07:48 INFO - MultiFileLogger online at 20160606 11:07:48 in /builds/slave/test 11:07:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:07:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:07:48 INFO - {'append_to_log': False, 11:07:48 INFO - 'base_work_dir': '/builds/slave/test', 11:07:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:07:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:07:48 INFO - 'branch': 'Mozilla-Aurora', 11:07:48 INFO - 'buildbot_json_path': 'buildprops.json', 11:07:48 INFO - 'config_files': ('talos/linux_config.py',), 11:07:48 INFO - 'default_actions': ('clobber', 11:07:48 INFO - 'read-buildbot-config', 11:07:48 INFO - 'download-and-extract', 11:07:48 INFO - 'populate-webroot', 11:07:48 INFO - 'create-virtualenv', 11:07:48 INFO - 'install', 11:07:48 INFO - 'run-tests'), 11:07:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:07:48 INFO - 'download_minidump_stackwalk': True, 11:07:48 INFO - 'download_symbols': 'ondemand', 11:07:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:07:48 INFO - 'tooltool.py': '/tools/tooltool.py', 11:07:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:07:48 INFO - '/tools/misc-python/virtualenv.py')}, 11:07:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:07:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:07:48 INFO - 'installer_path': 'installer.exe', 11:07:48 INFO - 'log_level': 'info', 11:07:48 INFO - 'log_name': 'talos', 11:07:48 INFO - 'log_to_console': True, 11:07:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:07:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:07:48 INFO - 'opt_config_files': (), 11:07:48 INFO - 'pip_index': False, 11:07:48 INFO - 'sps_profile': False, 11:07:48 INFO - 'sps_profile_interval': 0, 11:07:48 INFO - 'suite': 'dromaeojs', 11:07:48 INFO - 'system_bits': '32', 11:07:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:07:48 INFO - 'title': 'talos-linux64-ix-019', 11:07:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:07:48 INFO - 'use_talos_json': True, 11:07:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:07:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:07:48 INFO - 'work_dir': 'build'} 11:07:48 INFO - ##### 11:07:48 INFO - ##### Running clobber step. 11:07:48 INFO - ##### 11:07:48 INFO - Running pre-action listener: _resource_record_pre_action 11:07:48 INFO - Running main action method: clobber 11:07:48 INFO - rmtree: /builds/slave/test/build 11:07:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:07:49 INFO - Running post-action listener: _resource_record_post_action 11:07:49 INFO - ##### 11:07:49 INFO - ##### Running read-buildbot-config step. 11:07:49 INFO - ##### 11:07:49 INFO - Running pre-action listener: _resource_record_pre_action 11:07:49 INFO - Running main action method: read_buildbot_config 11:07:49 INFO - Using buildbot properties: 11:07:49 INFO - { 11:07:49 INFO - "project": "", 11:07:49 INFO - "product": "firefox", 11:07:49 INFO - "script_repo_revision": "production", 11:07:49 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:07:49 INFO - "repository": "", 11:07:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:07:49 INFO - "buildid": "20160606053329", 11:07:49 INFO - "pgo_build": "True", 11:07:49 INFO - "basedir": "/builds/slave/test", 11:07:49 INFO - "buildnumber": 366, 11:07:49 INFO - "slavename": "talos-linux64-ix-019", 11:07:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:07:49 INFO - "platform": "ubuntu64_hw", 11:07:49 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:07:49 INFO - "branch": "mozilla-aurora", 11:07:49 INFO - "repo_path": "releases/mozilla-aurora", 11:07:49 INFO - "revision": "5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64", 11:07:49 INFO - "stage_platform": "linux64-pgo", 11:07:49 INFO - "builduid": "d7acf4330f0b47b6844d82d15649fe74", 11:07:49 INFO - "slavebuilddir": "test" 11:07:49 INFO - } 11:07:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 11:07:49 INFO - Running post-action listener: _resource_record_post_action 11:07:49 INFO - ##### 11:07:49 INFO - ##### Running download-and-extract step. 11:07:49 INFO - ##### 11:07:49 INFO - Running pre-action listener: _resource_record_pre_action 11:07:49 INFO - Running main action method: download_and_extract 11:07:49 INFO - mkdir: /builds/slave/test/build/tests 11:07:49 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:49 INFO - https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:07:51 INFO - Downloaded 1361 bytes. 11:07:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:07:51 INFO - Using the following test package requirements: 11:07:51 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 11:07:51 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:07:51 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:07:51 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:51 INFO - u'jsshell-linux-x86_64.zip'], 11:07:51 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:07:51 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 11:07:51 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:07:51 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:07:51 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:07:51 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:07:51 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:07:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:51 INFO - https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:54 INFO - Downloaded 24176279 bytes. 11:07:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:07:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:07:56 INFO - Return code: 0 11:07:56 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:07: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:56 INFO - https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:58 INFO - Downloaded 24176279 bytes. 11:07:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:07:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:07:59 INFO - Return code: 0 11:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:59 INFO - https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:07:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:07:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:07:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:07:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:08:00 INFO - Downloaded 10840145 bytes. 11:08:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:08:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:08:01 INFO - Return code: 0 11:08:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:01 INFO - https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:08:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:08:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:08:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:08:02 INFO - Downloaded 62799916 bytes. 11:08:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:08:02 INFO - mkdir: /builds/slave/test/properties 11:08:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:08:02 INFO - Writing to file /builds/slave/test/properties/build_url 11:08:02 INFO - Contents: 11:08:02 INFO - build_url:https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:08:03 INFO - Running post-action listener: _resource_record_post_action 11:08:03 INFO - Running post-action listener: set_extra_try_arguments 11:08:03 INFO - ##### 11:08:03 INFO - ##### Running populate-webroot step. 11:08:03 INFO - ##### 11:08:03 INFO - Running pre-action listener: _resource_record_pre_action 11:08:03 INFO - Running main action method: populate_webroot 11:08:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:08:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:08:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:08:03 INFO - '--tppagecycles', 11:08:03 INFO - '7'], 11:08:03 INFO - 'tests': ['tsvgm']}}, 11:08:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:08:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:08:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:08:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:08:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:08:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:08:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:03 INFO - 'talos_options': ['--disable-e10s'], 11:08:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:03 INFO - 'talos_options': ['--disable-e10s'], 11:08:03 INFO - 'tests': ['damp', 'tps']}, 11:08:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:03 INFO - 'tests': ['damp', 'tps']}, 11:08:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:08:03 INFO - 'tests': ['dromaeo_dom']}, 11:08:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:08:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:08:03 INFO - 'tests': ['a11yr', 11:08:03 INFO - 'ts_paint', 11:08:03 INFO - 'tpaint', 11:08:03 INFO - 'sessionrestore', 11:08:03 INFO - 'sessionrestore_no_auto_restore', 11:08:03 INFO - 'tabpaint']}, 11:08:03 INFO - 'other-e10s': {'tests': ['a11yr', 11:08:03 INFO - 'ts_paint', 11:08:03 INFO - 'tpaint', 11:08:03 INFO - 'sessionrestore', 11:08:03 INFO - 'sessionrestore_no_auto_restore', 11:08:03 INFO - 'tabpaint']}, 11:08:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:08:03 INFO - 'ts_paint', 11:08:03 INFO - 'tpaint', 11:08:03 INFO - 'sessionrestore', 11:08:03 INFO - 'sessionrestore_no_auto_restore', 11:08:03 INFO - 'tabpaint']}, 11:08:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:08:03 INFO - 'ts_paint', 11:08:03 INFO - 'tpaint', 11:08:03 INFO - 'sessionrestore', 11:08:03 INFO - 'sessionrestore_no_auto_restore', 11:08:03 INFO - 'tabpaint']}, 11:08:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:08:03 INFO - 'tests': ['a11yr', 11:08:03 INFO - 'ts_paint', 11:08:03 INFO - 'tpaint', 11:08:03 INFO - 'sessionrestore', 11:08:03 INFO - 'sessionrestore_no_auto_restore', 11:08:03 INFO - 'tabpaint']}, 11:08:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:08:03 INFO - 'tests': ['a11yr', 11:08:03 INFO - 'ts_paint', 11:08:03 INFO - 'tpaint', 11:08:03 INFO - 'sessionrestore', 11:08:03 INFO - 'sessionrestore_no_auto_restore', 11:08:03 INFO - 'tabpaint']}, 11:08:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:08:03 INFO - 'tests': ['tsvgx', 11:08:03 INFO - 'tsvgr_opacity', 11:08:03 INFO - 'tart', 11:08:03 INFO - 'tscrollx', 11:08:03 INFO - 'cart']}, 11:08:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:08:03 INFO - 'tsvgr_opacity', 11:08:03 INFO - 'tart', 11:08:03 INFO - 'tscrollx', 11:08:03 INFO - 'cart']}, 11:08:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:03 INFO - 'talos_options': ['--disable-e10s'], 11:08:03 INFO - 'tests': ['tp5o']}, 11:08:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:03 INFO - 'tests': ['tp5o']}, 11:08:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:03 INFO - 'talos_options': ['--disable-e10s', 11:08:03 INFO - '--xperf_path', 11:08:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:03 INFO - 'tests': ['tp5n']}, 11:08:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:03 INFO - 'talos_options': ['--xperf_path', 11:08:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:03 INFO - 'tests': ['tp5n']}}, 11:08:03 INFO - 'talos.zip': {'path': '', 11:08:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:08:03 INFO - Running post-action listener: _resource_record_post_action 11:08:03 INFO - ##### 11:08:03 INFO - ##### Running create-virtualenv step. 11:08:03 INFO - ##### 11:08:03 INFO - Running pre-action listener: _resource_record_pre_action 11:08:03 INFO - Running main action method: create_virtualenv 11:08:03 INFO - Creating virtualenv /builds/slave/test/build/venv 11:08:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:08:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:08:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:08:03 INFO - Using real prefix '/usr' 11:08:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:08:04 INFO - Installing distribute.............................................................................................................................................................................................done. 11:08:06 INFO - Installing pip.................done. 11:08:06 INFO - Return code: 0 11:08:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f980c76cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c410>, '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 0x2c2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', '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 11:08:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:08:06 INFO - Using env: {'DISPLAY': ':0', 11:08:06 INFO - 'HOME': '/home/cltbld', 11:08:06 INFO - 'LANG': 'en_US.UTF-8', 11:08:06 INFO - 'LANGUAGE': 'en_US:en', 11:08:06 INFO - 'LOGNAME': 'cltbld', 11:08:06 INFO - 'MAIL': '/var/mail/cltbld', 11:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:06 INFO - 'MOZ_NO_REMOTE': '1', 11:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:06 INFO - 'NO_EM_RESTART': '1', 11:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:06 INFO - 'PWD': '/builds/slave/test', 11:08:06 INFO - 'SHELL': '/bin/bash', 11:08:06 INFO - 'SHLVL': '1', 11:08:06 INFO - 'TERM': 'linux', 11:08:06 INFO - 'TMOUT': '86400', 11:08:06 INFO - 'USER': 'cltbld', 11:08:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', 11:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:06 INFO - '_': '/tools/buildbot/bin/python'} 11:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:08:06 INFO - Cleaning up... 11:08:06 INFO - Return code: 0 11:08:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f980c76cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c410>, '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 0x2c2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', '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 11:08:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:08:06 INFO - Using env: {'DISPLAY': ':0', 11:08:06 INFO - 'HOME': '/home/cltbld', 11:08:06 INFO - 'LANG': 'en_US.UTF-8', 11:08:06 INFO - 'LANGUAGE': 'en_US:en', 11:08:06 INFO - 'LOGNAME': 'cltbld', 11:08:06 INFO - 'MAIL': '/var/mail/cltbld', 11:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:06 INFO - 'MOZ_NO_REMOTE': '1', 11:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:06 INFO - 'NO_EM_RESTART': '1', 11:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:06 INFO - 'PWD': '/builds/slave/test', 11:08:06 INFO - 'SHELL': '/bin/bash', 11:08:06 INFO - 'SHLVL': '1', 11:08:06 INFO - 'TERM': 'linux', 11:08:06 INFO - 'TMOUT': '86400', 11:08:06 INFO - 'USER': 'cltbld', 11:08:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', 11:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:06 INFO - '_': '/tools/buildbot/bin/python'} 11:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:06 INFO - Downloading/unpacking psutil>=0.7.1 11:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:08:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:08 INFO - Installing collected packages: psutil 11:08:08 INFO - Running setup.py install for psutil 11:08:08 INFO - building 'psutil._psutil_linux' extension 11:08:08 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 11:08:09 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 11:08:09 INFO - building 'psutil._psutil_posix' extension 11:08:09 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 11:08:09 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 11:08:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:09 INFO - Successfully installed psutil 11:08:09 INFO - Cleaning up... 11:08:09 INFO - Return code: 0 11:08:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:09 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f980c76cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c410>, '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 0x2c2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', '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 11:08:09 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.0.0'] in /builds/slave/test/build 11:08:09 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.0.0 11:08:09 INFO - Using env: {'DISPLAY': ':0', 11:08:09 INFO - 'HOME': '/home/cltbld', 11:08:09 INFO - 'LANG': 'en_US.UTF-8', 11:08:09 INFO - 'LANGUAGE': 'en_US:en', 11:08:09 INFO - 'LOGNAME': 'cltbld', 11:08:09 INFO - 'MAIL': '/var/mail/cltbld', 11:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:09 INFO - 'MOZ_NO_REMOTE': '1', 11:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:09 INFO - 'NO_EM_RESTART': '1', 11:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:09 INFO - 'PWD': '/builds/slave/test', 11:08:09 INFO - 'SHELL': '/bin/bash', 11:08:09 INFO - 'SHLVL': '1', 11:08:09 INFO - 'TERM': 'linux', 11:08:09 INFO - 'TMOUT': '86400', 11:08:09 INFO - 'USER': 'cltbld', 11:08:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', 11:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:09 INFO - '_': '/tools/buildbot/bin/python'} 11:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:08:11 INFO - Installing collected packages: mozsystemmonitor 11:08:11 INFO - Running setup.py install for mozsystemmonitor 11:08:11 INFO - Successfully installed mozsystemmonitor 11:08:11 INFO - Cleaning up... 11:08:11 INFO - Return code: 0 11:08:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:11 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 0x7f980c76cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c410>, '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 0x2c2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', '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 11:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:08:11 INFO - Using env: {'DISPLAY': ':0', 11:08:11 INFO - 'HOME': '/home/cltbld', 11:08:11 INFO - 'LANG': 'en_US.UTF-8', 11:08:11 INFO - 'LANGUAGE': 'en_US:en', 11:08:11 INFO - 'LOGNAME': 'cltbld', 11:08:11 INFO - 'MAIL': '/var/mail/cltbld', 11:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:11 INFO - 'MOZ_NO_REMOTE': '1', 11:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:11 INFO - 'NO_EM_RESTART': '1', 11:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:11 INFO - 'PWD': '/builds/slave/test', 11:08:11 INFO - 'SHELL': '/bin/bash', 11:08:11 INFO - 'SHLVL': '1', 11:08:11 INFO - 'TERM': 'linux', 11:08:11 INFO - 'TMOUT': '86400', 11:08:11 INFO - 'USER': 'cltbld', 11:08:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', 11:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:11 INFO - '_': '/tools/buildbot/bin/python'} 11:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:11 INFO - Downloading/unpacking blobuploader==1.2.4 11:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:13 INFO - Downloading blobuploader-1.2.4.tar.gz 11:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:08:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:08:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:14 INFO - Downloading docopt-0.6.1.tar.gz 11:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:08:14 INFO - Installing collected packages: blobuploader, requests, docopt 11:08:14 INFO - Running setup.py install for blobuploader 11:08:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:08:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:08:14 INFO - Running setup.py install for requests 11:08:14 INFO - Running setup.py install for docopt 11:08:14 INFO - Successfully installed blobuploader requests docopt 11:08:14 INFO - Cleaning up... 11:08:15 INFO - Return code: 0 11:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:15 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 0x7f980c76cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c410>, '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 0x2c2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', '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 11:08:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:08:15 INFO - Using env: {'DISPLAY': ':0', 11:08:15 INFO - 'HOME': '/home/cltbld', 11:08:15 INFO - 'LANG': 'en_US.UTF-8', 11:08:15 INFO - 'LANGUAGE': 'en_US:en', 11:08:15 INFO - 'LOGNAME': 'cltbld', 11:08:15 INFO - 'MAIL': '/var/mail/cltbld', 11:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:15 INFO - 'MOZ_NO_REMOTE': '1', 11:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:15 INFO - 'NO_EM_RESTART': '1', 11:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:15 INFO - 'PWD': '/builds/slave/test', 11:08:15 INFO - 'SHELL': '/bin/bash', 11:08:15 INFO - 'SHLVL': '1', 11:08:15 INFO - 'TERM': 'linux', 11:08:15 INFO - 'TMOUT': '86400', 11:08:15 INFO - 'USER': 'cltbld', 11:08:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', 11:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:15 INFO - '_': '/tools/buildbot/bin/python'} 11:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:15 INFO - Running setup.py (path:/tmp/pip-Y2RGml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:15 INFO - Running setup.py (path:/tmp/pip-MUMXm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:15 INFO - Running setup.py (path:/tmp/pip-0WcoPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:15 INFO - Running setup.py (path:/tmp/pip-d6nQtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:15 INFO - Running setup.py (path:/tmp/pip-j1IhRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:15 INFO - Running setup.py (path:/tmp/pip-aZo2Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:15 INFO - Running setup.py (path:/tmp/pip-hg8eNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:15 INFO - Running setup.py (path:/tmp/pip-FXy5Xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:15 INFO - Running setup.py (path:/tmp/pip-VwdUmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:15 INFO - Running setup.py (path:/tmp/pip-kwvdOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:15 INFO - Running setup.py (path:/tmp/pip-Es88qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:16 INFO - Running setup.py (path:/tmp/pip-E9KLqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:16 INFO - Running setup.py (path:/tmp/pip-ksm0CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:16 INFO - Running setup.py (path:/tmp/pip-HE7X3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:16 INFO - Running setup.py (path:/tmp/pip-aZlGyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:16 INFO - Running setup.py (path:/tmp/pip-USF0Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:16 INFO - Running setup.py (path:/tmp/pip-J0WqDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:08:16 INFO - Running setup.py install for manifestparser 11:08:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:08:16 INFO - Running setup.py install for mozcrash 11:08:16 INFO - Running setup.py install for mozdebug 11:08:16 INFO - Running setup.py install for mozdevice 11:08:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:08:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:08:16 INFO - Running setup.py install for mozfile 11:08:16 INFO - Running setup.py install for mozhttpd 11:08:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Running setup.py install for mozinfo 11:08:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Running setup.py install for mozInstall 11:08:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Running setup.py install for mozleak 11:08:17 INFO - Running setup.py install for mozlog 11:08:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Running setup.py install for moznetwork 11:08:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Running setup.py install for mozprocess 11:08:17 INFO - Running setup.py install for mozprofile 11:08:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Running setup.py install for mozrunner 11:08:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:08:17 INFO - Running setup.py install for mozscreenshot 11:08:18 INFO - Running setup.py install for moztest 11:08:18 INFO - Running setup.py install for mozversion 11:08:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:08:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:08:18 INFO - Cleaning up... 11:08:18 INFO - Return code: 0 11:08:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:18 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 0x7f980c76cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c410>, '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 0x2c2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', '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 11:08:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:08:18 INFO - Using env: {'DISPLAY': ':0', 11:08:18 INFO - 'HOME': '/home/cltbld', 11:08:18 INFO - 'LANG': 'en_US.UTF-8', 11:08:18 INFO - 'LANGUAGE': 'en_US:en', 11:08:18 INFO - 'LOGNAME': 'cltbld', 11:08:18 INFO - 'MAIL': '/var/mail/cltbld', 11:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:18 INFO - 'MOZ_NO_REMOTE': '1', 11:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:18 INFO - 'NO_EM_RESTART': '1', 11:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:18 INFO - 'PWD': '/builds/slave/test', 11:08:18 INFO - 'SHELL': '/bin/bash', 11:08:18 INFO - 'SHLVL': '1', 11:08:18 INFO - 'TERM': 'linux', 11:08:18 INFO - 'TMOUT': '86400', 11:08:18 INFO - 'USER': 'cltbld', 11:08:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', 11:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:18 INFO - '_': '/tools/buildbot/bin/python'} 11:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:18 INFO - Running setup.py (path:/tmp/pip-z702Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:18 INFO - Running setup.py (path:/tmp/pip-oO2wkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:18 INFO - Running setup.py (path:/tmp/pip-fqnXeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:18 INFO - Running setup.py (path:/tmp/pip-mRCUNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:18 INFO - Running setup.py (path:/tmp/pip-3tI7Ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:18 INFO - Running setup.py (path:/tmp/pip-MSsbeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:18 INFO - Running setup.py (path:/tmp/pip-4Y80Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:18 INFO - Running setup.py (path:/tmp/pip-DAdxjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:19 INFO - Running setup.py (path:/tmp/pip-4fKPzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:19 INFO - Running setup.py (path:/tmp/pip-I9Uen5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:19 INFO - Running setup.py (path:/tmp/pip-dsvddq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:19 INFO - Running setup.py (path:/tmp/pip-vz4f1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:19 INFO - Running setup.py (path:/tmp/pip-aqXdyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:19 INFO - Running setup.py (path:/tmp/pip-BSBxnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:19 INFO - Running setup.py (path:/tmp/pip-nGrGC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:19 INFO - Running setup.py (path:/tmp/pip-QfY6XZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:19 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)) 11:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:19 INFO - Running setup.py (path:/tmp/pip-lPnot3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:08:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08:21 INFO - Downloading blessings-1.6.tar.gz 11:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:08:21 INFO - Installing collected packages: blessings 11:08:21 INFO - Running setup.py install for blessings 11:08:21 INFO - Successfully installed blessings 11:08:21 INFO - Cleaning up... 11:08:21 INFO - Return code: 0 11:08:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:22 INFO - Reading from file tmpfile_stdout 11:08:22 INFO - Current package versions: 11:08:22 INFO - argparse == 1.2.1 11:08:22 INFO - blessings == 1.6 11:08:22 INFO - blobuploader == 1.2.4 11:08:22 INFO - docopt == 0.6.1 11:08:22 INFO - manifestparser == 1.1 11:08:22 INFO - mozInstall == 1.12 11:08:22 INFO - mozcrash == 0.17 11:08:22 INFO - mozdebug == 0.1 11:08:22 INFO - mozdevice == 0.48 11:08:22 INFO - mozfile == 1.2 11:08:22 INFO - mozhttpd == 0.7 11:08:22 INFO - mozinfo == 0.9 11:08:22 INFO - mozleak == 0.1 11:08:22 INFO - mozlog == 3.1 11:08:22 INFO - moznetwork == 0.27 11:08:22 INFO - mozprocess == 0.22 11:08:22 INFO - mozprofile == 0.28 11:08:22 INFO - mozrunner == 6.11 11:08:22 INFO - mozscreenshot == 0.1 11:08:22 INFO - mozsystemmonitor == 0.0 11:08:22 INFO - moztest == 0.7 11:08:22 INFO - mozversion == 1.4 11:08:22 INFO - psutil == 3.1.1 11:08:22 INFO - requests == 1.2.3 11:08:22 INFO - wsgiref == 0.1.2 11:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:22 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 0x7f980c76cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c410>, '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 0x2c2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', '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 11:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:08:22 INFO - Using env: {'DISPLAY': ':0', 11:08:22 INFO - 'HOME': '/home/cltbld', 11:08:22 INFO - 'LANG': 'en_US.UTF-8', 11:08:22 INFO - 'LANGUAGE': 'en_US:en', 11:08:22 INFO - 'LOGNAME': 'cltbld', 11:08:22 INFO - 'MAIL': '/var/mail/cltbld', 11:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:22 INFO - 'MOZ_NO_REMOTE': '1', 11:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:22 INFO - 'NO_EM_RESTART': '1', 11:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:22 INFO - 'PWD': '/builds/slave/test', 11:08:22 INFO - 'SHELL': '/bin/bash', 11:08:22 INFO - 'SHLVL': '1', 11:08:22 INFO - 'TERM': 'linux', 11:08:22 INFO - 'TMOUT': '86400', 11:08:22 INFO - 'USER': 'cltbld', 11:08:22 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', 11:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:22 INFO - '_': '/tools/buildbot/bin/python'} 11:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:08:22 INFO - Cleaning up... 11:08:22 INFO - Return code: 0 11:08:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f980c76cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c410>, '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 0x2c2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', '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 11:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:08:22 INFO - Using env: {'DISPLAY': ':0', 11:08:22 INFO - 'HOME': '/home/cltbld', 11:08:22 INFO - 'LANG': 'en_US.UTF-8', 11:08:22 INFO - 'LANGUAGE': 'en_US:en', 11:08:22 INFO - 'LOGNAME': 'cltbld', 11:08:22 INFO - 'MAIL': '/var/mail/cltbld', 11:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:22 INFO - 'MOZ_NO_REMOTE': '1', 11:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:22 INFO - 'NO_EM_RESTART': '1', 11:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:22 INFO - 'PWD': '/builds/slave/test', 11:08:22 INFO - 'SHELL': '/bin/bash', 11:08:22 INFO - 'SHLVL': '1', 11:08:22 INFO - 'TERM': 'linux', 11:08:22 INFO - 'TMOUT': '86400', 11:08:22 INFO - 'USER': 'cltbld', 11:08:22 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', 11:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:22 INFO - '_': '/tools/buildbot/bin/python'} 11:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:22 INFO - Downloading/unpacking jsonschema 11:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:08:24 INFO - Downloading/unpacking functools32 (from jsonschema) 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08:24 INFO - Downloading functools32-3.2.3-2.tar.gz 11:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:08:24 INFO - warning: no files found matching '*.txt' 11:08:24 INFO - no previously-included directories found matching 'build' 11:08:24 INFO - no previously-included directories found matching 'dist' 11:08:24 INFO - no previously-included directories found matching '.git*' 11:08:24 INFO - Installing collected packages: jsonschema, functools32 11:08:24 INFO - Running setup.py install for functools32 11:08:24 INFO - warning: no files found matching '*.txt' 11:08:24 INFO - no previously-included directories found matching 'build' 11:08:24 INFO - no previously-included directories found matching 'dist' 11:08:24 INFO - no previously-included directories found matching '.git*' 11:08:24 INFO - Successfully installed jsonschema functools32 11:08:24 INFO - Cleaning up... 11:08:24 INFO - Return code: 0 11:08:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f980c76cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c410>, '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 0x2c2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', '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 11:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:08:24 INFO - Using env: {'DISPLAY': ':0', 11:08:24 INFO - 'HOME': '/home/cltbld', 11:08:24 INFO - 'LANG': 'en_US.UTF-8', 11:08:24 INFO - 'LANGUAGE': 'en_US:en', 11:08:24 INFO - 'LOGNAME': 'cltbld', 11:08:24 INFO - 'MAIL': '/var/mail/cltbld', 11:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:24 INFO - 'MOZ_NO_REMOTE': '1', 11:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:24 INFO - 'NO_EM_RESTART': '1', 11:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:24 INFO - 'PWD': '/builds/slave/test', 11:08:24 INFO - 'SHELL': '/bin/bash', 11:08:24 INFO - 'SHLVL': '1', 11:08:24 INFO - 'TERM': 'linux', 11:08:24 INFO - 'TMOUT': '86400', 11:08:24 INFO - 'USER': 'cltbld', 11:08:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', 11:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:24 INFO - '_': '/tools/buildbot/bin/python'} 11:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:25 INFO - Downloading/unpacking flake8 11:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:08:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:08:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:08:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:27 INFO - no previously-included directories found matching 'docs/_build' 11:08:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:08:27 INFO - Running setup.py install for pep8 11:08:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:28 INFO - no previously-included directories found matching 'docs/_build' 11:08:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:08:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:08:28 INFO - Cleaning up... 11:08:28 INFO - Return code: 0 11:08:28 INFO - Running post-action listener: _resource_record_post_action 11:08:28 INFO - Running post-action listener: _start_resource_monitoring 11:08:28 INFO - Starting resource monitoring. 11:08:28 INFO - ##### 11:08:28 INFO - ##### Running install step. 11:08:28 INFO - ##### 11:08:28 INFO - Running pre-action listener: _resource_record_pre_action 11:08:28 INFO - Running main action method: install 11:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:28 INFO - Reading from file tmpfile_stdout 11:08:28 INFO - Detecting whether we're running mozinstall >=1.0... 11:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:08:28 INFO - Reading from file tmpfile_stdout 11:08:28 INFO - Output received: 11:08:28 INFO - Usage: mozinstall [options] installer 11:08:28 INFO - Options: 11:08:28 INFO - -h, --help show this help message and exit 11:08:28 INFO - -d DEST, --destination=DEST 11:08:28 INFO - Directory to install application into. [default: 11:08:28 INFO - "/builds/slave/test"] 11:08:28 INFO - --app=APP Application being installed. [default: firefox] 11:08:28 INFO - mkdir: /builds/slave/test/build/application 11:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:08:44 INFO - Reading from file tmpfile_stdout 11:08:44 INFO - Output received: 11:08:44 INFO - /builds/slave/test/build/application/firefox/firefox 11:08:44 INFO - Running post-action listener: _resource_record_post_action 11:08:44 INFO - ##### 11:08:44 INFO - ##### Running run-tests step. 11:08:44 INFO - ##### 11:08:44 INFO - Running pre-action listener: _resource_record_pre_action 11:08:44 INFO - Running main action method: run_tests 11:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:08:44 INFO - Python 2.7.3 11:08:44 INFO - Return code: 0 11:08:44 INFO - grabbing minidump binary from tooltool 11:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c410>, '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 0x2c2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:08:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:08:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:08:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:08:44 INFO - Return code: 0 11:08:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:08:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:08:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:08:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:08:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:08:45 INFO - Return code: 0 11:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:08:45 INFO - Using env: {'DISPLAY': ':0', 11:08:45 INFO - 'HOME': '/home/cltbld', 11:08:45 INFO - 'LANG': 'en_US.UTF-8', 11:08:45 INFO - 'LANGUAGE': 'en_US:en', 11:08:45 INFO - 'LOGNAME': 'cltbld', 11:08:45 INFO - 'MAIL': '/var/mail/cltbld', 11:08:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:08:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:45 INFO - 'MOZ_NO_REMOTE': '1', 11:08:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:45 INFO - 'NO_EM_RESTART': '1', 11:08:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:45 INFO - 'PWD': '/builds/slave/test', 11:08:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:08:45 INFO - 'SHELL': '/bin/bash', 11:08:45 INFO - 'SHLVL': '1', 11:08:45 INFO - 'TERM': 'linux', 11:08:45 INFO - 'TMOUT': '86400', 11:08:45 INFO - 'USER': 'cltbld', 11:08:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455', 11:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:45 INFO - '_': '/tools/buildbot/bin/python'} 11:08:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:08:45 INFO - mozversion application_buildid: 20160606053329 11:08:45 INFO - mozversion application_changeset: 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 11:08:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:08:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:08:45 INFO - mozversion application_name: Firefox 11:08:45 INFO - mozversion application_remotingname: firefox-dev 11:08:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:08:45 INFO - mozversion application_vendor: Mozilla 11:08:45 INFO - mozversion application_version: 48.0a2 11:08:45 INFO - mozversion platform_buildid: 20160606053329 11:08:45 INFO - mozversion platform_changeset: 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 11:08:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:08:45 INFO - mozversion platform_version: 48.0a2 11:08:45 INFO - using testdate: 1465236525 11:08:45 INFO - actual date: 1465236525 11:08:45 INFO - starting webserver on 'localhost:37699' 11:08:45 INFO - SUITE-START | Running 2 tests 11:08:45 INFO - TEST-START | dromaeo_css 11:08:45 INFO - operating with platform_type : linux_ 11:08:45 INFO - Initialising browser for dromaeo_css test... 11:08:45 INFO - TEST-INFO | started process 5404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOu5H95/profile http://localhost:37699/getInfo.html) 11:08:49 INFO - PROCESS | 5404 | __metrics Screen width/height:1600/1200 11:08:49 INFO - PROCESS | 5404 | colorDepth:24 11:08:49 INFO - PROCESS | 5404 | Browser inner width/height: 1024/697 11:08:49 INFO - PROCESS | 5404 | __metrics 11:08:50 ERROR - PROCESS | 5404 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:08:51 INFO - TEST-INFO | 5404: exit 0 11:08:51 INFO - Browser initialized. 11:08:51 INFO - Running cycle 1/1 for dromaeo_css test... 11:08:51 INFO - TEST-INFO | started process 5494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOu5H95/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:03 INFO - PROCESS | 5494 | RSS: Main: 142651392 11:09:03 INFO - PROCESS | 5494 | 11:09:54 INFO - PROCESS | 5494 | 1465236594094 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] 11:12:01 INFO - PROCESS | 5494 | Cycle 1(1): loaded http://localhost:37699/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37699/tests/dromaeo/cssquery-ext.html) 11:12:02 INFO - PROCESS | 5494 | RSS: Main: 250998784 11:12:02 INFO - PROCESS | 5494 | 11:15:05 INFO - PROCESS | 5494 | Cycle 1(1): loaded http://localhost:37699/tests/dromaeo/cssquery-ext.html (next: http://localhost:37699/tests/dromaeo/cssquery-jquery.html) 11:15:05 INFO - PROCESS | 5494 | RSS: Main: 222932992 11:15:05 INFO - PROCESS | 5494 | 11:18:07 INFO - PROCESS | 5494 | Cycle 1(1): loaded http://localhost:37699/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37699/tests/dromaeo/cssquery-mootools.html) 11:18:08 INFO - PROCESS | 5494 | RSS: Main: 218845184 11:18:08 INFO - PROCESS | 5494 | 11:21:09 INFO - PROCESS | 5494 | Cycle 1(1): loaded http://localhost:37699/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37699/tests/dromaeo/cssquery-prototype.html) 11:21:10 INFO - PROCESS | 5494 | RSS: Main: 215986176 11:21:10 INFO - PROCESS | 5494 | 11:24:13 INFO - PROCESS | 5494 | Cycle 1(1): loaded http://localhost:37699/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37699/tests/dromaeo/cssquery-yui.html) 11:24:13 INFO - PROCESS | 5494 | RSS: Main: 213180416 11:24:13 INFO - PROCESS | 5494 | 11:27:15 INFO - PROCESS | 5494 | Cycle 1(1): loaded http://localhost:37699/tests/dromaeo/cssquery-yui.html (next: http://localhost:37699/tests/dromaeo/cssquery-dojo.html) 11:27:16 INFO - PROCESS | 5494 | RSS: Main: 238485504 11:27:16 INFO - PROCESS | 5494 | 11:27:16 INFO - PROCESS | 5494 | __start_tp_report 11:27:16 INFO - PROCESS | 5494 | _x_x_mozilla_page_load 11:27:16 INFO - PROCESS | 5494 | _x_x_mozilla_page_load_details 11:27:16 INFO - PROCESS | 5494 | |i|pagename|runs| 11:27:16 INFO - PROCESS | 5494 | |0;dojo.html;3256.283617604127;3284.6058472983245;3285.030915879816;3319.1038419626716;3330.9167270818243;5307.389650190229;5312.203169524573;5323.494268044529;5355.892882142355;5357.8392648220515;5341.03861304965;5341.30563026806;5348.491893270143;5349;5364.892702145955;4882.731449770261;4935.185694360444;4943.060818444502;4994.225894986264;5001.949590585981;4884.705553028451;4954.603631709455;4989.476105008976;4990.301357809892;4990.30135780991;4989.700617962916;5010.298558201855;5062.443131255559;5070.112730272206;5082.923756143661;5012.373453318335;5039.269305950654;5050.318207042039;5054.721990290533;5086.542211200991;4928.359313289286;4956.752162391902;4964;4969.329140566049;5036.093503169428;5303.469653034705;5332.3867755207875;5342.706151161685;5350.224217488481;5357.651752636066;5808.186853840466;5865.266841644794;5867.090600956859;5868.413158684098;5872.265966754156;5903.881922361572;5911.349751527328;6021.849453763691;6033.155358249848;6057.848553786146;5539.944600553983;5561.277033985596;5580.665160090408;5587.692676902769;5592.245046918695;5905.261842269716;6065.848353791191;6080.0879868019265;6089.604175728652;6091.817245482643;5703.74333155009;5775.913361299584;5778.855528611734;5780.335261444903;5795.971020144957;5862.03276459388;5873.559483038704;5876.9118463223085;5879.176915231871;5902.1441890926435;5646.858828529237;5826.2134611827705;5835.94164058354;5839.532837373;5865.677387743715;5893.233879595625;5929.644221346733;5933.792317268875;5952.255968003999;5982.371850955674;4517.480489743656;4526.841560545431;4528.980979279701;4530.22986092365;4558.9742307981105;3942.64516193544;3996.7402118862183;4013.13717550728;4059.3707975263883;4107.014316564003;5497.780088796403;5517.503424691797;5526.723663816793;5527.839153777752;5536;5806.042003069446;5812.651240925558;5815.854603634858;5816;5822;5435.592330575223;5453.890922181614;5497.340319161726;5508.173773933861;5516.365617953907;4999.625028122905;5027.170516864677;5027.622928280393;5075.467075956972;5075.839006329897;6077.027675571887;6085.5435842312;6092.268927728701;6093.299270583851;6094.024956007106;5703;5934.525237981037;5983.880322393441;5991.700414979321;6006.699665016819;6073.271207455134;6152.600080994721;6173.722182501709;6181.505479561534;6181.5363847710705;5677.716114194356;5837.708114594338;5840.678762668094;5844.620099693507;5851;5768.653880767168;5816.534677225727;5822.359540450631;5842.707864606838;5853.09277062056;5700.657960522382;5724;5726.0838265877255;5726.942730572641;5727.31272247333;5559.16612508127;5716.514096301695;5723.5707321950185;5729.4843464088435;5735.168400581976;5704.9429505706075;5724.742386592697;5726;5734.111212762028;5763.538916886723;5780.393058728773;5835.79574714883;5838.211841401527;5839.7372118255635;5846.210761547307;5488.1493368527945;5623.2408624835125;5709.058005429058;5734.741936612946;5746.712664366682 11:27:16 INFO - PROCESS | 5494 | |1;ext.html;665.3546060321489;669.0833558025505;676.7935779587224;680.3876511139975;690.4234963805229;35595.82202088989;36150.63849361506;40077;40535;40574.39138412919;44138.11723765523;44669.10661786763;44684;44715;44733.10533789322;8005.199480051977;8894.021657617674;9063.909360906373;9094.226990705798;10523.579056837718;10585.84121238182;10744.838827417596;10747;10747.731306717316;10747.946260268687;10732.034116929475;10787.83818242727;10796.136309095253;10799.622013229538;10801.729956751065;8243.670253189895;8482.78793030173;10522;10565.78868422631;10699.572017119384;10728.195385346131;10839.729006774895;10843.67468975932;10855.131589472901;10857.185711071623;38581.61418385808;39211;39287.214255715015;39296.80351598252;39323.803380982914;3773.226488569864;3791.052236940765;3843.903902402434;4064.4309796628495;4473.172463094305;34216.48675269873;34704.82647586771;34790.30419391598;34892.30215395703;35204.823975880216;4257.723247988871;4310.806013729359;4386.254336762758;4392.934105988413;4403.779811009469;319091;322030;322083;323330;323369;40832.9999999994;41422.37866432006;67402.66298668475;68070.31929680739;68158.65920670365;39341.40987885184;39422.60577394189;39539.20921581552;39547.60452395497;39568.40647390291;17175.484735457958;17337.56656083583;17341.306347745947;17352.65294694099;17364.39224627132;12829.807552886714;14532.273386330853;14670.119792812466;14691;14701.55895323142;9528.475933823567;9545.52272386378;9550.140487356033;9590.760230994281;9639.277054220962;3696.5748938871834;3703.3148867459604;3725.4598083277774;3748.5126933499014;3765.5104836371097;1047.6804574604819;1092.3882625729616;1101.823708206683;1129.5481807277156;1158.9743077376413;34371;34391.656083439346;34638.653613463546;35161.85403187083;35410.822945885106;1191.9284842909453;1194.7610477904454;1223.1010207497661;1243.5585367194697;1378.8138601288697;17639.73540396895;17668;17905.462836114937;17938.372156974445;18143.818561814478;500980;502998;503485;503829;506043;63562.36437635565;65077.67461162758;65177.34822651808;65238.673806630664;65377;1302.3553341096217;1490.0984904132843;1490.3591455673948;1518.8025556677562;1601.4394961763523;30515.847420762755;31399.84300078485;33540.1614959628;33858.49212261769;33968.32063358768;51793.482065180375;51808.740956294976;52166;52183.478165217864;52339.47660523346;317646;319434;319956;321015;321043;28543.714562854937;31657.36685266328;31946.68053319437;32180.517292240165;32344.514832277066;44032.559674404125;49381.75309123431;49417.752911236654;49729;50579.747101264256;40946.272170461;41413;42406.78796605997;42879.571204288804;43230.135397292506;40317.59682403138;40848.38727419032;40967.1806563873;41160.79419602883;41762.37356439717;42412.575874242095;42702.35946460868;42901.570984289756;43222;43289.134217314844;35290.82354588211;37374.626253737115;37479.25041499209;37521.24957500889;37613;29031.56452653254;29200.41599168047;29205.123846284645;29227.7077229225;29263.56104658389 11:27:16 INFO - PROCESS | 5494 | |2;jquery.html;429.0897308124721;430.8685850815501;441.25868540851366;443.6273530234602;451.09105153116496;18959.62080758384;19211.903940480297;19781.307654232103;21363.359099227007;21365.67951480729;20189.697154542693;20651.793482065175;20801.895990520024;20804.271850485235;20816.791832081675;5301.7084060376665;5586.497215250627;5587.832365029056;5595.720213989304;5597.692126933017;4097.836086556535;5493.176023596472;5570.136628822539;5876.970615146918;6201.131841542187;6189.473894718954;6205.131281620576;6235.594686345373;6236.937630623681;6237.532185086114;5989.9101513477335;6176.505879529627;6225.346338634424;6236.875262494747;6242.344553821874;3935.980320098381;4107.568705285962;5710.657360558338;6052.757889684407;6081.270247570275;21833.67249491259;22472.88763556188;22509.88745056264;22565.54868902629;22719.318420447413;2537.619357096432;2548.5285222233947;2586.1336452288506;2799.9440011199868;2824.4633519631207;10606.893931060667;11020.283681560673;11142.832857507145;13525.729485410335;14319;2057.5370541628163;2063.515073957619;2069.855110142291;2113.4610674278115;2118.5339225370394;78581;80958.59520702418;82482.58758706228;82980.17019829784;83068.16931830665;11346.319220846775;11495.585926955266;11653.88346116545;11676.94161529187;11692.655344635306;16412.589685257964;16473.176341183134;16481.093539855425;16503.91748041252;16538.421155259508;8812.8678069829;8957.552122393854;8958.776030599156;9024.503652299056;9092.318076144316;8785.428947118417;8795.340349473687;8855.114488551222;8943.150400711922;8956.776080598038;4990.900181996412;5071.492850714899;5076.162433198481;5152.690838549699;5167.560757335594;1796.7373747724637;2017.465371676507;2029.5839352932614;2103.9263625773024;2117.618828610865;966.5988614724811;1014.3102690170607;1050.5955207245265;1081.8918108189118;1147.2026941275733;18025.459236222934;18825.435236942914;19023.239070437303;19699.11353989074;19792.307269245506;1007.5516395204211;1015.421209910344;1034.7206254311293;1061.5010944855906;1072;10321.432321222404;10945.179111566664;10977.176711746652;11084.445777711082;11089.722756931142;505879;511794;521784;532884;539505;89492;90121.54939225393;90580.54709726409;91075.54462227646;91651.54174229086;1012.5291739341242;1024.4416792847917;1037.5590374090982;1038.2161468091542;1049.9212559057949;17006.659866802842;17160.914195429443;17320.30718771235;17442.389516366868;17584.56038599045;39185.41221881731;39397.80301098476;39489;40268.79865600653;41080.794596026826;57660;57768.422315776304;58425.831483370945;58711.412885870595;58949.70525147347;8641.135886411308;8951.373403861668;9091.909080909107;9157.587908544265;9222.308326875376;11727.76544469123;13118.409671564612;13610.59168224955;13737.107088039245;13777.380017899419;11592;11925;12046.819297710717;12117.636470905887;12139.453724582238;11696.87066991818;12162.513499459923;12211.844197138385;12272.631821045383;12764.106512544033;12080.697982550506;12694.619161425171;12704.428300726675;12766;12884.484620615445;8766.474011559327;9017.639294428413;9149.130832570896;9243.953780231324;9343.71968840936;12064.939675301568;12159.939200303941;12211.206271592673;12235.143539952474;12321 11:27:16 INFO - PROCESS | 5494 | |3;mootools.html;1393.0318428692062;1556.5719427157533;1558.0963041435969;1748.484197161837;1907.6184763047395;7973.202679732031;8176.95911520443;8193.836123277531;8194.262516373525;8201.91798082019;8016.599170041489;8183.222593853589;8194.83610327793;8195.22145396188;8199.631016604253;2091.184438069154;2140.967885481711;2281.2129815213807;2361.9881900590517;2386.72552656445;2377.7146742390937;2384;2386.606209975361;2388.032846697082;2395.784379405853;2293.827962902789;2311.93064208074;2329.499157681098;2412.0351859256352;2423.297243799296;2065.979340206594;2306.1813056365086;2356.516914032636;2357.1396440299254;2358.646203069536;2342.672025916373;2372.5729368713623;2375.133076427109;2376.714794224687;2377.108584280895;8052.637631306605;8068.47554908929;8102.39232057598;8104.594770261463;8112.269895709414;5109.846704598831;5224.63427560071;5229.764660590245;5232.633715639907;5234.42421333653;3348.7823291485975;3361.109306033903;3501.1422201560526;3541.11472131967;3541.9114522136897;1095.0746619106842;1128.6670432222513;1140.9144314176388;1172.6188988578747;1176.605837044591;12351.19717218378;12356.938215308955;12381.93809030958;12387.132900696955;12389.75220495585;4526.411566496335;4582.77086145698;4605.723656580616;4624.815007399734;4628.120657075145;10374.22193335503;10384.740381490523;10418.114460270961;10462.581496740046;10467.371957682564;5342.759575819097;5344.465553444702;5345.438728933484;5348.491893270133;5354.973225133849;4312.245357062501;4703.529647035338;4798;4858.955324605156;4923.359963204761;4003.719739618257;4041.393790931325;4080.7143499955314;4106.3635136553885;4147.149834283965;1326.4495234477777;1326.8872145867517;1330.647378444713;1331.8202042724301;1348.110247236819;1027.7379268286688;1027.7430642339416;1033.4006276359694;1047.2302857399804;1058.7459009837582;5693.829185124453;5729.914051289234;5770.682612456271;5959.404059594092;6030.246219222598;978.7650963768644;1046.853440518328;1048.9143736232961;1070.6092276319087;1095.90684791792;3954.387070004154;3981.5620281768984;3997.900052498711;4006.899827504336;4030.1738143680477;9871.60513579463;10188.184945204366;10241.590336386611;10246.590136394461;10257.538410771533;10083.445410502347;10107.545160467796;10350.792984140426;10352.378857268588;10381.377117372982;7920.881186782203;8165.265126138676;8181.386396020203;8202.425830191829;8211.630476628567;5857.209276747755;5917.082852157922;5952.791652292149;5964.105384192406;6016.2479690038745;8765;8961.50711710836;9026.097390260922;9098.863517047383;9114.40756350835;9031.548422578713;9205.125513076247;9207.125323094295;9208.677696280598;9213.493257870881;6829.112215412163;7235.819104522429;7400.851982960418;7609.771706848804;7710.228977102245;7828.804279893048;7858.764237072897;7862.960685196537;7897.091834439113;7908.406869484927;7090.290970903075;7244.565326080452;7268.27317268269;7354.889676654748;7391.445641576795;7167;7199.568025918462;7238.384737297178;7260.67326970277;7275.12698476165;6869.587824730532;6874.106366172366;6933.791986240421;6938.895916561155;6941.34057264559;4803.495632958489;4805.471398146271;4847.272909063528;4954.157793175241;5003.274525193754;4951.801927922987;4978.626603004716;5007.424146223086;5050.368703912011;5052.216906379517 11:27:16 INFO - PROCESS | 5494 | |4;prototype.html;358.50168266110114;359.50388463919785;367.09877251347945;368.9686376657984;373.53867973053275;6182.350853160421;6183.567150299481;6183.81448556544;6230.813075607728;6295.464885484739;6151.138840562325;6152.692365381724;6155.384461553843;6171.969140154304;6191.4737247333915;4522.8417005404735;4627.953720462786;4711.740854253015;4716.292556116576;4733.976330118362;4712.128256272584;4720.90558188836;4722.5513576210205;4744.4069491313585;4755.762211889409;4503.864884053483;4707.552782485658;4713.457952335491;4716.551927566876;4717.905641887178;4586.3808385867815;4592.1045396147765;4630.37489938859;4665.556772106678;4672.0889426561835;4088.0393107619684;4092.856750013735;4112.876613701564;4115.938260926088;4117.814698338582;5891.911621325684;5893.675847828367;5908.527317814564;5911.379305172938;5913.763449462016;5418.29562156921;5423.945760542383;5427.647202931837;5428.891422171534;5433.022056029913;6422.6467544285515;6433.613983160979;6435.292117867031;6442.806715798533;6445.484361251136;4434.49003364614;4546.090781843644;4549.840755573539;4568.291914753218;4573.931391029138;6629.469642428594;6740.157480314961;6747.730090796363;6747.966260168668;6757.020232066323;4729.0541891621815;4729.6689231754135;4731.716097034189;4732.053589282157;4735.881602959954;4792.329073929653;4808.110499557593;4812.542808433193;4815.22956326986;4821.108095002365;5489.533389661844;5493.313335833021;5494.478024587737;5496.065668836308;5505.394406615269;6434.871302573923;6556.737730490822;6569.343065693392;6572.901406478906;6580.5722628029025;1691.8308169183229;1698.9490315290313;1711.9315227390764;1711.9828801711824;1712.9657406851793;1061.6655753437642;1116.3134672176552;1122.1976286954866;1143.8398624192619;1149.230015889356;6274.05889116627;6350.8412289692205;6362.777302794472;6368.554201205871;6379.744810207632;6820.624865632438;6825.419839313714;6833.350831670983;6835.58986460814;6838.452923766087;6418.935810641927;6419.101325814389;6427.0076276354475;6436.903446448307;6441.420272175433;3623.583287921923;3649.59854416014;3664.0839790052487;3672.485851980725;3676.852925882935;6930.965345173343;7054;7090.7945649239755;7094.361507464353;7100.076989991268;6884.65576721162;6887.139107611549;6899;6899.827504312432;6908.5509441887125;7052.894206586905;7071.469639777038;7088.468364872655;7089.361957423856;7090.326418990291;6734.292899245509;6784.185897692111;6794.184697836094;6796.524243303119;6803.115594972622;6484.383983521558;6681.164854393201;6721.966390168213;6723.630200338833;6776.491763117688;7141.571505709674;7157.57054576727;7157.856842863218;7160.928390716026;7163.749268775777;4651.534846515321;4700.130475861976;4708.223143181337;4712.7643617818285;4715.22198837188;6784.151981002375;6788.253292137762;6788.558743681645;6800.183977922681;6800.625965571941;6343.429091381798;6593.538452308292;6608.173978252718;6609.20689517261;6612.768553100618;6539.673016349258;6584.967075164594;6591.011348297794;6593.241777195684;6593.406593406617;6471.708773105316;6476.6114033158165;6479.319671434431;6483.059956306215;6483.7730679425995;6613.570117942319;6617.139771829631;6624.337566243337;6627.867442651216;6631.701573429304;6285.654289013965;6412.038194270896;6426.42162205385;6471.579347342407;6476.514261430318 11:27:16 INFO - PROCESS | 5494 | |5;yui.html;844.8014716541612;945.1352012908189;946.1484663802581;947.9526023698813;960.7838236396807;14760.188189649565;15053.397864085437;15061.32224049919;15122.395104195819;15148.545543633682;13185.736285274288;14381.280935953213;14755.336009879555;14816.55550333489;14889.478868239614;913.9451632902014;924.3806649544821;932.4684929590103;932.5430539035857;934.8317302885478;916.6058594804232;920.0661328751323;920.5259291464901;920.6731610278355;921.0191146429065;963.0850691842743;964.4984608003833;965.0446058402166;965.4159233663638;966.1884017425361;948.5067764762285;958.8322043642335;959.1942768074816;959.3859929645033;959.7168835193635;701.9681068828864;708.950373473857;709.2977951827705;709.4111887133666;709.5033476566424;12709.809352859715;12775.61673149807;12778.361081945866;12790.488380464863;12800.80798788019;12392.81410778839;12435.502579896793;12437.875621243762;12695.365231738468;13169.078164528486;11239.662810115628;11351.772964540663;11408.486618102206;11537.826932596017;11747.060235181165;4022.2357752027315;4040.373742069984;4043.97978010111;4058;4073.205724883649;55774.16338754922;56619.71690141564;56751.432485675025;56766.14850777283;56893.999999999585;9936.552855121538;10062.597496100221;10190.745231369126;10218.029287217703;10259.897401026043;19371.578552680916;19613.50966225856;19729;19760.20959161646;19769.703454448194;8535.189157030072;8721.651133954698;8821.647134114692;8839.955800220958;8896.288296936229;4745.525447455227;4783.904321913542;4836.564709176191;4850.514948505192;5107.106256405114;3619.1675914539805;3679.521662183899;3684.9263014739554;3685.336639404933;3689.4834723138783;697.9371856532834;706.9222385537587;711.661960568736;712.7540998355663;718.9388901943289;681.0941447874415;720.5424555407354;731.2869951796955;761.6191904047976;773.1147835728173;8997.505137217386;9093.636254549743;9160.992290848002;9189.724308270763;9216.354855160209;674.2280089297726;749.5277974875794;749.7825630567183;760.8250102476461;764.1327093748636;4227.7463352198965;4271.380649805761;4490.910181796346;4697.201475749131;4744.644151688637;68138.65930670315;68606;68741.3125868735;68788.3121168792;68838;44133.11733765371;56994.99999999917;57077;58710;60600.39399606036;41755.58244417517;48302.51697483121;49127;49602.255966160534;50125.24812127821;9829.115379615869;10171;10182.694519164437;10231.539580719034;10310.43292618913;38328.42507362336;38682;39053.8047309773;39522;40388;45857.77071114623;48243.27635085547;48578;49136.2629560564;49376;13009.154404963647;13034.934825325812;13042.54351097707;13167.53913613019;13327.200367977952;14108.365123569669;14242.430302787772;14248.430062797786;14289.28553572338;14694.63263418423;12426.75146497083;13478.460861565427;13855.722885542435;13969.092009019381;14170.149791012573;12262.632121036384;12565.43455544521;12621.05342099328;13497.122687025312;13547.119437236548;13796.103253288504;13810.585682429542;13850;13905.374258158205;13982;11102.444877756241;11122.388268645302;11122.96175768781;11141.387223702774;11764.294142351486;10865.293755905841;11035.724106897393;11102.500387482743;11208.383538905438;11336.412902193535 11:27:16 INFO - PROCESS | 5494 | __end_tp_report 11:27:16 INFO - PROCESS | 5494 | __start_cc_report 11:27:16 INFO - PROCESS | 5494 | _x_x_mozilla_cycle_collect,834 11:27:16 INFO - PROCESS | 5494 | __end_cc_report 11:27:16 INFO - PROCESS | 5494 | __startTimestamp1465237636140__endTimestamp 11:27:16 INFO - PROCESS | 5494 | 11:27:16 INFO - PROCESS | 5494 | ------- Summary: start ------- 11:27:16 INFO - PROCESS | 5494 | Number of tests: 6 11:27:16 INFO - PROCESS | 5494 | 11:27:16 INFO - PROCESS | 5494 | [#0] dojo.html Cycles:165 Average:5453.96 Median:5703.74 stddev:610.70 (10.7%) stddev-sans-first:587.74 11:27:16 INFO - PROCESS | 5494 | Values: 3256.3 3284.6 3285.0 3319.1 3330.9 5307.4 5312.2 5323.5 5355.9 5357.8 5341.0 5341.3 5348.5 5349.0 5364.9 4882.7 4935.2 4943.1 4994.2 5001.9 4884.7 4954.6 4989.5 4990.3 4990.3 4989.7 5010.3 5062.4 5070.1 5082.9 5012.4 5039.3 5050.3 5054.7 5086.5 4928.4 4956.8 4964.0 4969.3 5036.1 5303.5 5332.4 5342.7 5350.2 5357.7 5808.2 5865.3 5867.1 5868.4 5872.3 5903.9 5911.3 6021.8 6033.2 6057.8 5539.9 5561.3 5580.7 5587.7 5592.2 5905.3 6065.8 6080.1 6089.6 6091.8 5703.7 5775.9 5778.9 5780.3 5796.0 5862.0 5873.6 5876.9 5879.2 5902.1 5646.9 5826.2 5835.9 5839.5 5865.7 5893.2 5929.6 5933.8 5952.3 5982.4 4517.5 4526.8 4529.0 4530.2 4559.0 3942.6 3996.7 4013.1 4059.4 4107.0 5497.8 5517.5 5526.7 5527.8 5536.0 5806.0 5812.7 5815.9 5816.0 5822.0 5435.6 5453.9 5497.3 5508.2 5516.4 4999.6 5027.2 5027.6 5075.5 5075.8 6077.0 6085.5 6092.3 6093.3 6094.0 5703.0 5934.5 5983.9 5991.7 6006.7 6073.3 6152.6 6173.7 6181.5 6181.5 5677.7 5837.7 5840.7 5844.6 5851.0 5768.7 5816.5 5822.4 5842.7 5853.1 5700.7 5724.0 5726.1 5726.9 5727.3 5559.2 5716.5 5723.6 5729.5 5735.2 5704.9 5724.7 5726.0 5734.1 5763.5 5780.4 5835.8 5838.2 5839.7 5846.2 5488.1 5623.2 5709.1 5734.7 5746.7 11:27:16 INFO - PROCESS | 5494 | 11:27:16 INFO - PROCESS | 5494 | [#1] ext.html Cycles:180 Average:55067.89 Median:37426.94 stddev:103442.68 (276.4%) stddev-sans-first:103652.22 11:27:16 INFO - PROCESS | 5494 | Values: 665.4 669.1 676.8 680.4 690.4 35595.8 36150.6 40077.0 40535.0 40574.4 44138.1 44669.1 44684.0 44715.0 44733.1 8005.2 8894.0 9063.9 9094.2 10523.6 10585.8 10744.8 10747.0 10747.7 10747.9 10732.0 10787.8 10796.1 10799.6 10801.7 8243.7 8482.8 10522.0 10565.8 10699.6 10728.2 10839.7 10843.7 10855.1 10857.2 38581.6 39211.0 39287.2 39296.8 39323.8 3773.2 3791.1 3843.9 4064.4 4473.2 34216.5 34704.8 34790.3 34892.3 35204.8 4257.7 4310.8 4386.3 4392.9 4403.8 319091.0 322030.0 322083.0 323330.0 323369.0 40833.0 41422.4 67402.7 68070.3 68158.7 39341.4 39422.6 39539.2 39547.6 39568.4 17175.5 17337.6 17341.3 17352.7 17364.4 12829.8 14532.3 14670.1 14691.0 14701.6 9528.5 9545.5 9550.1 9590.8 9639.3 3696.6 3703.3 3725.5 3748.5 3765.5 1047.7 1092.4 1101.8 1129.5 1159.0 34371.0 34391.7 34638.7 35161.9 35410.8 1191.9 1194.8 1223.1 1243.6 1378.8 17639.7 17668.0 17905.5 17938.4 18143.8 500980.0 502998.0 503485.0 503829.0 506043.0 63562.4 65077.7 65177.3 65238.7 65377.0 1302.4 1490.1 1490.4 1518.8 1601.4 30515.8 31399.8 33540.2 33858.5 33968.3 51793.5 51808.7 52166.0 52183.5 52339.5 317646.0 319434.0 319956.0 321015.0 321043.0 28543.7 31657.4 31946.7 32180.5 32344.5 44032.6 49381.8 49417.8 49729.0 50579.7 40946.3 41413.0 42406.8 42879.6 43230.1 40317.6 40848.4 40967.2 41160.8 41762.4 42412.6 42702.4 42901.6 43222.0 43289.1 35290.8 37374.6 37479.3 37521.2 37613.0 29031.6 29200.4 29205.1 29227.7 29263.6 11:27:16 INFO - PROCESS | 5494 | 11:27:16 INFO - PROCESS | 5494 | [#2] jquery.html Cycles:180 Average:30153.48 Median:22491.39 stddev:85896.12 (381.9%) stddev-sans-first:86108.08 11:27:16 INFO - PROCESS | 5494 | Values: 429.1 430.9 441.3 443.6 451.1 18959.6 19211.9 19781.3 21363.4 21365.7 20189.7 20651.8 20801.9 20804.3 20816.8 5301.7 5586.5 5587.8 5595.7 5597.7 4097.8 5493.2 5570.1 5877.0 6201.1 6189.5 6205.1 6235.6 6236.9 6237.5 5989.9 6176.5 6225.3 6236.9 6242.3 3936.0 4107.6 5710.7 6052.8 6081.3 21833.7 22472.9 22509.9 22565.5 22719.3 2537.6 2548.5 2586.1 2799.9 2824.5 10606.9 11020.3 11142.8 13525.7 14319.0 2057.5 2063.5 2069.9 2113.5 2118.5 78581.0 80958.6 82482.6 82980.2 83068.2 11346.3 11495.6 11653.9 11676.9 11692.7 16412.6 16473.2 16481.1 16503.9 16538.4 8812.9 8957.6 8958.8 9024.5 9092.3 8785.4 8795.3 8855.1 8943.2 8956.8 4990.9 5071.5 5076.2 5152.7 5167.6 1796.7 2017.5 2029.6 2103.9 2117.6 966.6 1014.3 1050.6 1081.9 1147.2 18025.5 18825.4 19023.2 19699.1 19792.3 1007.6 1015.4 1034.7 1061.5 1072.0 10321.4 10945.2 10977.2 11084.4 11089.7 505879.0 511794.0 521784.0 532884.0 539505.0 89492.0 90121.5 90580.5 91075.5 91651.5 1012.5 1024.4 1037.6 1038.2 1049.9 17006.7 17160.9 17320.3 17442.4 17584.6 39185.4 39397.8 39489.0 40268.8 41080.8 57660.0 57768.4 58425.8 58711.4 58949.7 8641.1 8951.4 9091.9 9157.6 9222.3 11727.8 13118.4 13610.6 13737.1 13777.4 11592.0 11925.0 12046.8 12117.6 12139.5 11696.9 12162.5 12211.8 12272.6 12764.1 12080.7 12694.6 12704.4 12766.0 12884.5 8766.5 9017.6 9149.1 9244.0 9343.7 12064.9 12159.9 12211.2 12235.1 12321.0 11:27:16 INFO - PROCESS | 5494 | 11:27:16 INFO - PROCESS | 5494 | [#3] mootools.html Cycles:180 Average:5596.00 Median:4800.75 stddev:3075.57 (64.1%) stddev-sans-first:3067.97 11:27:16 INFO - PROCESS | 5494 | Values: 1393.0 1556.6 1558.1 1748.5 1907.6 7973.2 8177.0 8193.8 8194.3 8201.9 8016.6 8183.2 8194.8 8195.2 8199.6 2091.2 2141.0 2281.2 2362.0 2386.7 2377.7 2384.0 2386.6 2388.0 2395.8 2293.8 2311.9 2329.5 2412.0 2423.3 2066.0 2306.2 2356.5 2357.1 2358.6 2342.7 2372.6 2375.1 2376.7 2377.1 8052.6 8068.5 8102.4 8104.6 8112.3 5109.8 5224.6 5229.8 5232.6 5234.4 3348.8 3361.1 3501.1 3541.1 3541.9 1095.1 1128.7 1140.9 1172.6 1176.6 12351.2 12356.9 12381.9 12387.1 12389.8 4526.4 4582.8 4605.7 4624.8 4628.1 10374.2 10384.7 10418.1 10462.6 10467.4 5342.8 5344.5 5345.4 5348.5 5355.0 4312.2 4703.5 4798.0 4859.0 4923.4 4003.7 4041.4 4080.7 4106.4 4147.1 1326.4 1326.9 1330.6 1331.8 1348.1 1027.7 1027.7 1033.4 1047.2 1058.7 5693.8 5729.9 5770.7 5959.4 6030.2 978.8 1046.9 1048.9 1070.6 1095.9 3954.4 3981.6 3997.9 4006.9 4030.2 9871.6 10188.2 10241.6 10246.6 10257.5 10083.4 10107.5 10350.8 10352.4 10381.4 7920.9 8165.3 8181.4 8202.4 8211.6 5857.2 5917.1 5952.8 5964.1 6016.2 8765.0 8961.5 9026.1 9098.9 9114.4 9031.5 9205.1 9207.1 9208.7 9213.5 6829.1 7235.8 7400.9 7609.8 7710.2 7828.8 7858.8 7863.0 7897.1 7908.4 7090.3 7244.6 7268.3 7354.9 7391.4 7167.0 7199.6 7238.4 7260.7 7275.1 6869.6 6874.1 6933.8 6938.9 6941.3 4803.5 4805.5 4847.3 4954.2 5003.3 4951.8 4978.6 5007.4 5050.4 5052.2 11:27:16 INFO - PROCESS | 5494 | 11:27:16 INFO - PROCESS | 5494 | [#4] prototype.html Cycles:180 Average:5500.66 Median:6290.56 stddev:1657.09 (26.3%) stddev-sans-first:1616.16 11:27:16 INFO - PROCESS | 5494 | Values: 358.5 359.5 367.1 369.0 373.5 6182.4 6183.6 6183.8 6230.8 6295.5 6151.1 6152.7 6155.4 6172.0 6191.5 4522.8 4628.0 4711.7 4716.3 4734.0 4712.1 4720.9 4722.6 4744.4 4755.8 4503.9 4707.6 4713.5 4716.6 4717.9 4586.4 4592.1 4630.4 4665.6 4672.1 4088.0 4092.9 4112.9 4115.9 4117.8 5891.9 5893.7 5908.5 5911.4 5913.8 5418.3 5423.9 5427.6 5428.9 5433.0 6422.6 6433.6 6435.3 6442.8 6445.5 4434.5 4546.1 4549.8 4568.3 4573.9 6629.5 6740.2 6747.7 6748.0 6757.0 4729.1 4729.7 4731.7 4732.1 4735.9 4792.3 4808.1 4812.5 4815.2 4821.1 5489.5 5493.3 5494.5 5496.1 5505.4 6434.9 6556.7 6569.3 6572.9 6580.6 1691.8 1698.9 1711.9 1712.0 1713.0 1061.7 1116.3 1122.2 1143.8 1149.2 6274.1 6350.8 6362.8 6368.6 6379.7 6820.6 6825.4 6833.4 6835.6 6838.5 6418.9 6419.1 6427.0 6436.9 6441.4 3623.6 3649.6 3664.1 3672.5 3676.9 6931.0 7054.0 7090.8 7094.4 7100.1 6884.7 6887.1 6899.0 6899.8 6908.6 7052.9 7071.5 7088.5 7089.4 7090.3 6734.3 6784.2 6794.2 6796.5 6803.1 6484.4 6681.2 6722.0 6723.6 6776.5 7141.6 7157.6 7157.9 7160.9 7163.7 4651.5 4700.1 4708.2 4712.8 4715.2 6784.2 6788.3 6788.6 6800.2 6800.6 6343.4 6593.5 6608.2 6609.2 6612.8 6539.7 6585.0 6591.0 6593.2 6593.4 6471.7 6476.6 6479.3 6483.1 6483.8 6613.6 6617.1 6624.3 6627.9 6631.7 6285.7 6412.0 6426.4 6471.6 6476.5 11:27:16 INFO - PROCESS | 5494 | 11:27:16 INFO - PROCESS | 5494 | [#5] yui.html Cycles:180 Average:15411.48 Median:24202.25 stddev:17939.44 (74.1%) stddev-sans-first:17956.41 11:27:16 INFO - PROCESS | 5494 | Values: 844.8 945.1 946.1 948.0 960.8 14760.2 15053.4 15061.3 15122.4 15148.5 13185.7 14381.3 14755.3 14816.6 14889.5 913.9 924.4 932.5 932.5 934.8 916.6 920.1 920.5 920.7 921.0 963.1 964.5 965.0 965.4 966.2 948.5 958.8 959.2 959.4 959.7 702.0 709.0 709.3 709.4 709.5 12709.8 12775.6 12778.4 12790.5 12800.8 12392.8 12435.5 12437.9 12695.4 13169.1 11239.7 11351.8 11408.5 11537.8 11747.1 4022.2 4040.4 4044.0 4058.0 4073.2 55774.2 56619.7 56751.4 56766.1 56894.0 9936.6 10062.6 10190.7 10218.0 10259.9 19371.6 19613.5 19729.0 19760.2 19769.7 8535.2 8721.7 8821.6 8840.0 8896.3 4745.5 4783.9 4836.6 4850.5 5107.1 3619.2 3679.5 3684.9 3685.3 3689.5 697.9 706.9 711.7 712.8 718.9 681.1 720.5 731.3 761.6 773.1 8997.5 9093.6 9161.0 9189.7 9216.4 674.2 749.5 749.8 760.8 764.1 4227.7 4271.4 4490.9 4697.2 4744.6 68138.7 68606.0 68741.3 68788.3 68838.0 44133.1 56995.0 57077.0 58710.0 60600.4 41755.6 48302.5 49127.0 49602.3 50125.2 9829.1 10171.0 10182.7 10231.5 10310.4 38328.4 38682.0 39053.8 39522.0 40388.0 45857.8 48243.3 48578.0 49136.3 49376.0 13009.2 13034.9 13042.5 13167.5 13327.2 14108.4 14242.4 14248.4 14289.3 14694.6 12426.8 13478.5 13855.7 13969.1 14170.1 12262.6 12565.4 12621.1 13497.1 13547.1 13796.1 13810.6 13850.0 13905.4 13982.0 11102.4 11122.4 11123.0 11141.4 11764.3 10865.3 11035.7 11102.5 11208.4 11336.4 11:27:16 INFO - PROCESS | 5494 | -------- Summary: end -------- 11:27:16 INFO - PROCESS | 5494 | 11:27:16 INFO - TEST-INFO | 5494: exit 0 11:27:16 INFO - TEST-OK | dromaeo_css | took 1111627ms 11:27:16 INFO - TEST-START | kraken 11:27:16 INFO - operating with platform_type : linux_ 11:27:16 INFO - Initialising browser for kraken test... 11:27:16 INFO - TEST-INFO | started process 5681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmdc1uY/profile http://localhost:37699/getInfo.html) 11:27:20 INFO - PROCESS | 5681 | __metrics Screen width/height:1600/1200 11:27:20 INFO - PROCESS | 5681 | colorDepth:24 11:27:20 INFO - PROCESS | 5681 | Browser inner width/height: 1024/697 11:27:20 INFO - PROCESS | 5681 | __metrics 11:27:21 ERROR - PROCESS | 5681 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:27:22 INFO - TEST-INFO | 5681: exit 0 11:27:22 INFO - Browser initialized. 11:27:22 INFO - Running cycle 1/1 for kraken test... 11:27:22 INFO - TEST-INFO | started process 5772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmdc1uY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:34 INFO - PROCESS | 5772 | RSS: Main: 142749696 11:27:34 INFO - PROCESS | 5772 | 11:27:37 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37699/tests/kraken/driver.html?testName=audio-beat-detection) 11:27:37 INFO - PROCESS | 5772 | RSS: Main: 199331840 11:27:37 INFO - PROCESS | 5772 | 11:27:40 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37699/tests/kraken/driver.html?testName=audio-dft) 11:27:41 INFO - PROCESS | 5772 | RSS: Main: 185069568 11:27:41 INFO - PROCESS | 5772 | 11:27:43 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37699/tests/kraken/driver.html?testName=audio-fft) 11:27:44 INFO - PROCESS | 5772 | RSS: Main: 273866752 11:27:44 INFO - PROCESS | 5772 | 11:27:46 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37699/tests/kraken/driver.html?testName=audio-oscillator) 11:27:47 INFO - PROCESS | 5772 | RSS: Main: 180576256 11:27:47 INFO - PROCESS | 5772 | 11:27:49 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37699/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:49 INFO - PROCESS | 5772 | RSS: Main: 178298880 11:27:49 INFO - PROCESS | 5772 | 11:27:52 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37699/tests/kraken/driver.html?testName=imaging-darkroom) 11:27:53 INFO - PROCESS | 5772 | RSS: Main: 213585920 11:27:53 INFO - PROCESS | 5772 | 11:27:56 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37699/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:57 INFO - PROCESS | 5772 | RSS: Main: 213544960 11:27:57 INFO - PROCESS | 5772 | 11:28:00 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37699/tests/kraken/driver.html?testName=json-parse-financial) 11:28:00 INFO - PROCESS | 5772 | RSS: Main: 213430272 11:28:00 INFO - PROCESS | 5772 | 11:28:02 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37699/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:28:02 INFO - PROCESS | 5772 | RSS: Main: 192024576 11:28:02 INFO - PROCESS | 5772 | 11:28:04 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37699/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:28:05 INFO - PROCESS | 5772 | RSS: Main: 195883008 11:28:05 INFO - PROCESS | 5772 | 11:28:07 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37699/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:28:07 INFO - PROCESS | 5772 | RSS: Main: 209702912 11:28:07 INFO - PROCESS | 5772 | 11:28:10 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:28:10 INFO - PROCESS | 5772 | RSS: Main: 218148864 11:28:10 INFO - PROCESS | 5772 | 11:28:13 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:28:14 INFO - PROCESS | 5772 | RSS: Main: 213037056 11:28:14 INFO - PROCESS | 5772 | 11:28:15 INFO - PROCESS | 5772 | Cycle 1(1): loaded http://localhost:37699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37699/tests/kraken/driver.html?testName=ai-astar) 11:28:16 INFO - PROCESS | 5772 | RSS: Main: 273276928 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | __start_tp_report 11:28:16 INFO - PROCESS | 5772 | _x_x_mozilla_page_load 11:28:16 INFO - PROCESS | 5772 | _x_x_mozilla_page_load_details 11:28:16 INFO - PROCESS | 5772 | |i|pagename|runs| 11:28:16 INFO - PROCESS | 5772 | |0;ai-astar;111;111;110;111;109;111;105;111;109;110 11:28:16 INFO - PROCESS | 5772 | |1;audio-beat-detection;159;124;156;196;137;155;159;133;186;134 11:28:16 INFO - PROCESS | 5772 | |2;audio-dft;160;162;161;162;159;159;161;159;159;159 11:28:16 INFO - PROCESS | 5772 | |3;audio-fft;76;76;73;169;76;76;76;76;167;83 11:28:16 INFO - PROCESS | 5772 | |4;audio-oscillator;93;92;157;92;92;93;154;94;93;149 11:28:16 INFO - PROCESS | 5772 | |5;imaging-gaussian-blur;116;117;116;117;117;116;118;117;116;117 11:28:16 INFO - PROCESS | 5772 | |6;imaging-darkroom;146;145;146;147;146;145;147;149;145;145 11:28:16 INFO - PROCESS | 5772 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;95;94 11:28:16 INFO - PROCESS | 5772 | |8;json-parse-financial;55;55;55;56;54;56;58;78;56;53 11:28:16 INFO - PROCESS | 5772 | |9;json-stringify-tinderbox;60;60;60;59;59;59;59;60;59;59 11:28:16 INFO - PROCESS | 5772 | |10;stanford-crypto-aes;71;72;71;73;72;80;80;72;72;81 11:28:16 INFO - PROCESS | 5772 | |11;stanford-crypto-ccm;117;113;115;110;113;113;113;112;141;126 11:28:16 INFO - PROCESS | 5772 | |12;stanford-crypto-pbkdf2;162;161;164;163;161;161;159;160;159;155 11:28:16 INFO - PROCESS | 5772 | |13;stanford-crypto-sha256-iterative;66;66;67;65;67;67;65;65;66;67 11:28:16 INFO - PROCESS | 5772 | __end_tp_report 11:28:16 INFO - PROCESS | 5772 | __start_cc_report 11:28:16 INFO - PROCESS | 5772 | _x_x_mozilla_cycle_collect,1625 11:28:16 INFO - PROCESS | 5772 | __end_cc_report 11:28:16 INFO - PROCESS | 5772 | __startTimestamp1465237696048__endTimestamp 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | ------- Summary: start ------- 11:28:16 INFO - PROCESS | 5772 | Number of tests: 14 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:1.87 (1.7%) stddev-sans-first:1.94 11:28:16 INFO - PROCESS | 5772 | Values: 111.0 111.0 110.0 111.0 109.0 111.0 105.0 111.0 109.0 110.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:157.50 stddev:23.27 (14.8%) stddev-sans-first:24.61 11:28:16 INFO - PROCESS | 5772 | Values: 159.0 124.0 156.0 196.0 137.0 155.0 159.0 133.0 186.0 134.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:1.29 (0.8%) stddev-sans-first:1.36 11:28:16 INFO - PROCESS | 5772 | Values: 160.0 162.0 161.0 162.0 159.0 159.0 161.0 159.0 159.0 159.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:38.66 (50.9%) stddev-sans-first:40.41 11:28:16 INFO - PROCESS | 5772 | Values: 76.0 76.0 73.0 169.0 76.0 76.0 76.0 76.0 167.0 83.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:92.50 stddev:29.35 (31.7%) stddev-sans-first:30.41 11:28:16 INFO - PROCESS | 5772 | Values: 93.0 92.0 157.0 92.0 92.0 93.0 154.0 94.0 93.0 149.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 11:28:16 INFO - PROCESS | 5772 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 118.0 117.0 116.0 117.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:1.29 (0.9%) stddev-sans-first:1.36 11:28:16 INFO - PROCESS | 5772 | Values: 146.0 145.0 146.0 147.0 146.0 145.0 147.0 149.0 145.0 145.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:28:16 INFO - PROCESS | 5772 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:56.00 stddev:7.29 (13.0%) stddev-sans-first:7.67 11:28:16 INFO - PROCESS | 5772 | Values: 55.0 55.0 55.0 56.0 54.0 56.0 58.0 78.0 56.0 53.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 11:28:16 INFO - PROCESS | 5772 | Values: 60.0 60.0 60.0 59.0 59.0 59.0 59.0 60.0 59.0 59.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:72.50 stddev:4.14 (5.7%) stddev-sans-first:4.21 11:28:16 INFO - PROCESS | 5772 | Values: 71.0 72.0 71.0 73.0 72.0 80.0 80.0 72.0 72.0 81.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:114.00 stddev:9.42 (8.3%) stddev-sans-first:9.99 11:28:16 INFO - PROCESS | 5772 | Values: 117.0 113.0 115.0 110.0 113.0 113.0 113.0 112.0 141.0 126.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.00 stddev:2.51 (1.6%) stddev-sans-first:2.60 11:28:16 INFO - PROCESS | 5772 | Values: 162.0 161.0 164.0 163.0 161.0 161.0 159.0 160.0 159.0 155.0 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - PROCESS | 5772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:0.88 (1.3%) stddev-sans-first:0.93 11:28:16 INFO - PROCESS | 5772 | Values: 66.0 66.0 67.0 65.0 67.0 67.0 65.0 65.0 66.0 67.0 11:28:16 INFO - PROCESS | 5772 | -------- Summary: end -------- 11:28:16 INFO - PROCESS | 5772 | 11:28:16 INFO - TEST-INFO | 5772: exit 0 11:28:16 INFO - TEST-OK | kraken | took 60131ms 11:28:16 INFO - SUITE-END | took 1171s 11:28:17 INFO - Completed test suite (00:19:31) 11:28:17 INFO - javascript benchmark 11:28:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.283617604127, 3284.6058472983245, 3285.030915879816, 3319.1038419626716, 3330.9167270818243, 5307.389650190229, 5312.203169524573, 5323.494268044529, 5355.892882142355, 5357.8392648220515, 5341.03861304965, 5341.30563026806, 5348.491893270143, 5349.0, 5364.892702145955, 4882.731449770261, 4935.185694360444, 4943.060818444502, 4994.225894986264, 5001.949590585981, 4884.705553028451, 4954.603631709455, 4989.476105008976, 4990.301357809892, 4990.30135780991, 4989.700617962916, 5010.298558201855, 5062.443131255559, 5070.112730272206, 5082.923756143661, 5012.373453318335, 5039.269305950654, 5050.318207042039, 5054.721990290533, 5086.542211200991, 4928.359313289286, 4956.752162391902, 4964.0, 4969.329140566049, 5036.093503169428, 5303.469653034705, 5332.3867755207875, 5342.706151161685, 5350.224217488481, 5357.651752636066, 5808.186853840466, 5865.266841644794, 5867.090600956859, 5868.413158684098, 5872.265966754156, 5903.881922361572, 5911.349751527328, 6021.849453763691, 6033.155358249848, 6057.848553786146, 5539.944600553983, 5561.277033985596, 5580.665160090408, 5587.692676902769, 5592.245046918695, 5905.261842269716, 6065.848353791191, 6080.0879868019265, 6089.604175728652, 6091.817245482643, 5703.74333155009, 5775.913361299584, 5778.855528611734, 5780.335261444903, 5795.971020144957, 5862.03276459388, 5873.559483038704, 5876.9118463223085, 5879.176915231871, 5902.1441890926435, 5646.858828529237, 5826.2134611827705, 5835.94164058354, 5839.532837373, 5865.677387743715, 5893.233879595625, 5929.644221346733, 5933.792317268875, 5952.255968003999, 5982.371850955674, 4517.480489743656, 4526.841560545431, 4528.980979279701, 4530.22986092365, 4558.9742307981105, 3942.64516193544, 3996.7402118862183, 4013.13717550728, 4059.3707975263883, 4107.014316564003, 5497.780088796403, 5517.503424691797, 5526.723663816793, 5527.839153777752, 5536.0, 5806.042003069446, 5812.651240925558, 5815.854603634858, 5816.0, 5822.0, 5435.592330575223, 5453.890922181614, 5497.340319161726, 5508.173773933861, 5516.365617953907, 4999.625028122905, 5027.170516864677, 5027.622928280393, 5075.467075956972, 5075.839006329897, 6077.027675571887, 6085.5435842312, 6092.268927728701, 6093.299270583851, 6094.024956007106, 5703.0, 5934.525237981037, 5983.880322393441, 5991.700414979321, 6006.699665016819, 6073.271207455134, 6152.600080994721, 6173.722182501709, 6181.505479561534, 6181.5363847710705, 5677.716114194356, 5837.708114594338, 5840.678762668094, 5844.620099693507, 5851.0, 5768.653880767168, 5816.534677225727, 5822.359540450631, 5842.707864606838, 5853.09277062056, 5700.657960522382, 5724.0, 5726.0838265877255, 5726.942730572641, 5727.31272247333, 5559.16612508127, 5716.514096301695, 5723.5707321950185, 5729.4843464088435, 5735.168400581976, 5704.9429505706075, 5724.742386592697, 5726.0, 5734.111212762028, 5763.538916886723, 5780.393058728773, 5835.79574714883, 5838.211841401527, 5839.7372118255635, 5846.210761547307, 5488.1493368527945, 5623.2408624835125, 5709.058005429058, 5734.741936612946, 5746.712664366682], "value": 5414.167776832767, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.3546060321489, 669.0833558025505, 676.7935779587224, 680.3876511139975, 690.4234963805229, 35595.82202088989, 36150.63849361506, 40077.0, 40535.0, 40574.39138412919, 44138.11723765523, 44669.10661786763, 44684.0, 44715.0, 44733.10533789322, 8005.199480051977, 8894.021657617674, 9063.909360906373, 9094.226990705798, 10523.579056837718, 10585.84121238182, 10744.838827417596, 10747.0, 10747.731306717316, 10747.946260268687, 10732.034116929475, 10787.83818242727, 10796.136309095253, 10799.622013229538, 10801.729956751065, 8243.670253189895, 8482.78793030173, 10522.0, 10565.78868422631, 10699.572017119384, 10728.195385346131, 10839.729006774895, 10843.67468975932, 10855.131589472901, 10857.185711071623, 38581.61418385808, 39211.0, 39287.214255715015, 39296.80351598252, 39323.803380982914, 3773.226488569864, 3791.052236940765, 3843.903902402434, 4064.4309796628495, 4473.172463094305, 34216.48675269873, 34704.82647586771, 34790.30419391598, 34892.30215395703, 35204.823975880216, 4257.723247988871, 4310.806013729359, 4386.254336762758, 4392.934105988413, 4403.779811009469, 319091.0, 322030.0, 322083.0, 323330.0, 323369.0, 40832.9999999994, 41422.37866432006, 67402.66298668475, 68070.31929680739, 68158.65920670365, 39341.40987885184, 39422.60577394189, 39539.20921581552, 39547.60452395497, 39568.40647390291, 17175.484735457958, 17337.56656083583, 17341.306347745947, 17352.65294694099, 17364.39224627132, 12829.807552886714, 14532.273386330853, 14670.119792812466, 14691.0, 14701.55895323142, 9528.475933823567, 9545.52272386378, 9550.140487356033, 9590.760230994281, 9639.277054220962, 3696.5748938871834, 3703.3148867459604, 3725.4598083277774, 3748.5126933499014, 3765.5104836371097, 1047.6804574604819, 1092.3882625729616, 1101.823708206683, 1129.5481807277156, 1158.9743077376413, 34371.0, 34391.656083439346, 34638.653613463546, 35161.85403187083, 35410.822945885106, 1191.9284842909453, 1194.7610477904454, 1223.1010207497661, 1243.5585367194697, 1378.8138601288697, 17639.73540396895, 17668.0, 17905.462836114937, 17938.372156974445, 18143.818561814478, 500980.0, 502998.0, 503485.0, 503829.0, 506043.0, 63562.36437635565, 65077.67461162758, 65177.34822651808, 65238.673806630664, 65377.0, 1302.3553341096217, 1490.0984904132843, 1490.3591455673948, 1518.8025556677562, 1601.4394961763523, 30515.847420762755, 31399.84300078485, 33540.1614959628, 33858.49212261769, 33968.32063358768, 51793.482065180375, 51808.740956294976, 52166.0, 52183.478165217864, 52339.47660523346, 317646.0, 319434.0, 319956.0, 321015.0, 321043.0, 28543.714562854937, 31657.36685266328, 31946.68053319437, 32180.517292240165, 32344.514832277066, 44032.559674404125, 49381.75309123431, 49417.752911236654, 49729.0, 50579.747101264256, 40946.272170461, 41413.0, 42406.78796605997, 42879.571204288804, 43230.135397292506, 40317.59682403138, 40848.38727419032, 40967.1806563873, 41160.79419602883, 41762.37356439717, 42412.575874242095, 42702.35946460868, 42901.570984289756, 43222.0, 43289.134217314844, 35290.82354588211, 37374.626253737115, 37479.25041499209, 37521.24957500889, 37613.0, 29031.56452653254, 29200.41599168047, 29205.123846284645, 29227.7077229225, 29263.56104658389], "value": 19865.942162887957, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.0897308124721, 430.8685850815501, 441.25868540851366, 443.6273530234602, 451.09105153116496, 18959.62080758384, 19211.903940480297, 19781.307654232103, 21363.359099227007, 21365.67951480729, 20189.697154542693, 20651.793482065175, 20801.895990520024, 20804.271850485235, 20816.791832081675, 5301.7084060376665, 5586.497215250627, 5587.832365029056, 5595.720213989304, 5597.692126933017, 4097.836086556535, 5493.176023596472, 5570.136628822539, 5876.970615146918, 6201.131841542187, 6189.473894718954, 6205.131281620576, 6235.594686345373, 6236.937630623681, 6237.532185086114, 5989.9101513477335, 6176.505879529627, 6225.346338634424, 6236.875262494747, 6242.344553821874, 3935.980320098381, 4107.568705285962, 5710.657360558338, 6052.757889684407, 6081.270247570275, 21833.67249491259, 22472.88763556188, 22509.88745056264, 22565.54868902629, 22719.318420447413, 2537.619357096432, 2548.5285222233947, 2586.1336452288506, 2799.9440011199868, 2824.4633519631207, 10606.893931060667, 11020.283681560673, 11142.832857507145, 13525.729485410335, 14319.0, 2057.5370541628163, 2063.515073957619, 2069.855110142291, 2113.4610674278115, 2118.5339225370394, 78581.0, 80958.59520702418, 82482.58758706228, 82980.17019829784, 83068.16931830665, 11346.319220846775, 11495.585926955266, 11653.88346116545, 11676.94161529187, 11692.655344635306, 16412.589685257964, 16473.176341183134, 16481.093539855425, 16503.91748041252, 16538.421155259508, 8812.8678069829, 8957.552122393854, 8958.776030599156, 9024.503652299056, 9092.318076144316, 8785.428947118417, 8795.340349473687, 8855.114488551222, 8943.150400711922, 8956.776080598038, 4990.900181996412, 5071.492850714899, 5076.162433198481, 5152.690838549699, 5167.560757335594, 1796.7373747724637, 2017.465371676507, 2029.5839352932614, 2103.9263625773024, 2117.618828610865, 966.5988614724811, 1014.3102690170607, 1050.5955207245265, 1081.8918108189118, 1147.2026941275733, 18025.459236222934, 18825.435236942914, 19023.239070437303, 19699.11353989074, 19792.307269245506, 1007.5516395204211, 1015.421209910344, 1034.7206254311293, 1061.5010944855906, 1072.0, 10321.432321222404, 10945.179111566664, 10977.176711746652, 11084.445777711082, 11089.722756931142, 505879.0, 511794.0, 521784.0, 532884.0, 539505.0, 89492.0, 90121.54939225393, 90580.54709726409, 91075.54462227646, 91651.54174229086, 1012.5291739341242, 1024.4416792847917, 1037.5590374090982, 1038.2161468091542, 1049.9212559057949, 17006.659866802842, 17160.914195429443, 17320.30718771235, 17442.389516366868, 17584.56038599045, 39185.41221881731, 39397.80301098476, 39489.0, 40268.79865600653, 41080.794596026826, 57660.0, 57768.422315776304, 58425.831483370945, 58711.412885870595, 58949.70525147347, 8641.135886411308, 8951.373403861668, 9091.909080909107, 9157.587908544265, 9222.308326875376, 11727.76544469123, 13118.409671564612, 13610.59168224955, 13737.107088039245, 13777.380017899419, 11592.0, 11925.0, 12046.819297710717, 12117.636470905887, 12139.453724582238, 11696.87066991818, 12162.513499459923, 12211.844197138385, 12272.631821045383, 12764.106512544033, 12080.697982550506, 12694.619161425171, 12704.428300726675, 12766.0, 12884.484620615445, 8766.474011559327, 9017.639294428413, 9149.130832570896, 9243.953780231324, 9343.71968840936, 12064.939675301568, 12159.939200303941, 12211.206271592673, 12235.143539952474, 12321.0], "value": 9598.578602990541, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.0318428692062, 1556.5719427157533, 1558.0963041435969, 1748.484197161837, 1907.6184763047395, 7973.202679732031, 8176.95911520443, 8193.836123277531, 8194.262516373525, 8201.91798082019, 8016.599170041489, 8183.222593853589, 8194.83610327793, 8195.22145396188, 8199.631016604253, 2091.184438069154, 2140.967885481711, 2281.2129815213807, 2361.9881900590517, 2386.72552656445, 2377.7146742390937, 2384.0, 2386.606209975361, 2388.032846697082, 2395.784379405853, 2293.827962902789, 2311.93064208074, 2329.499157681098, 2412.0351859256352, 2423.297243799296, 2065.979340206594, 2306.1813056365086, 2356.516914032636, 2357.1396440299254, 2358.646203069536, 2342.672025916373, 2372.5729368713623, 2375.133076427109, 2376.714794224687, 2377.108584280895, 8052.637631306605, 8068.47554908929, 8102.39232057598, 8104.594770261463, 8112.269895709414, 5109.846704598831, 5224.63427560071, 5229.764660590245, 5232.633715639907, 5234.42421333653, 3348.7823291485975, 3361.109306033903, 3501.1422201560526, 3541.11472131967, 3541.9114522136897, 1095.0746619106842, 1128.6670432222513, 1140.9144314176388, 1172.6188988578747, 1176.605837044591, 12351.19717218378, 12356.938215308955, 12381.93809030958, 12387.132900696955, 12389.75220495585, 4526.411566496335, 4582.77086145698, 4605.723656580616, 4624.815007399734, 4628.120657075145, 10374.22193335503, 10384.740381490523, 10418.114460270961, 10462.581496740046, 10467.371957682564, 5342.759575819097, 5344.465553444702, 5345.438728933484, 5348.491893270133, 5354.973225133849, 4312.245357062501, 4703.529647035338, 4798.0, 4858.955324605156, 4923.359963204761, 4003.719739618257, 4041.393790931325, 4080.7143499955314, 4106.3635136553885, 4147.149834283965, 1326.4495234477777, 1326.8872145867517, 1330.647378444713, 1331.8202042724301, 1348.110247236819, 1027.7379268286688, 1027.7430642339416, 1033.4006276359694, 1047.2302857399804, 1058.7459009837582, 5693.829185124453, 5729.914051289234, 5770.682612456271, 5959.404059594092, 6030.246219222598, 978.7650963768644, 1046.853440518328, 1048.9143736232961, 1070.6092276319087, 1095.90684791792, 3954.387070004154, 3981.5620281768984, 3997.900052498711, 4006.899827504336, 4030.1738143680477, 9871.60513579463, 10188.184945204366, 10241.590336386611, 10246.590136394461, 10257.538410771533, 10083.445410502347, 10107.545160467796, 10350.792984140426, 10352.378857268588, 10381.377117372982, 7920.881186782203, 8165.265126138676, 8181.386396020203, 8202.425830191829, 8211.630476628567, 5857.209276747755, 5917.082852157922, 5952.791652292149, 5964.105384192406, 6016.2479690038745, 8765.0, 8961.50711710836, 9026.097390260922, 9098.863517047383, 9114.40756350835, 9031.548422578713, 9205.125513076247, 9207.125323094295, 9208.677696280598, 9213.493257870881, 6829.112215412163, 7235.819104522429, 7400.851982960418, 7609.771706848804, 7710.228977102245, 7828.804279893048, 7858.764237072897, 7862.960685196537, 7897.091834439113, 7908.406869484927, 7090.290970903075, 7244.565326080452, 7268.27317268269, 7354.889676654748, 7391.445641576795, 7167.0, 7199.568025918462, 7238.384737297178, 7260.67326970277, 7275.12698476165, 6869.587824730532, 6874.106366172366, 6933.791986240421, 6938.895916561155, 6941.34057264559, 4803.495632958489, 4805.471398146271, 4847.272909063528, 4954.157793175241, 5003.274525193754, 4951.801927922987, 4978.626603004716, 5007.424146223086, 5050.368703912011, 5052.216906379517], "value": 4564.555827363351, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.50168266110114, 359.50388463919785, 367.09877251347945, 368.9686376657984, 373.53867973053275, 6182.350853160421, 6183.567150299481, 6183.81448556544, 6230.813075607728, 6295.464885484739, 6151.138840562325, 6152.692365381724, 6155.384461553843, 6171.969140154304, 6191.4737247333915, 4522.8417005404735, 4627.953720462786, 4711.740854253015, 4716.292556116576, 4733.976330118362, 4712.128256272584, 4720.90558188836, 4722.5513576210205, 4744.4069491313585, 4755.762211889409, 4503.864884053483, 4707.552782485658, 4713.457952335491, 4716.551927566876, 4717.905641887178, 4586.3808385867815, 4592.1045396147765, 4630.37489938859, 4665.556772106678, 4672.0889426561835, 4088.0393107619684, 4092.856750013735, 4112.876613701564, 4115.938260926088, 4117.814698338582, 5891.911621325684, 5893.675847828367, 5908.527317814564, 5911.379305172938, 5913.763449462016, 5418.29562156921, 5423.945760542383, 5427.647202931837, 5428.891422171534, 5433.022056029913, 6422.6467544285515, 6433.613983160979, 6435.292117867031, 6442.806715798533, 6445.484361251136, 4434.49003364614, 4546.090781843644, 4549.840755573539, 4568.291914753218, 4573.931391029138, 6629.469642428594, 6740.157480314961, 6747.730090796363, 6747.966260168668, 6757.020232066323, 4729.0541891621815, 4729.6689231754135, 4731.716097034189, 4732.053589282157, 4735.881602959954, 4792.329073929653, 4808.110499557593, 4812.542808433193, 4815.22956326986, 4821.108095002365, 5489.533389661844, 5493.313335833021, 5494.478024587737, 5496.065668836308, 5505.394406615269, 6434.871302573923, 6556.737730490822, 6569.343065693392, 6572.901406478906, 6580.5722628029025, 1691.8308169183229, 1698.9490315290313, 1711.9315227390764, 1711.9828801711824, 1712.9657406851793, 1061.6655753437642, 1116.3134672176552, 1122.1976286954866, 1143.8398624192619, 1149.230015889356, 6274.05889116627, 6350.8412289692205, 6362.777302794472, 6368.554201205871, 6379.744810207632, 6820.624865632438, 6825.419839313714, 6833.350831670983, 6835.58986460814, 6838.452923766087, 6418.935810641927, 6419.101325814389, 6427.0076276354475, 6436.903446448307, 6441.420272175433, 3623.583287921923, 3649.59854416014, 3664.0839790052487, 3672.485851980725, 3676.852925882935, 6930.965345173343, 7054.0, 7090.7945649239755, 7094.361507464353, 7100.076989991268, 6884.65576721162, 6887.139107611549, 6899.0, 6899.827504312432, 6908.5509441887125, 7052.894206586905, 7071.469639777038, 7088.468364872655, 7089.361957423856, 7090.326418990291, 6734.292899245509, 6784.185897692111, 6794.184697836094, 6796.524243303119, 6803.115594972622, 6484.383983521558, 6681.164854393201, 6721.966390168213, 6723.630200338833, 6776.491763117688, 7141.571505709674, 7157.57054576727, 7157.856842863218, 7160.928390716026, 7163.749268775777, 4651.534846515321, 4700.130475861976, 4708.223143181337, 4712.7643617818285, 4715.22198837188, 6784.151981002375, 6788.253292137762, 6788.558743681645, 6800.183977922681, 6800.625965571941, 6343.429091381798, 6593.538452308292, 6608.173978252718, 6609.20689517261, 6612.768553100618, 6539.673016349258, 6584.967075164594, 6591.011348297794, 6593.241777195684, 6593.406593406617, 6471.708773105316, 6476.6114033158165, 6479.319671434431, 6483.059956306215, 6483.7730679425995, 6613.570117942319, 6617.139771829631, 6624.337566243337, 6627.867442651216, 6631.701573429304, 6285.654289013965, 6412.038194270896, 6426.42162205385, 6471.579347342407, 6476.514261430318], "value": 4969.002164523938, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.8014716541612, 945.1352012908189, 946.1484663802581, 947.9526023698813, 960.7838236396807, 14760.188189649565, 15053.397864085437, 15061.32224049919, 15122.395104195819, 15148.545543633682, 13185.736285274288, 14381.280935953213, 14755.336009879555, 14816.55550333489, 14889.478868239614, 913.9451632902014, 924.3806649544821, 932.4684929590103, 932.5430539035857, 934.8317302885478, 916.6058594804232, 920.0661328751323, 920.5259291464901, 920.6731610278355, 921.0191146429065, 963.0850691842743, 964.4984608003833, 965.0446058402166, 965.4159233663638, 966.1884017425361, 948.5067764762285, 958.8322043642335, 959.1942768074816, 959.3859929645033, 959.7168835193635, 701.9681068828864, 708.950373473857, 709.2977951827705, 709.4111887133666, 709.5033476566424, 12709.809352859715, 12775.61673149807, 12778.361081945866, 12790.488380464863, 12800.80798788019, 12392.81410778839, 12435.502579896793, 12437.875621243762, 12695.365231738468, 13169.078164528486, 11239.662810115628, 11351.772964540663, 11408.486618102206, 11537.826932596017, 11747.060235181165, 4022.2357752027315, 4040.373742069984, 4043.97978010111, 4058.0, 4073.205724883649, 55774.16338754922, 56619.71690141564, 56751.432485675025, 56766.14850777283, 56893.999999999585, 9936.552855121538, 10062.597496100221, 10190.745231369126, 10218.029287217703, 10259.897401026043, 19371.578552680916, 19613.50966225856, 19729.0, 19760.20959161646, 19769.703454448194, 8535.189157030072, 8721.651133954698, 8821.647134114692, 8839.955800220958, 8896.288296936229, 4745.525447455227, 4783.904321913542, 4836.564709176191, 4850.514948505192, 5107.106256405114, 3619.1675914539805, 3679.521662183899, 3684.9263014739554, 3685.336639404933, 3689.4834723138783, 697.9371856532834, 706.9222385537587, 711.661960568736, 712.7540998355663, 718.9388901943289, 681.0941447874415, 720.5424555407354, 731.2869951796955, 761.6191904047976, 773.1147835728173, 8997.505137217386, 9093.636254549743, 9160.992290848002, 9189.724308270763, 9216.354855160209, 674.2280089297726, 749.5277974875794, 749.7825630567183, 760.8250102476461, 764.1327093748636, 4227.7463352198965, 4271.380649805761, 4490.910181796346, 4697.201475749131, 4744.644151688637, 68138.65930670315, 68606.0, 68741.3125868735, 68788.3121168792, 68838.0, 44133.11733765371, 56994.99999999917, 57077.0, 58710.0, 60600.39399606036, 41755.58244417517, 48302.51697483121, 49127.0, 49602.255966160534, 50125.24812127821, 9829.115379615869, 10171.0, 10182.694519164437, 10231.539580719034, 10310.43292618913, 38328.42507362336, 38682.0, 39053.8047309773, 39522.0, 40388.0, 45857.77071114623, 48243.27635085547, 48578.0, 49136.2629560564, 49376.0, 13009.154404963647, 13034.934825325812, 13042.54351097707, 13167.53913613019, 13327.200367977952, 14108.365123569669, 14242.430302787772, 14248.430062797786, 14289.28553572338, 14694.63263418423, 12426.75146497083, 13478.460861565427, 13855.722885542435, 13969.092009019381, 14170.149791012573, 12262.632121036384, 12565.43455544521, 12621.05342099328, 13497.122687025312, 13547.119437236548, 13796.103253288504, 13810.585682429542, 13850.0, 13905.374258158205, 13982.0, 11102.444877756241, 11122.388268645302, 11122.96175768781, 11141.387223702774, 11764.294142351486, 10865.293755905841, 11035.724106897393, 11102.500387482743, 11208.383538905438, 11336.412902193535], "value": 7111.368546657153, "unit": "score"}], "name": "dromaeo_css", "value": 7417.394650355877, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 111.0, 109.0, 111.0, 105.0, 111.0, 109.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 156.0, 196.0, 137.0, 155.0, 159.0, 133.0, 186.0, 134.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 162.0, 159.0, 159.0, 161.0, 159.0, 159.0, 159.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 73.0, 169.0, 76.0, 76.0, 76.0, 76.0, 167.0, 83.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 157.0, 92.0, 92.0, 93.0, 154.0, 94.0, 93.0, 149.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 118.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 147.0, 149.0, 145.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 54.0, 56.0, 58.0, 78.0, 56.0, 53.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 73.0, 72.0, 80.0, 80.0, 72.0, 72.0, 81.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 115.0, 110.0, 113.0, 113.0, 113.0, 112.0, 141.0, 126.0], "value": 117.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 163.0, 161.0, 161.0, 159.0, 160.0, 159.0, 155.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 65.0, 67.0, 67.0, 65.0, 65.0, 66.0, 67.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1522.3, "alertThreshold": 2.0}]} 11:28:17 INFO - Return code: 0 11:28:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:28:17 ERROR - # TBPL SUCCESS # 11:28:17 INFO - Running post-action listener: _resource_record_post_action 11:28:17 INFO - Running post-run listener: _resource_record_post_run 11:28:18 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 243720192; Read time: 20; Write time: 120364 11:28:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 491520; Read time: 0; Write time: 52 11:28:18 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 243228672; Read time: 20; Write time: 120312 11:28:18 INFO - Running post-run listener: _upload_blobber_files 11:28:18 INFO - Blob upload gear active. 11:28:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:28:18 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 11:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:28:18 INFO - (blobuploader) - INFO - Open directory for files ... 11:28:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:28:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:28:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:19 INFO - (blobuploader) - INFO - Done attempting. 11:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:28:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:20 INFO - (blobuploader) - INFO - Done attempting. 11:28:20 INFO - (blobuploader) - INFO - Iteration through files over. 11:28:20 INFO - Return code: 0 11:28:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:28:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:28:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1fa797ea34485077048eb8c246d9a7505e050b42b931a227b25dd66386c00f680985460bad8c00ea010a8595e43838ee4631c923c9a48a0bd74b768b0982844", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db3ff9ee230a4de86dd028b145f774e7ed6e6bfc2deffc543fc2f1474577d6e526302289908fc7968843613b67b9e22c07b38cc74211fe4740d497ca4396ae49"} 11:28:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:28:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:28:20 INFO - Contents: 11:28:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1fa797ea34485077048eb8c246d9a7505e050b42b931a227b25dd66386c00f680985460bad8c00ea010a8595e43838ee4631c923c9a48a0bd74b768b0982844", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db3ff9ee230a4de86dd028b145f774e7ed6e6bfc2deffc543fc2f1474577d6e526302289908fc7968843613b67b9e22c07b38cc74211fe4740d497ca4396ae49"} 11:28:20 INFO - Running post-run listener: copy_logs_to_upload_dir 11:28:20 INFO - Copying logs to upload dir... 11:28:20 INFO - mkdir: /builds/slave/test/build/upload/logs 11:28:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.642829 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-06 11:28:20.415196) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 11:28:20.419020) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1fa797ea34485077048eb8c246d9a7505e050b42b931a227b25dd66386c00f680985460bad8c00ea010a8595e43838ee4631c923c9a48a0bd74b768b0982844", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db3ff9ee230a4de86dd028b145f774e7ed6e6bfc2deffc543fc2f1474577d6e526302289908fc7968843613b67b9e22c07b38cc74211fe4740d497ca4396ae49"} build_url:https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011479 build_url: 'https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1fa797ea34485077048eb8c246d9a7505e050b42b931a227b25dd66386c00f680985460bad8c00ea010a8595e43838ee4631c923c9a48a0bd74b768b0982844", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db3ff9ee230a4de86dd028b145f774e7ed6e6bfc2deffc543fc2f1474577d6e526302289908fc7968843613b67b9e22c07b38cc74211fe4740d497ca4396ae49"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 11:28:20.447967) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:28:20.448579) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465236466.688106-1568597455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:28:20.530801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 11:28:20.531167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 11:28:20.531514) ========= ========= Total master_lag: 0.18 =========