builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1461703453.91 results: success (0) buildid: 20160426062558 builduid: 18458ff6a626441ea2f2e0a4fd3bd5e1 revision: cbeae0c4410bef3864b3d3f4ad939321c61cb15b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:13.907710) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:13.908489) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:13.909033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:13.928148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:13.928825) ========= 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=1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 13:44:14-- 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% 67.6M=0s 2016-04-26 13:44:14 (67.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:14.039876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:14.040208) ========= 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=1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017958 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:14.090032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:14.090426) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cbeae0c4410bef3864b3d3f4ad939321c61cb15b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cbeae0c4410bef3864b3d3f4ad939321c61cb15b --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=1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 13:44:14,684 truncating revision to first 12 chars 2016-04-26 13:44:14,684 Setting DEBUG logging. 2016-04-26 13:44:14,685 attempt 1/10 2016-04-26 13:44:14,685 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cbeae0c4410b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 13:44:15,076 unpacking tar archive at: mozilla-aurora-cbeae0c4410b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667403 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:14.771046) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:14.771389) ========= script_repo_revision: cbeae0c4410bef3864b3d3f4ad939321c61cb15b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:14.771836) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:14.772106) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 13:44:14.781475) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 8 secs) (at 2016-04-26 13:44:14.781935) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:44:15 INFO - MultiFileLogger online at 20160426 13:44:15 in /builds/slave/test 13:44:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:44:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:44:15 INFO - {'append_to_log': False, 13:44:15 INFO - 'base_work_dir': '/builds/slave/test', 13:44:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:44:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:44:15 INFO - 'branch': 'Mozilla-Aurora', 13:44:15 INFO - 'buildbot_json_path': 'buildprops.json', 13:44:15 INFO - 'config_files': ('talos/linux_config.py',), 13:44:15 INFO - 'default_actions': ('clobber', 13:44:15 INFO - 'read-buildbot-config', 13:44:15 INFO - 'download-and-extract', 13:44:15 INFO - 'populate-webroot', 13:44:15 INFO - 'create-virtualenv', 13:44:15 INFO - 'install', 13:44:15 INFO - 'run-tests'), 13:44:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:44:15 INFO - 'download_minidump_stackwalk': True, 13:44:15 INFO - 'download_symbols': 'ondemand', 13:44:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:44:15 INFO - 'tooltool.py': '/tools/tooltool.py', 13:44:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:44:15 INFO - '/tools/misc-python/virtualenv.py')}, 13:44:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:44:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:44:15 INFO - 'installer_path': 'installer.exe', 13:44:15 INFO - 'log_level': 'info', 13:44:15 INFO - 'log_name': 'talos', 13:44:15 INFO - 'log_to_console': True, 13:44:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:44:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:44:15 INFO - 'opt_config_files': (), 13:44:15 INFO - 'pip_index': False, 13:44:15 INFO - 'sps_profile': False, 13:44:15 INFO - 'sps_profile_interval': 0, 13:44:15 INFO - 'suite': 'dromaeojs', 13:44:15 INFO - 'system_bits': '32', 13:44:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:44:15 INFO - 'title': 'talos-linux64-ix-069', 13:44:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:44:15 INFO - 'use_talos_json': True, 13:44:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:44:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:44:15 INFO - 'work_dir': 'build'} 13:44:15 INFO - ##### 13:44:15 INFO - ##### Running clobber step. 13:44:15 INFO - ##### 13:44:15 INFO - Running pre-action listener: _resource_record_pre_action 13:44:15 INFO - Running main action method: clobber 13:44:15 INFO - rmtree: /builds/slave/test/build 13:44:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:44:15 INFO - Running post-action listener: _resource_record_post_action 13:44:15 INFO - ##### 13:44:15 INFO - ##### Running read-buildbot-config step. 13:44:15 INFO - ##### 13:44:15 INFO - Running pre-action listener: _resource_record_pre_action 13:44:15 INFO - Running main action method: read_buildbot_config 13:44:15 INFO - Using buildbot properties: 13:44:15 INFO - { 13:44:15 INFO - "project": "", 13:44:15 INFO - "product": "firefox", 13:44:15 INFO - "script_repo_revision": "production", 13:44:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:44:15 INFO - "repository": "", 13:44:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:44:15 INFO - "buildid": "20160426062558", 13:44:15 INFO - "pgo_build": "True", 13:44:15 INFO - "basedir": "/builds/slave/test", 13:44:15 INFO - "buildnumber": 470, 13:44:15 INFO - "slavename": "talos-linux64-ix-069", 13:44:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:44:15 INFO - "platform": "ubuntu64_hw", 13:44:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:44:15 INFO - "branch": "mozilla-aurora", 13:44:15 INFO - "repo_path": "releases/mozilla-aurora", 13:44:15 INFO - "revision": "cbeae0c4410bef3864b3d3f4ad939321c61cb15b", 13:44:15 INFO - "stage_platform": "linux64-pgo", 13:44:15 INFO - "builduid": "18458ff6a626441ea2f2e0a4fd3bd5e1", 13:44:15 INFO - "slavebuilddir": "test" 13:44:15 INFO - } 13:44:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 13:44:15 INFO - Running post-action listener: _resource_record_post_action 13:44:15 INFO - ##### 13:44:15 INFO - ##### Running download-and-extract step. 13:44:15 INFO - ##### 13:44:15 INFO - Running pre-action listener: _resource_record_pre_action 13:44:15 INFO - Running main action method: download_and_extract 13:44:15 INFO - mkdir: /builds/slave/test/build/tests 13:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:15 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:44:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:44:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:44:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:44:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:44:16 INFO - Downloaded 1361 bytes. 13:44:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:44:16 INFO - Using the following test package requirements: 13:44:16 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:44:16 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:44:16 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:44:16 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:16 INFO - u'jsshell-linux-x86_64.zip'], 13:44:16 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:44:16 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:44:16 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:44:16 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:44:16 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:44:16 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:44:16 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:44:16 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:44:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:44:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:44:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:44:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:51:44 INFO - Downloaded 23820445 bytes. 13:51:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:51:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:51:45 INFO - Return code: 0 13:51:45 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:51:45 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')]} 13:51:45 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:51:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:51:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:51:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:51:48 INFO - Downloaded 23820445 bytes. 13:51:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:51:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:51:50 INFO - Return code: 0 13:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:51:50 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:51:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:51:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:51:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:51:52 INFO - Downloaded 10840145 bytes. 13:51:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:51:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:51:52 INFO - Return code: 0 13:51:52 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')]} 13:51:52 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:51:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:51:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:51:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:51:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:51:59 INFO - Downloaded 62689705 bytes. 13:51:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:51:59 INFO - mkdir: /builds/slave/test/properties 13:51:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:59 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:59 INFO - Contents: 13:51:59 INFO - build_url:https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:52:00 INFO - Running post-action listener: _resource_record_post_action 13:52:00 INFO - Running post-action listener: set_extra_try_arguments 13:52:00 INFO - ##### 13:52:00 INFO - ##### Running populate-webroot step. 13:52:00 INFO - ##### 13:52:00 INFO - Running pre-action listener: _resource_record_pre_action 13:52:00 INFO - Running main action method: populate_webroot 13:52:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:52:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:52:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:52:00 INFO - '--tppagecycles', 13:52:00 INFO - '7'], 13:52:00 INFO - 'tests': ['tsvgm']}}, 13:52:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:52:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:52:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:52:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:52:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:52:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:52:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:00 INFO - 'talos_options': ['--disable-e10s'], 13:52:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:00 INFO - 'talos_options': ['--disable-e10s'], 13:52:00 INFO - 'tests': ['damp', 'tps']}, 13:52:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:00 INFO - 'tests': ['damp', 'tps']}, 13:52:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:52:00 INFO - 'tests': ['dromaeo_dom']}, 13:52:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:52:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:52:00 INFO - 'tests': ['a11yr', 13:52:00 INFO - 'ts_paint', 13:52:00 INFO - 'tpaint', 13:52:00 INFO - 'sessionrestore', 13:52:00 INFO - 'sessionrestore_no_auto_restore', 13:52:00 INFO - 'tabpaint']}, 13:52:00 INFO - 'other-e10s': {'tests': ['a11yr', 13:52:00 INFO - 'ts_paint', 13:52:00 INFO - 'tpaint', 13:52:00 INFO - 'sessionrestore', 13:52:00 INFO - 'sessionrestore_no_auto_restore', 13:52:00 INFO - 'tabpaint']}, 13:52:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:52:00 INFO - 'ts_paint', 13:52:00 INFO - 'tpaint', 13:52:00 INFO - 'sessionrestore', 13:52:00 INFO - 'sessionrestore_no_auto_restore', 13:52:00 INFO - 'tabpaint']}, 13:52:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:52:00 INFO - 'ts_paint', 13:52:00 INFO - 'tpaint', 13:52:00 INFO - 'sessionrestore', 13:52:00 INFO - 'sessionrestore_no_auto_restore', 13:52:00 INFO - 'tabpaint']}, 13:52:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:52:00 INFO - 'tests': ['a11yr', 13:52:00 INFO - 'ts_paint', 13:52:00 INFO - 'tpaint', 13:52:00 INFO - 'sessionrestore', 13:52:00 INFO - 'sessionrestore_no_auto_restore', 13:52:00 INFO - 'tabpaint']}, 13:52:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:52:00 INFO - 'tests': ['a11yr', 13:52:00 INFO - 'ts_paint', 13:52:00 INFO - 'tpaint', 13:52:00 INFO - 'sessionrestore', 13:52:00 INFO - 'sessionrestore_no_auto_restore', 13:52:00 INFO - 'tabpaint']}, 13:52:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:52:00 INFO - 'tests': ['tsvgx', 13:52:00 INFO - 'tsvgr_opacity', 13:52:00 INFO - 'tart', 13:52:00 INFO - 'tscrollx', 13:52:00 INFO - 'cart']}, 13:52:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:52:00 INFO - 'tsvgr_opacity', 13:52:00 INFO - 'tart', 13:52:00 INFO - 'tscrollx', 13:52:00 INFO - 'cart']}, 13:52:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:00 INFO - 'talos_options': ['--disable-e10s'], 13:52:00 INFO - 'tests': ['tp5o']}, 13:52:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:00 INFO - 'tests': ['tp5o']}, 13:52:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:00 INFO - 'talos_options': ['--disable-e10s', 13:52:00 INFO - '--xperf_path', 13:52:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:00 INFO - 'tests': ['tp5n']}, 13:52:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:00 INFO - 'talos_options': ['--xperf_path', 13:52:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:00 INFO - 'tests': ['tp5n']}}, 13:52:00 INFO - 'talos.zip': {'path': '', 13:52:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:52:00 INFO - Running post-action listener: _resource_record_post_action 13:52:00 INFO - ##### 13:52:00 INFO - ##### Running create-virtualenv step. 13:52:00 INFO - ##### 13:52:00 INFO - Running pre-action listener: _resource_record_pre_action 13:52:00 INFO - Running main action method: create_virtualenv 13:52:00 INFO - Creating virtualenv /builds/slave/test/build/venv 13:52:00 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 13:52:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:52:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:52:00 INFO - Using real prefix '/usr' 13:52:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:52:01 INFO - Installing distribute.............................................................................................................................................................................................done. 13:52:03 INFO - Installing pip.................done. 13:52:03 INFO - Return code: 0 13:52:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:52:03 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')]} 13:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:03 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')]} 13:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:03 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 0x7f99e0c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2211410>, '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 0x2212310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22127a0>, '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': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', '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 13:52:03 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 13:52:03 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 13:52:03 INFO - Using env: {'DISPLAY': ':0', 13:52:03 INFO - 'HOME': '/home/cltbld', 13:52:03 INFO - 'LANG': 'en_US.UTF-8', 13:52:03 INFO - 'LANGUAGE': 'en_US:en', 13:52:03 INFO - 'LOGNAME': 'cltbld', 13:52:03 INFO - 'MAIL': '/var/mail/cltbld', 13:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:03 INFO - 'MOZ_NO_REMOTE': '1', 13:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:03 INFO - 'NO_EM_RESTART': '1', 13:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:03 INFO - 'PWD': '/builds/slave/test', 13:52:03 INFO - 'SHELL': '/bin/bash', 13:52:03 INFO - 'SHLVL': '1', 13:52:03 INFO - 'TERM': 'linux', 13:52:03 INFO - 'TMOUT': '86400', 13:52:03 INFO - 'USER': 'cltbld', 13:52:03 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', 13:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:03 INFO - '_': '/tools/buildbot/bin/python'} 13:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:03 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 13:52:03 INFO - Cleaning up... 13:52:03 INFO - Return code: 0 13:52:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:52:03 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')]} 13:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:03 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')]} 13:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:03 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 0x7f99e0c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2211410>, '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 0x2212310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22127a0>, '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': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', '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 13:52:03 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 13:52:03 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 13:52:03 INFO - Using env: {'DISPLAY': ':0', 13:52:03 INFO - 'HOME': '/home/cltbld', 13:52:03 INFO - 'LANG': 'en_US.UTF-8', 13:52:03 INFO - 'LANGUAGE': 'en_US:en', 13:52:03 INFO - 'LOGNAME': 'cltbld', 13:52:03 INFO - 'MAIL': '/var/mail/cltbld', 13:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:03 INFO - 'MOZ_NO_REMOTE': '1', 13:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:03 INFO - 'NO_EM_RESTART': '1', 13:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:03 INFO - 'PWD': '/builds/slave/test', 13:52:03 INFO - 'SHELL': '/bin/bash', 13:52:03 INFO - 'SHLVL': '1', 13:52:03 INFO - 'TERM': 'linux', 13:52:03 INFO - 'TMOUT': '86400', 13:52:03 INFO - 'USER': 'cltbld', 13:52:03 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', 13:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:03 INFO - '_': '/tools/buildbot/bin/python'} 13:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:03 INFO - Downloading/unpacking psutil>=0.7.1 13:52:03 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 13:52:03 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 13:52:03 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 13:52:03 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 13:52:03 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 13:52:03 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 13:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:52:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:05 INFO - Installing collected packages: psutil 13:52:05 INFO - Running setup.py install for psutil 13:52:05 INFO - building 'psutil._psutil_linux' extension 13:52:05 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 13:52:05 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 13:52:05 INFO - building 'psutil._psutil_posix' extension 13:52:05 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 13:52:05 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 13:52:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:05 INFO - Successfully installed psutil 13:52:05 INFO - Cleaning up... 13:52:05 INFO - Return code: 0 13:52:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:52:05 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')]} 13:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:05 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')]} 13:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:05 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 0x7f99e0c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2211410>, '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 0x2212310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22127a0>, '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': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', '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 13:52:05 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 13:52:05 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 13:52:05 INFO - Using env: {'DISPLAY': ':0', 13:52:05 INFO - 'HOME': '/home/cltbld', 13:52:05 INFO - 'LANG': 'en_US.UTF-8', 13:52:05 INFO - 'LANGUAGE': 'en_US:en', 13:52:05 INFO - 'LOGNAME': 'cltbld', 13:52:05 INFO - 'MAIL': '/var/mail/cltbld', 13:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:05 INFO - 'MOZ_NO_REMOTE': '1', 13:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:05 INFO - 'NO_EM_RESTART': '1', 13:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:05 INFO - 'PWD': '/builds/slave/test', 13:52:05 INFO - 'SHELL': '/bin/bash', 13:52:05 INFO - 'SHLVL': '1', 13:52:05 INFO - 'TERM': 'linux', 13:52:05 INFO - 'TMOUT': '86400', 13:52:05 INFO - 'USER': 'cltbld', 13:52:05 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', 13:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:05 INFO - '_': '/tools/buildbot/bin/python'} 13:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:52:08 INFO - Installing collected packages: mozsystemmonitor 13:52:08 INFO - Running setup.py install for mozsystemmonitor 13:52:08 INFO - Successfully installed mozsystemmonitor 13:52:08 INFO - Cleaning up... 13:52:08 INFO - Return code: 0 13:52:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:08 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 0x7f99e0c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2211410>, '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 0x2212310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22127a0>, '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': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', '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 13:52:08 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 13:52:08 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 13:52:08 INFO - Using env: {'DISPLAY': ':0', 13:52:08 INFO - 'HOME': '/home/cltbld', 13:52:08 INFO - 'LANG': 'en_US.UTF-8', 13:52:08 INFO - 'LANGUAGE': 'en_US:en', 13:52:08 INFO - 'LOGNAME': 'cltbld', 13:52:08 INFO - 'MAIL': '/var/mail/cltbld', 13:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:08 INFO - 'MOZ_NO_REMOTE': '1', 13:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:08 INFO - 'NO_EM_RESTART': '1', 13:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:08 INFO - 'PWD': '/builds/slave/test', 13:52:08 INFO - 'SHELL': '/bin/bash', 13:52:08 INFO - 'SHLVL': '1', 13:52:08 INFO - 'TERM': 'linux', 13:52:08 INFO - 'TMOUT': '86400', 13:52:08 INFO - 'USER': 'cltbld', 13:52:08 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', 13:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:08 INFO - '_': '/tools/buildbot/bin/python'} 13:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:08 INFO - Downloading/unpacking blobuploader==1.2.4 13:52:08 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 13:52:08 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 13:52:08 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 13:52:08 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 13:52:08 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 13:52:08 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 13:52:10 INFO - Downloading blobuploader-1.2.4.tar.gz 13:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:52:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:52:10 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 13:52:10 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 13:52:10 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 13:52:10 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 13:52:10 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 13:52:10 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 13:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:52:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:52:10 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 13:52:10 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 13:52:10 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 13:52:10 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 13:52:10 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 13:52:10 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 13:52:10 INFO - Downloading docopt-0.6.1.tar.gz 13:52:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:52:11 INFO - Installing collected packages: blobuploader, requests, docopt 13:52:11 INFO - Running setup.py install for blobuploader 13:52:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:52:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:52:11 INFO - Running setup.py install for requests 13:52:11 INFO - Running setup.py install for docopt 13:52:11 INFO - Successfully installed blobuploader requests docopt 13:52:11 INFO - Cleaning up... 13:52:11 INFO - Return code: 0 13:52:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:11 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 0x7f99e0c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2211410>, '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 0x2212310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22127a0>, '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': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', '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 13:52:11 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 13:52:11 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 13:52:11 INFO - Using env: {'DISPLAY': ':0', 13:52:11 INFO - 'HOME': '/home/cltbld', 13:52:11 INFO - 'LANG': 'en_US.UTF-8', 13:52:11 INFO - 'LANGUAGE': 'en_US:en', 13:52:11 INFO - 'LOGNAME': 'cltbld', 13:52:11 INFO - 'MAIL': '/var/mail/cltbld', 13:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:11 INFO - 'MOZ_NO_REMOTE': '1', 13:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:11 INFO - 'NO_EM_RESTART': '1', 13:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:11 INFO - 'PWD': '/builds/slave/test', 13:52:11 INFO - 'SHELL': '/bin/bash', 13:52:11 INFO - 'SHLVL': '1', 13:52:11 INFO - 'TERM': 'linux', 13:52:11 INFO - 'TMOUT': '86400', 13:52:11 INFO - 'USER': 'cltbld', 13:52:11 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', 13:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:11 INFO - '_': '/tools/buildbot/bin/python'} 13:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:52:11 INFO - Running setup.py (path:/tmp/pip-geweGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:52:11 INFO - Running setup.py (path:/tmp/pip-vLTylQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:52:12 INFO - Running setup.py (path:/tmp/pip-A1_wB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:52:12 INFO - Running setup.py (path:/tmp/pip-K1tozv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:52:12 INFO - Running setup.py (path:/tmp/pip-dSvewm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:52:12 INFO - Running setup.py (path:/tmp/pip-mb8G11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:52:12 INFO - Running setup.py (path:/tmp/pip-JNrgq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:52:12 INFO - Running setup.py (path:/tmp/pip-gODCHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:52:12 INFO - Running setup.py (path:/tmp/pip-9DKPcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:52:12 INFO - Running setup.py (path:/tmp/pip-NfY_x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:52:12 INFO - Running setup.py (path:/tmp/pip-36dXKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:52:12 INFO - Running setup.py (path:/tmp/pip-Saw5Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:52:12 INFO - Running setup.py (path:/tmp/pip-kEAHi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:52:12 INFO - Running setup.py (path:/tmp/pip-hsy_UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:12 INFO - Running setup.py (path:/tmp/pip-uieYYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:52:12 INFO - Running setup.py (path:/tmp/pip-xglnsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:52:13 INFO - Running setup.py (path:/tmp/pip-7cr1Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:52:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:52:13 INFO - Running setup.py install for manifestparser 13:52:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:52:13 INFO - Running setup.py install for mozcrash 13:52:13 INFO - Running setup.py install for mozdebug 13:52:13 INFO - Running setup.py install for mozdevice 13:52:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:52:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:52:13 INFO - Running setup.py install for mozfile 13:52:13 INFO - Running setup.py install for mozhttpd 13:52:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:52:13 INFO - Running setup.py install for mozinfo 13:52:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:52:13 INFO - Running setup.py install for mozInstall 13:52:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:52:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:52:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:52:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:52:13 INFO - Running setup.py install for mozleak 13:52:14 INFO - Running setup.py install for mozlog 13:52:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:52:14 INFO - Running setup.py install for moznetwork 13:52:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:52:14 INFO - Running setup.py install for mozprocess 13:52:14 INFO - Running setup.py install for mozprofile 13:52:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:52:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:52:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:52:14 INFO - Running setup.py install for mozrunner 13:52:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:52:14 INFO - Running setup.py install for mozscreenshot 13:52:14 INFO - Running setup.py install for moztest 13:52:14 INFO - Running setup.py install for mozversion 13:52:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:52:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:52:14 INFO - Cleaning up... 13:52:14 INFO - Return code: 0 13:52:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:14 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 0x7f99e0c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2211410>, '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 0x2212310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22127a0>, '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': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', '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 13:52:14 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 13:52:14 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 13:52:14 INFO - Using env: {'DISPLAY': ':0', 13:52:14 INFO - 'HOME': '/home/cltbld', 13:52:14 INFO - 'LANG': 'en_US.UTF-8', 13:52:14 INFO - 'LANGUAGE': 'en_US:en', 13:52:14 INFO - 'LOGNAME': 'cltbld', 13:52:14 INFO - 'MAIL': '/var/mail/cltbld', 13:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:14 INFO - 'MOZ_NO_REMOTE': '1', 13:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:14 INFO - 'NO_EM_RESTART': '1', 13:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:14 INFO - 'PWD': '/builds/slave/test', 13:52:14 INFO - 'SHELL': '/bin/bash', 13:52:14 INFO - 'SHLVL': '1', 13:52:14 INFO - 'TERM': 'linux', 13:52:14 INFO - 'TMOUT': '86400', 13:52:14 INFO - 'USER': 'cltbld', 13:52:14 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', 13:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:14 INFO - '_': '/tools/buildbot/bin/python'} 13:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:52:15 INFO - Running setup.py (path:/tmp/pip-8lkd1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:52:15 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)) 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:52:15 INFO - Running setup.py (path:/tmp/pip-vgwmvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:52:15 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)) 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:52:15 INFO - Running setup.py (path:/tmp/pip-XmDBXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:52:15 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)) 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:52:15 INFO - Running setup.py (path:/tmp/pip-EmiggK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:52:15 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)) 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:52:15 INFO - Running setup.py (path:/tmp/pip-ZuF1Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:52:15 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)) 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:52:15 INFO - Running setup.py (path:/tmp/pip-7H28XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:52:15 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)) 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:52:15 INFO - Running setup.py (path:/tmp/pip-I1bGt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:52:15 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)) 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:52:15 INFO - Running setup.py (path:/tmp/pip-ZC0ngC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:52:15 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)) 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:52:15 INFO - Running setup.py (path:/tmp/pip-QoE1Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:52:15 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)) 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:52:15 INFO - Running setup.py (path:/tmp/pip-tVYwq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:52:15 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)) 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:52:15 INFO - Running setup.py (path:/tmp/pip-DHCSFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:52:15 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)) 13:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:52:15 INFO - Running setup.py (path:/tmp/pip-bmGoeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:52:16 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)) 13:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:52:16 INFO - Running setup.py (path:/tmp/pip-ydLlBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:52:16 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)) 13:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:52:16 INFO - Running setup.py (path:/tmp/pip-C4N5AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:52:16 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)) 13:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:16 INFO - Running setup.py (path:/tmp/pip-1uYGtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:16 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)) 13:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:52:16 INFO - Running setup.py (path:/tmp/pip-bIp3_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:52:16 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)) 13:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:52:16 INFO - Running setup.py (path:/tmp/pip-EZS9tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:52:16 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)) 13:52:16 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)) 13:52:16 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)) 13:52:16 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)) 13:52:16 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)) 13:52:16 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)) 13:52:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:18 INFO - Downloading blessings-1.6.tar.gz 13:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:52:18 INFO - Installing collected packages: blessings 13:52:18 INFO - Running setup.py install for blessings 13:52:18 INFO - Successfully installed blessings 13:52:18 INFO - Cleaning up... 13:52:18 INFO - Return code: 0 13:52:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:52:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:52:18 INFO - Reading from file tmpfile_stdout 13:52:18 INFO - Current package versions: 13:52:18 INFO - argparse == 1.2.1 13:52:18 INFO - blessings == 1.6 13:52:18 INFO - blobuploader == 1.2.4 13:52:18 INFO - docopt == 0.6.1 13:52:18 INFO - manifestparser == 1.1 13:52:18 INFO - mozInstall == 1.12 13:52:18 INFO - mozcrash == 0.17 13:52:18 INFO - mozdebug == 0.1 13:52:18 INFO - mozdevice == 0.48 13:52:18 INFO - mozfile == 1.2 13:52:18 INFO - mozhttpd == 0.7 13:52:18 INFO - mozinfo == 0.9 13:52:18 INFO - mozleak == 0.1 13:52:18 INFO - mozlog == 3.1 13:52:18 INFO - moznetwork == 0.27 13:52:18 INFO - mozprocess == 0.22 13:52:18 INFO - mozprofile == 0.28 13:52:18 INFO - mozrunner == 6.11 13:52:18 INFO - mozscreenshot == 0.1 13:52:18 INFO - mozsystemmonitor == 0.0 13:52:18 INFO - moztest == 0.7 13:52:18 INFO - mozversion == 1.4 13:52:18 INFO - psutil == 3.1.1 13:52:18 INFO - requests == 1.2.3 13:52:18 INFO - wsgiref == 0.1.2 13:52:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:18 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 0x7f99e0c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2211410>, '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 0x2212310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22127a0>, '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': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', '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 13:52:18 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 13:52:18 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 13:52:18 INFO - Using env: {'DISPLAY': ':0', 13:52:18 INFO - 'HOME': '/home/cltbld', 13:52:18 INFO - 'LANG': 'en_US.UTF-8', 13:52:18 INFO - 'LANGUAGE': 'en_US:en', 13:52:18 INFO - 'LOGNAME': 'cltbld', 13:52:18 INFO - 'MAIL': '/var/mail/cltbld', 13:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:18 INFO - 'MOZ_NO_REMOTE': '1', 13:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:18 INFO - 'NO_EM_RESTART': '1', 13:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:18 INFO - 'PWD': '/builds/slave/test', 13:52:18 INFO - 'SHELL': '/bin/bash', 13:52:18 INFO - 'SHLVL': '1', 13:52:18 INFO - 'TERM': 'linux', 13:52:18 INFO - 'TMOUT': '86400', 13:52:18 INFO - 'USER': 'cltbld', 13:52:18 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', 13:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:18 INFO - '_': '/tools/buildbot/bin/python'} 13:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:18 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)) 13:52:18 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)) 13:52:18 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)) 13:52:18 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)) 13:52:18 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)) 13:52:18 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)) 13:52:18 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)) 13:52:18 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)) 13:52:18 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)) 13:52:18 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)) 13:52:18 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)) 13:52:18 INFO - Cleaning up... 13:52:18 INFO - Return code: 0 13:52:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e0c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2211410>, '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 0x2212310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22127a0>, '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': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', '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 13:52:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:52:18 INFO - Using env: {'DISPLAY': ':0', 13:52:18 INFO - 'HOME': '/home/cltbld', 13:52:18 INFO - 'LANG': 'en_US.UTF-8', 13:52:18 INFO - 'LANGUAGE': 'en_US:en', 13:52:18 INFO - 'LOGNAME': 'cltbld', 13:52:18 INFO - 'MAIL': '/var/mail/cltbld', 13:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:18 INFO - 'MOZ_NO_REMOTE': '1', 13:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:18 INFO - 'NO_EM_RESTART': '1', 13:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:18 INFO - 'PWD': '/builds/slave/test', 13:52:18 INFO - 'SHELL': '/bin/bash', 13:52:18 INFO - 'SHLVL': '1', 13:52:18 INFO - 'TERM': 'linux', 13:52:18 INFO - 'TMOUT': '86400', 13:52:18 INFO - 'USER': 'cltbld', 13:52:18 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', 13:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:18 INFO - '_': '/tools/buildbot/bin/python'} 13:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:19 INFO - Downloading/unpacking jsonschema 13:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:52:21 INFO - Downloading/unpacking functools32 (from jsonschema) 13:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:21 INFO - Downloading functools32-3.2.3-2.tar.gz 13:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:52:21 INFO - warning: no files found matching '*.txt' 13:52:21 INFO - no previously-included directories found matching 'build' 13:52:21 INFO - no previously-included directories found matching 'dist' 13:52:21 INFO - no previously-included directories found matching '.git*' 13:52:21 INFO - Installing collected packages: jsonschema, functools32 13:52:21 INFO - Running setup.py install for functools32 13:52:21 INFO - warning: no files found matching '*.txt' 13:52:21 INFO - no previously-included directories found matching 'build' 13:52:21 INFO - no previously-included directories found matching 'dist' 13:52:21 INFO - no previously-included directories found matching '.git*' 13:52:21 INFO - Successfully installed jsonschema functools32 13:52:21 INFO - Cleaning up... 13:52:21 INFO - Return code: 0 13:52:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e0c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2211410>, '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 0x2212310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22127a0>, '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': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', '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 13:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:52:21 INFO - Using env: {'DISPLAY': ':0', 13:52:21 INFO - 'HOME': '/home/cltbld', 13:52:21 INFO - 'LANG': 'en_US.UTF-8', 13:52:21 INFO - 'LANGUAGE': 'en_US:en', 13:52:21 INFO - 'LOGNAME': 'cltbld', 13:52:21 INFO - 'MAIL': '/var/mail/cltbld', 13:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:21 INFO - 'MOZ_NO_REMOTE': '1', 13:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:21 INFO - 'NO_EM_RESTART': '1', 13:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:21 INFO - 'PWD': '/builds/slave/test', 13:52:21 INFO - 'SHELL': '/bin/bash', 13:52:21 INFO - 'SHLVL': '1', 13:52:21 INFO - 'TERM': 'linux', 13:52:21 INFO - 'TMOUT': '86400', 13:52:21 INFO - 'USER': 'cltbld', 13:52:21 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', 13:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:21 INFO - '_': '/tools/buildbot/bin/python'} 13:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:21 INFO - Downloading/unpacking flake8 13:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:52:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:52:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:52:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:52:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:52:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:52:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:52:24 INFO - no previously-included directories found matching 'docs/_build' 13:52:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:52:24 INFO - Running setup.py install for pep8 13:52:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:52:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:52:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:52:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:52:24 INFO - no previously-included directories found matching 'docs/_build' 13:52:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:52:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:52:24 INFO - Cleaning up... 13:52:25 INFO - Return code: 0 13:52:25 INFO - Running post-action listener: _resource_record_post_action 13:52:25 INFO - Running post-action listener: _start_resource_monitoring 13:52:25 INFO - Starting resource monitoring. 13:52:25 INFO - ##### 13:52:25 INFO - ##### Running install step. 13:52:25 INFO - ##### 13:52:25 INFO - Running pre-action listener: _resource_record_pre_action 13:52:25 INFO - Running main action method: install 13:52:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:52:28 INFO - Reading from file tmpfile_stdout 13:52:28 INFO - Detecting whether we're running mozinstall >=1.0... 13:52:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:52:29 INFO - Reading from file tmpfile_stdout 13:52:29 INFO - Output received: 13:52:29 INFO - Usage: mozinstall [options] installer 13:52:29 INFO - Options: 13:52:29 INFO - -h, --help show this help message and exit 13:52:29 INFO - -d DEST, --destination=DEST 13:52:29 INFO - Directory to install application into. [default: 13:52:29 INFO - "/builds/slave/test"] 13:52:29 INFO - --app=APP Application being installed. [default: firefox] 13:52:29 INFO - mkdir: /builds/slave/test/build/application 13:52:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:52:45 INFO - Reading from file tmpfile_stdout 13:52:45 INFO - Output received: 13:52:45 INFO - /builds/slave/test/build/application/firefox/firefox 13:52:45 INFO - Running post-action listener: _resource_record_post_action 13:52:45 INFO - ##### 13:52:45 INFO - ##### Running run-tests step. 13:52:45 INFO - ##### 13:52:45 INFO - Running pre-action listener: _resource_record_pre_action 13:52:45 INFO - Running main action method: run_tests 13:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:45 INFO - Python 2.7.3 13:52:45 INFO - Return code: 0 13:52:45 INFO - grabbing minidump binary from tooltool 13:52:45 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')]} 13:52:45 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 0x2211410>, '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 0x2212310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22127a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52:45 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 13:52:45 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 13:52:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:45 INFO - Return code: 0 13:52:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:52:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:52:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:52:46 INFO - Return code: 0 13:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 13:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 13:52:46 INFO - Using env: {'DISPLAY': ':0', 13:52:46 INFO - 'HOME': '/home/cltbld', 13:52:46 INFO - 'LANG': 'en_US.UTF-8', 13:52:46 INFO - 'LANGUAGE': 'en_US:en', 13:52:46 INFO - 'LOGNAME': 'cltbld', 13:52:46 INFO - 'MAIL': '/var/mail/cltbld', 13:52:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:46 INFO - 'MOZ_NO_REMOTE': '1', 13:52:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:46 INFO - 'NO_EM_RESTART': '1', 13:52:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:46 INFO - 'PWD': '/builds/slave/test', 13:52:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:46 INFO - 'SHELL': '/bin/bash', 13:52:46 INFO - 'SHLVL': '1', 13:52:46 INFO - 'TERM': 'linux', 13:52:46 INFO - 'TMOUT': '86400', 13:52:46 INFO - 'USER': 'cltbld', 13:52:46 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406', 13:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:46 INFO - '_': '/tools/buildbot/bin/python'} 13:52:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 13:52:46 INFO - mozversion application_buildid: 20160426062558 13:52:46 INFO - mozversion application_changeset: cbeae0c4410bef3864b3d3f4ad939321c61cb15b 13:52:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:52:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:46 INFO - mozversion application_name: Firefox 13:52:46 INFO - mozversion application_remotingname: firefox-dev 13:52:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:52:46 INFO - mozversion application_vendor: Mozilla 13:52:46 INFO - mozversion application_version: 48.0a2 13:52:46 INFO - mozversion platform_buildid: 20160426062558 13:52:46 INFO - mozversion platform_changeset: cbeae0c4410bef3864b3d3f4ad939321c61cb15b 13:52:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:52:46 INFO - mozversion platform_version: 48.0a2 13:52:46 INFO - using testdate: 1461703966 13:52:46 INFO - actual date: 1461703966 13:52:46 INFO - starting webserver on 'localhost:46894' 13:52:46 INFO - SUITE-START | Running 2 tests 13:52:46 INFO - TEST-START | dromaeo_css 13:52:46 INFO - operating with platform_type : linux_ 13:52:46 INFO - Initialising browser for dromaeo_css test... 13:52:46 INFO - TEST-INFO | started process 23623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmvCzdM/profile http://localhost:46894/getInfo.html) 13:52:50 INFO - PROCESS | 23623 | __metrics Screen width/height:1600/1200 13:52:50 INFO - PROCESS | 23623 | colorDepth:24 13:52:50 INFO - PROCESS | 23623 | Browser inner width/height: 1024/697 13:52:50 INFO - PROCESS | 23623 | __metrics 13:52:51 ERROR - PROCESS | 23623 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:52:52 INFO - TEST-INFO | 23623: exit 0 13:52:52 INFO - Browser initialized. 13:52:52 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:52 INFO - TEST-INFO | started process 23717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmvCzdM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:04 INFO - PROCESS | 23717 | RSS: Main: 142733312 13:53:04 INFO - PROCESS | 23717 | 13:53:56 INFO - PROCESS | 23717 | 1461704036201 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] 13:56:02 INFO - PROCESS | 23717 | Cycle 1(1): loaded http://localhost:46894/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46894/tests/dromaeo/cssquery-ext.html) 13:56:04 INFO - PROCESS | 23717 | RSS: Main: 252317696 13:56:04 INFO - PROCESS | 23717 | 13:59:06 INFO - PROCESS | 23717 | Cycle 1(1): loaded http://localhost:46894/tests/dromaeo/cssquery-ext.html (next: http://localhost:46894/tests/dromaeo/cssquery-jquery.html) 13:59:06 INFO - PROCESS | 23717 | RSS: Main: 227057664 13:59:06 INFO - PROCESS | 23717 | 14:02:08 INFO - PROCESS | 23717 | Cycle 1(1): loaded http://localhost:46894/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46894/tests/dromaeo/cssquery-mootools.html) 14:02:09 INFO - PROCESS | 23717 | RSS: Main: 226590720 14:02:09 INFO - PROCESS | 23717 | 14:05:11 INFO - PROCESS | 23717 | Cycle 1(1): loaded http://localhost:46894/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46894/tests/dromaeo/cssquery-prototype.html) 14:05:11 INFO - PROCESS | 23717 | RSS: Main: 219500544 14:05:11 INFO - PROCESS | 23717 | 14:08:14 INFO - PROCESS | 23717 | Cycle 1(1): loaded http://localhost:46894/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46894/tests/dromaeo/cssquery-yui.html) 14:08:15 INFO - PROCESS | 23717 | RSS: Main: 209289216 14:08:15 INFO - PROCESS | 23717 | 14:11:17 INFO - PROCESS | 23717 | Cycle 1(1): loaded http://localhost:46894/tests/dromaeo/cssquery-yui.html (next: http://localhost:46894/tests/dromaeo/cssquery-dojo.html) 14:11:17 INFO - PROCESS | 23717 | RSS: Main: 258281472 14:11:17 INFO - PROCESS | 23717 | 14:11:17 INFO - PROCESS | 23717 | __start_tp_report 14:11:17 INFO - PROCESS | 23717 | _x_x_mozilla_page_load 14:11:17 INFO - PROCESS | 23717 | _x_x_mozilla_page_load_details 14:11:17 INFO - PROCESS | 23717 | |i|pagename|runs| 14:11:17 INFO - PROCESS | 23717 | |0;dojo.html;3254.463013602756;3286.145602143445;3320.236345640501;3327.500874868769;3356.043527594635;5396.163594642827;5439.993601183779;5442.727863606819;5448.128299472085;5495.587830912687;5433.212184233284;5438.564914806816;5450.672959622426;5459.863503412406;5461.399246082928;4851.902961940759;4932.975335123319;4978.900421991558;4999.225120106389;5019.949800501985;4848.345473361086;4934.0625281196635;4971.080350135218;5049.394072711261;5063.367079115111;4988.526090021461;4999.4000719913665;5004.824831130911;5013.3482647255805;5030.6981581105065;4944.554990050912;4962.776675049631;4991.825286115005;5003.824866129705;5013.498650134994;4789.066132104241;4884.218525035977;4927.063857866994;4948.430930443009;4956.058348913731;5344.5724342052545;5377.919331210035;5379.112446446332;5381.704006279653;5391.703456309901;5672.092465205588;5819.970900145515;5828.475437210672;5831.154482599999;5862.560307976876;5870.412958704138;5919.348871624118;5926.585139040269;5931.703414829241;5954.910676339859;5468.835934921919;5480.095784195603;5483.985462689415;5556.555475561945;5578.86052848678;5869.706514674249;5966.343702192756;5977.3126090500145;6023;6027.969860150672;5766.509846662997;5766.769329226868;5769.711514424262;5785.652860828363;5801.883962320814;5828.446297601806;5849.239598852207;5849.707514624337;5852.385499522574;5857.209276747584;5650.152477128464;5811.15738217956;5826.708664566755;5845.853853653608;5922.792702255487;5836.562257830679;5845.123231515222;5852.034414321589;5855.765769369263;5856.59003869725;4466.441694788152;4490.708103973231;4499.595036446735;4512.142692888341;4525.977370113128;3962.7622342659533;4003.619656132663;4036.3945408189006;4080.7143499955314;4099.97950010248;5466.180072989004;5470.64440811346;5486.561075113981;5487.314085739283;5488.725563721798;5830.679312637845;5846.561507886926;5847.6908351279835;5848.561357898175;5879.794207202727;5300.734963251822;5407.432219616883;5449.427810079964;5490.56075513958;5492.670439773627;5043.067032598981;5062.11413002723;5065.974670126626;5069.822556210515;5095.8980820383385;5724.398938111522;5862.618929769551;5901.203337549462;5919.3192782829665;5930.584859059911;5833.591648584558;5857.443542863592;5907.9704601476715;5912.142739302863;5927.229460170322;5865.208196893364;5866.765329386777;5867.325257595431;5867.383924687846;5868.354481007001;5634.098544232903;5729.398413166724;5729.828105156852;5738.9139162913425;5754.482096611325;5876.382979787232;5912.46787789101;5923.526117910643;5923.763049477972;5951;5736.6558006519745;5750.741216645345;5752.6836024019085;5755.482006619424;5758.827235182951;5560.471755183251;5677.971610141923;5703.515201207943;5718.056520674042;5733.598648094593;5670.574706896917;5695;5699.116636921284;5705.258316418839;5706.857328566819;5789.681567513659;5800.564957628279;5803.564732644984;5807;5827.708614569339;5319.2287118368395;5605.271314729059;5648.887022259614;5678.574106942078;5684.8294551163535 14:11:17 INFO - PROCESS | 23717 | |1;ext.html;661.6096503063195;662.218582073154;670.7484693240035;678.240370784721;729.9415847021817;32958.67041329586;40890;42036.78981605088;42111.57888421115;42137.36793948089;42768;43624.34563481542;43643.3453498197;43651.12697746043;43657;8253.83492330153;8840.248578870787;9072.909270907272;10456.895431045707;10704;10302.690919272434;10614.681559553226;10617.893821061767;10629.734256643607;10643.787124257511;10533.104686101691;10674.679759607225;10688.358698478116;10688.51901664427;10693.83959240612;8119.309858661992;10291.794164116676;10577.84133238002;10581.259311848175;10582;10488.160947124212;10612.416317102556;10619.57521699131;10623.84064239037;10640;40172.397414038816;40837.591624083674;40864.38703419451;40886;40901.59098409008;3676.3382591133586;3721.702263818888;3771.1891943232063;3931.528216613996;4053.391991201314;30634.38731225363;31007.844960775277;31154.844225778954;31455;31467.52798708021;4394.62645675118;4448.777561121931;4457;4548.272276435754;4583.793729282191;287215;289901;290015;290126;290582;61878.690606546676;61999.6900015497;62235;62331.37668623347;62373;62428.68785656043;62756;62760.37239627637;62811.371886280554;64514.35485645178;16969.745453818203;18095.095245237684;18231.72652410215;18261.726074108898;18289.359872404402;14064.08583442073;14370.49703260381;14383.137011779327;14386.35261413239;14390.928045359706;20369.287074952306;20409.387718368474;20545;20553.89723051375;20625;7552.358049565739;7569.583672897933;7580.924190758022;7682.654280557388;7729.265719756614;1035.0684384054412;1079.2445288298065;1120.4789772755707;1221.5358163897663;1269.8412698412699;34953.825230873685;35119.64880351215;35149;35511;35569.28861422757;1201.411308458849;1219.4390580333147;1222.0712258683463;1231.408923716603;1307.7253776706807;18370.816291837178;18450.169742361624;18640;18648.813511864708;18700.532486687942;538175;548287;548690;548744;550248;64053.35946640567;65009.67495162494;65043.02435463472;65385.67307163434;65486;1405.6275087101926;1473.1087691946432;1477.3425825507545;1548.5044785668704;1578.2818817438038;30598.694013059583;33039.8348008268;33195.83402082974;35002.12494687653;35138.824305878305;52036.479635204676;52339;52636;52647;52681.47318526919;316148;322999;323404;324425;325183;25706.87146564255;28404.289892752848;28474.85762571174;29049.564256536592;30481.23796905095;45280;45333;45770.77114614539;46338.30492542547;46490.30264546102;38486.80756596199;38760.22479550337;38905.2218955625;39106.804465978625;41974;41922.37116443317;41997.580024199364;42400.15199696051;43043.7847810759;43359.783201083796;42770.35844462398;42992.570074298856;43057;43477;44459.999300030926;36962.8151859239;37849.4322585156;38369.61630383772;38413.2317353657;38652.420213697376;28380.71619283781;28846.855765721037;28982.42035159327;29174.41651167007;29194 14:11:17 INFO - PROCESS | 23717 | |2;jquery.html;439.74055307368656;442.27687730560524;443.9953609453318;445.7815670321543;456;19637.803621963776;19808.801911980874;20678.89660551697;20735;20737.170513179455;18733.34433294835;20308.796912030874;20491.897540512313;20492.69260961087;20551.177952881902;5738.626989245707;5972.731227094791;6000.339962604132;6013.639181649093;6016.969915150418;5787.450192231731;5830.242068531085;5848.327442344121;5907.172995780594;5911.615744976584;5889.793857214999;5896.027155519334;5901.114832775075;5905.025670764318;5934.43622855828;5812.709364531777;5904.2029326040865;5950.642961422285;5954.523638108941;5959.10613407988;5207;5233.398159211702;5289.7619607117385;5297.152455607084;5342.091844386464;23865;24016.51966960651;24205.394865128514;24509;24607.50784984308;2281.9087236510686;2673.70589235184;2974.7768917331287;3070.5240687693445;3326.334733053399;10095.242856785697;10122.64570740028;10141.543630536644;12789.848913597822;13503;2001.9699704504444;2011.8088781565875;2037.7962203779502;2061.597988392264;2108.9050992705365;86953;88594.5570272151;88693;88789;91167;11376.488058037408;11616.477258523219;11623.76752464946;11792.584889813277;11809.704757381134;16564.337426503047;16755.743319251105;16805.663886722195;16825.747613785803;16858.578535536464;8447.239748422671;8742;8851.734447966572;8882.289416846637;8926.821463570692;8593.69922052725;8601.354898382646;8624.698135565224;8717.215450609348;8736.825263494822;4979.402471703346;5063.291139240509;5064.898702025939;5089.643724939293;5124.205748109049;1991.9203231870852;2071.4200023993308;2104.4648781875085;2113.091370710609;2140.197425965263;1063.9680809575725;1094.042712626452;1096.4627332606965;1120.9047230985457;1127.5602515018986;19767.901160494104;20082.39752807418;20400.18399264013;20509.38471845847;20670.379888603064;1046.884842667306;1053.6891616972857;1059.6291298045621;1087.6465148826662;1139.5897476908306;10980.560777568968;11344.829827552594;11421.373084190684;11652.067834573214;11720.941395292968;537176;540065;544292;545322;547192;99463;103542;103570;103838.48080759699;104047.4797626007;1072.2976450424985;1072.5924148823397;1080.6974047266779;1082.2045796339526;1082.3451811653993;17916.283348665907;18074.457766267034;18232.544186395447;18392.172352244448;18393;35671;36849.58629873258;39913.600863990985;40588;43461.34807977946;58740.70629646824;59369.70315148397;60552.69723651354;60598;60777;9014.594343254437;9261.166495015212;9335.393199442015;9339.766505837137;9505.952470237604;10568.313059651098;13309.933450332686;13361.66595835112;13851.930740346234;14100.153990760587;10161;11612.477438515456;11982;11991;12186;11513.330567067896;11928.045756339645;11957.701057473632;12100.334481603244;12687.936560317139;11558.826617600911;11868.76262474763;12114;12663.556775512812;12856.935715321364;9267.582958766738;9345.766355840886;9404.52977351116;9455.101765332283;9502.85745713801;11577.826332605186;12154.513819447124;12177.878221217674;12271.938640306742;12416.441260143496 14:11:17 INFO - PROCESS | 23717 | |3;mootools.html;1384.473899918031;1536.6926614677063;1604.3342013064578;1733.0728060487634;1860.8697391182614;7838.921610783897;8155.632996515156;8163.755087347389;8170.795730106735;8184.386171037167;7927.960360198205;8182.91817081829;8192.631331590077;8194.83610327793;8195.71315003975;2077.6571865642227;2314.0512389920136;2340.660604212384;2382.273406610983;2387.6299173628117;2413.3122060212845;2439.6462512935614;2443.535728211643;2443.767842055002;2444.8166387521005;2324.732655744594;2380.0241900820665;2384.3443053160345;2384.3681424422543;2384.8569085854906;2060.186226440555;2316.224064938248;2376.548455793411;2388.0686532252435;2390.6294524348755;2251.8423710340285;2270.5118399544176;2282.851614645043;2283.908643654252;2285.1887579909057;7924.128345881948;8004.919950800476;8019.719309824187;8079;8092.352611791042;5057.342545469065;5208;5227.032998895179;5237.109691352441;5246.160614301732;3322.9335413291597;3333.683300086512;3365.6848004715334;3465.42820434628;3470.8091054991964;1087.456271864068;1099.6810924831789;1120.5405783628755;1120.7030137013699;1153.3253046967534;11096.667099987013;11324.320540767498;11332.546698132148;11372.715682107932;11388.658340249805;4570.474395444567;4585.10590434862;4689.929651055237;4714.033623107255;4716.622670186377;9736.902630973742;9745.269104817167;9770.853437198448;9781.266405019509;9800.950995244979;4504.25679762842;5052.8484145475695;5164.2770012198325;5171.405288391883;5173.508516690908;4700.482946875841;4769.523047695272;4804.25534042224;4826.396700412449;4843.176659967814;3926.9214615707524;3982.4026396040827;4031.4759081319826;4036.7486079315504;4073.450084238649;1270.9364531773374;1310.6199202231246;1313.7044165062784;1321.0554453565555;1337.8193943817655;956.6221342569646;1053.2153545608417;1064.9414282214552;1072.7157303314627;1081.551156270139;5787.592176180575;5853.502452291603;5878.882422351529;5977.252843394575;6123.632582045091;483.35230790740576;500.21965733455926;1075.9031687148195;1157.6874243954085;1158.5481662151767;3962.9618554953877;4122.2579935611275;4367.235733746582;4401.625861801719;4402.823887044482;9923;10271;10334.844977325347;10363.896361036293;10372.429516376671;10162.898371016196;10245.487725613839;10251.84622230667;10259.640912568024;10263.127634151031;7404.444666650023;7768.495047821873;7807.258310460497;7811.648475818602;7836.098848632366;5974.40255974399;6154.723037463235;6158.107074474086;6227.595206311576;6301.7164227608955;9231.953840230755;9491.145796878314;9529.237660987243;9588.856167157637;9589.424634521672;9659.71020869375;9696.466694331879;9751.658691946031;9764.462954537568;9773.41359518431;6738.393544581011;7229.49393542447;7284.38082762971;7416.295451932057;7438.181800002104;8034.437589368688;8040.919590804017;8077.676892924453;8108.108108108221;8123.512589244664;7294.124705035218;7501.962490187514;7531.209223031503;7641.847163056819;7656.770296891103;7366.152892417441;7458.850822983619;7473.6263186841525;7550.962245188739;7559.886601700869;6724.899126513008;6767.492438067066;6807.285235050248;6812.795616131524;6823.965880170567;5084.872878178076;5173.1722924333435;5247.081760691787;5369.624126311277;5456.20884971669;5162.432132465351;5186.9221961669855;5236.816711415082;5284.682919024717;5318.627696061239 14:11:17 INFO - PROCESS | 23717 | |4;prototype.html;356.19855325517585;360.281238928338;363.0596754406088;363.58006502489627;364.22965428119534;5306.787728490861;5399.622026458144;5401.918971215435;5422.4306447823;5425;5277.366715994077;5281.155015197569;5316.3354580677415;5324.787008519665;5326.283595366362;3896.47397601323;3998.480197574311;4210.431591735122;4220.493540775111;4234.30134027885;4198.307279298912;4206.47419072616;4211.68412369072;4217.873463796091;4258.297380932143;4029.2344454553686;4186.162767446508;4207.474065741782;4211.684123690736;4217.388478670591;4103.363978583325;4205.158968206356;4218.894527636803;4220.345846393814;4230.76730779807;3720.423334383148;3748.3627783276634;3749;3757.7369584129124;3768.434734789776;5128.692278463304;5141.383034035902;5160.303359046518;5193.2989046479;5219.582433405319;4564.269716845322;4798.424189097331;4825.879353016167;4826.951730482685;4828.806847726087;5542.91685624716;5615.691136987464;5652.208690783294;5656.4060773618585;5683;3935.74417662851;4103.2409004334295;4105.815238314283;4107.609777071173;4134.462519872397;5543.501084902378;5706;5802;5851.76592936282;5897.201353587154;4110.17796440713;4115.971007248188;4133.937990930139;4149.585041495826;4158.313878210122;4132.276851550967;4178.1643671265865;4181.184668989518;4184.581541845791;4190.727602705814;4623.768811559408;4749.596284315803;4761.857144285677;4774.236122220428;4778.474367819537;5592.3009623797025;5598.524125449382;5603.7478313475995;5623.212750214973;5637.915431268534;1485.8588434098742;1486.7323881701398;1486.851314868526;1494.4694633405202;1498.7002599480147;1015.1067060986433;1016.7458135466134;1045.0594464981425;1051.984220236697;1052.7473406382567;5656.85857853557;5693.259876216065;5701.486866182064;5703.62926409782;5732.656040637575;6105.572609917263;6131.386861313833;6133.938660613337;6143.907841382383;6151.784687535915;5539.833804985857;5684.8294551163535;5687.829365119053;5696.458836410535;5698.8290351289525;3255.283837555734;3265.9183520411702;3267.1995361136674;3269.640339562646;3275.410426123273;5957.970210148921;6153.692315384213;6167.691615419211;6182.938170618326;6197.4732147767045;6253.530985176039;6253.6873156342;6258.123862659231;6265.530085243625;6273.937260627426;6104.328523862371;6138.969305153535;6141.293751218578;6146.877062458726;6155.538334624921;5905.143754155538;6126.724297406538;6143.477804386677;6155.169052177898;6157.907631385622;6015.909761353496;6029.618300771259;6041.942660034564;6050.878982420415;6053.969730151321;5500.697461639648;5520.978618955506;5644.0650861552585;5834.541364658835;6148.1699970503405;4042.9797851010558;4055.9594404055583;4067.2272268270117;4070.9185816284103;4084.183163367279;5635.577331700057;5736.627119237236;5797.826065218051;5802.1296805479515;5818.44724751148;5533;5585.9720701397855;5619.971900140473;5659.773609055756;5661.46216109469;5568.749406276808;5612.4387561245185;5622.522085622768;5658.047973449154;5665.413684168439;5290.947090529199;5525.972370138124;5536.695481748542;5540;5542.7782888684005;5634.7321852582845;5657.4908258256955;5667.574931880043;5699.287589051369;5711.914321285101;5554.50009499147;5558.333000040021;5580.637258578179;5626.087130375692;5632.633878797865 14:11:17 INFO - PROCESS | 23717 | |5;yui.html;802.8434455281215;830.1698301698302;835.2482765511039;835.2816577743143;875.5928493250638;13959.511417100404;14464.710705785878;14472.276386180689;14474.421023159075;14476.203808790513;11861.822072668896;13167.20996740194;13228.735425291488;13235.735285294313;13256.072074954756;875.5359659380523;913.4017218721715;917.4678686361927;917.5091326140516;920.5029284186564;906.7687739626386;910.3763921713614;913.9177474027337;914.89021317442;915.4781774388601;762.5615271219043;940.9388389754678;941.8728471656307;942.7218970403713;943.259541260111;774.9612519374037;909.6134142989237;941.9811603767921;944.1644144931716;944.8535477001076;691.9792406227821;692.4979389942301;692.5636848785233;692.9064576282187;693.1024323501078;13701.588952331445;14250.643733906632;14294.64263393413;14307.356168972421;14319.642008949755;14131.364088616037;14266.286685665675;14343.139411635335;14491.42034318626;14600.415983360654;11866.821997670042;12004.819927701092;12033.63899083029;12063.758724825455;12160.391980400944;4336.111097225062;4370.497392799837;4470.709403888769;4526.86419407415;4565.885852853672;54286;54294;54703.72648136734;54923.450765492635;55100;10657.573697052187;11191.216614836883;11244.66266012021;11481.483333250024;11630;19599.11803968825;19622.803771962383;19625.509362266057;19632.70550941737;19671.606567868563;8051.235132662505;8148.307393871587;8277;8376.01115202633;8476.110008449148;4611.331356953223;4631.328457373662;4744.264638980963;5008.173651347487;5112.437631860493;3640.8179591020344;3740.981295093507;3751.3622684143215;3755.6244375562223;3756.3426400379826;675.2504719761062;679.5379142183264;681.6625770243761;689.8068540808481;696.5994553131969;811.0996793559144;817.3992115794886;820.6471217376585;821.8849361089452;830.1864173110386;9792.755181120387;10326.173906087644;10398.480075996322;10421.218408619385;10422.843657345145;670.7853486884151;720.9243029481829;789.1634867040955;813.3086876155221;856.6915910272297;4562;4611.677182597186;4665.603423708955;4739.194336962724;4826.372571565674;61525.384746152864;65672.6716366415;66304;66833;67027.66486167636;57591.13613295804;57675.71162144246;57909;59156.70421647864;59288.11067833986;53895.46104538983;54235.45764542304;54348;54461.72769136129;54871.451285487434;9643.614255429984;9699.1436936082;9863.802723945337;9975.650852220137;9998.900010999796;33971.4904276441;34291.485627715105;34628.65371346254;35240.647593524765;35471.11322216965;45538.77230613826;48136.75931620319;48250;48325.75837120792;48396;13023;13071.542496012595;13118.672033198865;13199.07606467538;13393.062485625913;13003.739925201633;14029.859701402855;14105.365258563184;14449.927750361181;14665.853341466876;13634.386452609459;13852.376643051288;14209.715805683622;14223;14313.928430358199;12997.285149316878;13434;13469.932650336686;13601.931990339985;13872.930635346758;13512.23046748104;13896.37466313998;13917;14114.50599229022;14568.927155364156;10845.728856778329;11309.41792667266;11563.71090722705;11662.358570278377;11786.11604129711;11293.830592541282;11475.196736228383;11480.598179063692;11777.352245626573;11935.582254621047 14:11:17 INFO - PROCESS | 23717 | __end_tp_report 14:11:17 INFO - PROCESS | 23717 | __start_cc_report 14:11:17 INFO - PROCESS | 23717 | _x_x_mozilla_cycle_collect,918 14:11:17 INFO - PROCESS | 23717 | __end_cc_report 14:11:17 INFO - PROCESS | 23717 | __startTimestamp1461705077804__endTimestamp 14:11:17 INFO - PROCESS | 23717 | 14:11:17 INFO - PROCESS | 23717 | ------- Summary: start ------- 14:11:17 INFO - PROCESS | 23717 | Number of tests: 6 14:11:17 INFO - PROCESS | 23717 | 14:11:17 INFO - PROCESS | 23717 | [#0] dojo.html Cycles:165 Average:5425.20 Median:5672.09 stddev:589.54 (10.4%) stddev-sans-first:566.22 14:11:17 INFO - PROCESS | 23717 | Values: 3254.5 3286.1 3320.2 3327.5 3356.0 5396.2 5440.0 5442.7 5448.1 5495.6 5433.2 5438.6 5450.7 5459.9 5461.4 4851.9 4933.0 4978.9 4999.2 5019.9 4848.3 4934.1 4971.1 5049.4 5063.4 4988.5 4999.4 5004.8 5013.3 5030.7 4944.6 4962.8 4991.8 5003.8 5013.5 4789.1 4884.2 4927.1 4948.4 4956.1 5344.6 5377.9 5379.1 5381.7 5391.7 5672.1 5820.0 5828.5 5831.2 5862.6 5870.4 5919.3 5926.6 5931.7 5954.9 5468.8 5480.1 5484.0 5556.6 5578.9 5869.7 5966.3 5977.3 6023.0 6028.0 5766.5 5766.8 5769.7 5785.7 5801.9 5828.4 5849.2 5849.7 5852.4 5857.2 5650.2 5811.2 5826.7 5845.9 5922.8 5836.6 5845.1 5852.0 5855.8 5856.6 4466.4 4490.7 4499.6 4512.1 4526.0 3962.8 4003.6 4036.4 4080.7 4100.0 5466.2 5470.6 5486.6 5487.3 5488.7 5830.7 5846.6 5847.7 5848.6 5879.8 5300.7 5407.4 5449.4 5490.6 5492.7 5043.1 5062.1 5066.0 5069.8 5095.9 5724.4 5862.6 5901.2 5919.3 5930.6 5833.6 5857.4 5908.0 5912.1 5927.2 5865.2 5866.8 5867.3 5867.4 5868.4 5634.1 5729.4 5729.8 5738.9 5754.5 5876.4 5912.5 5923.5 5923.8 5951.0 5736.7 5750.7 5752.7 5755.5 5758.8 5560.5 5678.0 5703.5 5718.1 5733.6 5670.6 5695.0 5699.1 5705.3 5706.9 5789.7 5800.6 5803.6 5807.0 5827.7 5319.2 5605.3 5648.9 5678.6 5684.8 14:11:17 INFO - PROCESS | 23717 | 14:11:17 INFO - PROCESS | 23717 | [#1] ext.html Cycles:180 Average:56535.32 Median:35540.14 stddev:106686.83 (300.2%) stddev-sans-first:106903.64 14:11:17 INFO - PROCESS | 23717 | Values: 661.6 662.2 670.7 678.2 729.9 32958.7 40890.0 42036.8 42111.6 42137.4 42768.0 43624.3 43643.3 43651.1 43657.0 8253.8 8840.2 9072.9 10456.9 10704.0 10302.7 10614.7 10617.9 10629.7 10643.8 10533.1 10674.7 10688.4 10688.5 10693.8 8119.3 10291.8 10577.8 10581.3 10582.0 10488.2 10612.4 10619.6 10623.8 10640.0 40172.4 40837.6 40864.4 40886.0 40901.6 3676.3 3721.7 3771.2 3931.5 4053.4 30634.4 31007.8 31154.8 31455.0 31467.5 4394.6 4448.8 4457.0 4548.3 4583.8 287215.0 289901.0 290015.0 290126.0 290582.0 61878.7 61999.7 62235.0 62331.4 62373.0 62428.7 62756.0 62760.4 62811.4 64514.4 16969.7 18095.1 18231.7 18261.7 18289.4 14064.1 14370.5 14383.1 14386.4 14390.9 20369.3 20409.4 20545.0 20553.9 20625.0 7552.4 7569.6 7580.9 7682.7 7729.3 1035.1 1079.2 1120.5 1221.5 1269.8 34953.8 35119.6 35149.0 35511.0 35569.3 1201.4 1219.4 1222.1 1231.4 1307.7 18370.8 18450.2 18640.0 18648.8 18700.5 538175.0 548287.0 548690.0 548744.0 550248.0 64053.4 65009.7 65043.0 65385.7 65486.0 1405.6 1473.1 1477.3 1548.5 1578.3 30598.7 33039.8 33195.8 35002.1 35138.8 52036.5 52339.0 52636.0 52647.0 52681.5 316148.0 322999.0 323404.0 324425.0 325183.0 25706.9 28404.3 28474.9 29049.6 30481.2 45280.0 45333.0 45770.8 46338.3 46490.3 38486.8 38760.2 38905.2 39106.8 41974.0 41922.4 41997.6 42400.2 43043.8 43359.8 42770.4 42992.6 43057.0 43477.0 44460.0 36962.8 37849.4 38369.6 38413.2 38652.4 28380.7 28846.9 28982.4 29174.4 29194.0 14:11:17 INFO - PROCESS | 23717 | 14:11:17 INFO - PROCESS | 23717 | [#2] jquery.html Cycles:180 Average:31387.10 Median:2106.68 stddev:89527.34 (4249.7%) stddev-sans-first:89748.33 14:11:17 INFO - PROCESS | 23717 | Values: 439.7 442.3 444.0 445.8 456.0 19637.8 19808.8 20678.9 20735.0 20737.2 18733.3 20308.8 20491.9 20492.7 20551.2 5738.6 5972.7 6000.3 6013.6 6017.0 5787.5 5830.2 5848.3 5907.2 5911.6 5889.8 5896.0 5901.1 5905.0 5934.4 5812.7 5904.2 5950.6 5954.5 5959.1 5207.0 5233.4 5289.8 5297.2 5342.1 23865.0 24016.5 24205.4 24509.0 24607.5 2281.9 2673.7 2974.8 3070.5 3326.3 10095.2 10122.6 10141.5 12789.8 13503.0 2002.0 2011.8 2037.8 2061.6 2108.9 86953.0 88594.6 88693.0 88789.0 91167.0 11376.5 11616.5 11623.8 11792.6 11809.7 16564.3 16755.7 16805.7 16825.7 16858.6 8447.2 8742.0 8851.7 8882.3 8926.8 8593.7 8601.4 8624.7 8717.2 8736.8 4979.4 5063.3 5064.9 5089.6 5124.2 1991.9 2071.4 2104.5 2113.1 2140.2 1064.0 1094.0 1096.5 1120.9 1127.6 19767.9 20082.4 20400.2 20509.4 20670.4 1046.9 1053.7 1059.6 1087.6 1139.6 10980.6 11344.8 11421.4 11652.1 11720.9 537176.0 540065.0 544292.0 545322.0 547192.0 99463.0 103542.0 103570.0 103838.5 104047.5 1072.3 1072.6 1080.7 1082.2 1082.3 17916.3 18074.5 18232.5 18392.2 18393.0 35671.0 36849.6 39913.6 40588.0 43461.3 58740.7 59369.7 60552.7 60598.0 60777.0 9014.6 9261.2 9335.4 9339.8 9506.0 10568.3 13309.9 13361.7 13851.9 14100.2 10161.0 11612.5 11982.0 11991.0 12186.0 11513.3 11928.0 11957.7 12100.3 12687.9 11558.8 11868.8 12114.0 12663.6 12856.9 9267.6 9345.8 9404.5 9455.1 9502.9 11577.8 12154.5 12177.9 12271.9 12416.4 14:11:17 INFO - PROCESS | 23717 | 14:11:17 INFO - PROCESS | 23717 | [#3] mootools.html Cycles:180 Average:5594.95 Median:5071.11 stddev:3030.49 (59.8%) stddev-sans-first:3022.47 14:11:17 INFO - PROCESS | 23717 | Values: 1384.5 1536.7 1604.3 1733.1 1860.9 7838.9 8155.6 8163.8 8170.8 8184.4 7928.0 8182.9 8192.6 8194.8 8195.7 2077.7 2314.1 2340.7 2382.3 2387.6 2413.3 2439.6 2443.5 2443.8 2444.8 2324.7 2380.0 2384.3 2384.4 2384.9 2060.2 2316.2 2376.5 2388.1 2390.6 2251.8 2270.5 2282.9 2283.9 2285.2 7924.1 8004.9 8019.7 8079.0 8092.4 5057.3 5208.0 5227.0 5237.1 5246.2 3322.9 3333.7 3365.7 3465.4 3470.8 1087.5 1099.7 1120.5 1120.7 1153.3 11096.7 11324.3 11332.5 11372.7 11388.7 4570.5 4585.1 4689.9 4714.0 4716.6 9736.9 9745.3 9770.9 9781.3 9801.0 4504.3 5052.8 5164.3 5171.4 5173.5 4700.5 4769.5 4804.3 4826.4 4843.2 3926.9 3982.4 4031.5 4036.7 4073.5 1270.9 1310.6 1313.7 1321.1 1337.8 956.6 1053.2 1064.9 1072.7 1081.6 5787.6 5853.5 5878.9 5977.3 6123.6 483.4 500.2 1075.9 1157.7 1158.5 3963.0 4122.3 4367.2 4401.6 4402.8 9923.0 10271.0 10334.8 10363.9 10372.4 10162.9 10245.5 10251.8 10259.6 10263.1 7404.4 7768.5 7807.3 7811.6 7836.1 5974.4 6154.7 6158.1 6227.6 6301.7 9232.0 9491.1 9529.2 9588.9 9589.4 9659.7 9696.5 9751.7 9764.5 9773.4 6738.4 7229.5 7284.4 7416.3 7438.2 8034.4 8040.9 8077.7 8108.1 8123.5 7294.1 7502.0 7531.2 7641.8 7656.8 7366.2 7458.9 7473.6 7551.0 7559.9 6724.9 6767.5 6807.3 6812.8 6824.0 5084.9 5173.2 5247.1 5369.6 5456.2 5162.4 5186.9 5236.8 5284.7 5318.6 14:11:17 INFO - PROCESS | 23717 | 14:11:17 INFO - PROCESS | 23717 | [#4] prototype.html Cycles:180 Average:4807.16 Median:5462.85 stddev:1419.68 (26.0%) stddev-sans-first:1383.79 14:11:17 INFO - PROCESS | 23717 | Values: 356.2 360.3 363.1 363.6 364.2 5306.8 5399.6 5401.9 5422.4 5425.0 5277.4 5281.2 5316.3 5324.8 5326.3 3896.5 3998.5 4210.4 4220.5 4234.3 4198.3 4206.5 4211.7 4217.9 4258.3 4029.2 4186.2 4207.5 4211.7 4217.4 4103.4 4205.2 4218.9 4220.3 4230.8 3720.4 3748.4 3749.0 3757.7 3768.4 5128.7 5141.4 5160.3 5193.3 5219.6 4564.3 4798.4 4825.9 4827.0 4828.8 5542.9 5615.7 5652.2 5656.4 5683.0 3935.7 4103.2 4105.8 4107.6 4134.5 5543.5 5706.0 5802.0 5851.8 5897.2 4110.2 4116.0 4133.9 4149.6 4158.3 4132.3 4178.2 4181.2 4184.6 4190.7 4623.8 4749.6 4761.9 4774.2 4778.5 5592.3 5598.5 5603.7 5623.2 5637.9 1485.9 1486.7 1486.9 1494.5 1498.7 1015.1 1016.7 1045.1 1052.0 1052.7 5656.9 5693.3 5701.5 5703.6 5732.7 6105.6 6131.4 6133.9 6143.9 6151.8 5539.8 5684.8 5687.8 5696.5 5698.8 3255.3 3265.9 3267.2 3269.6 3275.4 5958.0 6153.7 6167.7 6182.9 6197.5 6253.5 6253.7 6258.1 6265.5 6273.9 6104.3 6139.0 6141.3 6146.9 6155.5 5905.1 6126.7 6143.5 6155.2 6157.9 6015.9 6029.6 6041.9 6050.9 6054.0 5500.7 5521.0 5644.1 5834.5 6148.2 4043.0 4056.0 4067.2 4070.9 4084.2 5635.6 5736.6 5797.8 5802.1 5818.4 5533.0 5586.0 5620.0 5659.8 5661.5 5568.7 5612.4 5622.5 5658.0 5665.4 5290.9 5526.0 5536.7 5540.0 5542.8 5634.7 5657.5 5667.6 5699.3 5711.9 5554.5 5558.3 5580.6 5626.1 5632.6 14:11:17 INFO - PROCESS | 23717 | 14:11:17 INFO - PROCESS | 23717 | [#5] yui.html Cycles:180 Average:15535.67 Median:4588.61 stddev:17874.80 (389.5%) stddev-sans-first:17890.71 14:11:17 INFO - PROCESS | 23717 | Values: 802.8 830.2 835.2 835.3 875.6 13959.5 14464.7 14472.3 14474.4 14476.2 11861.8 13167.2 13228.7 13235.7 13256.1 875.5 913.4 917.5 917.5 920.5 906.8 910.4 913.9 914.9 915.5 762.6 940.9 941.9 942.7 943.3 775.0 909.6 942.0 944.2 944.9 692.0 692.5 692.6 692.9 693.1 13701.6 14250.6 14294.6 14307.4 14319.6 14131.4 14266.3 14343.1 14491.4 14600.4 11866.8 12004.8 12033.6 12063.8 12160.4 4336.1 4370.5 4470.7 4526.9 4565.9 54286.0 54294.0 54703.7 54923.5 55100.0 10657.6 11191.2 11244.7 11481.5 11630.0 19599.1 19622.8 19625.5 19632.7 19671.6 8051.2 8148.3 8277.0 8376.0 8476.1 4611.3 4631.3 4744.3 5008.2 5112.4 3640.8 3741.0 3751.4 3755.6 3756.3 675.3 679.5 681.7 689.8 696.6 811.1 817.4 820.6 821.9 830.2 9792.8 10326.2 10398.5 10421.2 10422.8 670.8 720.9 789.2 813.3 856.7 4562.0 4611.7 4665.6 4739.2 4826.4 61525.4 65672.7 66304.0 66833.0 67027.7 57591.1 57675.7 57909.0 59156.7 59288.1 53895.5 54235.5 54348.0 54461.7 54871.5 9643.6 9699.1 9863.8 9975.7 9998.9 33971.5 34291.5 34628.7 35240.6 35471.1 45538.8 48136.8 48250.0 48325.8 48396.0 13023.0 13071.5 13118.7 13199.1 13393.1 13003.7 14029.9 14105.4 14449.9 14665.9 13634.4 13852.4 14209.7 14223.0 14313.9 12997.3 13434.0 13469.9 13601.9 13872.9 13512.2 13896.4 13917.0 14114.5 14568.9 10845.7 11309.4 11563.7 11662.4 11786.1 11293.8 11475.2 11480.6 11777.4 11935.6 14:11:17 INFO - PROCESS | 23717 | -------- Summary: end -------- 14:11:17 INFO - PROCESS | 23717 | 14:11:18 INFO - TEST-INFO | 23717: exit 0 14:11:18 INFO - TEST-OK | dromaeo_css | took 1112205ms 14:11:18 INFO - TEST-START | kraken 14:11:18 INFO - operating with platform_type : linux_ 14:11:18 INFO - Initialising browser for kraken test... 14:11:18 INFO - TEST-INFO | started process 23907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5ggRo/profile http://localhost:46894/getInfo.html) 14:11:22 INFO - PROCESS | 23907 | __metrics Screen width/height:1600/1200 14:11:22 INFO - PROCESS | 23907 | colorDepth:24 14:11:22 INFO - PROCESS | 23907 | Browser inner width/height: 1024/697 14:11:22 INFO - PROCESS | 23907 | __metrics 14:11:24 ERROR - PROCESS | 23907 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:11:24 INFO - TEST-INFO | 23907: exit 0 14:11:24 INFO - Browser initialized. 14:11:24 INFO - Running cycle 1/1 for kraken test... 14:11:24 INFO - TEST-INFO | started process 23995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5ggRo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:36 INFO - PROCESS | 23995 | RSS: Main: 141942784 14:11:36 INFO - PROCESS | 23995 | 14:11:39 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46894/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:40 INFO - PROCESS | 23995 | RSS: Main: 190603264 14:11:40 INFO - PROCESS | 23995 | 14:11:42 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46894/tests/kraken/driver.html?testName=audio-dft) 14:11:43 INFO - PROCESS | 23995 | RSS: Main: 184532992 14:11:43 INFO - PROCESS | 23995 | 14:11:46 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46894/tests/kraken/driver.html?testName=audio-fft) 14:11:46 INFO - PROCESS | 23995 | RSS: Main: 273510400 14:11:46 INFO - PROCESS | 23995 | 14:11:48 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46894/tests/kraken/driver.html?testName=audio-oscillator) 14:11:49 INFO - PROCESS | 23995 | RSS: Main: 182611968 14:11:49 INFO - PROCESS | 23995 | 14:11:51 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46894/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:52 INFO - PROCESS | 23995 | RSS: Main: 180658176 14:11:52 INFO - PROCESS | 23995 | 14:11:55 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46894/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:55 INFO - PROCESS | 23995 | RSS: Main: 215973888 14:11:55 INFO - PROCESS | 23995 | 14:11:59 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46894/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:59 INFO - PROCESS | 23995 | RSS: Main: 214831104 14:11:59 INFO - PROCESS | 23995 | 14:12:02 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46894/tests/kraken/driver.html?testName=json-parse-financial) 14:12:03 INFO - PROCESS | 23995 | RSS: Main: 214429696 14:12:03 INFO - PROCESS | 23995 | 14:12:04 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46894/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:12:05 INFO - PROCESS | 23995 | RSS: Main: 195981312 14:12:05 INFO - PROCESS | 23995 | 14:12:06 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46894/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:12:07 INFO - PROCESS | 23995 | RSS: Main: 196640768 14:12:07 INFO - PROCESS | 23995 | 14:12:09 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46894/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:12:10 INFO - PROCESS | 23995 | RSS: Main: 207208448 14:12:10 INFO - PROCESS | 23995 | 14:12:12 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:12:13 INFO - PROCESS | 23995 | RSS: Main: 215371776 14:12:13 INFO - PROCESS | 23995 | 14:12:15 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:12:16 INFO - PROCESS | 23995 | RSS: Main: 212303872 14:12:16 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | Cycle 1(1): loaded http://localhost:46894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46894/tests/kraken/driver.html?testName=ai-astar) 14:12:18 INFO - PROCESS | 23995 | RSS: Main: 276426752 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | __start_tp_report 14:12:18 INFO - PROCESS | 23995 | _x_x_mozilla_page_load 14:12:18 INFO - PROCESS | 23995 | _x_x_mozilla_page_load_details 14:12:18 INFO - PROCESS | 23995 | |i|pagename|runs| 14:12:18 INFO - PROCESS | 23995 | |0;ai-astar;113;111;106;110;112;111;103;109;110;108 14:12:18 INFO - PROCESS | 23995 | |1;audio-beat-detection;166;127;150;172;128;161;159;134;198;127 14:12:18 INFO - PROCESS | 23995 | |2;audio-dft;161;159;160;162;161;160;160;165;160;161 14:12:18 INFO - PROCESS | 23995 | |3;audio-fft;76;77;76;176;76;74;72;74;162;85 14:12:18 INFO - PROCESS | 23995 | |4;audio-oscillator;93;92;144;92;91;94;157;92;93;150 14:12:18 INFO - PROCESS | 23995 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;116;117 14:12:18 INFO - PROCESS | 23995 | |6;imaging-darkroom;145;145;144;145;145;145;145;145;145;145 14:12:18 INFO - PROCESS | 23995 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 14:12:18 INFO - PROCESS | 23995 | |8;json-parse-financial;55;55;56;54;56;54;54;70;53;52 14:12:18 INFO - PROCESS | 23995 | |9;json-stringify-tinderbox;58;57;57;57;57;56;56;56;56;57 14:12:18 INFO - PROCESS | 23995 | |10;stanford-crypto-aes;73;73;73;72;81;73;75;74;75;76 14:12:18 INFO - PROCESS | 23995 | |11;stanford-crypto-ccm;119;119;115;122;120;117;119;115;149;126 14:12:18 INFO - PROCESS | 23995 | |12;stanford-crypto-pbkdf2;166;164;165;160;162;160;160;161;159;165 14:12:18 INFO - PROCESS | 23995 | |13;stanford-crypto-sha256-iterative;68;67;66;66;66;68;67;66;68;66 14:12:18 INFO - PROCESS | 23995 | __end_tp_report 14:12:18 INFO - PROCESS | 23995 | __start_cc_report 14:12:18 INFO - PROCESS | 23995 | _x_x_mozilla_cycle_collect,1609 14:12:18 INFO - PROCESS | 23995 | __end_cc_report 14:12:18 INFO - PROCESS | 23995 | __startTimestamp1461705138422__endTimestamp 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | ------- Summary: start ------- 14:12:18 INFO - PROCESS | 23995 | Number of tests: 14 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:2.98 (2.7%) stddev-sans-first:2.85 14:12:18 INFO - PROCESS | 23995 | Values: 113.0 111.0 106.0 110.0 112.0 111.0 103.0 109.0 110.0 108.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:160.00 stddev:23.56 (14.7%) stddev-sans-first:24.45 14:12:18 INFO - PROCESS | 23995 | Values: 166.0 127.0 150.0 172.0 128.0 161.0 159.0 134.0 198.0 127.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.66 (1.0%) stddev-sans-first:1.76 14:12:18 INFO - PROCESS | 23995 | Values: 161.0 159.0 160.0 162.0 161.0 160.0 160.0 165.0 160.0 161.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:39.39 (51.8%) stddev-sans-first:41.19 14:12:18 INFO - PROCESS | 23995 | Values: 76.0 77.0 76.0 176.0 76.0 74.0 72.0 74.0 162.0 85.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:28.15 (30.6%) stddev-sans-first:29.19 14:12:18 INFO - PROCESS | 23995 | Values: 93.0 92.0 144.0 92.0 91.0 94.0 157.0 92.0 93.0 150.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:12:18 INFO - PROCESS | 23995 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 14:12:18 INFO - PROCESS | 23995 | Values: 145.0 145.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:12:18 INFO - PROCESS | 23995 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.00 stddev:5.11 (9.3%) stddev-sans-first:5.41 14:12:18 INFO - PROCESS | 23995 | Values: 55.0 55.0 56.0 54.0 56.0 54.0 54.0 70.0 53.0 52.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:57.00 stddev:0.67 (1.2%) stddev-sans-first:0.53 14:12:18 INFO - PROCESS | 23995 | Values: 58.0 57.0 57.0 57.0 57.0 56.0 56.0 56.0 56.0 57.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.50 stddev:2.59 (3.5%) stddev-sans-first:2.69 14:12:18 INFO - PROCESS | 23995 | Values: 73.0 73.0 73.0 72.0 81.0 73.0 75.0 74.0 75.0 76.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:119.50 stddev:9.99 (8.4%) stddev-sans-first:10.54 14:12:18 INFO - PROCESS | 23995 | Values: 119.0 119.0 115.0 122.0 120.0 117.0 119.0 115.0 149.0 126.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:2.57 (1.6%) stddev-sans-first:2.33 14:12:18 INFO - PROCESS | 23995 | Values: 166.0 164.0 165.0 160.0 162.0 160.0 160.0 161.0 159.0 165.0 14:12:18 INFO - PROCESS | 23995 | 14:12:18 INFO - PROCESS | 23995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 14:12:18 INFO - PROCESS | 23995 | Values: 68.0 67.0 66.0 66.0 66.0 68.0 67.0 66.0 68.0 66.0 14:12:18 INFO - PROCESS | 23995 | -------- Summary: end -------- 14:12:18 INFO - PROCESS | 23995 | 14:12:19 INFO - TEST-INFO | 23995: exit 0 14:12:19 INFO - TEST-OK | kraken | took 60849ms 14:12:19 INFO - SUITE-END | took 1173s 14:12:19 INFO - Completed test suite (00:19:33) 14:12:19 INFO - javascript benchmark 14:12:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.463013602756, 3286.145602143445, 3320.236345640501, 3327.500874868769, 3356.043527594635, 5396.163594642827, 5439.993601183779, 5442.727863606819, 5448.128299472085, 5495.587830912687, 5433.212184233284, 5438.564914806816, 5450.672959622426, 5459.863503412406, 5461.399246082928, 4851.902961940759, 4932.975335123319, 4978.900421991558, 4999.225120106389, 5019.949800501985, 4848.345473361086, 4934.0625281196635, 4971.080350135218, 5049.394072711261, 5063.367079115111, 4988.526090021461, 4999.4000719913665, 5004.824831130911, 5013.3482647255805, 5030.6981581105065, 4944.554990050912, 4962.776675049631, 4991.825286115005, 5003.824866129705, 5013.498650134994, 4789.066132104241, 4884.218525035977, 4927.063857866994, 4948.430930443009, 4956.058348913731, 5344.5724342052545, 5377.919331210035, 5379.112446446332, 5381.704006279653, 5391.703456309901, 5672.092465205588, 5819.970900145515, 5828.475437210672, 5831.154482599999, 5862.560307976876, 5870.412958704138, 5919.348871624118, 5926.585139040269, 5931.703414829241, 5954.910676339859, 5468.835934921919, 5480.095784195603, 5483.985462689415, 5556.555475561945, 5578.86052848678, 5869.706514674249, 5966.343702192756, 5977.3126090500145, 6023.0, 6027.969860150672, 5766.509846662997, 5766.769329226868, 5769.711514424262, 5785.652860828363, 5801.883962320814, 5828.446297601806, 5849.239598852207, 5849.707514624337, 5852.385499522574, 5857.209276747584, 5650.152477128464, 5811.15738217956, 5826.708664566755, 5845.853853653608, 5922.792702255487, 5836.562257830679, 5845.123231515222, 5852.034414321589, 5855.765769369263, 5856.59003869725, 4466.441694788152, 4490.708103973231, 4499.595036446735, 4512.142692888341, 4525.977370113128, 3962.7622342659533, 4003.619656132663, 4036.3945408189006, 4080.7143499955314, 4099.97950010248, 5466.180072989004, 5470.64440811346, 5486.561075113981, 5487.314085739283, 5488.725563721798, 5830.679312637845, 5846.561507886926, 5847.6908351279835, 5848.561357898175, 5879.794207202727, 5300.734963251822, 5407.432219616883, 5449.427810079964, 5490.56075513958, 5492.670439773627, 5043.067032598981, 5062.11413002723, 5065.974670126626, 5069.822556210515, 5095.8980820383385, 5724.398938111522, 5862.618929769551, 5901.203337549462, 5919.3192782829665, 5930.584859059911, 5833.591648584558, 5857.443542863592, 5907.9704601476715, 5912.142739302863, 5927.229460170322, 5865.208196893364, 5866.765329386777, 5867.325257595431, 5867.383924687846, 5868.354481007001, 5634.098544232903, 5729.398413166724, 5729.828105156852, 5738.9139162913425, 5754.482096611325, 5876.382979787232, 5912.46787789101, 5923.526117910643, 5923.763049477972, 5951.0, 5736.6558006519745, 5750.741216645345, 5752.6836024019085, 5755.482006619424, 5758.827235182951, 5560.471755183251, 5677.971610141923, 5703.515201207943, 5718.056520674042, 5733.598648094593, 5670.574706896917, 5695.0, 5699.116636921284, 5705.258316418839, 5706.857328566819, 5789.681567513659, 5800.564957628279, 5803.564732644984, 5807.0, 5827.708614569339, 5319.2287118368395, 5605.271314729059, 5648.887022259614, 5678.574106942078, 5684.8294551163535], "value": 5387.803870501099, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.6096503063195, 662.218582073154, 670.7484693240035, 678.240370784721, 729.9415847021817, 32958.67041329586, 40890.0, 42036.78981605088, 42111.57888421115, 42137.36793948089, 42768.0, 43624.34563481542, 43643.3453498197, 43651.12697746043, 43657.0, 8253.83492330153, 8840.248578870787, 9072.909270907272, 10456.895431045707, 10704.0, 10302.690919272434, 10614.681559553226, 10617.893821061767, 10629.734256643607, 10643.787124257511, 10533.104686101691, 10674.679759607225, 10688.358698478116, 10688.51901664427, 10693.83959240612, 8119.309858661992, 10291.794164116676, 10577.84133238002, 10581.259311848175, 10582.0, 10488.160947124212, 10612.416317102556, 10619.57521699131, 10623.84064239037, 10640.0, 40172.397414038816, 40837.591624083674, 40864.38703419451, 40886.0, 40901.59098409008, 3676.3382591133586, 3721.702263818888, 3771.1891943232063, 3931.528216613996, 4053.391991201314, 30634.38731225363, 31007.844960775277, 31154.844225778954, 31455.0, 31467.52798708021, 4394.62645675118, 4448.777561121931, 4457.0, 4548.272276435754, 4583.793729282191, 287215.0, 289901.0, 290015.0, 290126.0, 290582.0, 61878.690606546676, 61999.6900015497, 62235.0, 62331.37668623347, 62373.0, 62428.68785656043, 62756.0, 62760.37239627637, 62811.371886280554, 64514.35485645178, 16969.745453818203, 18095.095245237684, 18231.72652410215, 18261.726074108898, 18289.359872404402, 14064.08583442073, 14370.49703260381, 14383.137011779327, 14386.35261413239, 14390.928045359706, 20369.287074952306, 20409.387718368474, 20545.0, 20553.89723051375, 20625.0, 7552.358049565739, 7569.583672897933, 7580.924190758022, 7682.654280557388, 7729.265719756614, 1035.0684384054412, 1079.2445288298065, 1120.4789772755707, 1221.5358163897663, 1269.8412698412699, 34953.825230873685, 35119.64880351215, 35149.0, 35511.0, 35569.28861422757, 1201.411308458849, 1219.4390580333147, 1222.0712258683463, 1231.408923716603, 1307.7253776706807, 18370.816291837178, 18450.169742361624, 18640.0, 18648.813511864708, 18700.532486687942, 538175.0, 548287.0, 548690.0, 548744.0, 550248.0, 64053.35946640567, 65009.67495162494, 65043.02435463472, 65385.67307163434, 65486.0, 1405.6275087101926, 1473.1087691946432, 1477.3425825507545, 1548.5044785668704, 1578.2818817438038, 30598.694013059583, 33039.8348008268, 33195.83402082974, 35002.12494687653, 35138.824305878305, 52036.479635204676, 52339.0, 52636.0, 52647.0, 52681.47318526919, 316148.0, 322999.0, 323404.0, 324425.0, 325183.0, 25706.87146564255, 28404.289892752848, 28474.85762571174, 29049.564256536592, 30481.23796905095, 45280.0, 45333.0, 45770.77114614539, 46338.30492542547, 46490.30264546102, 38486.80756596199, 38760.22479550337, 38905.2218955625, 39106.804465978625, 41974.0, 41922.37116443317, 41997.580024199364, 42400.15199696051, 43043.7847810759, 43359.783201083796, 42770.35844462398, 42992.570074298856, 43057.0, 43477.0, 44459.999300030926, 36962.8151859239, 37849.4322585156, 38369.61630383772, 38413.2317353657, 38652.420213697376, 28380.71619283781, 28846.855765721037, 28982.42035159327, 29174.41651167007, 29194.0], "value": 20986.690097038652, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.74055307368656, 442.27687730560524, 443.9953609453318, 445.7815670321543, 456.0, 19637.803621963776, 19808.801911980874, 20678.89660551697, 20735.0, 20737.170513179455, 18733.34433294835, 20308.796912030874, 20491.897540512313, 20492.69260961087, 20551.177952881902, 5738.626989245707, 5972.731227094791, 6000.339962604132, 6013.639181649093, 6016.969915150418, 5787.450192231731, 5830.242068531085, 5848.327442344121, 5907.172995780594, 5911.615744976584, 5889.793857214999, 5896.027155519334, 5901.114832775075, 5905.025670764318, 5934.43622855828, 5812.709364531777, 5904.2029326040865, 5950.642961422285, 5954.523638108941, 5959.10613407988, 5207.0, 5233.398159211702, 5289.7619607117385, 5297.152455607084, 5342.091844386464, 23865.0, 24016.51966960651, 24205.394865128514, 24509.0, 24607.50784984308, 2281.9087236510686, 2673.70589235184, 2974.7768917331287, 3070.5240687693445, 3326.334733053399, 10095.242856785697, 10122.64570740028, 10141.543630536644, 12789.848913597822, 13503.0, 2001.9699704504444, 2011.8088781565875, 2037.7962203779502, 2061.597988392264, 2108.9050992705365, 86953.0, 88594.5570272151, 88693.0, 88789.0, 91167.0, 11376.488058037408, 11616.477258523219, 11623.76752464946, 11792.584889813277, 11809.704757381134, 16564.337426503047, 16755.743319251105, 16805.663886722195, 16825.747613785803, 16858.578535536464, 8447.239748422671, 8742.0, 8851.734447966572, 8882.289416846637, 8926.821463570692, 8593.69922052725, 8601.354898382646, 8624.698135565224, 8717.215450609348, 8736.825263494822, 4979.402471703346, 5063.291139240509, 5064.898702025939, 5089.643724939293, 5124.205748109049, 1991.9203231870852, 2071.4200023993308, 2104.4648781875085, 2113.091370710609, 2140.197425965263, 1063.9680809575725, 1094.042712626452, 1096.4627332606965, 1120.9047230985457, 1127.5602515018986, 19767.901160494104, 20082.39752807418, 20400.18399264013, 20509.38471845847, 20670.379888603064, 1046.884842667306, 1053.6891616972857, 1059.6291298045621, 1087.6465148826662, 1139.5897476908306, 10980.560777568968, 11344.829827552594, 11421.373084190684, 11652.067834573214, 11720.941395292968, 537176.0, 540065.0, 544292.0, 545322.0, 547192.0, 99463.0, 103542.0, 103570.0, 103838.48080759699, 104047.4797626007, 1072.2976450424985, 1072.5924148823397, 1080.6974047266779, 1082.2045796339526, 1082.3451811653993, 17916.283348665907, 18074.457766267034, 18232.544186395447, 18392.172352244448, 18393.0, 35671.0, 36849.58629873258, 39913.600863990985, 40588.0, 43461.34807977946, 58740.70629646824, 59369.70315148397, 60552.69723651354, 60598.0, 60777.0, 9014.594343254437, 9261.166495015212, 9335.393199442015, 9339.766505837137, 9505.952470237604, 10568.313059651098, 13309.933450332686, 13361.66595835112, 13851.930740346234, 14100.153990760587, 10161.0, 11612.477438515456, 11982.0, 11991.0, 12186.0, 11513.330567067896, 11928.045756339645, 11957.701057473632, 12100.334481603244, 12687.936560317139, 11558.826617600911, 11868.76262474763, 12114.0, 12663.556775512812, 12856.935715321364, 9267.582958766738, 9345.766355840886, 9404.52977351116, 9455.101765332283, 9502.85745713801, 11577.826332605186, 12154.513819447124, 12177.878221217674, 12271.938640306742, 12416.441260143496], "value": 9773.479195345903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.473899918031, 1536.6926614677063, 1604.3342013064578, 1733.0728060487634, 1860.8697391182614, 7838.921610783897, 8155.632996515156, 8163.755087347389, 8170.795730106735, 8184.386171037167, 7927.960360198205, 8182.91817081829, 8192.631331590077, 8194.83610327793, 8195.71315003975, 2077.6571865642227, 2314.0512389920136, 2340.660604212384, 2382.273406610983, 2387.6299173628117, 2413.3122060212845, 2439.6462512935614, 2443.535728211643, 2443.767842055002, 2444.8166387521005, 2324.732655744594, 2380.0241900820665, 2384.3443053160345, 2384.3681424422543, 2384.8569085854906, 2060.186226440555, 2316.224064938248, 2376.548455793411, 2388.0686532252435, 2390.6294524348755, 2251.8423710340285, 2270.5118399544176, 2282.851614645043, 2283.908643654252, 2285.1887579909057, 7924.128345881948, 8004.919950800476, 8019.719309824187, 8079.0, 8092.352611791042, 5057.342545469065, 5208.0, 5227.032998895179, 5237.109691352441, 5246.160614301732, 3322.9335413291597, 3333.683300086512, 3365.6848004715334, 3465.42820434628, 3470.8091054991964, 1087.456271864068, 1099.6810924831789, 1120.5405783628755, 1120.7030137013699, 1153.3253046967534, 11096.667099987013, 11324.320540767498, 11332.546698132148, 11372.715682107932, 11388.658340249805, 4570.474395444567, 4585.10590434862, 4689.929651055237, 4714.033623107255, 4716.622670186377, 9736.902630973742, 9745.269104817167, 9770.853437198448, 9781.266405019509, 9800.950995244979, 4504.25679762842, 5052.8484145475695, 5164.2770012198325, 5171.405288391883, 5173.508516690908, 4700.482946875841, 4769.523047695272, 4804.25534042224, 4826.396700412449, 4843.176659967814, 3926.9214615707524, 3982.4026396040827, 4031.4759081319826, 4036.7486079315504, 4073.450084238649, 1270.9364531773374, 1310.6199202231246, 1313.7044165062784, 1321.0554453565555, 1337.8193943817655, 956.6221342569646, 1053.2153545608417, 1064.9414282214552, 1072.7157303314627, 1081.551156270139, 5787.592176180575, 5853.502452291603, 5878.882422351529, 5977.252843394575, 6123.632582045091, 483.35230790740576, 500.21965733455926, 1075.9031687148195, 1157.6874243954085, 1158.5481662151767, 3962.9618554953877, 4122.2579935611275, 4367.235733746582, 4401.625861801719, 4402.823887044482, 9923.0, 10271.0, 10334.844977325347, 10363.896361036293, 10372.429516376671, 10162.898371016196, 10245.487725613839, 10251.84622230667, 10259.640912568024, 10263.127634151031, 7404.444666650023, 7768.495047821873, 7807.258310460497, 7811.648475818602, 7836.098848632366, 5974.40255974399, 6154.723037463235, 6158.107074474086, 6227.595206311576, 6301.7164227608955, 9231.953840230755, 9491.145796878314, 9529.237660987243, 9588.856167157637, 9589.424634521672, 9659.71020869375, 9696.466694331879, 9751.658691946031, 9764.462954537568, 9773.41359518431, 6738.393544581011, 7229.49393542447, 7284.38082762971, 7416.295451932057, 7438.181800002104, 8034.437589368688, 8040.919590804017, 8077.676892924453, 8108.108108108221, 8123.512589244664, 7294.124705035218, 7501.962490187514, 7531.209223031503, 7641.847163056819, 7656.770296891103, 7366.152892417441, 7458.850822983619, 7473.6263186841525, 7550.962245188739, 7559.886601700869, 6724.899126513008, 6767.492438067066, 6807.285235050248, 6812.795616131524, 6823.965880170567, 5084.872878178076, 5173.1722924333435, 5247.081760691787, 5369.624126311277, 5456.20884971669, 5162.432132465351, 5186.9221961669855, 5236.816711415082, 5284.682919024717, 5318.627696061239], "value": 4553.379930303921, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.19855325517585, 360.281238928338, 363.0596754406088, 363.58006502489627, 364.22965428119534, 5306.787728490861, 5399.622026458144, 5401.918971215435, 5422.4306447823, 5425.0, 5277.366715994077, 5281.155015197569, 5316.3354580677415, 5324.787008519665, 5326.283595366362, 3896.47397601323, 3998.480197574311, 4210.431591735122, 4220.493540775111, 4234.30134027885, 4198.307279298912, 4206.47419072616, 4211.68412369072, 4217.873463796091, 4258.297380932143, 4029.2344454553686, 4186.162767446508, 4207.474065741782, 4211.684123690736, 4217.388478670591, 4103.363978583325, 4205.158968206356, 4218.894527636803, 4220.345846393814, 4230.76730779807, 3720.423334383148, 3748.3627783276634, 3749.0, 3757.7369584129124, 3768.434734789776, 5128.692278463304, 5141.383034035902, 5160.303359046518, 5193.2989046479, 5219.582433405319, 4564.269716845322, 4798.424189097331, 4825.879353016167, 4826.951730482685, 4828.806847726087, 5542.91685624716, 5615.691136987464, 5652.208690783294, 5656.4060773618585, 5683.0, 3935.74417662851, 4103.2409004334295, 4105.815238314283, 4107.609777071173, 4134.462519872397, 5543.501084902378, 5706.0, 5802.0, 5851.76592936282, 5897.201353587154, 4110.17796440713, 4115.971007248188, 4133.937990930139, 4149.585041495826, 4158.313878210122, 4132.276851550967, 4178.1643671265865, 4181.184668989518, 4184.581541845791, 4190.727602705814, 4623.768811559408, 4749.596284315803, 4761.857144285677, 4774.236122220428, 4778.474367819537, 5592.3009623797025, 5598.524125449382, 5603.7478313475995, 5623.212750214973, 5637.915431268534, 1485.8588434098742, 1486.7323881701398, 1486.851314868526, 1494.4694633405202, 1498.7002599480147, 1015.1067060986433, 1016.7458135466134, 1045.0594464981425, 1051.984220236697, 1052.7473406382567, 5656.85857853557, 5693.259876216065, 5701.486866182064, 5703.62926409782, 5732.656040637575, 6105.572609917263, 6131.386861313833, 6133.938660613337, 6143.907841382383, 6151.784687535915, 5539.833804985857, 5684.8294551163535, 5687.829365119053, 5696.458836410535, 5698.8290351289525, 3255.283837555734, 3265.9183520411702, 3267.1995361136674, 3269.640339562646, 3275.410426123273, 5957.970210148921, 6153.692315384213, 6167.691615419211, 6182.938170618326, 6197.4732147767045, 6253.530985176039, 6253.6873156342, 6258.123862659231, 6265.530085243625, 6273.937260627426, 6104.328523862371, 6138.969305153535, 6141.293751218578, 6146.877062458726, 6155.538334624921, 5905.143754155538, 6126.724297406538, 6143.477804386677, 6155.169052177898, 6157.907631385622, 6015.909761353496, 6029.618300771259, 6041.942660034564, 6050.878982420415, 6053.969730151321, 5500.697461639648, 5520.978618955506, 5644.0650861552585, 5834.541364658835, 6148.1699970503405, 4042.9797851010558, 4055.9594404055583, 4067.2272268270117, 4070.9185816284103, 4084.183163367279, 5635.577331700057, 5736.627119237236, 5797.826065218051, 5802.1296805479515, 5818.44724751148, 5533.0, 5585.9720701397855, 5619.971900140473, 5659.773609055756, 5661.46216109469, 5568.749406276808, 5612.4387561245185, 5622.522085622768, 5658.047973449154, 5665.413684168439, 5290.947090529199, 5525.972370138124, 5536.695481748542, 5540.0, 5542.7782888684005, 5634.7321852582845, 5657.4908258256955, 5667.574931880043, 5699.287589051369, 5711.914321285101, 5554.50009499147, 5558.333000040021, 5580.637258578179, 5626.087130375692, 5632.633878797865], "value": 4368.296884383244, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.8434455281215, 830.1698301698302, 835.2482765511039, 835.2816577743143, 875.5928493250638, 13959.511417100404, 14464.710705785878, 14472.276386180689, 14474.421023159075, 14476.203808790513, 11861.822072668896, 13167.20996740194, 13228.735425291488, 13235.735285294313, 13256.072074954756, 875.5359659380523, 913.4017218721715, 917.4678686361927, 917.5091326140516, 920.5029284186564, 906.7687739626386, 910.3763921713614, 913.9177474027337, 914.89021317442, 915.4781774388601, 762.5615271219043, 940.9388389754678, 941.8728471656307, 942.7218970403713, 943.259541260111, 774.9612519374037, 909.6134142989237, 941.9811603767921, 944.1644144931716, 944.8535477001076, 691.9792406227821, 692.4979389942301, 692.5636848785233, 692.9064576282187, 693.1024323501078, 13701.588952331445, 14250.643733906632, 14294.64263393413, 14307.356168972421, 14319.642008949755, 14131.364088616037, 14266.286685665675, 14343.139411635335, 14491.42034318626, 14600.415983360654, 11866.821997670042, 12004.819927701092, 12033.63899083029, 12063.758724825455, 12160.391980400944, 4336.111097225062, 4370.497392799837, 4470.709403888769, 4526.86419407415, 4565.885852853672, 54286.0, 54294.0, 54703.72648136734, 54923.450765492635, 55100.0, 10657.573697052187, 11191.216614836883, 11244.66266012021, 11481.483333250024, 11630.0, 19599.11803968825, 19622.803771962383, 19625.509362266057, 19632.70550941737, 19671.606567868563, 8051.235132662505, 8148.307393871587, 8277.0, 8376.01115202633, 8476.110008449148, 4611.331356953223, 4631.328457373662, 4744.264638980963, 5008.173651347487, 5112.437631860493, 3640.8179591020344, 3740.981295093507, 3751.3622684143215, 3755.6244375562223, 3756.3426400379826, 675.2504719761062, 679.5379142183264, 681.6625770243761, 689.8068540808481, 696.5994553131969, 811.0996793559144, 817.3992115794886, 820.6471217376585, 821.8849361089452, 830.1864173110386, 9792.755181120387, 10326.173906087644, 10398.480075996322, 10421.218408619385, 10422.843657345145, 670.7853486884151, 720.9243029481829, 789.1634867040955, 813.3086876155221, 856.6915910272297, 4562.0, 4611.677182597186, 4665.603423708955, 4739.194336962724, 4826.372571565674, 61525.384746152864, 65672.6716366415, 66304.0, 66833.0, 67027.66486167636, 57591.13613295804, 57675.71162144246, 57909.0, 59156.70421647864, 59288.11067833986, 53895.46104538983, 54235.45764542304, 54348.0, 54461.72769136129, 54871.451285487434, 9643.614255429984, 9699.1436936082, 9863.802723945337, 9975.650852220137, 9998.900010999796, 33971.4904276441, 34291.485627715105, 34628.65371346254, 35240.647593524765, 35471.11322216965, 45538.77230613826, 48136.75931620319, 48250.0, 48325.75837120792, 48396.0, 13023.0, 13071.542496012595, 13118.672033198865, 13199.07606467538, 13393.062485625913, 13003.739925201633, 14029.859701402855, 14105.365258563184, 14449.927750361181, 14665.853341466876, 13634.386452609459, 13852.376643051288, 14209.715805683622, 14223.0, 14313.928430358199, 12997.285149316878, 13434.0, 13469.932650336686, 13601.931990339985, 13872.930635346758, 13512.23046748104, 13896.37466313998, 13917.0, 14114.50599229022, 14568.927155364156, 10845.728856778329, 11309.41792667266, 11563.71090722705, 11662.358570278377, 11786.11604129711, 11293.830592541282, 11475.196736228383, 11480.598179063692, 11777.352245626573, 11935.582254621047], "value": 7179.238161010888, "unit": "score"}], "name": "dromaeo_css", "value": 7351.274582040318, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 106.0, 110.0, 112.0, 111.0, 103.0, 109.0, 110.0, 108.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 127.0, 150.0, 172.0, 128.0, 161.0, 159.0, 134.0, 198.0, 127.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 162.0, 161.0, 160.0, 160.0, 165.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 176.0, 76.0, 74.0, 72.0, 74.0, 162.0, 85.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 144.0, 92.0, 91.0, 94.0, 157.0, 92.0, 93.0, 150.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 54.0, 56.0, 54.0, 54.0, 70.0, 53.0, 52.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 56.0, 56.0, 56.0, 56.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 81.0, 73.0, 75.0, 74.0, 75.0, 76.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 115.0, 122.0, 120.0, 117.0, 119.0, 115.0, 149.0, 126.0], "value": 122.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 165.0, 160.0, 162.0, 160.0, 160.0, 161.0, 159.0, 165.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 66.0, 66.0, 68.0, 67.0, 66.0, 68.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1521.6999999999998, "alertThreshold": 2.0}]} 14:12:19 INFO - Return code: 0 14:12:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:12:19 ERROR - # TBPL SUCCESS # 14:12:19 INFO - Running post-action listener: _resource_record_post_action 14:12:19 INFO - Running post-run listener: _resource_record_post_run 14:12:20 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 351473664; Read time: 24; Write time: 630988 14:12:20 INFO - install - Wall time: 19s; CPU: 14.0%; Read bytes: 0; Write bytes: 66486272; Read time: 0; Write time: 214216 14:12:20 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 243961856; Read time: 24; Write time: 290032 14:12:20 INFO - Running post-run listener: _upload_blobber_files 14:12:20 INFO - Blob upload gear active. 14:12:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:12:20 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 14:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:12:21 INFO - (blobuploader) - INFO - Open directory for files ... 14:12:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:12:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:12:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:22 INFO - (blobuploader) - INFO - Done attempting. 14:12:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:12:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:12:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:23 INFO - (blobuploader) - INFO - Done attempting. 14:12:23 INFO - (blobuploader) - INFO - Iteration through files over. 14:12:23 INFO - Return code: 0 14:12:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:12:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:12:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c28d94595d24e2ea59adf01ee975a021bcb8662c16364e3005311390d54a190b1df8d70bcfad20d7c92459c0ea8c174368cf7255c2599ef62b778d3b40635602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a50773932b73adca2d90ec12455886afa1e4e183e5eb223fa451b8cb93b6ec547c014d11a479abf4e85494b615f2c1a48047e29cbaf3d2fbbc29985f5b17fbf4"} 14:12:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:12:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:12:23 INFO - Contents: 14:12:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c28d94595d24e2ea59adf01ee975a021bcb8662c16364e3005311390d54a190b1df8d70bcfad20d7c92459c0ea8c174368cf7255c2599ef62b778d3b40635602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a50773932b73adca2d90ec12455886afa1e4e183e5eb223fa451b8cb93b6ec547c014d11a479abf4e85494b615f2c1a48047e29cbaf3d2fbbc29985f5b17fbf4"} 14:12:23 INFO - Running post-run listener: copy_logs_to_upload_dir 14:12:23 INFO - Copying logs to upload dir... 14:12:23 INFO - mkdir: /builds/slave/test/build/upload/logs 14:12:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1688.631096 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 8 secs) (at 2016-04-26 14:12:23.394153) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 14:12:23.398185) ========= 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=1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c28d94595d24e2ea59adf01ee975a021bcb8662c16364e3005311390d54a190b1df8d70bcfad20d7c92459c0ea8c174368cf7255c2599ef62b778d3b40635602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a50773932b73adca2d90ec12455886afa1e4e183e5eb223fa451b8cb93b6ec547c014d11a479abf4e85494b615f2c1a48047e29cbaf3d2fbbc29985f5b17fbf4"} build_url:https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009841 build_url: 'https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c28d94595d24e2ea59adf01ee975a021bcb8662c16364e3005311390d54a190b1df8d70bcfad20d7c92459c0ea8c174368cf7255c2599ef62b778d3b40635602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a50773932b73adca2d90ec12455886afa1e4e183e5eb223fa451b8cb93b6ec547c014d11a479abf4e85494b615f2c1a48047e29cbaf3d2fbbc29985f5b17fbf4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 14:12:23.420261) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 14:12:23.420645) ========= 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=1861a34ebfea852630dec091000001fa-1461703453.809732-1635794406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 14:12:23.505141) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 14:12:23.505545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 14:12:23.506042) ========= ========= Total master_lag: 0.13 =========