builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1468459097.96 results: success (0) buildid: 20160713152943 builduid: 9d35a485de594b2897a64d1d4b1556c1 revision: f8051a3ef4ec5842689306cc3d7b22a6ec439c9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:17.962810) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:17.963203) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:17.963494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:17.978590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:17.978852) ========= 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=8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 18:18:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-07-13 18:18:18 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:18.114926) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:18.115216) ========= 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=8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020497 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:18.163862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:18.164191) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f8051a3ef4ec5842689306cc3d7b22a6ec439c9a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f8051a3ef4ec5842689306cc3d7b22a6ec439c9a --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=8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 18:18:18,300 truncating revision to first 12 chars 2016-07-13 18:18:18,300 Setting DEBUG logging. 2016-07-13 18:18:18,300 attempt 1/10 2016-07-13 18:18:18,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f8051a3ef4ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 18:18:18,639 unpacking tar archive at: mozilla-beta-f8051a3ef4ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701584 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:18.878780) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:18.879073) ========= script_repo_revision: f8051a3ef4ec5842689306cc3d7b22a6ec439c9a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:18.879497) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:18.879774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 18:18:18.890226) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-13 18:18:18.890521) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:18:19 INFO - MultiFileLogger online at 20160713 18:18:19 in /builds/slave/test 18:18:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 18:18:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:19 INFO - {'append_to_log': False, 18:18:19 INFO - 'base_work_dir': '/builds/slave/test', 18:18:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:18:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:19 INFO - 'branch': 'Mozilla-Beta', 18:18:19 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:19 INFO - 'config_files': ('talos/linux_config.py',), 18:18:19 INFO - 'default_actions': ('clobber', 18:18:19 INFO - 'read-buildbot-config', 18:18:19 INFO - 'download-and-extract', 18:18:19 INFO - 'populate-webroot', 18:18:19 INFO - 'create-virtualenv', 18:18:19 INFO - 'install', 18:18:19 INFO - 'run-tests'), 18:18:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:19 INFO - 'download_minidump_stackwalk': True, 18:18:19 INFO - 'download_symbols': 'ondemand', 18:18:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:19 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:19 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:19 INFO - 'installer_path': 'installer.exe', 18:18:19 INFO - 'log_level': 'info', 18:18:19 INFO - 'log_name': 'talos', 18:18:19 INFO - 'log_to_console': True, 18:18:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:18:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:18:19 INFO - 'opt_config_files': (), 18:18:19 INFO - 'pip_index': False, 18:18:19 INFO - 'sps_profile': False, 18:18:19 INFO - 'sps_profile_interval': 0, 18:18:19 INFO - 'suite': 'dromaeojs', 18:18:19 INFO - 'system_bits': '32', 18:18:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:19 INFO - 'title': 'talos-linux64-ix-038', 18:18:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:19 INFO - 'use_talos_json': True, 18:18:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:19 INFO - 'work_dir': 'build'} 18:18:19 INFO - ##### 18:18:19 INFO - ##### Running clobber step. 18:18:19 INFO - ##### 18:18:19 INFO - Running pre-action listener: _resource_record_pre_action 18:18:19 INFO - Running main action method: clobber 18:18:19 INFO - rmtree: /builds/slave/test/build 18:18:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:20 INFO - Running post-action listener: _resource_record_post_action 18:18:20 INFO - ##### 18:18:20 INFO - ##### Running read-buildbot-config step. 18:18:20 INFO - ##### 18:18:20 INFO - Running pre-action listener: _resource_record_pre_action 18:18:20 INFO - Running main action method: read_buildbot_config 18:18:20 INFO - Using buildbot properties: 18:18:20 INFO - { 18:18:20 INFO - "project": "", 18:18:20 INFO - "product": "firefox", 18:18:20 INFO - "script_repo_revision": "production", 18:18:20 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 18:18:20 INFO - "repository": "", 18:18:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 18:18:20 INFO - "buildid": "20160713152943", 18:18:20 INFO - "pgo_build": "True", 18:18:20 INFO - "basedir": "/builds/slave/test", 18:18:20 INFO - "buildnumber": 166, 18:18:20 INFO - "slavename": "talos-linux64-ix-038", 18:18:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:18:20 INFO - "platform": "ubuntu64_hw", 18:18:20 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 18:18:20 INFO - "branch": "mozilla-beta", 18:18:20 INFO - "repo_path": "releases/mozilla-beta", 18:18:20 INFO - "revision": "f8051a3ef4ec5842689306cc3d7b22a6ec439c9a", 18:18:20 INFO - "stage_platform": "linux64-pgo", 18:18:20 INFO - "builduid": "9d35a485de594b2897a64d1d4b1556c1", 18:18:20 INFO - "slavebuilddir": "test" 18:18:20 INFO - } 18:18:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 18:18:20 INFO - Running post-action listener: _resource_record_post_action 18:18:20 INFO - ##### 18:18:20 INFO - ##### Running download-and-extract step. 18:18:20 INFO - ##### 18:18:20 INFO - Running pre-action listener: _resource_record_pre_action 18:18:20 INFO - Running main action method: download_and_extract 18:18:20 INFO - mkdir: /builds/slave/test/build/tests 18:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:18:20 INFO - https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:18:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 18:18:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 18:18:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 18:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:18:22 INFO - Downloaded 1327 bytes. 18:18:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 18:18:22 INFO - Using the following test package requirements: 18:18:22 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 18:18:22 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 18:18:22 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 18:18:22 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:18:22 INFO - u'jsshell-linux-x86_64.zip'], 18:18:22 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 18:18:22 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 18:18:22 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 18:18:22 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 18:18:22 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 18:18:22 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 18:18:22 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:18: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')]} 18:18:22 INFO - https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 18:18:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 18:18:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 18:18:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:18:27 INFO - Downloaded 24238417 bytes. 18:18:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:18:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:18:29 INFO - Return code: 0 18:18:29 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:18:29 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')]} 18:18:29 INFO - https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 18:18:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 18:18:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 18:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:18:30 INFO - Downloaded 24238417 bytes. 18:18:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:18:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:18:31 INFO - Return code: 0 18:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:18:31 INFO - https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:18:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 18:18:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 18:18:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 18:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:18:32 INFO - Downloaded 10840145 bytes. 18:18:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:18:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:18:32 INFO - Return code: 0 18:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:18:32 INFO - https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:18:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 18:18:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 18:18:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 18:18:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:18:34 INFO - Downloaded 56018073 bytes. 18:18:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 18:18:34 INFO - mkdir: /builds/slave/test/properties 18:18:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:18:34 INFO - Writing to file /builds/slave/test/properties/build_url 18:18:34 INFO - Contents: 18:18:34 INFO - build_url:https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 18:18:34 INFO - Running post-action listener: _resource_record_post_action 18:18:34 INFO - Running post-action listener: set_extra_try_arguments 18:18:34 INFO - ##### 18:18:34 INFO - ##### Running populate-webroot step. 18:18:34 INFO - ##### 18:18:34 INFO - Running pre-action listener: _resource_record_pre_action 18:18:34 INFO - Running main action method: populate_webroot 18:18:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:34 INFO - '--tppagecycles', 18:18:34 INFO - '7'], 18:18:34 INFO - 'tests': ['tsvgm']}}, 18:18:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:18:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:18:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:18:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:18:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:18:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:34 INFO - 'talos_options': ['--disable-e10s'], 18:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:34 INFO - 'talos_options': ['--disable-e10s'], 18:18:34 INFO - 'tests': ['damp', 'tps']}, 18:18:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:34 INFO - 'tests': ['damp', 'tps']}, 18:18:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:18:34 INFO - 'tests': ['dromaeo_dom']}, 18:18:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:18:34 INFO - 'tests': ['a11yr', 18:18:34 INFO - 'ts_paint', 18:18:34 INFO - 'tpaint', 18:18:34 INFO - 'sessionrestore', 18:18:34 INFO - 'sessionrestore_no_auto_restore', 18:18:34 INFO - 'tabpaint']}, 18:18:34 INFO - 'other-e10s': {'tests': ['a11yr', 18:18:34 INFO - 'ts_paint', 18:18:34 INFO - 'tpaint', 18:18:34 INFO - 'sessionrestore', 18:18:34 INFO - 'sessionrestore_no_auto_restore', 18:18:34 INFO - 'tabpaint']}, 18:18:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:18:34 INFO - 'ts_paint', 18:18:34 INFO - 'tpaint', 18:18:34 INFO - 'sessionrestore', 18:18:34 INFO - 'sessionrestore_no_auto_restore', 18:18:34 INFO - 'tabpaint']}, 18:18:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:18:34 INFO - 'ts_paint', 18:18:34 INFO - 'tpaint', 18:18:34 INFO - 'sessionrestore', 18:18:34 INFO - 'sessionrestore_no_auto_restore', 18:18:34 INFO - 'tabpaint']}, 18:18:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:18:34 INFO - 'tests': ['a11yr', 18:18:34 INFO - 'ts_paint', 18:18:34 INFO - 'tpaint', 18:18:34 INFO - 'sessionrestore', 18:18:34 INFO - 'sessionrestore_no_auto_restore', 18:18:34 INFO - 'tabpaint']}, 18:18:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:18:34 INFO - 'tests': ['a11yr', 18:18:34 INFO - 'ts_paint', 18:18:34 INFO - 'tpaint', 18:18:34 INFO - 'sessionrestore', 18:18:34 INFO - 'sessionrestore_no_auto_restore', 18:18:34 INFO - 'tabpaint']}, 18:18:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:18:34 INFO - 'tests': ['tsvgx', 18:18:34 INFO - 'tsvgr_opacity', 18:18:34 INFO - 'tart', 18:18:34 INFO - 'tscrollx', 18:18:34 INFO - 'cart']}, 18:18:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:18:34 INFO - 'tsvgr_opacity', 18:18:34 INFO - 'tart', 18:18:34 INFO - 'tscrollx', 18:18:34 INFO - 'cart']}, 18:18:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:34 INFO - 'talos_options': ['--disable-e10s'], 18:18:34 INFO - 'tests': ['tp5o']}, 18:18:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:34 INFO - 'tests': ['tp5o']}, 18:18:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:34 INFO - 'talos_options': ['--disable-e10s', 18:18:34 INFO - '--xperf_path', 18:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:34 INFO - 'tests': ['tp5n']}, 18:18:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:34 INFO - 'talos_options': ['--xperf_path', 18:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:34 INFO - 'tests': ['tp5n']}}, 18:18:34 INFO - 'talos.zip': {'path': '', 18:18:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:34 INFO - Running post-action listener: _resource_record_post_action 18:18:34 INFO - ##### 18:18:34 INFO - ##### Running create-virtualenv step. 18:18:34 INFO - ##### 18:18:34 INFO - Running pre-action listener: _resource_record_pre_action 18:18:34 INFO - Running main action method: create_virtualenv 18:18:34 INFO - Creating virtualenv /builds/slave/test/build/venv 18:18:34 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 18:18:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:18:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:34 INFO - Using real prefix '/usr' 18:18:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:18:35 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:37 INFO - Installing pip.................done. 18:18:37 INFO - Return code: 0 18:18:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:37 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 0x7f945c115f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76410>, '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 0x1a77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a777a0>, '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': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', '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 18:18:37 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 18:18:37 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 18:18:37 INFO - Using env: {'DISPLAY': ':0', 18:18:37 INFO - 'HOME': '/home/cltbld', 18:18:37 INFO - 'LANG': 'en_US.UTF-8', 18:18:37 INFO - 'LANGUAGE': 'en_US:en', 18:18:37 INFO - 'LOGNAME': 'cltbld', 18:18:37 INFO - 'MAIL': '/var/mail/cltbld', 18:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:37 INFO - 'MOZ_NO_REMOTE': '1', 18:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:37 INFO - 'NO_EM_RESTART': '1', 18:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:37 INFO - 'PWD': '/builds/slave/test', 18:18:37 INFO - 'SHELL': '/bin/bash', 18:18:37 INFO - 'SHLVL': '1', 18:18:37 INFO - 'TERM': 'linux', 18:18:37 INFO - 'TMOUT': '86400', 18:18:37 INFO - 'USER': 'cltbld', 18:18:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', 18:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:37 INFO - '_': '/tools/buildbot/bin/python'} 18:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:37 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 18:18:37 INFO - Cleaning up... 18:18:37 INFO - Return code: 0 18:18:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:37 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 0x7f945c115f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76410>, '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 0x1a77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a777a0>, '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': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', '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 18:18:37 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 18:18:37 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 18:18:37 INFO - Using env: {'DISPLAY': ':0', 18:18:37 INFO - 'HOME': '/home/cltbld', 18:18:37 INFO - 'LANG': 'en_US.UTF-8', 18:18:37 INFO - 'LANGUAGE': 'en_US:en', 18:18:37 INFO - 'LOGNAME': 'cltbld', 18:18:37 INFO - 'MAIL': '/var/mail/cltbld', 18:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:37 INFO - 'MOZ_NO_REMOTE': '1', 18:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:37 INFO - 'NO_EM_RESTART': '1', 18:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:37 INFO - 'PWD': '/builds/slave/test', 18:18:37 INFO - 'SHELL': '/bin/bash', 18:18:37 INFO - 'SHLVL': '1', 18:18:37 INFO - 'TERM': 'linux', 18:18:37 INFO - 'TMOUT': '86400', 18:18:37 INFO - 'USER': 'cltbld', 18:18:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', 18:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:37 INFO - '_': '/tools/buildbot/bin/python'} 18:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:37 INFO - Downloading/unpacking psutil>=0.7.1 18:18:37 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 18:18:37 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 18:18:37 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 18:18:37 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 18:18:37 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 18:18:37 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 18:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:18:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:39 INFO - Installing collected packages: psutil 18:18:39 INFO - Running setup.py install for psutil 18:18:39 INFO - building 'psutil._psutil_linux' extension 18:18:39 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 18:18:40 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 18:18:40 INFO - building 'psutil._psutil_posix' extension 18:18:40 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 18:18:40 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 18:18:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:40 INFO - Successfully installed psutil 18:18:40 INFO - Cleaning up... 18:18:40 INFO - Return code: 0 18:18:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:18:40 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')]} 18:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:40 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')]} 18:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:40 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 0x7f945c115f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76410>, '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 0x1a77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a777a0>, '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': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', '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 18:18:40 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 18:18:40 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 18:18:40 INFO - Using env: {'DISPLAY': ':0', 18:18:40 INFO - 'HOME': '/home/cltbld', 18:18:40 INFO - 'LANG': 'en_US.UTF-8', 18:18:40 INFO - 'LANGUAGE': 'en_US:en', 18:18:40 INFO - 'LOGNAME': 'cltbld', 18:18:40 INFO - 'MAIL': '/var/mail/cltbld', 18:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:40 INFO - 'MOZ_NO_REMOTE': '1', 18:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:40 INFO - 'NO_EM_RESTART': '1', 18:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:40 INFO - 'PWD': '/builds/slave/test', 18:18:40 INFO - 'SHELL': '/bin/bash', 18:18:40 INFO - 'SHLVL': '1', 18:18:40 INFO - 'TERM': 'linux', 18:18:40 INFO - 'TMOUT': '86400', 18:18:40 INFO - 'USER': 'cltbld', 18:18:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', 18:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:40 INFO - '_': '/tools/buildbot/bin/python'} 18:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:18:40 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 18:18:40 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 18:18:40 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 18:18:40 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 18:18:40 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 18:18:40 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 18:18:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:18:42 INFO - Installing collected packages: mozsystemmonitor 18:18:42 INFO - Running setup.py install for mozsystemmonitor 18:18:42 INFO - Successfully installed mozsystemmonitor 18:18:42 INFO - Cleaning up... 18:18:42 INFO - Return code: 0 18:18:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f945c115f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76410>, '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 0x1a77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a777a0>, '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': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', '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 18:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:18:42 INFO - Using env: {'DISPLAY': ':0', 18:18:42 INFO - 'HOME': '/home/cltbld', 18:18:42 INFO - 'LANG': 'en_US.UTF-8', 18:18:42 INFO - 'LANGUAGE': 'en_US:en', 18:18:42 INFO - 'LOGNAME': 'cltbld', 18:18:42 INFO - 'MAIL': '/var/mail/cltbld', 18:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:42 INFO - 'MOZ_NO_REMOTE': '1', 18:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:42 INFO - 'NO_EM_RESTART': '1', 18:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:42 INFO - 'PWD': '/builds/slave/test', 18:18:42 INFO - 'SHELL': '/bin/bash', 18:18:42 INFO - 'SHLVL': '1', 18:18:42 INFO - 'TERM': 'linux', 18:18:42 INFO - 'TMOUT': '86400', 18:18:42 INFO - 'USER': 'cltbld', 18:18:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', 18:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:42 INFO - '_': '/tools/buildbot/bin/python'} 18:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:42 INFO - Downloading/unpacking blobuploader==1.2.4 18:18:42 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 18:18:42 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 18:18:42 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 18:18:42 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 18:18:42 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 18:18:42 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 18:18:44 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18:44 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 18:18:44 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 18:18:44 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 18:18:44 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 18:18:44 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 18:18:44 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 18:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:18:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 INFO - Downloading docopt-0.6.1.tar.gz 18:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:45 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:45 INFO - Running setup.py install for blobuploader 18:18:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:18:45 INFO - Running setup.py install for requests 18:18:46 INFO - Running setup.py install for docopt 18:18:46 INFO - Successfully installed blobuploader requests docopt 18:18:46 INFO - Cleaning up... 18:18:46 INFO - Return code: 0 18:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:46 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')]} 18:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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')]} 18:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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 0x7f945c115f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76410>, '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 0x1a77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a777a0>, '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': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', '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 18:18:46 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 18:18:46 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 18:18:46 INFO - Using env: {'DISPLAY': ':0', 18:18:46 INFO - 'HOME': '/home/cltbld', 18:18:46 INFO - 'LANG': 'en_US.UTF-8', 18:18:46 INFO - 'LANGUAGE': 'en_US:en', 18:18:46 INFO - 'LOGNAME': 'cltbld', 18:18:46 INFO - 'MAIL': '/var/mail/cltbld', 18:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:46 INFO - 'MOZ_NO_REMOTE': '1', 18:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:46 INFO - 'NO_EM_RESTART': '1', 18:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:46 INFO - 'PWD': '/builds/slave/test', 18:18:46 INFO - 'SHELL': '/bin/bash', 18:18:46 INFO - 'SHLVL': '1', 18:18:46 INFO - 'TERM': 'linux', 18:18:46 INFO - 'TMOUT': '86400', 18:18:46 INFO - 'USER': 'cltbld', 18:18:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', 18:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:46 INFO - '_': '/tools/buildbot/bin/python'} 18:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:46 INFO - Running setup.py (path:/tmp/pip-_l_acH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:46 INFO - Running setup.py (path:/tmp/pip-FfOok1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:46 INFO - Running setup.py (path:/tmp/pip-THIaL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:46 INFO - Running setup.py (path:/tmp/pip-8FzeyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:46 INFO - Running setup.py (path:/tmp/pip-3Up3wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:46 INFO - Running setup.py (path:/tmp/pip-whkNgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:46 INFO - Running setup.py (path:/tmp/pip-Mng9pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:46 INFO - Running setup.py (path:/tmp/pip-s9qMqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:46 INFO - Running setup.py (path:/tmp/pip-_Eyhu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:47 INFO - Running setup.py (path:/tmp/pip-X9AXng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:47 INFO - Running setup.py (path:/tmp/pip-2I1PV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:47 INFO - Running setup.py (path:/tmp/pip-P1H5px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:47 INFO - Running setup.py (path:/tmp/pip-FNDlkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:47 INFO - Running setup.py (path:/tmp/pip-xEo9n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:47 INFO - Running setup.py (path:/tmp/pip-Z3mfCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:47 INFO - Running setup.py (path:/tmp/pip-Y5E20p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:47 INFO - Running setup.py (path:/tmp/pip-IYmADF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:47 INFO - Running setup.py install for manifestparser 18:18:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:18:47 INFO - Running setup.py install for mozcrash 18:18:47 INFO - Running setup.py install for mozdebug 18:18:47 INFO - Running setup.py install for mozdevice 18:18:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Running setup.py install for mozfile 18:18:48 INFO - Running setup.py install for mozhttpd 18:18:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Running setup.py install for mozinfo 18:18:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Running setup.py install for mozInstall 18:18:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Running setup.py install for mozleak 18:18:48 INFO - Running setup.py install for mozlog 18:18:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Running setup.py install for moznetwork 18:18:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Running setup.py install for mozprocess 18:18:48 INFO - Running setup.py install for mozprofile 18:18:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Running setup.py install for mozrunner 18:18:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:18:49 INFO - Running setup.py install for mozscreenshot 18:18:49 INFO - Running setup.py install for moztest 18:18:49 INFO - Running setup.py install for mozversion 18:18:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:18:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:18:49 INFO - Cleaning up... 18:18:49 INFO - Return code: 0 18:18:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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 0x7f945c115f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76410>, '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 0x1a77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a777a0>, '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': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', '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 18:18:49 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 18:18:49 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 18:18:49 INFO - Using env: {'DISPLAY': ':0', 18:18:49 INFO - 'HOME': '/home/cltbld', 18:18:49 INFO - 'LANG': 'en_US.UTF-8', 18:18:49 INFO - 'LANGUAGE': 'en_US:en', 18:18:49 INFO - 'LOGNAME': 'cltbld', 18:18:49 INFO - 'MAIL': '/var/mail/cltbld', 18:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:49 INFO - 'MOZ_NO_REMOTE': '1', 18:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:49 INFO - 'NO_EM_RESTART': '1', 18:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:49 INFO - 'PWD': '/builds/slave/test', 18:18:49 INFO - 'SHELL': '/bin/bash', 18:18:49 INFO - 'SHLVL': '1', 18:18:49 INFO - 'TERM': 'linux', 18:18:49 INFO - 'TMOUT': '86400', 18:18:49 INFO - 'USER': 'cltbld', 18:18:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', 18:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:49 INFO - '_': '/tools/buildbot/bin/python'} 18:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:49 INFO - Running setup.py (path:/tmp/pip-_YWV13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:49 INFO - Running setup.py (path:/tmp/pip-Ra2AVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:49 INFO - Running setup.py (path:/tmp/pip-jcioe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:49 INFO - Running setup.py (path:/tmp/pip-7xpA4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:49 INFO - Running setup.py (path:/tmp/pip-ndLgyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:49 INFO - Running setup.py (path:/tmp/pip-5kF99P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:50 INFO - Running setup.py (path:/tmp/pip-7Yl4Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:50 INFO - Running setup.py (path:/tmp/pip-PAFUsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:50 INFO - Running setup.py (path:/tmp/pip-m5HgKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:50 INFO - Running setup.py (path:/tmp/pip-n4n5wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:50 INFO - Running setup.py (path:/tmp/pip-6AqU11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:50 INFO - Running setup.py (path:/tmp/pip-hRdoSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:50 INFO - Running setup.py (path:/tmp/pip-KB5AFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:50 INFO - Running setup.py (path:/tmp/pip-dcSwha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:50 INFO - Running setup.py (path:/tmp/pip-vKyNzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:50 INFO - Running setup.py (path:/tmp/pip-k9ojqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:50 INFO - Running setup.py (path:/tmp/pip-erHXFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:50 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)) 18:18:50 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)) 18:18:50 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)) 18:18:50 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)) 18:18:50 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)) 18:18:50 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)) 18:18:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:18:50 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 18:18:50 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 18:18:50 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 18:18:50 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 18:18:50 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 18:18:50 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 18:18:52 INFO - Downloading blessings-1.6.tar.gz 18:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:18:52 INFO - Installing collected packages: blessings 18:18:52 INFO - Running setup.py install for blessings 18:18:52 INFO - Successfully installed blessings 18:18:52 INFO - Cleaning up... 18:18:53 INFO - Return code: 0 18:18:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:18:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:53 INFO - Reading from file tmpfile_stdout 18:18:53 INFO - Current package versions: 18:18:53 INFO - argparse == 1.2.1 18:18:53 INFO - blessings == 1.6 18:18:53 INFO - blobuploader == 1.2.4 18:18:53 INFO - docopt == 0.6.1 18:18:53 INFO - manifestparser == 1.1 18:18:53 INFO - mozInstall == 1.12 18:18:53 INFO - mozcrash == 0.17 18:18:53 INFO - mozdebug == 0.1 18:18:53 INFO - mozdevice == 0.48 18:18:53 INFO - mozfile == 1.2 18:18:53 INFO - mozhttpd == 0.7 18:18:53 INFO - mozinfo == 0.9 18:18:53 INFO - mozleak == 0.1 18:18:53 INFO - mozlog == 3.1 18:18:53 INFO - moznetwork == 0.27 18:18:53 INFO - mozprocess == 0.22 18:18:53 INFO - mozprofile == 0.28 18:18:53 INFO - mozrunner == 6.11 18:18:53 INFO - mozscreenshot == 0.1 18:18:53 INFO - mozsystemmonitor == 0.0 18:18:53 INFO - moztest == 0.7 18:18:53 INFO - mozversion == 1.4 18:18:53 INFO - psutil == 3.1.1 18:18:53 INFO - requests == 1.2.3 18:18:53 INFO - wsgiref == 0.1.2 18:18:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:53 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')]} 18:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:53 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')]} 18:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:53 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 0x7f945c115f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76410>, '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 0x1a77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a777a0>, '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': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', '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 18:18:53 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 18:18:53 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 18:18:53 INFO - Using env: {'DISPLAY': ':0', 18:18:53 INFO - 'HOME': '/home/cltbld', 18:18:53 INFO - 'LANG': 'en_US.UTF-8', 18:18:53 INFO - 'LANGUAGE': 'en_US:en', 18:18:53 INFO - 'LOGNAME': 'cltbld', 18:18:53 INFO - 'MAIL': '/var/mail/cltbld', 18:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:53 INFO - 'MOZ_NO_REMOTE': '1', 18:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:53 INFO - 'NO_EM_RESTART': '1', 18:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:53 INFO - 'PWD': '/builds/slave/test', 18:18:53 INFO - 'SHELL': '/bin/bash', 18:18:53 INFO - 'SHLVL': '1', 18:18:53 INFO - 'TERM': 'linux', 18:18:53 INFO - 'TMOUT': '86400', 18:18:53 INFO - 'USER': 'cltbld', 18:18:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', 18:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:53 INFO - '_': '/tools/buildbot/bin/python'} 18:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:53 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)) 18:18:53 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)) 18:18:53 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)) 18:18:53 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)) 18:18:53 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)) 18:18:53 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)) 18:18:53 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)) 18:18:53 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)) 18:18:53 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)) 18:18:53 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)) 18:18:53 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)) 18:18:53 INFO - Cleaning up... 18:18:53 INFO - Return code: 0 18:18:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:18:53 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')]} 18:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:53 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')]} 18:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:53 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 0x7f945c115f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76410>, '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 0x1a77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a777a0>, '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': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', '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 18:18:53 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 18:18:53 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 18:18:53 INFO - Using env: {'DISPLAY': ':0', 18:18:53 INFO - 'HOME': '/home/cltbld', 18:18:53 INFO - 'LANG': 'en_US.UTF-8', 18:18:53 INFO - 'LANGUAGE': 'en_US:en', 18:18:53 INFO - 'LOGNAME': 'cltbld', 18:18:53 INFO - 'MAIL': '/var/mail/cltbld', 18:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:53 INFO - 'MOZ_NO_REMOTE': '1', 18:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:53 INFO - 'NO_EM_RESTART': '1', 18:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:53 INFO - 'PWD': '/builds/slave/test', 18:18:53 INFO - 'SHELL': '/bin/bash', 18:18:53 INFO - 'SHLVL': '1', 18:18:53 INFO - 'TERM': 'linux', 18:18:53 INFO - 'TMOUT': '86400', 18:18:53 INFO - 'USER': 'cltbld', 18:18:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', 18:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:53 INFO - '_': '/tools/buildbot/bin/python'} 18:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:53 INFO - Downloading/unpacking jsonschema 18:18:53 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 18:18:53 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 18:18:53 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 18:18:53 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 18:18:53 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 18:18:53 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 18:18:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:18:55 INFO - Downloading/unpacking functools32 (from jsonschema) 18:18:55 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 18:18:55 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 18:18:55 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 18:18:55 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 18:18:55 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 18:18:55 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 18:18:55 INFO - Downloading functools32-3.2.3-2.tar.gz 18:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:18:56 INFO - warning: no files found matching '*.txt' 18:18:56 INFO - no previously-included directories found matching 'build' 18:18:56 INFO - no previously-included directories found matching 'dist' 18:18:56 INFO - no previously-included directories found matching '.git*' 18:18:56 INFO - Installing collected packages: jsonschema, functools32 18:18:56 INFO - Running setup.py install for functools32 18:18:56 INFO - warning: no files found matching '*.txt' 18:18:56 INFO - no previously-included directories found matching 'build' 18:18:56 INFO - no previously-included directories found matching 'dist' 18:18:56 INFO - no previously-included directories found matching '.git*' 18:18:56 INFO - Successfully installed jsonschema functools32 18:18:56 INFO - Cleaning up... 18:18:56 INFO - Return code: 0 18:18:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:56 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 0x7f945c115f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76410>, '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 0x1a77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a777a0>, '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': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', '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 18:18:56 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 18:18:56 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 18:18:56 INFO - Using env: {'DISPLAY': ':0', 18:18:56 INFO - 'HOME': '/home/cltbld', 18:18:56 INFO - 'LANG': 'en_US.UTF-8', 18:18:56 INFO - 'LANGUAGE': 'en_US:en', 18:18:56 INFO - 'LOGNAME': 'cltbld', 18:18:56 INFO - 'MAIL': '/var/mail/cltbld', 18:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:56 INFO - 'MOZ_NO_REMOTE': '1', 18:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:56 INFO - 'NO_EM_RESTART': '1', 18:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:56 INFO - 'PWD': '/builds/slave/test', 18:18:56 INFO - 'SHELL': '/bin/bash', 18:18:56 INFO - 'SHLVL': '1', 18:18:56 INFO - 'TERM': 'linux', 18:18:56 INFO - 'TMOUT': '86400', 18:18:56 INFO - 'USER': 'cltbld', 18:18:56 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', 18:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:56 INFO - '_': '/tools/buildbot/bin/python'} 18:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:56 INFO - Downloading/unpacking flake8 18:18:56 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 18:18:56 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 18:18:56 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 18:18:56 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 18:18:56 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 18:18:56 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 18:18:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:18:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:18:58 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 18:18:58 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 18:18:58 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 18:18:58 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 18:18:58 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 18:18:58 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 18:18:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:18:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:18:58 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 18:18:58 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 18:18:58 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 18:18:58 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 18:18:58 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 18:18:58 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 18:18:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:18:58 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 18:18:58 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 18:18:58 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 18:18:58 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 18:18:58 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 18:18:58 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 18:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:18:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:18:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:18:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:18:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:18:59 INFO - no previously-included directories found matching 'docs/_build' 18:18:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:18:59 INFO - Running setup.py install for pep8 18:18:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:18:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:18:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:18:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:18:59 INFO - no previously-included directories found matching 'docs/_build' 18:18:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:18:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:18:59 INFO - Cleaning up... 18:18:59 INFO - Return code: 0 18:18:59 INFO - Running post-action listener: _resource_record_post_action 18:18:59 INFO - Running post-action listener: _start_resource_monitoring 18:18:59 INFO - Starting resource monitoring. 18:18:59 INFO - ##### 18:18:59 INFO - ##### Running install step. 18:18:59 INFO - ##### 18:18:59 INFO - Running pre-action listener: _resource_record_pre_action 18:18:59 INFO - Running main action method: install 18:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:59 INFO - Reading from file tmpfile_stdout 18:18:59 INFO - Detecting whether we're running mozinstall >=1.0... 18:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:18:59 INFO - Reading from file tmpfile_stdout 18:18:59 INFO - Output received: 18:18:59 INFO - Usage: mozinstall [options] installer 18:18:59 INFO - Options: 18:18:59 INFO - -h, --help show this help message and exit 18:18:59 INFO - -d DEST, --destination=DEST 18:18:59 INFO - Directory to install application into. [default: 18:18:59 INFO - "/builds/slave/test"] 18:18:59 INFO - --app=APP Application being installed. [default: firefox] 18:18:59 INFO - mkdir: /builds/slave/test/build/application 18:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:19:12 INFO - Reading from file tmpfile_stdout 18:19:12 INFO - Output received: 18:19:12 INFO - /builds/slave/test/build/application/firefox/firefox 18:19:12 INFO - Running post-action listener: _resource_record_post_action 18:19:12 INFO - ##### 18:19:12 INFO - ##### Running run-tests step. 18:19:12 INFO - ##### 18:19:12 INFO - Running pre-action listener: _resource_record_pre_action 18:19:12 INFO - Running main action method: run_tests 18:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:19:12 INFO - Python 2.7.3 18:19:12 INFO - Return code: 0 18:19:12 INFO - grabbing minidump binary from tooltool 18:19:12 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')]} 18:19:12 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 0x1a76410>, '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 0x1a77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a777a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:19:12 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 18:19:12 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 18:19:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:13 INFO - Return code: 0 18:19:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:19:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:19:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:19:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:19:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:19:13 INFO - Return code: 0 18:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 18:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 18:19:13 INFO - Using env: {'DISPLAY': ':0', 18:19:13 INFO - 'HOME': '/home/cltbld', 18:19:13 INFO - 'LANG': 'en_US.UTF-8', 18:19:13 INFO - 'LANGUAGE': 'en_US:en', 18:19:13 INFO - 'LOGNAME': 'cltbld', 18:19:13 INFO - 'MAIL': '/var/mail/cltbld', 18:19:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:13 INFO - 'MOZ_NO_REMOTE': '1', 18:19:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:13 INFO - 'NO_EM_RESTART': '1', 18:19:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:13 INFO - 'PWD': '/builds/slave/test', 18:19:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:13 INFO - 'SHELL': '/bin/bash', 18:19:13 INFO - 'SHLVL': '1', 18:19:13 INFO - 'TERM': 'linux', 18:19:13 INFO - 'TMOUT': '86400', 18:19:13 INFO - 'USER': 'cltbld', 18:19:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905', 18:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:13 INFO - '_': '/tools/buildbot/bin/python'} 18:19:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 18:19:14 INFO - mozversion application_buildid: 20160713152943 18:19:14 INFO - mozversion application_changeset: f8051a3ef4ec5842689306cc3d7b22a6ec439c9a 18:19:14 INFO - mozversion application_display_name: Firefox 18:19:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:14 INFO - mozversion application_name: Firefox 18:19:14 INFO - mozversion application_remotingname: firefox 18:19:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:19:14 INFO - mozversion application_vendor: Mozilla 18:19:14 INFO - mozversion application_version: 48.0 18:19:14 INFO - mozversion platform_buildid: 20160713152943 18:19:14 INFO - mozversion platform_changeset: f8051a3ef4ec5842689306cc3d7b22a6ec439c9a 18:19:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:19:14 INFO - mozversion platform_version: 48.0 18:19:14 INFO - using testdate: 1468459154 18:19:14 INFO - actual date: 1468459154 18:19:14 INFO - starting webserver on 'localhost:59800' 18:19:14 INFO - SUITE-START | Running 2 tests 18:19:14 INFO - TEST-START | dromaeo_css 18:19:14 INFO - operating with platform_type : linux_ 18:19:14 INFO - Initialising browser for dromaeo_css test... 18:19:14 INFO - TEST-INFO | started process 10281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB4clrR/profile http://localhost:59800/getInfo.html) 18:19:18 INFO - PROCESS | 10281 | __metrics Screen width/height:1600/1200 18:19:18 INFO - PROCESS | 10281 | colorDepth:24 18:19:18 INFO - PROCESS | 10281 | Browser inner width/height: 1024/697 18:19:18 INFO - PROCESS | 10281 | __metrics 18:19:19 ERROR - PROCESS | 10281 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:19:20 INFO - TEST-INFO | 10281: exit 0 18:19:20 INFO - Browser initialized. 18:19:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:20 INFO - TEST-INFO | started process 10374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB4clrR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:32 INFO - PROCESS | 10374 | RSS: Main: 139714560 18:19:32 INFO - PROCESS | 10374 | 18:20:23 INFO - PROCESS | 10374 | 1468459223266 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] 18:22:30 INFO - PROCESS | 10374 | Cycle 1(1): loaded http://localhost:59800/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59800/tests/dromaeo/cssquery-ext.html) 18:22:31 INFO - PROCESS | 10374 | RSS: Main: 249180160 18:22:31 INFO - PROCESS | 10374 | 18:25:34 INFO - PROCESS | 10374 | Cycle 1(1): loaded http://localhost:59800/tests/dromaeo/cssquery-ext.html (next: http://localhost:59800/tests/dromaeo/cssquery-jquery.html) 18:25:34 INFO - PROCESS | 10374 | RSS: Main: 224854016 18:25:34 INFO - PROCESS | 10374 | 18:28:36 INFO - PROCESS | 10374 | Cycle 1(1): loaded http://localhost:59800/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59800/tests/dromaeo/cssquery-mootools.html) 18:28:36 INFO - PROCESS | 10374 | RSS: Main: 211939328 18:28:36 INFO - PROCESS | 10374 | 18:31:38 INFO - PROCESS | 10374 | Cycle 1(1): loaded http://localhost:59800/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59800/tests/dromaeo/cssquery-prototype.html) 18:31:39 INFO - PROCESS | 10374 | RSS: Main: 213360640 18:31:39 INFO - PROCESS | 10374 | 18:34:41 INFO - PROCESS | 10374 | Cycle 1(1): loaded http://localhost:59800/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59800/tests/dromaeo/cssquery-yui.html) 18:34:42 INFO - PROCESS | 10374 | RSS: Main: 181063680 18:34:42 INFO - PROCESS | 10374 | 18:37:44 INFO - PROCESS | 10374 | Cycle 1(1): loaded http://localhost:59800/tests/dromaeo/cssquery-yui.html (next: http://localhost:59800/tests/dromaeo/cssquery-dojo.html) 18:37:44 INFO - PROCESS | 10374 | RSS: Main: 253865984 18:37:44 INFO - PROCESS | 10374 | 18:37:44 INFO - PROCESS | 10374 | __start_tp_report 18:37:44 INFO - PROCESS | 10374 | _x_x_mozilla_page_load 18:37:44 INFO - PROCESS | 10374 | _x_x_mozilla_page_load_details 18:37:44 INFO - PROCESS | 10374 | |i|pagename|runs| 18:37:44 INFO - PROCESS | 10374 | |0;dojo.html;3345.0633822529694;3383.593968723752;3390.0507857799807;3415.0949998250485;3432.021873765977;5517.779288828442;5529.364123125842;5538.224648549201;5542;5559.054960656688;5541.224228607998;5569.443055694429;5571.164325351199;5571.582131340156;5581.330240371151;4963.478834722357;5022.070916880389;5118.462561431052;5161.329027226455;5197.116490196657;4956.157453232959;5045.697258164503;5064.2403639454005;5077.492250774912;5083.18669012958;5034.24486327052;5054.140796064659;5118.667286626376;5120.411152717448;5148.5881129509735;5063.518965698253;5071.442141364447;5083.669561478529;5087.56755675768;5112.872178195556;4927.482614325516;4996.100701873661;5001.124803159469;5018.322526458918;5067.163917953533;5429.782808687687;5453.400125986138;5477.452254774531;5483.177523371486;5494.478024587698;5887.205227294303;5939.940600593982;5942;5944.227250457413;5953.3748956359395;5942.049272116441;5965.522758179335;6054.485368743618;6064.363241859585;6075.17985072014;5541.556675465953;5583.4974852263085;5655.8586035349035;5656.547476201935;5663.631863928831;5925.081612350093;6179.134921111048;6180.6909654517995;6183.4125758053815;6189.164462797555;5871.060630299132;5919.6152250103605;5937.732802023919;5940.524758019348;5950.018246989285;5943.8216853493595;5954;5954.851128721816;5956.702164891738;5962.731677074542;5732.713364331767;5857.736401861926;5928.258967629046;5935.52515798735;5944.464998150187;5889.705514724246;5895.292564892155;5896.439838215363;5900.439458251545;5929.347771745104;4534.614557762561;4535.25168347219;4535.365048893092;4536.251518499476;4564.908701825945;3999.6200360965663;4058.452108965311;4074.694397920168;4079.796010199478;4115.8971025724595;5702.116171993348;5714.771409143671;5731.541476681856;5733.684647344353;5736.483716465538;5963.165156878041;5982.790602328898;5988.4909782668965;5989.580729348903;5994.580379373402;5558.360788509292;5625.240592520039;5674.801381951612;5704.258446401941;5742.59801813869;5059.139946209153;5071.036503064406;5074.340335756328;5075.695458272516;5076.314697515862;6214.347493513206;6216.627002379872;6220.688965551795;6228.377162283826;6230.626162430269;5831.271091113696;5892;6003.459688628044;6014.48876845473;6014.518838492998;6205.1074422301635;6215.844603884939;6231.3145553988115;6237.812865614039;6247.3440288769025;5873.676947767914;5874.001419758566;5874.853128671817;5877.206577112035;5914.763409463573;5767.423257674199;5983.611065280917;6019.127226552213;6039.909401359071;6065.302490213682;5738.340090889601;5773.624714393719;5847.06446968483;5849.210356601974;5849.707514624337;5710.5146062585145;5781.4218578141845;5809.331926828469;5837.474627283565;5838.970805145947;5725.34158571753;5781.479666830005;5786.826395208151;5795.710214489343;5816.447437493432;5757.79847705345;5791.189233507396;5793.217915581343;5801.100829371454;5806.68063256525;5571.275734154534;5657.943420565906;5662.85842853932;5704.8003319885265;5736.4550367715 18:37:44 INFO - PROCESS | 10374 | |1;ext.html;682.9624370659614;684.8322161070538;686.728742146852;749.6176949755622;751.8872169174623;33427.66572334279;34152.65847341526;40352.39471407931;41790.16419671605;41841.790791046005;44164.55835441653;44307;44413.33379999294;44758.77620611901;44778.1044379113;8726.52004139772;8990.505522196276;8991.10088991099;8996.235319997808;8998.595063222137;8600.913990860105;8760.60577274021;8776.122387761237;8778;8797.472151670889;8828.117188281152;9059.50172740499;9110.453372797654;9117;9139.360244782867;9063.09369063095;9116.361854670176;9122.133397327243;9123.543822808899;9123.95438022809;9065.68270110543;9207.355485116044;9216.815663686688;9219.67731129414;9222.584983675752;44219.77890110529;44746.32880506795;44746.77626611879;44754.776226118986;44783.552164478264;3674.7243956703087;3724.1434470072036;3743.251349730038;4076.5923407658997;4699.7415142167165;34022;34234.972950811265;34338.48492272618;34351;35766.821165894005;3241.497567876983;3297.4394352959816;3347.7656564040526;3419.743519236067;3654.214343916044;308269.4586527075;309667;311193;311199;311532;39717.20565588672;40693.59306406957;40753.796231018656;66033.6698316515;66576.33423665799;38461.42307865384;38524.80737596294;38587.035324117125;38587.421188682194;38619.420708689395;17334.56663583395;17519.73720394195;17539.29842806299;17562.121893905252;17562.47312580599;14783.113013219241;14842.257887105818;14866.256687165598;14873.628159295888;14885.776713349309;9226.35415520907;9232.7691807704;9249.167574918156;9273.72178834636;9339.20616747584;3500.9299814003575;3544.2734239480847;3545.982270088633;3572.356975744391;3576.5529308836394;1121;1127.881572434899;1162.436218434059;1174.9941250293864;1249.631358749171;31766.523502147487;32901.50647740286;33484;33595.52804951078;33671;1246.6696325473756;1274.2354587247578;1281.4425724809737;1290.6128161551496;1294.6698591859204;17226.827731722773;17554.32339277666;17777.377791777224;17836.643267134845;17923.462296131136;507898;510361;515772;515904;515919;64080.35919640837;66019;66094.66952665205;66132;66162.66918665472;1396.2809153286066;1448.3989144504912;1450.1951416963686;1517.9772303415457;1539.5227479481173;25861.224163275132;32979.34041319112;33411.49882751712;33835;34541;51289;63054.68472657607;65375;65422.67288663716;65455.67272163609;459392;463688;463865;464437;465123;37568.43647345347;48383;48806.511934880196;49080.50919490902;50028.749856250484;47778.28332574945;48125.518744813504;48319.75840120777;49065.26402104043;49158.508414916825;42908.356374653784;43293.78353108215;43798.34302485529;44198.55801441945;45091.77454112709;42998.506996284705;43304;43391.56608433875;43517.56482435135;44417;35240.82379588085;39680.801595991834;39767.801160995165;39824;44059;30051;35846.103847404025;37218;39127.413088804264;39585;28124.296892577848;28280.85859570689;28374.858125710067;28456.57315140316;28637.570436443886 18:37:44 INFO - PROCESS | 10374 | |2;jquery.html;419.43585876995434;428.5478819845062;429.2895258347436;430.52642093696926;442.3983382599664;18326.54183645408;19127.71308430373;19134.42596722097;19370.903145484288;20245;12602;12673.239605623647;12841.22952622841;20634.89682551589;21619.783802161975;6318.368163183691;6433.93566064338;6602.372774586406;6620.3710647488415;6642.169728783902;6575;6611.768588099418;6651.833704157387;6675.132232809728;6676.399124078832;6390.520710946675;6611.702473388685;6615.966920165417;6666.133402657672;6682.465402767767;6582.506312026593;6595.901061484082;6598.999999999976;6618.437432818217;6644.534882558223;6266.310705822356;6444.387783160592;6468.611883286971;6509.93490065098;6518.641474718888;27239.591406128922;27302.5904611431;27443.17670469889;27900.581491277648;27930;2427.9150229741877;2462.347477918353;2777.5139350613763;2786.094519281242;3244.286257023451;15094.396224151022;15515;16042.486860248908;16268;16405.91797041019;2079.396974877284;2169.8372622053253;2179.0192427063935;2205.9448513787283;2235.575240704261;90231;93596.06403936009;96365;97512.51243743807;98282.5085874566;18149.818501815076;18476.538086547946;18664.226898444627;19109.140088696044;19149.32977345814;35201;35227.82386088053;35377.64622353795;35824.82087589546;35854.282914341566;8114.229148230908;8526.957365213135;8546.743597692079;8577.914220857836;8659.437136586102;8300.086990431048;8410.074891761902;8439.282660973886;8500.872486912702;8544.273736732323;4995.425526064549;4995.950040499549;5064.822731204464;5089.160288552347;5117.437081920985;2039.2556716798263;2066.8759874407583;2087.534692410591;2093.72781538399;2105.505206276524;1034.3897100710617;1049.2393015064017;1091.3942761767296;1112.6606385052637;1216.3188614375802;18749.437516874244;18799.308062274187;19350.903245483965;19614.607707845764;19631.31290404829;991.6136394213679;1019.1744686803713;1047.586203449633;1049.7375656085978;1057.259918057363;10745.462726863625;10988.780224395467;11036.227464077598;11090.112790976702;11142.665720028412;547706;547995;564329;566354;568127;67921.66039169772;82998.58500707458;83177;85372;93026.06973930175;1076.6662334676275;1111.5942680921244;1112.554978008803;1116.1573012375604;1127.7237076916044;17357.826421736125;17929.282828687228;17992.91003544974;18076;18332.725009124606;37767;38365.80817095897;38503.61496385001;38537.80731096327;41018;49905.25142122943;51875.2218716712;52375.47624523706;52574.737126314125;56705.432945671666;8886.422382545114;9071.138241867013;9361;9442.961274259964;9480.52597370115;11853.703657408634;13742.03805733629;13968.511102111785;14033.929830350782;14136.929315353358;10642.8935710645;10971.188038323131;11273.943630281796;11569.363684997406;12080.335581543099;10766.192535559707;11407.486663100015;11609.129315301556;11789.056875450115;11802.586909458129;11725.706857328634;11811.350375729417;11840.526378944745;12586.307753073303;13098.803517947428;8729;9116.1339672731;9298.767530811783;9327.953360233156;9361.906380936376;12222.633321000385;12231.75536489283;12367.62897113088;12401.75196496047;12476.43856026499 18:37:44 INFO - PROCESS | 10374 | |3;mootools.html;1404.339960218697;1563.9218039098043;1580.517942027681;1803.3507937142635;1922.4040547430297;8407.369447291454;8653.30773538117;8661.133886611336;8667.566621668915;8672.913270867297;8235.423520353577;8336.666533338659;8359.205875441838;8373.790655233623;8389.91610083899;2440.2313271319476;2458.029078513986;2458.4222707663776;2460.618604116356;2461.778439940405;2424.624183251599;2524.899004039836;2543.2878793937634;2543.796496280293;2551.285640020797;2468.888899999495;2497.1884137655243;2501.862397568142;2507.022261318078;2508.648789169518;2467.90128394864;2491.9252422427357;2495.6506089147533;2496.1263557754824;2511.409818692615;2463.507298540299;2492.675952126212;2507.360623041113;2509.8619575923317;2523.6340730594143;8499.74500764978;8506.106858779864;8553.700620478254;8571.185737354941;8716.302695784385;5415.350157981067;5539.169124631298;5550.056490396642;5553.111502159635;5559.166125081229;3640.3447379471686;3676.6507181817683;3703.4259689748133;3719.4606782016726;3747.981260093682;1266.7213213093196;1277.3868543099272;1290.2387591321165;1300.5253082624868;1343.1940835498622;12366.319852408114;12772;12783;12794.680132996657;12821.807672884914;4618.468876079294;4753.073150735573;4794.328793968777;4797.4482934462285;4835.347228124158;9978.401295922267;9979.251556133318;9989.051040151175;9989.500524973722;10016.39901605906;5372.865678358073;5406.756695948692;5409.215663728737;5417.783288668409;5420.620556561082;4363.127374525107;4543.977280113579;4907.582855457326;4971.577415919687;4977.552020318189;3918.7256892017285;4008.899777505586;4050.5746896576024;4100.794960251976;4135.069609337875;1249.3003917805877;1258.5657948007922;1264.342541878218;1271.5295340723992;1283.775339315616;955.5365647660878;1046.0951277145214;1047.8585390972273;1064.4305296666246;1072.9946350268199;6041.335453100155;6059.424354686386;6062.605930614584;6094.573379863456;6271.4669253114;504.55599072815687;507.97968081277077;514.6346094273033;521.098499595694;521.9843404697865;4174.31123864559;4265.445492086009;4310.50429200646;4347.695661303678;4356.847510337123;10769.784604308026;11249.83125253122;11254.324740515594;11279.379634120201;11328.433578321052;10728.678139655824;11114.722131946766;11122.888771112348;11138.941800528937;11191.384473853854;8441.915580844114;8443.788905277417;8459.407841451162;8512.40413171072;8559.786005349915;5988.28140623128;5988.8802223956145;6018.488428483628;6083.6653984029535;6094.268687757498;9700.75748106303;9732.951335243562;9958.950205248928;9993.550290236812;9998.800023999625;9829.803403932025;10124.34191777532;10176.592936282763;10345.172386209235;10359.223058270509;7443.478956473212;7532.284432978859;7575.924240757522;7607;7618.276263754934;8581;8631.482111073356;8640.524771137647;8645.697400590949;8689.695860644848;7677.270659287359;7680.078390593165;7713.074431068083;7728.149903510722;7995.040595128622;7473.92526074754;7590.203028681909;7610.277023682741;7681.69273229087;7715.614219289126;6915.723371065101;6945.166580010431;6966.094407727166;6969.233384327618;6974.407175390149;5176.249443830548;5267.947320526746;5393.27190829233;5406.486383793534;5426.7829286829665;5252.080885844885;5283.973580132075;5285.867853303698;5286.788528458818;5335.653182543122 18:37:44 INFO - PROCESS | 10374 | |4;prototype.html;340.3295507849537;344.2254926415565;354.1041165850398;355.78297238684416;359.5344029481821;6116.9082463763025;6117.66352850593;6118.816435506931;6129.111278864562;6138.9999999999945;5766.481016708495;5871.44221298977;6040.335563088057;6081.695915204233;6109.053096770008;4697.953020469786;4723.07899959508;4728.550787675165;4731.834385796497;4736.810527578901;4722.031983443403;4723.811047558093;4724.622030237572;4734.266188740734;4736.100140973222;4513.52607976161;4523.2762757958735;4663.090697314025;4670;4676.321933319667;4619.930701039487;4652.58126768589;4654.371659825914;4674.0418214266165;4677.087967846254;4109.97945010276;4111.951452379624;4117.382392641098;4121.237571049365;4128.525219599755;5869.8239052828485;5874.735636896307;5879.559033072536;5884.205632239678;5895.174675545427;5406.945930540723;5411.702356370398;5415.620906536544;5424.538914192299;5428.0500912340185;6157.7229024694;6330.525210609177;6342.270638876542;6376.840578985516;6393.712282947278;4368.432103826514;4379.64962802975;4391.560843915615;4392.297232442826;4397.450318710161;6620.6358650274215;6694.297098804653;6696.7656132035145;6700.497462690269;6704.5306828522025;4552.294394368878;4558.430196225406;4566.4748553916725;4569.109023740405;4574.382458368078;4618.214903466419;4619.69971951822;4623.982723800758;4624.028953919647;4631.814727410933;5183.170692689152;5348.171033489815;5358.624896257303;5359.3032905722;5365.7585408656705;6377.202849643794;6400.9039864402075;6412.903806442814;6420.775272865428;6423.646699431576;1536.43152033746;1595.4256467671628;1609.6378314879294;1615.927283272232;1627.1864067966017;1117.2961234117872;1123.4158237716506;1123.5618108937522;1138.910099966554;1144.822552504363;6201.317855035943;6226.968865155736;6251.0623406488485;6255.12428260044;6257.561970662101;6551.475881929529;6560.671966401756;6567.408933195939;6569.474442044625;6571.3757193066585;6223.066540019034;6224.719887605069;6232.127502149703;6240.937590624036;6249.968750156311;3510.210202704422;3512.5433693620175;3534.7879127252445;3544.627814079536;3546.4680297954997;6711;6875.896861547081;6887.758928437581;6888.070110535114;6903.689333979983;6639.668016599151;6664.466842652576;6684.4318232950745;6704.396604305636;6708.228553716385;6858.142732158381;6872.759453419107;6875.3812156906115;6878.484113691493;6888.104546409035;6542.443892269211;6564.540482166393;6564.80305590833;6567.376099270562;6571.769988050395;6361.940573982233;6427.646479443675;6492.5455218134275;6496.545241833026;6504.60972341661;6819.283975182733;6837.89743153863;6842.144731908512;6844.794656160323;6845.383915447434;4677.111348843709;4687.367205427224;4687.531246875285;4702.905941881211;4707.952920470751;6362.618242905441;6547.279799221987;6611.471082313307;6611.537192396486;6611.636360000246;6308.936910631019;6450.548461607643;6486;6490.870182596416;6501.934980650133;6461.838454038687;6462.515311351762;6465.838354041187;6470.482361410982;6482.837929051811;6367.267764207176;6369.235691717024;6370.522210834299;6374.394432528902;6379.649119298483;6321.8735625288155;6509.902351464826;6512.413882750575;6526.053722210348;6532.248791389051;6320.968395157995;6337.176167098248;6341.048842673636;6349.746010159727;6354.142190804368 18:37:44 INFO - PROCESS | 10374 | |5;yui.html;926.3746970794713;931.9627214911408;933.6358820060176;949.4777872170305;964.7298756348221;14211.218382988944;14393.064450810716;14416.423343066264;14448.855511444883;14466.493672721457;13763.65590860229;13824.516141935035;13847.584572462842;13870.791938120936;13874;734.1080587086689;885.0485727842563;899.6896070855577;902.8871391076116;905.7871400220943;887.7203680840547;897.9012308646044;898.8471959766823;902.5712786426428;902.715644571961;924.8843894513186;936.1761649748212;936.7892224249557;937.7046230437425;937.7093101138635;786.1745167574053;945.4658118163215;954.8901876284247;955.7515046087998;955.928305377096;696.7770313499632;697.2017040488663;699.1610067918467;700.6846918886522;701.4773993374918;14691.11853288806;14757.926210368987;14765.114093154445;14767.187804670739;14774.335154918055;14784.48254311094;14786;15108.54674359771;15150.090994540253;15281.388744450209;12114.939425302817;12195.329256890867;12233.143679942408;12350.320732359716;12740.171888827197;3913.5695073541888;3927.1949250403886;3996.580359062286;4004.819783109767;4032.697547683906;54938.45061549373;56071.15893261564;56444.71777641086;56570.15144772832;56583.151252731244;11644.32387477471;11865.940670296593;11923.582674606347;12142.575009874789;12210.26738395699;20577.794222057888;20628;20631.277905273244;20665.276715314892;20670.379888603366;8657.42542638445;8765.254953329038;8854.734357969272;8908.688195913111;8935.597898094602;4865.878353041131;4915.827946021872;5035.345405097314;5186.429492755794;5281.841544753664;3617.7467577269863;3646.908827279286;3670.2659468106485;3671.30245253401;3673.063368840982;611.1291409741101;641.5220660607877;661.5567569728294;661.6956200147889;686.605202008847;775.8991331126917;781.5427974634903;782.8708263136518;783.5533745764973;789.9289063984154;8793.824123517494;9287.257019438428;9417.623295068257;9425.575849086808;9484.668036618685;784.0512979295003;790.8260182759784;806.1817255485687;809.223145780046;811.5252577242379;4281.100968796525;4396.3185706214945;4411.139827733561;4442.333649952533;4483.596476317147;60172.39827601756;60215.39784602186;60433;61700.38299617036;62078;49810.50189498131;50574;50953.745231273606;51141.74429127831;51259;52696.73651631717;53186.46813531892;53810.730946345015;53890.46109538854;54835.17747233795;9928.751781205528;10117.08946194846;10126.341787783771;10163;10292.742681433025;37135.44296835495;37964.05089872775;38515.229695406495;38681.6131838678;38720.6127938717;50088;50130;50409.243861341376;50578;53370.73314633402;12232.571859984857;12286.631401057983;13235.470581176645;13306.800397993844;13461.663458413617;12915.289659068842;14064.296785160497;14386.35261413218;14590;14897.106173629616;13260.867391326348;13296.268705221306;13453.932730336286;13958.860411396163;13991.370388332345;13536.796948045983;13927.651808704863;13930.721385572435;13960.441582336593;14196.290185490478;12935.223886566837;13263.33683315811;13546.254955977516;13647.317634118453;14127.15237085778;11575.536978521102;11660.490101701598;11707.121965852424;12063.819042714542;12201.694957625776;11384.43077846121;11396.601118960796;11472.31166130035;11659.650210493699;11705.297682138758 18:37:44 INFO - PROCESS | 10374 | __end_tp_report 18:37:44 INFO - PROCESS | 10374 | __start_cc_report 18:37:44 INFO - PROCESS | 10374 | _x_x_mozilla_cycle_collect,825 18:37:44 INFO - PROCESS | 10374 | __end_cc_report 18:37:44 INFO - PROCESS | 10374 | __startTimestamp1468460264881__endTimestamp 18:37:44 INFO - PROCESS | 10374 | 18:37:44 INFO - PROCESS | 10374 | ------- Summary: start ------- 18:37:44 INFO - PROCESS | 10374 | Number of tests: 6 18:37:44 INFO - PROCESS | 10374 | 18:37:44 INFO - PROCESS | 10374 | [#0] dojo.html Cycles:165 Average:5539.39 Median:5738.34 stddev:616.35 (10.7%) stddev-sans-first:593.72 18:37:44 INFO - PROCESS | 10374 | Values: 3345.1 3383.6 3390.1 3415.1 3432.0 5517.8 5529.4 5538.2 5542.0 5559.1 5541.2 5569.4 5571.2 5571.6 5581.3 4963.5 5022.1 5118.5 5161.3 5197.1 4956.2 5045.7 5064.2 5077.5 5083.2 5034.2 5054.1 5118.7 5120.4 5148.6 5063.5 5071.4 5083.7 5087.6 5112.9 4927.5 4996.1 5001.1 5018.3 5067.2 5429.8 5453.4 5477.5 5483.2 5494.5 5887.2 5939.9 5942.0 5944.2 5953.4 5942.0 5965.5 6054.5 6064.4 6075.2 5541.6 5583.5 5655.9 5656.5 5663.6 5925.1 6179.1 6180.7 6183.4 6189.2 5871.1 5919.6 5937.7 5940.5 5950.0 5943.8 5954.0 5954.9 5956.7 5962.7 5732.7 5857.7 5928.3 5935.5 5944.5 5889.7 5895.3 5896.4 5900.4 5929.3 4534.6 4535.3 4535.4 4536.3 4564.9 3999.6 4058.5 4074.7 4079.8 4115.9 5702.1 5714.8 5731.5 5733.7 5736.5 5963.2 5982.8 5988.5 5989.6 5994.6 5558.4 5625.2 5674.8 5704.3 5742.6 5059.1 5071.0 5074.3 5075.7 5076.3 6214.3 6216.6 6220.7 6228.4 6230.6 5831.3 5892.0 6003.5 6014.5 6014.5 6205.1 6215.8 6231.3 6237.8 6247.3 5873.7 5874.0 5874.9 5877.2 5914.8 5767.4 5983.6 6019.1 6039.9 6065.3 5738.3 5773.6 5847.1 5849.2 5849.7 5710.5 5781.4 5809.3 5837.5 5839.0 5725.3 5781.5 5786.8 5795.7 5816.4 5757.8 5791.2 5793.2 5801.1 5806.7 5571.3 5657.9 5662.9 5704.8 5736.5 18:37:44 INFO - PROCESS | 10374 | 18:37:44 INFO - PROCESS | 10374 | [#1] ext.html Cycles:180 Average:59392.65 Median:41815.98 stddev:116038.64 (277.5%) stddev-sans-first:116280.44 18:37:44 INFO - PROCESS | 10374 | Values: 683.0 684.8 686.7 749.6 751.9 33427.7 34152.7 40352.4 41790.2 41841.8 44164.6 44307.0 44413.3 44758.8 44778.1 8726.5 8990.5 8991.1 8996.2 8998.6 8600.9 8760.6 8776.1 8778.0 8797.5 8828.1 9059.5 9110.5 9117.0 9139.4 9063.1 9116.4 9122.1 9123.5 9124.0 9065.7 9207.4 9216.8 9219.7 9222.6 44219.8 44746.3 44746.8 44754.8 44783.6 3674.7 3724.1 3743.3 4076.6 4699.7 34022.0 34235.0 34338.5 34351.0 35766.8 3241.5 3297.4 3347.8 3419.7 3654.2 308269.5 309667.0 311193.0 311199.0 311532.0 39717.2 40693.6 40753.8 66033.7 66576.3 38461.4 38524.8 38587.0 38587.4 38619.4 17334.6 17519.7 17539.3 17562.1 17562.5 14783.1 14842.3 14866.3 14873.6 14885.8 9226.4 9232.8 9249.2 9273.7 9339.2 3500.9 3544.3 3546.0 3572.4 3576.6 1121.0 1127.9 1162.4 1175.0 1249.6 31766.5 32901.5 33484.0 33595.5 33671.0 1246.7 1274.2 1281.4 1290.6 1294.7 17226.8 17554.3 17777.4 17836.6 17923.5 507898.0 510361.0 515772.0 515904.0 515919.0 64080.4 66019.0 66094.7 66132.0 66162.7 1396.3 1448.4 1450.2 1518.0 1539.5 25861.2 32979.3 33411.5 33835.0 34541.0 51289.0 63054.7 65375.0 65422.7 65455.7 459392.0 463688.0 463865.0 464437.0 465123.0 37568.4 48383.0 48806.5 49080.5 50028.7 47778.3 48125.5 48319.8 49065.3 49158.5 42908.4 43293.8 43798.3 44198.6 45091.8 42998.5 43304.0 43391.6 43517.6 44417.0 35240.8 39680.8 39767.8 39824.0 44059.0 30051.0 35846.1 37218.0 39127.4 39585.0 28124.3 28280.9 28374.9 28456.6 28637.6 18:37:44 INFO - PROCESS | 10374 | 18:37:44 INFO - PROCESS | 10374 | [#2] jquery.html Cycles:180 Average:32055.15 Median:15343.34 stddev:91709.21 (597.7%) stddev-sans-first:91935.71 18:37:44 INFO - PROCESS | 10374 | Values: 419.4 428.5 429.3 430.5 442.4 18326.5 19127.7 19134.4 19370.9 20245.0 12602.0 12673.2 12841.2 20634.9 21619.8 6318.4 6433.9 6602.4 6620.4 6642.2 6575.0 6611.8 6651.8 6675.1 6676.4 6390.5 6611.7 6616.0 6666.1 6682.5 6582.5 6595.9 6599.0 6618.4 6644.5 6266.3 6444.4 6468.6 6509.9 6518.6 27239.6 27302.6 27443.2 27900.6 27930.0 2427.9 2462.3 2777.5 2786.1 3244.3 15094.4 15515.0 16042.5 16268.0 16405.9 2079.4 2169.8 2179.0 2205.9 2235.6 90231.0 93596.1 96365.0 97512.5 98282.5 18149.8 18476.5 18664.2 19109.1 19149.3 35201.0 35227.8 35377.6 35824.8 35854.3 8114.2 8527.0 8546.7 8577.9 8659.4 8300.1 8410.1 8439.3 8500.9 8544.3 4995.4 4996.0 5064.8 5089.2 5117.4 2039.3 2066.9 2087.5 2093.7 2105.5 1034.4 1049.2 1091.4 1112.7 1216.3 18749.4 18799.3 19350.9 19614.6 19631.3 991.6 1019.2 1047.6 1049.7 1057.3 10745.5 10988.8 11036.2 11090.1 11142.7 547706.0 547995.0 564329.0 566354.0 568127.0 67921.7 82998.6 83177.0 85372.0 93026.1 1076.7 1111.6 1112.6 1116.2 1127.7 17357.8 17929.3 17992.9 18076.0 18332.7 37767.0 38365.8 38503.6 38537.8 41018.0 49905.3 51875.2 52375.5 52574.7 56705.4 8886.4 9071.1 9361.0 9443.0 9480.5 11853.7 13742.0 13968.5 14033.9 14136.9 10642.9 10971.2 11273.9 11569.4 12080.3 10766.2 11407.5 11609.1 11789.1 11802.6 11725.7 11811.4 11840.5 12586.3 13098.8 8729.0 9116.1 9298.8 9328.0 9361.9 12222.6 12231.8 12367.6 12401.8 12476.4 18:37:44 INFO - PROCESS | 10374 | 18:37:44 INFO - PROCESS | 10374 | [#3] mootools.html Cycles:180 Average:5860.23 Median:511.31 stddev:3269.77 (639.5%) stddev-sans-first:3261.79 18:37:44 INFO - PROCESS | 10374 | Values: 1404.3 1563.9 1580.5 1803.4 1922.4 8407.4 8653.3 8661.1 8667.6 8672.9 8235.4 8336.7 8359.2 8373.8 8389.9 2440.2 2458.0 2458.4 2460.6 2461.8 2424.6 2524.9 2543.3 2543.8 2551.3 2468.9 2497.2 2501.9 2507.0 2508.6 2467.9 2491.9 2495.7 2496.1 2511.4 2463.5 2492.7 2507.4 2509.9 2523.6 8499.7 8506.1 8553.7 8571.2 8716.3 5415.4 5539.2 5550.1 5553.1 5559.2 3640.3 3676.7 3703.4 3719.5 3748.0 1266.7 1277.4 1290.2 1300.5 1343.2 12366.3 12772.0 12783.0 12794.7 12821.8 4618.5 4753.1 4794.3 4797.4 4835.3 9978.4 9979.3 9989.1 9989.5 10016.4 5372.9 5406.8 5409.2 5417.8 5420.6 4363.1 4544.0 4907.6 4971.6 4977.6 3918.7 4008.9 4050.6 4100.8 4135.1 1249.3 1258.6 1264.3 1271.5 1283.8 955.5 1046.1 1047.9 1064.4 1073.0 6041.3 6059.4 6062.6 6094.6 6271.5 504.6 508.0 514.6 521.1 522.0 4174.3 4265.4 4310.5 4347.7 4356.8 10769.8 11249.8 11254.3 11279.4 11328.4 10728.7 11114.7 11122.9 11138.9 11191.4 8441.9 8443.8 8459.4 8512.4 8559.8 5988.3 5988.9 6018.5 6083.7 6094.3 9700.8 9733.0 9959.0 9993.6 9998.8 9829.8 10124.3 10176.6 10345.2 10359.2 7443.5 7532.3 7575.9 7607.0 7618.3 8581.0 8631.5 8640.5 8645.7 8689.7 7677.3 7680.1 7713.1 7728.1 7995.0 7473.9 7590.2 7610.3 7681.7 7715.6 6915.7 6945.2 6966.1 6969.2 6974.4 5176.2 5267.9 5393.3 5406.5 5426.8 5252.1 5284.0 5285.9 5286.8 5335.7 18:37:44 INFO - PROCESS | 10374 | 18:37:44 INFO - PROCESS | 10374 | [#4] prototype.html Cycles:180 Average:5383.27 Median:6179.52 stddev:1609.02 (26.0%) stddev-sans-first:1568.39 18:37:44 INFO - PROCESS | 10374 | Values: 340.3 344.2 354.1 355.8 359.5 6116.9 6117.7 6118.8 6129.1 6139.0 5766.5 5871.4 6040.3 6081.7 6109.1 4698.0 4723.1 4728.6 4731.8 4736.8 4722.0 4723.8 4724.6 4734.3 4736.1 4513.5 4523.3 4663.1 4670.0 4676.3 4619.9 4652.6 4654.4 4674.0 4677.1 4110.0 4112.0 4117.4 4121.2 4128.5 5869.8 5874.7 5879.6 5884.2 5895.2 5406.9 5411.7 5415.6 5424.5 5428.1 6157.7 6330.5 6342.3 6376.8 6393.7 4368.4 4379.6 4391.6 4392.3 4397.5 6620.6 6694.3 6696.8 6700.5 6704.5 4552.3 4558.4 4566.5 4569.1 4574.4 4618.2 4619.7 4624.0 4624.0 4631.8 5183.2 5348.2 5358.6 5359.3 5365.8 6377.2 6400.9 6412.9 6420.8 6423.6 1536.4 1595.4 1609.6 1615.9 1627.2 1117.3 1123.4 1123.6 1138.9 1144.8 6201.3 6227.0 6251.1 6255.1 6257.6 6551.5 6560.7 6567.4 6569.5 6571.4 6223.1 6224.7 6232.1 6240.9 6250.0 3510.2 3512.5 3534.8 3544.6 3546.5 6711.0 6875.9 6887.8 6888.1 6903.7 6639.7 6664.5 6684.4 6704.4 6708.2 6858.1 6872.8 6875.4 6878.5 6888.1 6542.4 6564.5 6564.8 6567.4 6571.8 6361.9 6427.6 6492.5 6496.5 6504.6 6819.3 6837.9 6842.1 6844.8 6845.4 4677.1 4687.4 4687.5 4702.9 4708.0 6362.6 6547.3 6611.5 6611.5 6611.6 6308.9 6450.5 6486.0 6490.9 6501.9 6461.8 6462.5 6465.8 6470.5 6482.8 6367.3 6369.2 6370.5 6374.4 6379.6 6321.9 6509.9 6512.4 6526.1 6532.2 6321.0 6337.2 6341.0 6349.7 6354.1 18:37:44 INFO - PROCESS | 10374 | 18:37:44 INFO - PROCESS | 10374 | [#5] yui.html Cycles:180 Average:15493.62 Median:4403.73 stddev:17403.87 (395.2%) stddev-sans-first:17418.31 18:37:44 INFO - PROCESS | 10374 | Values: 926.4 932.0 933.6 949.5 964.7 14211.2 14393.1 14416.4 14448.9 14466.5 13763.7 13824.5 13847.6 13870.8 13874.0 734.1 885.0 899.7 902.9 905.8 887.7 897.9 898.8 902.6 902.7 924.9 936.2 936.8 937.7 937.7 786.2 945.5 954.9 955.8 955.9 696.8 697.2 699.2 700.7 701.5 14691.1 14757.9 14765.1 14767.2 14774.3 14784.5 14786.0 15108.5 15150.1 15281.4 12114.9 12195.3 12233.1 12350.3 12740.2 3913.6 3927.2 3996.6 4004.8 4032.7 54938.5 56071.2 56444.7 56570.2 56583.2 11644.3 11865.9 11923.6 12142.6 12210.3 20577.8 20628.0 20631.3 20665.3 20670.4 8657.4 8765.3 8854.7 8908.7 8935.6 4865.9 4915.8 5035.3 5186.4 5281.8 3617.7 3646.9 3670.3 3671.3 3673.1 611.1 641.5 661.6 661.7 686.6 775.9 781.5 782.9 783.6 789.9 8793.8 9287.3 9417.6 9425.6 9484.7 784.1 790.8 806.2 809.2 811.5 4281.1 4396.3 4411.1 4442.3 4483.6 60172.4 60215.4 60433.0 61700.4 62078.0 49810.5 50574.0 50953.7 51141.7 51259.0 52696.7 53186.5 53810.7 53890.5 54835.2 9928.8 10117.1 10126.3 10163.0 10292.7 37135.4 37964.1 38515.2 38681.6 38720.6 50088.0 50130.0 50409.2 50578.0 53370.7 12232.6 12286.6 13235.5 13306.8 13461.7 12915.3 14064.3 14386.4 14590.0 14897.1 13260.9 13296.3 13453.9 13958.9 13991.4 13536.8 13927.7 13930.7 13960.4 14196.3 12935.2 13263.3 13546.3 13647.3 14127.2 11575.5 11660.5 11707.1 12063.8 12201.7 11384.4 11396.6 11472.3 11659.7 11705.3 18:37:44 INFO - PROCESS | 10374 | -------- Summary: end -------- 18:37:44 INFO - PROCESS | 10374 | 18:37:45 INFO - TEST-INFO | 10374: exit 0 18:37:45 INFO - TEST-OK | dromaeo_css | took 1111326ms 18:37:45 INFO - TEST-START | kraken 18:37:45 INFO - operating with platform_type : linux_ 18:37:45 INFO - Initialising browser for kraken test... 18:37:45 INFO - TEST-INFO | started process 10569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjUN87p/profile http://localhost:59800/getInfo.html) 18:37:49 INFO - PROCESS | 10569 | __metrics Screen width/height:1600/1200 18:37:49 INFO - PROCESS | 10569 | colorDepth:24 18:37:49 INFO - PROCESS | 10569 | Browser inner width/height: 1024/697 18:37:49 INFO - PROCESS | 10569 | __metrics 18:37:50 ERROR - PROCESS | 10569 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:37:51 INFO - TEST-INFO | 10569: exit 0 18:37:51 INFO - Browser initialized. 18:37:51 INFO - Running cycle 1/1 for kraken test... 18:37:51 INFO - TEST-INFO | started process 10661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjUN87p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:03 INFO - PROCESS | 10661 | RSS: Main: 140070912 18:38:03 INFO - PROCESS | 10661 | 18:38:05 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59800/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:06 INFO - PROCESS | 10661 | RSS: Main: 198025216 18:38:06 INFO - PROCESS | 10661 | 18:38:09 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59800/tests/kraken/driver.html?testName=audio-dft) 18:38:09 INFO - PROCESS | 10661 | RSS: Main: 184127488 18:38:09 INFO - PROCESS | 10661 | 18:38:12 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59800/tests/kraken/driver.html?testName=audio-fft) 18:38:13 INFO - PROCESS | 10661 | RSS: Main: 274079744 18:38:13 INFO - PROCESS | 10661 | 18:38:15 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59800/tests/kraken/driver.html?testName=audio-oscillator) 18:38:15 INFO - PROCESS | 10661 | RSS: Main: 179728384 18:38:15 INFO - PROCESS | 10661 | 18:38:18 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59800/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:18 INFO - PROCESS | 10661 | RSS: Main: 177704960 18:38:18 INFO - PROCESS | 10661 | 18:38:21 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59800/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:22 INFO - PROCESS | 10661 | RSS: Main: 212094976 18:38:22 INFO - PROCESS | 10661 | 18:38:25 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59800/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:26 INFO - PROCESS | 10661 | RSS: Main: 212119552 18:38:26 INFO - PROCESS | 10661 | 18:38:28 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59800/tests/kraken/driver.html?testName=json-parse-financial) 18:38:29 INFO - PROCESS | 10661 | RSS: Main: 211898368 18:38:29 INFO - PROCESS | 10661 | 18:38:31 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59800/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:38:31 INFO - PROCESS | 10661 | RSS: Main: 195751936 18:38:31 INFO - PROCESS | 10661 | 18:38:33 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59800/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:38:33 INFO - PROCESS | 10661 | RSS: Main: 199065600 18:38:33 INFO - PROCESS | 10661 | 18:38:35 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59800/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:36 INFO - PROCESS | 10661 | RSS: Main: 208187392 18:38:36 INFO - PROCESS | 10661 | 18:38:38 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:38:39 INFO - PROCESS | 10661 | RSS: Main: 217616384 18:38:39 INFO - PROCESS | 10661 | 18:38:42 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:38:42 INFO - PROCESS | 10661 | RSS: Main: 212975616 18:38:42 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | Cycle 1(1): loaded http://localhost:59800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59800/tests/kraken/driver.html?testName=ai-astar) 18:38:44 INFO - PROCESS | 10661 | RSS: Main: 273113088 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | __start_tp_report 18:38:44 INFO - PROCESS | 10661 | _x_x_mozilla_page_load 18:38:44 INFO - PROCESS | 10661 | _x_x_mozilla_page_load_details 18:38:44 INFO - PROCESS | 10661 | |i|pagename|runs| 18:38:44 INFO - PROCESS | 10661 | |0;ai-astar;112;111;108;111;112;113;106;109;109;110 18:38:44 INFO - PROCESS | 10661 | |1;audio-beat-detection;152;125;154;172;124;155;147;126;178;128 18:38:44 INFO - PROCESS | 10661 | |2;audio-dft;162;160;162;161;160;162;163;159;160;160 18:38:44 INFO - PROCESS | 10661 | |3;audio-fft;75;75;76;173;72;75;74;76;157;73 18:38:44 INFO - PROCESS | 10661 | |4;audio-oscillator;92;92;149;91;92;92;151;92;92;149 18:38:44 INFO - PROCESS | 10661 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;116;116 18:38:44 INFO - PROCESS | 10661 | |6;imaging-darkroom;145;145;145;145;146;145;145;146;144;145 18:38:44 INFO - PROCESS | 10661 | |7;imaging-desaturate;94;94;95;95;95;95;95;95;95;94 18:38:44 INFO - PROCESS | 10661 | |8;json-parse-financial;53;55;53;54;55;55;55;78;52;53 18:38:44 INFO - PROCESS | 10661 | |9;json-stringify-tinderbox;57;58;59;58;59;59;59;59;59;59 18:38:44 INFO - PROCESS | 10661 | |10;stanford-crypto-aes;80;73;70;71;74;72;72;71;72;72 18:38:44 INFO - PROCESS | 10661 | |11;stanford-crypto-ccm;115;113;111;110;113;112;114;112;134;112 18:38:44 INFO - PROCESS | 10661 | |12;stanford-crypto-pbkdf2;158;156;159;158;157;160;163;158;159;159 18:38:44 INFO - PROCESS | 10661 | |13;stanford-crypto-sha256-iterative;66;67;65;65;64;66;64;64;65;65 18:38:44 INFO - PROCESS | 10661 | __end_tp_report 18:38:44 INFO - PROCESS | 10661 | __start_cc_report 18:38:44 INFO - PROCESS | 10661 | _x_x_mozilla_cycle_collect,1560 18:38:44 INFO - PROCESS | 10661 | __end_cc_report 18:38:44 INFO - PROCESS | 10661 | __startTimestamp1468460324754__endTimestamp 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | ------- Summary: start ------- 18:38:44 INFO - PROCESS | 10661 | Number of tests: 14 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.13 (1.9%) stddev-sans-first:2.15 18:38:44 INFO - PROCESS | 10661 | Values: 112.0 111.0 108.0 111.0 112.0 113.0 106.0 109.0 109.0 110.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:153.00 stddev:19.81 (12.9%) stddev-sans-first:20.89 18:38:44 INFO - PROCESS | 10661 | Values: 152.0 125.0 154.0 172.0 124.0 155.0 147.0 126.0 178.0 128.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.29 (0.8%) stddev-sans-first:1.30 18:38:44 INFO - PROCESS | 10661 | Values: 162.0 160.0 162.0 161.0 160.0 162.0 163.0 159.0 160.0 160.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#3] audio-fft Cycles:10 Average:92.60 Median:75.00 stddev:38.36 (51.2%) stddev-sans-first:40.16 18:38:44 INFO - PROCESS | 10661 | Values: 75.0 75.0 76.0 173.0 72.0 75.0 74.0 76.0 157.0 73.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:92.00 stddev:27.93 (30.4%) stddev-sans-first:28.92 18:38:44 INFO - PROCESS | 10661 | Values: 92.0 92.0 149.0 91.0 92.0 92.0 151.0 92.0 92.0 149.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:38:44 INFO - PROCESS | 10661 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 18:38:44 INFO - PROCESS | 10661 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 144.0 145.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 18:38:44 INFO - PROCESS | 10661 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.00 stddev:7.70 (14.0%) stddev-sans-first:8.08 18:38:44 INFO - PROCESS | 10661 | Values: 53.0 55.0 53.0 54.0 55.0 55.0 55.0 78.0 52.0 53.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.44 18:38:44 INFO - PROCESS | 10661 | Values: 57.0 58.0 59.0 58.0 59.0 59.0 59.0 59.0 59.0 59.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:72.00 stddev:2.79 (3.9%) stddev-sans-first:1.17 18:38:44 INFO - PROCESS | 10661 | Values: 80.0 73.0 70.0 71.0 74.0 72.0 72.0 71.0 72.0 72.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#11] stanford-crypto-ccm Cycles:10 Average:114.60 Median:113.00 stddev:6.96 (6.2%) stddev-sans-first:7.38 18:38:44 INFO - PROCESS | 10661 | Values: 115.0 113.0 111.0 110.0 113.0 112.0 114.0 112.0 134.0 112.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.00 stddev:1.89 (1.2%) stddev-sans-first:1.99 18:38:44 INFO - PROCESS | 10661 | Values: 158.0 156.0 159.0 158.0 157.0 160.0 163.0 158.0 159.0 159.0 18:38:44 INFO - PROCESS | 10661 | 18:38:44 INFO - PROCESS | 10661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 18:38:44 INFO - PROCESS | 10661 | Values: 66.0 67.0 65.0 65.0 64.0 66.0 64.0 64.0 65.0 65.0 18:38:44 INFO - PROCESS | 10661 | -------- Summary: end -------- 18:38:44 INFO - PROCESS | 10661 | 18:38:45 INFO - TEST-INFO | 10661: exit 0 18:38:45 INFO - TEST-OK | kraken | took 60407ms 18:38:45 INFO - SUITE-END | took 1171s 18:38:46 INFO - Completed test suite (00:19:32) 18:38:46 INFO - javascript benchmark 18:38:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.0633822529694, 3383.593968723752, 3390.0507857799807, 3415.0949998250485, 3432.021873765977, 5517.779288828442, 5529.364123125842, 5538.224648549201, 5542.0, 5559.054960656688, 5541.224228607998, 5569.443055694429, 5571.164325351199, 5571.582131340156, 5581.330240371151, 4963.478834722357, 5022.070916880389, 5118.462561431052, 5161.329027226455, 5197.116490196657, 4956.157453232959, 5045.697258164503, 5064.2403639454005, 5077.492250774912, 5083.18669012958, 5034.24486327052, 5054.140796064659, 5118.667286626376, 5120.411152717448, 5148.5881129509735, 5063.518965698253, 5071.442141364447, 5083.669561478529, 5087.56755675768, 5112.872178195556, 4927.482614325516, 4996.100701873661, 5001.124803159469, 5018.322526458918, 5067.163917953533, 5429.782808687687, 5453.400125986138, 5477.452254774531, 5483.177523371486, 5494.478024587698, 5887.205227294303, 5939.940600593982, 5942.0, 5944.227250457413, 5953.3748956359395, 5942.049272116441, 5965.522758179335, 6054.485368743618, 6064.363241859585, 6075.17985072014, 5541.556675465953, 5583.4974852263085, 5655.8586035349035, 5656.547476201935, 5663.631863928831, 5925.081612350093, 6179.134921111048, 6180.6909654517995, 6183.4125758053815, 6189.164462797555, 5871.060630299132, 5919.6152250103605, 5937.732802023919, 5940.524758019348, 5950.018246989285, 5943.8216853493595, 5954.0, 5954.851128721816, 5956.702164891738, 5962.731677074542, 5732.713364331767, 5857.736401861926, 5928.258967629046, 5935.52515798735, 5944.464998150187, 5889.705514724246, 5895.292564892155, 5896.439838215363, 5900.439458251545, 5929.347771745104, 4534.614557762561, 4535.25168347219, 4535.365048893092, 4536.251518499476, 4564.908701825945, 3999.6200360965663, 4058.452108965311, 4074.694397920168, 4079.796010199478, 4115.8971025724595, 5702.116171993348, 5714.771409143671, 5731.541476681856, 5733.684647344353, 5736.483716465538, 5963.165156878041, 5982.790602328898, 5988.4909782668965, 5989.580729348903, 5994.580379373402, 5558.360788509292, 5625.240592520039, 5674.801381951612, 5704.258446401941, 5742.59801813869, 5059.139946209153, 5071.036503064406, 5074.340335756328, 5075.695458272516, 5076.314697515862, 6214.347493513206, 6216.627002379872, 6220.688965551795, 6228.377162283826, 6230.626162430269, 5831.271091113696, 5892.0, 6003.459688628044, 6014.48876845473, 6014.518838492998, 6205.1074422301635, 6215.844603884939, 6231.3145553988115, 6237.812865614039, 6247.3440288769025, 5873.676947767914, 5874.001419758566, 5874.853128671817, 5877.206577112035, 5914.763409463573, 5767.423257674199, 5983.611065280917, 6019.127226552213, 6039.909401359071, 6065.302490213682, 5738.340090889601, 5773.624714393719, 5847.06446968483, 5849.210356601974, 5849.707514624337, 5710.5146062585145, 5781.4218578141845, 5809.331926828469, 5837.474627283565, 5838.970805145947, 5725.34158571753, 5781.479666830005, 5786.826395208151, 5795.710214489343, 5816.447437493432, 5757.79847705345, 5791.189233507396, 5793.217915581343, 5801.100829371454, 5806.68063256525, 5571.275734154534, 5657.943420565906, 5662.85842853932, 5704.8003319885265, 5736.4550367715], "value": 5499.587779489796, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.9624370659614, 684.8322161070538, 686.728742146852, 749.6176949755622, 751.8872169174623, 33427.66572334279, 34152.65847341526, 40352.39471407931, 41790.16419671605, 41841.790791046005, 44164.55835441653, 44307.0, 44413.33379999294, 44758.77620611901, 44778.1044379113, 8726.52004139772, 8990.505522196276, 8991.10088991099, 8996.235319997808, 8998.595063222137, 8600.913990860105, 8760.60577274021, 8776.122387761237, 8778.0, 8797.472151670889, 8828.117188281152, 9059.50172740499, 9110.453372797654, 9117.0, 9139.360244782867, 9063.09369063095, 9116.361854670176, 9122.133397327243, 9123.543822808899, 9123.95438022809, 9065.68270110543, 9207.355485116044, 9216.815663686688, 9219.67731129414, 9222.584983675752, 44219.77890110529, 44746.32880506795, 44746.77626611879, 44754.776226118986, 44783.552164478264, 3674.7243956703087, 3724.1434470072036, 3743.251349730038, 4076.5923407658997, 4699.7415142167165, 34022.0, 34234.972950811265, 34338.48492272618, 34351.0, 35766.821165894005, 3241.497567876983, 3297.4394352959816, 3347.7656564040526, 3419.743519236067, 3654.214343916044, 308269.4586527075, 309667.0, 311193.0, 311199.0, 311532.0, 39717.20565588672, 40693.59306406957, 40753.796231018656, 66033.6698316515, 66576.33423665799, 38461.42307865384, 38524.80737596294, 38587.035324117125, 38587.421188682194, 38619.420708689395, 17334.56663583395, 17519.73720394195, 17539.29842806299, 17562.121893905252, 17562.47312580599, 14783.113013219241, 14842.257887105818, 14866.256687165598, 14873.628159295888, 14885.776713349309, 9226.35415520907, 9232.7691807704, 9249.167574918156, 9273.72178834636, 9339.20616747584, 3500.9299814003575, 3544.2734239480847, 3545.982270088633, 3572.356975744391, 3576.5529308836394, 1121.0, 1127.881572434899, 1162.436218434059, 1174.9941250293864, 1249.631358749171, 31766.523502147487, 32901.50647740286, 33484.0, 33595.52804951078, 33671.0, 1246.6696325473756, 1274.2354587247578, 1281.4425724809737, 1290.6128161551496, 1294.6698591859204, 17226.827731722773, 17554.32339277666, 17777.377791777224, 17836.643267134845, 17923.462296131136, 507898.0, 510361.0, 515772.0, 515904.0, 515919.0, 64080.35919640837, 66019.0, 66094.66952665205, 66132.0, 66162.66918665472, 1396.2809153286066, 1448.3989144504912, 1450.1951416963686, 1517.9772303415457, 1539.5227479481173, 25861.224163275132, 32979.34041319112, 33411.49882751712, 33835.0, 34541.0, 51289.0, 63054.68472657607, 65375.0, 65422.67288663716, 65455.67272163609, 459392.0, 463688.0, 463865.0, 464437.0, 465123.0, 37568.43647345347, 48383.0, 48806.511934880196, 49080.50919490902, 50028.749856250484, 47778.28332574945, 48125.518744813504, 48319.75840120777, 49065.26402104043, 49158.508414916825, 42908.356374653784, 43293.78353108215, 43798.34302485529, 44198.55801441945, 45091.77454112709, 42998.506996284705, 43304.0, 43391.56608433875, 43517.56482435135, 44417.0, 35240.82379588085, 39680.801595991834, 39767.801160995165, 39824.0, 44059.0, 30051.0, 35846.103847404025, 37218.0, 39127.413088804264, 39585.0, 28124.296892577848, 28280.85859570689, 28374.858125710067, 28456.57315140316, 28637.570436443886], "value": 19878.900586259024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.43585876995434, 428.5478819845062, 429.2895258347436, 430.52642093696926, 442.3983382599664, 18326.54183645408, 19127.71308430373, 19134.42596722097, 19370.903145484288, 20245.0, 12602.0, 12673.239605623647, 12841.22952622841, 20634.89682551589, 21619.783802161975, 6318.368163183691, 6433.93566064338, 6602.372774586406, 6620.3710647488415, 6642.169728783902, 6575.0, 6611.768588099418, 6651.833704157387, 6675.132232809728, 6676.399124078832, 6390.520710946675, 6611.702473388685, 6615.966920165417, 6666.133402657672, 6682.465402767767, 6582.506312026593, 6595.901061484082, 6598.999999999976, 6618.437432818217, 6644.534882558223, 6266.310705822356, 6444.387783160592, 6468.611883286971, 6509.93490065098, 6518.641474718888, 27239.591406128922, 27302.5904611431, 27443.17670469889, 27900.581491277648, 27930.0, 2427.9150229741877, 2462.347477918353, 2777.5139350613763, 2786.094519281242, 3244.286257023451, 15094.396224151022, 15515.0, 16042.486860248908, 16268.0, 16405.91797041019, 2079.396974877284, 2169.8372622053253, 2179.0192427063935, 2205.9448513787283, 2235.575240704261, 90231.0, 93596.06403936009, 96365.0, 97512.51243743807, 98282.5085874566, 18149.818501815076, 18476.538086547946, 18664.226898444627, 19109.140088696044, 19149.32977345814, 35201.0, 35227.82386088053, 35377.64622353795, 35824.82087589546, 35854.282914341566, 8114.229148230908, 8526.957365213135, 8546.743597692079, 8577.914220857836, 8659.437136586102, 8300.086990431048, 8410.074891761902, 8439.282660973886, 8500.872486912702, 8544.273736732323, 4995.425526064549, 4995.950040499549, 5064.822731204464, 5089.160288552347, 5117.437081920985, 2039.2556716798263, 2066.8759874407583, 2087.534692410591, 2093.72781538399, 2105.505206276524, 1034.3897100710617, 1049.2393015064017, 1091.3942761767296, 1112.6606385052637, 1216.3188614375802, 18749.437516874244, 18799.308062274187, 19350.903245483965, 19614.607707845764, 19631.31290404829, 991.6136394213679, 1019.1744686803713, 1047.586203449633, 1049.7375656085978, 1057.259918057363, 10745.462726863625, 10988.780224395467, 11036.227464077598, 11090.112790976702, 11142.665720028412, 547706.0, 547995.0, 564329.0, 566354.0, 568127.0, 67921.66039169772, 82998.58500707458, 83177.0, 85372.0, 93026.06973930175, 1076.6662334676275, 1111.5942680921244, 1112.554978008803, 1116.1573012375604, 1127.7237076916044, 17357.826421736125, 17929.282828687228, 17992.91003544974, 18076.0, 18332.725009124606, 37767.0, 38365.80817095897, 38503.61496385001, 38537.80731096327, 41018.0, 49905.25142122943, 51875.2218716712, 52375.47624523706, 52574.737126314125, 56705.432945671666, 8886.422382545114, 9071.138241867013, 9361.0, 9442.961274259964, 9480.52597370115, 11853.703657408634, 13742.03805733629, 13968.511102111785, 14033.929830350782, 14136.929315353358, 10642.8935710645, 10971.188038323131, 11273.943630281796, 11569.363684997406, 12080.335581543099, 10766.192535559707, 11407.486663100015, 11609.129315301556, 11789.056875450115, 11802.586909458129, 11725.706857328634, 11811.350375729417, 11840.526378944745, 12586.307753073303, 13098.803517947428, 8729.0, 9116.1339672731, 9298.767530811783, 9327.953360233156, 9361.906380936376, 12222.633321000385, 12231.75536489283, 12367.62897113088, 12401.75196496047, 12476.43856026499], "value": 10200.045478431935, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.339960218697, 1563.9218039098043, 1580.517942027681, 1803.3507937142635, 1922.4040547430297, 8407.369447291454, 8653.30773538117, 8661.133886611336, 8667.566621668915, 8672.913270867297, 8235.423520353577, 8336.666533338659, 8359.205875441838, 8373.790655233623, 8389.91610083899, 2440.2313271319476, 2458.029078513986, 2458.4222707663776, 2460.618604116356, 2461.778439940405, 2424.624183251599, 2524.899004039836, 2543.2878793937634, 2543.796496280293, 2551.285640020797, 2468.888899999495, 2497.1884137655243, 2501.862397568142, 2507.022261318078, 2508.648789169518, 2467.90128394864, 2491.9252422427357, 2495.6506089147533, 2496.1263557754824, 2511.409818692615, 2463.507298540299, 2492.675952126212, 2507.360623041113, 2509.8619575923317, 2523.6340730594143, 8499.74500764978, 8506.106858779864, 8553.700620478254, 8571.185737354941, 8716.302695784385, 5415.350157981067, 5539.169124631298, 5550.056490396642, 5553.111502159635, 5559.166125081229, 3640.3447379471686, 3676.6507181817683, 3703.4259689748133, 3719.4606782016726, 3747.981260093682, 1266.7213213093196, 1277.3868543099272, 1290.2387591321165, 1300.5253082624868, 1343.1940835498622, 12366.319852408114, 12772.0, 12783.0, 12794.680132996657, 12821.807672884914, 4618.468876079294, 4753.073150735573, 4794.328793968777, 4797.4482934462285, 4835.347228124158, 9978.401295922267, 9979.251556133318, 9989.051040151175, 9989.500524973722, 10016.39901605906, 5372.865678358073, 5406.756695948692, 5409.215663728737, 5417.783288668409, 5420.620556561082, 4363.127374525107, 4543.977280113579, 4907.582855457326, 4971.577415919687, 4977.552020318189, 3918.7256892017285, 4008.899777505586, 4050.5746896576024, 4100.794960251976, 4135.069609337875, 1249.3003917805877, 1258.5657948007922, 1264.342541878218, 1271.5295340723992, 1283.775339315616, 955.5365647660878, 1046.0951277145214, 1047.8585390972273, 1064.4305296666246, 1072.9946350268199, 6041.335453100155, 6059.424354686386, 6062.605930614584, 6094.573379863456, 6271.4669253114, 504.55599072815687, 507.97968081277077, 514.6346094273033, 521.098499595694, 521.9843404697865, 4174.31123864559, 4265.445492086009, 4310.50429200646, 4347.695661303678, 4356.847510337123, 10769.784604308026, 11249.83125253122, 11254.324740515594, 11279.379634120201, 11328.433578321052, 10728.678139655824, 11114.722131946766, 11122.888771112348, 11138.941800528937, 11191.384473853854, 8441.915580844114, 8443.788905277417, 8459.407841451162, 8512.40413171072, 8559.786005349915, 5988.28140623128, 5988.8802223956145, 6018.488428483628, 6083.6653984029535, 6094.268687757498, 9700.75748106303, 9732.951335243562, 9958.950205248928, 9993.550290236812, 9998.800023999625, 9829.803403932025, 10124.34191777532, 10176.592936282763, 10345.172386209235, 10359.223058270509, 7443.478956473212, 7532.284432978859, 7575.924240757522, 7607.0, 7618.276263754934, 8581.0, 8631.482111073356, 8640.524771137647, 8645.697400590949, 8689.695860644848, 7677.270659287359, 7680.078390593165, 7713.074431068083, 7728.149903510722, 7995.040595128622, 7473.92526074754, 7590.203028681909, 7610.277023682741, 7681.69273229087, 7715.614219289126, 6915.723371065101, 6945.166580010431, 6966.094407727166, 6969.233384327618, 6974.407175390149, 5176.249443830548, 5267.947320526746, 5393.27190829233, 5406.486383793534, 5426.7829286829665, 5252.080885844885, 5283.973580132075, 5285.867853303698, 5286.788528458818, 5335.653182543122], "value": 4683.959416009844, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.3295507849537, 344.2254926415565, 354.1041165850398, 355.78297238684416, 359.5344029481821, 6116.9082463763025, 6117.66352850593, 6118.816435506931, 6129.111278864562, 6138.9999999999945, 5766.481016708495, 5871.44221298977, 6040.335563088057, 6081.695915204233, 6109.053096770008, 4697.953020469786, 4723.07899959508, 4728.550787675165, 4731.834385796497, 4736.810527578901, 4722.031983443403, 4723.811047558093, 4724.622030237572, 4734.266188740734, 4736.100140973222, 4513.52607976161, 4523.2762757958735, 4663.090697314025, 4670.0, 4676.321933319667, 4619.930701039487, 4652.58126768589, 4654.371659825914, 4674.0418214266165, 4677.087967846254, 4109.97945010276, 4111.951452379624, 4117.382392641098, 4121.237571049365, 4128.525219599755, 5869.8239052828485, 5874.735636896307, 5879.559033072536, 5884.205632239678, 5895.174675545427, 5406.945930540723, 5411.702356370398, 5415.620906536544, 5424.538914192299, 5428.0500912340185, 6157.7229024694, 6330.525210609177, 6342.270638876542, 6376.840578985516, 6393.712282947278, 4368.432103826514, 4379.64962802975, 4391.560843915615, 4392.297232442826, 4397.450318710161, 6620.6358650274215, 6694.297098804653, 6696.7656132035145, 6700.497462690269, 6704.5306828522025, 4552.294394368878, 4558.430196225406, 4566.4748553916725, 4569.109023740405, 4574.382458368078, 4618.214903466419, 4619.69971951822, 4623.982723800758, 4624.028953919647, 4631.814727410933, 5183.170692689152, 5348.171033489815, 5358.624896257303, 5359.3032905722, 5365.7585408656705, 6377.202849643794, 6400.9039864402075, 6412.903806442814, 6420.775272865428, 6423.646699431576, 1536.43152033746, 1595.4256467671628, 1609.6378314879294, 1615.927283272232, 1627.1864067966017, 1117.2961234117872, 1123.4158237716506, 1123.5618108937522, 1138.910099966554, 1144.822552504363, 6201.317855035943, 6226.968865155736, 6251.0623406488485, 6255.12428260044, 6257.561970662101, 6551.475881929529, 6560.671966401756, 6567.408933195939, 6569.474442044625, 6571.3757193066585, 6223.066540019034, 6224.719887605069, 6232.127502149703, 6240.937590624036, 6249.968750156311, 3510.210202704422, 3512.5433693620175, 3534.7879127252445, 3544.627814079536, 3546.4680297954997, 6711.0, 6875.896861547081, 6887.758928437581, 6888.070110535114, 6903.689333979983, 6639.668016599151, 6664.466842652576, 6684.4318232950745, 6704.396604305636, 6708.228553716385, 6858.142732158381, 6872.759453419107, 6875.3812156906115, 6878.484113691493, 6888.104546409035, 6542.443892269211, 6564.540482166393, 6564.80305590833, 6567.376099270562, 6571.769988050395, 6361.940573982233, 6427.646479443675, 6492.5455218134275, 6496.545241833026, 6504.60972341661, 6819.283975182733, 6837.89743153863, 6842.144731908512, 6844.794656160323, 6845.383915447434, 4677.111348843709, 4687.367205427224, 4687.531246875285, 4702.905941881211, 4707.952920470751, 6362.618242905441, 6547.279799221987, 6611.471082313307, 6611.537192396486, 6611.636360000246, 6308.936910631019, 6450.548461607643, 6486.0, 6490.870182596416, 6501.934980650133, 6461.838454038687, 6462.515311351762, 6465.838354041187, 6470.482361410982, 6482.837929051811, 6367.267764207176, 6369.235691717024, 6370.522210834299, 6374.394432528902, 6379.649119298483, 6321.8735625288155, 6509.902351464826, 6512.413882750575, 6526.053722210348, 6532.248791389051, 6320.968395157995, 6337.176167098248, 6341.048842673636, 6349.746010159727, 6354.142190804368], "value": 4863.360682623135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [926.3746970794713, 931.9627214911408, 933.6358820060176, 949.4777872170305, 964.7298756348221, 14211.218382988944, 14393.064450810716, 14416.423343066264, 14448.855511444883, 14466.493672721457, 13763.65590860229, 13824.516141935035, 13847.584572462842, 13870.791938120936, 13874.0, 734.1080587086689, 885.0485727842563, 899.6896070855577, 902.8871391076116, 905.7871400220943, 887.7203680840547, 897.9012308646044, 898.8471959766823, 902.5712786426428, 902.715644571961, 924.8843894513186, 936.1761649748212, 936.7892224249557, 937.7046230437425, 937.7093101138635, 786.1745167574053, 945.4658118163215, 954.8901876284247, 955.7515046087998, 955.928305377096, 696.7770313499632, 697.2017040488663, 699.1610067918467, 700.6846918886522, 701.4773993374918, 14691.11853288806, 14757.926210368987, 14765.114093154445, 14767.187804670739, 14774.335154918055, 14784.48254311094, 14786.0, 15108.54674359771, 15150.090994540253, 15281.388744450209, 12114.939425302817, 12195.329256890867, 12233.143679942408, 12350.320732359716, 12740.171888827197, 3913.5695073541888, 3927.1949250403886, 3996.580359062286, 4004.819783109767, 4032.697547683906, 54938.45061549373, 56071.15893261564, 56444.71777641086, 56570.15144772832, 56583.151252731244, 11644.32387477471, 11865.940670296593, 11923.582674606347, 12142.575009874789, 12210.26738395699, 20577.794222057888, 20628.0, 20631.277905273244, 20665.276715314892, 20670.379888603366, 8657.42542638445, 8765.254953329038, 8854.734357969272, 8908.688195913111, 8935.597898094602, 4865.878353041131, 4915.827946021872, 5035.345405097314, 5186.429492755794, 5281.841544753664, 3617.7467577269863, 3646.908827279286, 3670.2659468106485, 3671.30245253401, 3673.063368840982, 611.1291409741101, 641.5220660607877, 661.5567569728294, 661.6956200147889, 686.605202008847, 775.8991331126917, 781.5427974634903, 782.8708263136518, 783.5533745764973, 789.9289063984154, 8793.824123517494, 9287.257019438428, 9417.623295068257, 9425.575849086808, 9484.668036618685, 784.0512979295003, 790.8260182759784, 806.1817255485687, 809.223145780046, 811.5252577242379, 4281.100968796525, 4396.3185706214945, 4411.139827733561, 4442.333649952533, 4483.596476317147, 60172.39827601756, 60215.39784602186, 60433.0, 61700.38299617036, 62078.0, 49810.50189498131, 50574.0, 50953.745231273606, 51141.74429127831, 51259.0, 52696.73651631717, 53186.46813531892, 53810.730946345015, 53890.46109538854, 54835.17747233795, 9928.751781205528, 10117.08946194846, 10126.341787783771, 10163.0, 10292.742681433025, 37135.44296835495, 37964.05089872775, 38515.229695406495, 38681.6131838678, 38720.6127938717, 50088.0, 50130.0, 50409.243861341376, 50578.0, 53370.73314633402, 12232.571859984857, 12286.631401057983, 13235.470581176645, 13306.800397993844, 13461.663458413617, 12915.289659068842, 14064.296785160497, 14386.35261413218, 14590.0, 14897.106173629616, 13260.867391326348, 13296.268705221306, 13453.932730336286, 13958.860411396163, 13991.370388332345, 13536.796948045983, 13927.651808704863, 13930.721385572435, 13960.441582336593, 14196.290185490478, 12935.223886566837, 13263.33683315811, 13546.254955977516, 13647.317634118453, 14127.15237085778, 11575.536978521102, 11660.490101701598, 11707.121965852424, 12063.819042714542, 12201.694957625776, 11384.43077846121, 11396.601118960796, 11472.31166130035, 11659.650210493699, 11705.297682138758], "value": 7205.907478848511, "unit": "score"}], "name": "dromaeo_css", "value": 7535.298471753306, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 108.0, 111.0, 112.0, 113.0, 106.0, 109.0, 109.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 154.0, 172.0, 124.0, 155.0, 147.0, 126.0, 178.0, 128.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 161.0, 160.0, 162.0, 163.0, 159.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 173.0, 72.0, 75.0, 74.0, 76.0, 157.0, 73.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 149.0, 91.0, 92.0, 92.0, 151.0, 92.0, 92.0, 149.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 144.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 54.0, 55.0, 55.0, 55.0, 78.0, 52.0, 53.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 73.0, 70.0, 71.0, 74.0, 72.0, 72.0, 71.0, 72.0, 72.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 111.0, 110.0, 113.0, 112.0, 114.0, 112.0, 134.0, 112.0], "value": 114.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 159.0, 158.0, 157.0, 160.0, 163.0, 158.0, 159.0, 159.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 64.0, 66.0, 64.0, 64.0, 65.0, 65.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1501.3, "alertThreshold": 2.0}]} 18:38:46 INFO - Return code: 0 18:38:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:38:46 ERROR - # TBPL SUCCESS # 18:38:46 INFO - Running post-action listener: _resource_record_post_action 18:38:46 INFO - Running post-run listener: _resource_record_post_run 18:38:47 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 28672; Write bytes: 462360576; Read time: 16; Write time: 965724 18:38:47 INFO - install - Wall time: 14s; CPU: 20.0%; Read bytes: 0; Write bytes: 242143232; Read time: 0; Write time: 666188 18:38:47 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219680768; Read time: 8; Write time: 298976 18:38:47 INFO - Running post-run listener: _upload_blobber_files 18:38:47 INFO - Blob upload gear active. 18:38:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:38:47 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 18:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:38:48 INFO - (blobuploader) - INFO - Open directory for files ... 18:38:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:38:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:38:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:48 INFO - (blobuploader) - INFO - Done attempting. 18:38:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:38:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:38:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:49 INFO - (blobuploader) - INFO - Done attempting. 18:38:49 INFO - (blobuploader) - INFO - Iteration through files over. 18:38:49 INFO - Return code: 0 18:38:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:38:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:38:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ecbff219f9de371c03ac77657242f90fc266ec4adcd020f43d5e30c38ebb4bbac9b61f5a2028a15cf02e57af4b95b0ad87a41805c00826409493b4acb7d83f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b1500e25cf80ff86828d04bf2b6bc9e1cec1ff755a4d87245c92f8e8b170f8a8a4c612da8ba2bfd8adf5328c34baf0d84bb7f52d720ae45e9a3e475b64983c5"} 18:38:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:38:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:38:49 INFO - Contents: 18:38:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ecbff219f9de371c03ac77657242f90fc266ec4adcd020f43d5e30c38ebb4bbac9b61f5a2028a15cf02e57af4b95b0ad87a41805c00826409493b4acb7d83f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b1500e25cf80ff86828d04bf2b6bc9e1cec1ff755a4d87245c92f8e8b170f8a8a4c612da8ba2bfd8adf5328c34baf0d84bb7f52d720ae45e9a3e475b64983c5"} 18:38:49 INFO - Running post-run listener: copy_logs_to_upload_dir 18:38:49 INFO - Copying logs to upload dir... 18:38:49 INFO - mkdir: /builds/slave/test/build/upload/logs 18:38:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.669183 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-13 18:38:49.583005) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 18:38:49.586862) ========= 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=8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ecbff219f9de371c03ac77657242f90fc266ec4adcd020f43d5e30c38ebb4bbac9b61f5a2028a15cf02e57af4b95b0ad87a41805c00826409493b4acb7d83f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b1500e25cf80ff86828d04bf2b6bc9e1cec1ff755a4d87245c92f8e8b170f8a8a4c612da8ba2bfd8adf5328c34baf0d84bb7f52d720ae45e9a3e475b64983c5"} build_url:https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/HLwl6fOpS7ugiM7Q239UYQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ecbff219f9de371c03ac77657242f90fc266ec4adcd020f43d5e30c38ebb4bbac9b61f5a2028a15cf02e57af4b95b0ad87a41805c00826409493b4acb7d83f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b1500e25cf80ff86828d04bf2b6bc9e1cec1ff755a4d87245c92f8e8b170f8a8a4c612da8ba2bfd8adf5328c34baf0d84bb7f52d720ae45e9a3e475b64983c5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 18:38:49.612659) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:38:49.613006) ========= 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=8783db0840cc980e80bb0bd400000236-1468458723.180478-1607813905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:38:49.695270) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 18:38:49.695667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 18:38:49.696018) ========= ========= Total master_lag: 0.17 =========