builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1461703185.68 results: success (0) buildid: 20160426062558 builduid: 18458ff6a626441ea2f2e0a4fd3bd5e1 revision: cbeae0c4410bef3864b3d3f4ad939321c61cb15b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:45.685226) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:45.685673) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:45.685942) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:45.702031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:45.702394) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 13:39:45-- 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% 25.3M=0s 2016-04-26 13:39:45 (25.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119848 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:45.835548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:45.835856) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016677 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:45.884910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 13:39:45.885375) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 13:39:46,062 truncating revision to first 12 chars 2016-04-26 13:39:46,062 Setting DEBUG logging. 2016-04-26 13:39:46,062 attempt 1/10 2016-04-26 13:39:46,062 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:39:47,375 unpacking tar archive at: mozilla-aurora-cbeae0c4410b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.596840 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 13:39:47.495099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:47.495418) ========= script_repo_revision: cbeae0c4410bef3864b3d3f4ad939321c61cb15b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:47.495793) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:47.496071) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 13:39:47.504883) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 47 secs) (at 2016-04-26 13:39:47.505262) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:39:47 INFO - MultiFileLogger online at 20160426 13:39:47 in /builds/slave/test 13:39:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:39:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:39:47 INFO - {'append_to_log': False, 13:39:47 INFO - 'base_work_dir': '/builds/slave/test', 13:39:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:39:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:39:47 INFO - 'branch': 'Mozilla-Aurora', 13:39:47 INFO - 'buildbot_json_path': 'buildprops.json', 13:39:47 INFO - 'config_files': ('talos/linux_config.py',), 13:39:47 INFO - 'default_actions': ('clobber', 13:39:47 INFO - 'read-buildbot-config', 13:39:47 INFO - 'download-and-extract', 13:39:47 INFO - 'populate-webroot', 13:39:47 INFO - 'create-virtualenv', 13:39:47 INFO - 'install', 13:39:47 INFO - 'run-tests'), 13:39:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:39:47 INFO - 'download_minidump_stackwalk': True, 13:39:47 INFO - 'download_symbols': 'ondemand', 13:39:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:39:47 INFO - 'tooltool.py': '/tools/tooltool.py', 13:39:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:39:47 INFO - '/tools/misc-python/virtualenv.py')}, 13:39:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:39:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:39:47 INFO - 'installer_path': 'installer.exe', 13:39:47 INFO - 'log_level': 'info', 13:39:47 INFO - 'log_name': 'talos', 13:39:47 INFO - 'log_to_console': True, 13:39:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:39:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:39:47 INFO - 'opt_config_files': (), 13:39:47 INFO - 'pip_index': False, 13:39:47 INFO - 'sps_profile': False, 13:39:47 INFO - 'sps_profile_interval': 0, 13:39:47 INFO - 'suite': 'dromaeojs-e10s', 13:39:47 INFO - 'system_bits': '32', 13:39:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:39:47 INFO - 'title': 'talos-linux64-ix-041', 13:39:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:39:47 INFO - 'use_talos_json': True, 13:39:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:39:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:39:47 INFO - 'work_dir': 'build'} 13:39:47 INFO - ##### 13:39:47 INFO - ##### Running clobber step. 13:39:47 INFO - ##### 13:39:47 INFO - Running pre-action listener: _resource_record_pre_action 13:39:47 INFO - Running main action method: clobber 13:39:47 INFO - rmtree: /builds/slave/test/build 13:39:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:39:48 INFO - Running post-action listener: _resource_record_post_action 13:39:48 INFO - ##### 13:39:48 INFO - ##### Running read-buildbot-config step. 13:39:48 INFO - ##### 13:39:48 INFO - Running pre-action listener: _resource_record_pre_action 13:39:48 INFO - Running main action method: read_buildbot_config 13:39:48 INFO - Using buildbot properties: 13:39:48 INFO - { 13:39:48 INFO - "project": "", 13:39:48 INFO - "product": "firefox", 13:39:48 INFO - "script_repo_revision": "production", 13:39:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:39:48 INFO - "repository": "", 13:39:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:39:48 INFO - "buildid": "20160426062558", 13:39:48 INFO - "pgo_build": "True", 13:39:48 INFO - "basedir": "/builds/slave/test", 13:39:48 INFO - "buildnumber": 257, 13:39:48 INFO - "slavename": "talos-linux64-ix-041", 13:39:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:39:48 INFO - "platform": "ubuntu64_hw", 13:39:48 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:39:48 INFO - "branch": "mozilla-aurora", 13:39:48 INFO - "repo_path": "releases/mozilla-aurora", 13:39:48 INFO - "revision": "cbeae0c4410bef3864b3d3f4ad939321c61cb15b", 13:39:48 INFO - "stage_platform": "linux64-pgo", 13:39:48 INFO - "builduid": "18458ff6a626441ea2f2e0a4fd3bd5e1", 13:39:48 INFO - "slavebuilddir": "test" 13:39:48 INFO - } 13:39:48 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:39:48 INFO - Running post-action listener: _resource_record_post_action 13:39:48 INFO - ##### 13:39:48 INFO - ##### Running download-and-extract step. 13:39:48 INFO - ##### 13:39:48 INFO - Running pre-action listener: _resource_record_pre_action 13:39:48 INFO - Running main action method: download_and_extract 13:39:48 INFO - mkdir: /builds/slave/test/build/tests 13:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:49 INFO - Downloaded 1361 bytes. 13:39:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:39:49 INFO - Using the following test package requirements: 13:39:49 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:39:49 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:39:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:39:49 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:39:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:39:49 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:39:49 INFO - u'jsshell-linux-x86_64.zip'], 13:39:49 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:39:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:39:49 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:39:49 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:39:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:39:49 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:39:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:39:49 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:39:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:39:49 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:39:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:39:49 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:49 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:39:49 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:39:49 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:39:49 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:39:49 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:39:56 INFO - Downloaded 23820445 bytes. 13:39:56 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:39:56 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:39:58 INFO - Return code: 0 13:39:58 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:39:58 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:39:58 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:39:58 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:39:58 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:39:58 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:39:58 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:40:43 INFO - Downloaded 23820445 bytes. 13:40:43 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:40:43 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:40:45 INFO - Return code: 0 13:40: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:40:45 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:40: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.talos.tests.zip 13:40: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.talos.tests.zip 13:40: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.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:40: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.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:44:44 INFO - Downloaded 10840145 bytes. 13:44:44 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:44:44 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:44:44 INFO - Return code: 0 13:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:44 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:44:44 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:44:44 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:44:44 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:44:44 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:44:47 INFO - Downloaded 62689705 bytes. 13:44:47 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:44:47 INFO - mkdir: /builds/slave/test/properties 13:44:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:44:47 INFO - Writing to file /builds/slave/test/properties/build_url 13:44:47 INFO - Contents: 13:44:47 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:44:48 INFO - Running post-action listener: _resource_record_post_action 13:44:48 INFO - Running post-action listener: set_extra_try_arguments 13:44:48 INFO - ##### 13:44:48 INFO - ##### Running populate-webroot step. 13:44:48 INFO - ##### 13:44:48 INFO - Running pre-action listener: _resource_record_pre_action 13:44:48 INFO - Running main action method: populate_webroot 13:44:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:44:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:44:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:44:49 INFO - '--tppagecycles', 13:44:49 INFO - '7'], 13:44:49 INFO - 'tests': ['tsvgm']}}, 13:44:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:44:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:44:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:44:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:44:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:44:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:44:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:49 INFO - 'talos_options': ['--disable-e10s'], 13:44:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:49 INFO - 'talos_options': ['--disable-e10s'], 13:44:49 INFO - 'tests': ['damp', 'tps']}, 13:44:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:49 INFO - 'tests': ['damp', 'tps']}, 13:44:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:44:49 INFO - 'tests': ['dromaeo_dom']}, 13:44:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:44:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:44:49 INFO - 'tests': ['a11yr', 13:44:49 INFO - 'ts_paint', 13:44:49 INFO - 'tpaint', 13:44:49 INFO - 'sessionrestore', 13:44:49 INFO - 'sessionrestore_no_auto_restore', 13:44:49 INFO - 'tabpaint']}, 13:44:49 INFO - 'other-e10s': {'tests': ['a11yr', 13:44:49 INFO - 'ts_paint', 13:44:49 INFO - 'tpaint', 13:44:49 INFO - 'sessionrestore', 13:44:49 INFO - 'sessionrestore_no_auto_restore', 13:44:49 INFO - 'tabpaint']}, 13:44:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:44:49 INFO - 'ts_paint', 13:44:49 INFO - 'tpaint', 13:44:49 INFO - 'sessionrestore', 13:44:49 INFO - 'sessionrestore_no_auto_restore', 13:44:49 INFO - 'tabpaint']}, 13:44:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:44:49 INFO - 'ts_paint', 13:44:49 INFO - 'tpaint', 13:44:49 INFO - 'sessionrestore', 13:44:49 INFO - 'sessionrestore_no_auto_restore', 13:44:49 INFO - 'tabpaint']}, 13:44:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:44:49 INFO - 'tests': ['a11yr', 13:44:49 INFO - 'ts_paint', 13:44:49 INFO - 'tpaint', 13:44:49 INFO - 'sessionrestore', 13:44:49 INFO - 'sessionrestore_no_auto_restore', 13:44:49 INFO - 'tabpaint']}, 13:44:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:44:49 INFO - 'tests': ['a11yr', 13:44:49 INFO - 'ts_paint', 13:44:49 INFO - 'tpaint', 13:44:49 INFO - 'sessionrestore', 13:44:49 INFO - 'sessionrestore_no_auto_restore', 13:44:49 INFO - 'tabpaint']}, 13:44:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:44:49 INFO - 'tests': ['tsvgx', 13:44:49 INFO - 'tsvgr_opacity', 13:44:49 INFO - 'tart', 13:44:49 INFO - 'tscrollx', 13:44:49 INFO - 'cart']}, 13:44:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:44:49 INFO - 'tsvgr_opacity', 13:44:49 INFO - 'tart', 13:44:49 INFO - 'tscrollx', 13:44:49 INFO - 'cart']}, 13:44:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:49 INFO - 'talos_options': ['--disable-e10s'], 13:44:49 INFO - 'tests': ['tp5o']}, 13:44:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:49 INFO - 'tests': ['tp5o']}, 13:44:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:49 INFO - 'talos_options': ['--disable-e10s', 13:44:49 INFO - '--xperf_path', 13:44:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:49 INFO - 'tests': ['tp5n']}, 13:44:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:49 INFO - 'talos_options': ['--xperf_path', 13:44:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:49 INFO - 'tests': ['tp5n']}}, 13:44:49 INFO - 'talos.zip': {'path': '', 13:44:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:44:49 INFO - Running post-action listener: _resource_record_post_action 13:44:49 INFO - ##### 13:44:49 INFO - ##### Running create-virtualenv step. 13:44:49 INFO - ##### 13:44:49 INFO - Running pre-action listener: _resource_record_pre_action 13:44:49 INFO - Running main action method: create_virtualenv 13:44:49 INFO - Creating virtualenv /builds/slave/test/build/venv 13:44:49 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:44:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:44:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:44:49 INFO - Using real prefix '/usr' 13:44:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:44:49 INFO - Installing distribute.............................................................................................................................................................................................done. 13:44:51 INFO - Installing pip.................done. 13:44:51 INFO - Return code: 0 13:44:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:51 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 0x7f0b59b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c1410>, '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 0x29c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c27a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', '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:44:51 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:44:51 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:44:51 INFO - Using env: {'DISPLAY': ':0', 13:44:51 INFO - 'HOME': '/home/cltbld', 13:44:51 INFO - 'LANG': 'en_US.UTF-8', 13:44:51 INFO - 'LANGUAGE': 'en_US:en', 13:44:51 INFO - 'LOGNAME': 'cltbld', 13:44:51 INFO - 'MAIL': '/var/mail/cltbld', 13:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:51 INFO - 'MOZ_NO_REMOTE': '1', 13:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:51 INFO - 'NO_EM_RESTART': '1', 13:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:51 INFO - 'PWD': '/builds/slave/test', 13:44:51 INFO - 'SHELL': '/bin/bash', 13:44:51 INFO - 'SHLVL': '1', 13:44:51 INFO - 'TERM': 'linux', 13:44:51 INFO - 'TMOUT': '86400', 13:44:51 INFO - 'USER': 'cltbld', 13:44:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', 13:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:51 INFO - '_': '/tools/buildbot/bin/python'} 13:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:51 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:44:51 INFO - Cleaning up... 13:44:51 INFO - Return code: 0 13:44:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:51 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 0x7f0b59b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c1410>, '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 0x29c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c27a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', '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:44:51 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:44:51 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:44:51 INFO - Using env: {'DISPLAY': ':0', 13:44:51 INFO - 'HOME': '/home/cltbld', 13:44:51 INFO - 'LANG': 'en_US.UTF-8', 13:44:51 INFO - 'LANGUAGE': 'en_US:en', 13:44:51 INFO - 'LOGNAME': 'cltbld', 13:44:51 INFO - 'MAIL': '/var/mail/cltbld', 13:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:51 INFO - 'MOZ_NO_REMOTE': '1', 13:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:51 INFO - 'NO_EM_RESTART': '1', 13:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:51 INFO - 'PWD': '/builds/slave/test', 13:44:51 INFO - 'SHELL': '/bin/bash', 13:44:51 INFO - 'SHLVL': '1', 13:44:51 INFO - 'TERM': 'linux', 13:44:51 INFO - 'TMOUT': '86400', 13:44:51 INFO - 'USER': 'cltbld', 13:44:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', 13:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:51 INFO - '_': '/tools/buildbot/bin/python'} 13:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:51 INFO - Downloading/unpacking psutil>=0.7.1 13:44:51 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:44:51 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:44:51 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:44:51 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:44:51 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:44:51 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:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:44:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:54 INFO - Installing collected packages: psutil 13:44:54 INFO - Running setup.py install for psutil 13:44:54 INFO - building 'psutil._psutil_linux' extension 13:44:54 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:44:54 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:44:54 INFO - building 'psutil._psutil_posix' extension 13:44:54 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:44:54 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:44:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:54 INFO - Successfully installed psutil 13:44:54 INFO - Cleaning up... 13:44:54 INFO - Return code: 0 13:44:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:54 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 0x7f0b59b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c1410>, '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 0x29c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c27a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', '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:44:54 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:44:54 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:44:54 INFO - Using env: {'DISPLAY': ':0', 13:44:54 INFO - 'HOME': '/home/cltbld', 13:44:54 INFO - 'LANG': 'en_US.UTF-8', 13:44:54 INFO - 'LANGUAGE': 'en_US:en', 13:44:54 INFO - 'LOGNAME': 'cltbld', 13:44:54 INFO - 'MAIL': '/var/mail/cltbld', 13:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:54 INFO - 'MOZ_NO_REMOTE': '1', 13:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:54 INFO - 'NO_EM_RESTART': '1', 13:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:54 INFO - 'PWD': '/builds/slave/test', 13:44:54 INFO - 'SHELL': '/bin/bash', 13:44:54 INFO - 'SHLVL': '1', 13:44:54 INFO - 'TERM': 'linux', 13:44:54 INFO - 'TMOUT': '86400', 13:44:54 INFO - 'USER': 'cltbld', 13:44:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', 13:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:54 INFO - '_': '/tools/buildbot/bin/python'} 13:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:44:54 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:44:54 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:44:54 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:44:54 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:44:54 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:44:54 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:44:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:44:56 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:44:56 INFO - Installing collected packages: mozsystemmonitor 13:44:56 INFO - Running setup.py install for mozsystemmonitor 13:44:56 INFO - Successfully installed mozsystemmonitor 13:44:56 INFO - Cleaning up... 13:44:56 INFO - Return code: 0 13:44:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0b59b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c1410>, '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 0x29c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c27a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', '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:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:44:57 INFO - Using env: {'DISPLAY': ':0', 13:44:57 INFO - 'HOME': '/home/cltbld', 13:44:57 INFO - 'LANG': 'en_US.UTF-8', 13:44:57 INFO - 'LANGUAGE': 'en_US:en', 13:44:57 INFO - 'LOGNAME': 'cltbld', 13:44:57 INFO - 'MAIL': '/var/mail/cltbld', 13:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:57 INFO - 'MOZ_NO_REMOTE': '1', 13:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:57 INFO - 'NO_EM_RESTART': '1', 13:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:57 INFO - 'PWD': '/builds/slave/test', 13:44:57 INFO - 'SHELL': '/bin/bash', 13:44:57 INFO - 'SHLVL': '1', 13:44:57 INFO - 'TERM': 'linux', 13:44:57 INFO - 'TMOUT': '86400', 13:44:57 INFO - 'USER': 'cltbld', 13:44:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', 13:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:57 INFO - '_': '/tools/buildbot/bin/python'} 13:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:57 INFO - Downloading/unpacking blobuploader==1.2.4 13:44:57 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:44:57 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:44:57 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:44:57 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:44:57 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:44:57 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:44:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:44:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:44:59 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:44:59 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:44:59 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:44:59 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:44:59 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:44:59 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:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:44:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:44:59 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:44:59 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:44:59 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:44:59 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:44:59 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:44:59 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:44:59 INFO - Downloading docopt-0.6.1.tar.gz 13:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:44:59 INFO - Installing collected packages: blobuploader, requests, docopt 13:44:59 INFO - Running setup.py install for blobuploader 13:44:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:44:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:44:59 INFO - Running setup.py install for requests 13:45:00 INFO - Running setup.py install for docopt 13:45:00 INFO - Successfully installed blobuploader requests docopt 13:45:00 INFO - Cleaning up... 13:45:00 INFO - Return code: 0 13:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:00 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:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:00 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:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:00 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 0x7f0b59b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c1410>, '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 0x29c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c27a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', '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:45:00 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:45:00 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:45:00 INFO - Using env: {'DISPLAY': ':0', 13:45:00 INFO - 'HOME': '/home/cltbld', 13:45:00 INFO - 'LANG': 'en_US.UTF-8', 13:45:00 INFO - 'LANGUAGE': 'en_US:en', 13:45:00 INFO - 'LOGNAME': 'cltbld', 13:45:00 INFO - 'MAIL': '/var/mail/cltbld', 13:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:00 INFO - 'MOZ_NO_REMOTE': '1', 13:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:00 INFO - 'NO_EM_RESTART': '1', 13:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:00 INFO - 'PWD': '/builds/slave/test', 13:45:00 INFO - 'SHELL': '/bin/bash', 13:45:00 INFO - 'SHLVL': '1', 13:45:00 INFO - 'TERM': 'linux', 13:45:00 INFO - 'TMOUT': '86400', 13:45:00 INFO - 'USER': 'cltbld', 13:45:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', 13:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:00 INFO - '_': '/tools/buildbot/bin/python'} 13:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:00 INFO - Running setup.py (path:/tmp/pip-GmuIin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:00 INFO - Running setup.py (path:/tmp/pip-oUgVnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:00 INFO - Running setup.py (path:/tmp/pip-Tpfyax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:00 INFO - Running setup.py (path:/tmp/pip-JT7haH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:00 INFO - Running setup.py (path:/tmp/pip-5MqHkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:01 INFO - Running setup.py (path:/tmp/pip-C9hw4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:01 INFO - Running setup.py (path:/tmp/pip-NP5ZIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:01 INFO - Running setup.py (path:/tmp/pip-ibORnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:01 INFO - Running setup.py (path:/tmp/pip-kbjIfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:01 INFO - Running setup.py (path:/tmp/pip-nmXQXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:01 INFO - Running setup.py (path:/tmp/pip-_hY5Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:01 INFO - Running setup.py (path:/tmp/pip-HYQnSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:01 INFO - Running setup.py (path:/tmp/pip-6TTaqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:01 INFO - Running setup.py (path:/tmp/pip-QB2h1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:01 INFO - Running setup.py (path:/tmp/pip-Or4dDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:01 INFO - Running setup.py (path:/tmp/pip-2Kni__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:01 INFO - Running setup.py (path:/tmp/pip-TKbi_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:45:01 INFO - Running setup.py install for manifestparser 13:45:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:45:01 INFO - Running setup.py install for mozcrash 13:45:02 INFO - Running setup.py install for mozdebug 13:45:02 INFO - Running setup.py install for mozdevice 13:45:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Running setup.py install for mozfile 13:45:02 INFO - Running setup.py install for mozhttpd 13:45:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Running setup.py install for mozinfo 13:45:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Running setup.py install for mozInstall 13:45:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Running setup.py install for mozleak 13:45:02 INFO - Running setup.py install for mozlog 13:45:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Running setup.py install for moznetwork 13:45:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Running setup.py install for mozprocess 13:45:03 INFO - Running setup.py install for mozprofile 13:45:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Running setup.py install for mozrunner 13:45:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Running setup.py install for mozscreenshot 13:45:03 INFO - Running setup.py install for moztest 13:45:03 INFO - Running setup.py install for mozversion 13:45:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:45:03 INFO - Cleaning up... 13:45:03 INFO - Return code: 0 13:45:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45: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:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:03 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 0x7f0b59b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c1410>, '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 0x29c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c27a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', '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:45:03 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:45:03 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:45:03 INFO - Using env: {'DISPLAY': ':0', 13:45:03 INFO - 'HOME': '/home/cltbld', 13:45:03 INFO - 'LANG': 'en_US.UTF-8', 13:45:03 INFO - 'LANGUAGE': 'en_US:en', 13:45:03 INFO - 'LOGNAME': 'cltbld', 13:45:03 INFO - 'MAIL': '/var/mail/cltbld', 13:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:03 INFO - 'MOZ_NO_REMOTE': '1', 13:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:03 INFO - 'NO_EM_RESTART': '1', 13:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:03 INFO - 'PWD': '/builds/slave/test', 13:45:03 INFO - 'SHELL': '/bin/bash', 13:45:03 INFO - 'SHLVL': '1', 13:45:03 INFO - 'TERM': 'linux', 13:45:03 INFO - 'TMOUT': '86400', 13:45:03 INFO - 'USER': 'cltbld', 13:45:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', 13:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:03 INFO - '_': '/tools/buildbot/bin/python'} 13:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:03 INFO - Running setup.py (path:/tmp/pip-kUyt2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:03 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:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:03 INFO - Running setup.py (path:/tmp/pip-MZ7RcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:04 INFO - Running setup.py (path:/tmp/pip-XhHpQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:04 INFO - Running setup.py (path:/tmp/pip-MwRBDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:04 INFO - Running setup.py (path:/tmp/pip-zypOC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:04 INFO - Running setup.py (path:/tmp/pip-CQVX9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:04 INFO - Running setup.py (path:/tmp/pip-yIckoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:04 INFO - Running setup.py (path:/tmp/pip-43kY08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:04 INFO - Running setup.py (path:/tmp/pip-g81d45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:04 INFO - Running setup.py (path:/tmp/pip-ymxpL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:04 INFO - Running setup.py (path:/tmp/pip-vvGqt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:04 INFO - Running setup.py (path:/tmp/pip-lftdnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:04 INFO - Running setup.py (path:/tmp/pip-DPeKug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:04 INFO - Running setup.py (path:/tmp/pip-p5w8Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:04 INFO - Running setup.py (path:/tmp/pip-ZLBeg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:04 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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:04 INFO - Running setup.py (path:/tmp/pip-nIxtf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:05 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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:05 INFO - Running setup.py (path:/tmp/pip-ZfyH0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:06 INFO - Downloading blessings-1.6.tar.gz 13:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:45:07 INFO - Installing collected packages: blessings 13:45:07 INFO - Running setup.py install for blessings 13:45:07 INFO - Successfully installed blessings 13:45:07 INFO - Cleaning up... 13:45:07 INFO - Return code: 0 13:45:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:07 INFO - Reading from file tmpfile_stdout 13:45:07 INFO - Current package versions: 13:45:07 INFO - argparse == 1.2.1 13:45:07 INFO - blessings == 1.6 13:45:07 INFO - blobuploader == 1.2.4 13:45:07 INFO - docopt == 0.6.1 13:45:07 INFO - manifestparser == 1.1 13:45:07 INFO - mozInstall == 1.12 13:45:07 INFO - mozcrash == 0.17 13:45:07 INFO - mozdebug == 0.1 13:45:07 INFO - mozdevice == 0.48 13:45:07 INFO - mozfile == 1.2 13:45:07 INFO - mozhttpd == 0.7 13:45:07 INFO - mozinfo == 0.9 13:45:07 INFO - mozleak == 0.1 13:45:07 INFO - mozlog == 3.1 13:45:07 INFO - moznetwork == 0.27 13:45:07 INFO - mozprocess == 0.22 13:45:07 INFO - mozprofile == 0.28 13:45:07 INFO - mozrunner == 6.11 13:45:07 INFO - mozscreenshot == 0.1 13:45:07 INFO - mozsystemmonitor == 0.0 13:45:07 INFO - moztest == 0.7 13:45:07 INFO - mozversion == 1.4 13:45:07 INFO - psutil == 3.1.1 13:45:07 INFO - requests == 1.2.3 13:45:07 INFO - wsgiref == 0.1.2 13:45:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:07 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:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:07 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:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:07 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 0x7f0b59b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c1410>, '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 0x29c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c27a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', '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:45:07 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:45:07 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:45:07 INFO - Using env: {'DISPLAY': ':0', 13:45:07 INFO - 'HOME': '/home/cltbld', 13:45:07 INFO - 'LANG': 'en_US.UTF-8', 13:45:07 INFO - 'LANGUAGE': 'en_US:en', 13:45:07 INFO - 'LOGNAME': 'cltbld', 13:45:07 INFO - 'MAIL': '/var/mail/cltbld', 13:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:07 INFO - 'MOZ_NO_REMOTE': '1', 13:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:07 INFO - 'NO_EM_RESTART': '1', 13:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:07 INFO - 'PWD': '/builds/slave/test', 13:45:07 INFO - 'SHELL': '/bin/bash', 13:45:07 INFO - 'SHLVL': '1', 13:45:07 INFO - 'TERM': 'linux', 13:45:07 INFO - 'TMOUT': '86400', 13:45:07 INFO - 'USER': 'cltbld', 13:45:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', 13:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:07 INFO - '_': '/tools/buildbot/bin/python'} 13:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:07 INFO - Cleaning up... 13:45:07 INFO - Return code: 0 13:45:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:45:07 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:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:07 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:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:07 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 0x7f0b59b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c1410>, '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 0x29c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c27a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', '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:45:07 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:45:07 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:45:07 INFO - Using env: {'DISPLAY': ':0', 13:45:07 INFO - 'HOME': '/home/cltbld', 13:45:07 INFO - 'LANG': 'en_US.UTF-8', 13:45:07 INFO - 'LANGUAGE': 'en_US:en', 13:45:07 INFO - 'LOGNAME': 'cltbld', 13:45:07 INFO - 'MAIL': '/var/mail/cltbld', 13:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:07 INFO - 'MOZ_NO_REMOTE': '1', 13:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:07 INFO - 'NO_EM_RESTART': '1', 13:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:07 INFO - 'PWD': '/builds/slave/test', 13:45:07 INFO - 'SHELL': '/bin/bash', 13:45:07 INFO - 'SHLVL': '1', 13:45:07 INFO - 'TERM': 'linux', 13:45:07 INFO - 'TMOUT': '86400', 13:45:07 INFO - 'USER': 'cltbld', 13:45:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', 13:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:07 INFO - '_': '/tools/buildbot/bin/python'} 13:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:07 INFO - Downloading/unpacking jsonschema 13:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:07 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:45:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:45:09 INFO - Downloading/unpacking functools32 (from jsonschema) 13:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:09 INFO - Downloading functools32-3.2.3-2.tar.gz 13:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:45:09 INFO - warning: no files found matching '*.txt' 13:45:09 INFO - no previously-included directories found matching 'build' 13:45:09 INFO - no previously-included directories found matching 'dist' 13:45:09 INFO - no previously-included directories found matching '.git*' 13:45:09 INFO - Installing collected packages: jsonschema, functools32 13:45:10 INFO - Running setup.py install for functools32 13:45:10 INFO - warning: no files found matching '*.txt' 13:45:10 INFO - no previously-included directories found matching 'build' 13:45:10 INFO - no previously-included directories found matching 'dist' 13:45:10 INFO - no previously-included directories found matching '.git*' 13:45:10 INFO - Successfully installed jsonschema functools32 13:45:10 INFO - Cleaning up... 13:45:10 INFO - Return code: 0 13:45:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:45:10 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:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:10 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:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:10 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 0x7f0b59b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c1410>, '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 0x29c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c27a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', '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:45:10 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:45:10 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:45:10 INFO - Using env: {'DISPLAY': ':0', 13:45:10 INFO - 'HOME': '/home/cltbld', 13:45:10 INFO - 'LANG': 'en_US.UTF-8', 13:45:10 INFO - 'LANGUAGE': 'en_US:en', 13:45:10 INFO - 'LOGNAME': 'cltbld', 13:45:10 INFO - 'MAIL': '/var/mail/cltbld', 13:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:10 INFO - 'MOZ_NO_REMOTE': '1', 13:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:10 INFO - 'NO_EM_RESTART': '1', 13:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:10 INFO - 'PWD': '/builds/slave/test', 13:45:10 INFO - 'SHELL': '/bin/bash', 13:45:10 INFO - 'SHLVL': '1', 13:45:10 INFO - 'TERM': 'linux', 13:45:10 INFO - 'TMOUT': '86400', 13:45:10 INFO - 'USER': 'cltbld', 13:45:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', 13:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:10 INFO - '_': '/tools/buildbot/bin/python'} 13:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:10 INFO - Downloading/unpacking flake8 13:45: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:45: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:45: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:45: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:45: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:45: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:45:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:45:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:45:12 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:45:12 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:45:12 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:45:12 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:45:12 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:45:12 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:45:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:45:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:45:12 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:45:12 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:45:12 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:45:12 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:45:12 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:45:12 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:45:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:45:12 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:45:12 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:45:12 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:45:12 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:45:12 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:45:12 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:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:45:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:12 INFO - no previously-included directories found matching 'docs/_build' 13:45:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:45:13 INFO - Running setup.py install for pep8 13:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:13 INFO - no previously-included directories found matching 'docs/_build' 13:45:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:45:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:45:13 INFO - Cleaning up... 13:45:13 INFO - Return code: 0 13:45:13 INFO - Running post-action listener: _resource_record_post_action 13:45:13 INFO - Running post-action listener: _start_resource_monitoring 13:45:13 INFO - Starting resource monitoring. 13:45:13 INFO - ##### 13:45:13 INFO - ##### Running install step. 13:45:13 INFO - ##### 13:45:13 INFO - Running pre-action listener: _resource_record_pre_action 13:45:13 INFO - Running main action method: install 13:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:13 INFO - Reading from file tmpfile_stdout 13:45:13 INFO - Detecting whether we're running mozinstall >=1.0... 13:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:45:13 INFO - Reading from file tmpfile_stdout 13:45:13 INFO - Output received: 13:45:13 INFO - Usage: mozinstall [options] installer 13:45:13 INFO - Options: 13:45:13 INFO - -h, --help show this help message and exit 13:45:13 INFO - -d DEST, --destination=DEST 13:45:13 INFO - Directory to install application into. [default: 13:45:13 INFO - "/builds/slave/test"] 13:45:13 INFO - --app=APP Application being installed. [default: firefox] 13:45:13 INFO - mkdir: /builds/slave/test/build/application 13:45:13 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:45:13 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:45:29 INFO - Reading from file tmpfile_stdout 13:45:29 INFO - Output received: 13:45:29 INFO - /builds/slave/test/build/application/firefox/firefox 13:45:29 INFO - Running post-action listener: _resource_record_post_action 13:45:29 INFO - ##### 13:45:29 INFO - ##### Running run-tests step. 13:45:29 INFO - ##### 13:45:29 INFO - Running pre-action listener: _resource_record_pre_action 13:45:29 INFO - Running main action method: run_tests 13:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:45:29 INFO - Python 2.7.3 13:45:29 INFO - Return code: 0 13:45:29 INFO - grabbing minidump binary from tooltool 13:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:29 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 0x29c1410>, '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 0x29c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:45:29 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:45:29 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:45:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:45:29 INFO - Return code: 0 13:45:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:45:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:45:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:45:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:45:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:45:30 INFO - Return code: 0 13:45:30 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-e10s', '--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-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:45:30 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-e10s --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-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:45:30 INFO - Using env: {'DISPLAY': ':0', 13:45:30 INFO - 'HOME': '/home/cltbld', 13:45:30 INFO - 'LANG': 'en_US.UTF-8', 13:45:30 INFO - 'LANGUAGE': 'en_US:en', 13:45:30 INFO - 'LOGNAME': 'cltbld', 13:45:30 INFO - 'MAIL': '/var/mail/cltbld', 13:45:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:45:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:30 INFO - 'MOZ_NO_REMOTE': '1', 13:45:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:30 INFO - 'NO_EM_RESTART': '1', 13:45:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:30 INFO - 'PWD': '/builds/slave/test', 13:45:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:45:30 INFO - 'SHELL': '/bin/bash', 13:45:30 INFO - 'SHLVL': '1', 13:45:30 INFO - 'TERM': 'linux', 13:45:30 INFO - 'TMOUT': '86400', 13:45:30 INFO - 'USER': 'cltbld', 13:45:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599', 13:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:30 INFO - '_': '/tools/buildbot/bin/python'} 13:45:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--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-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:45:30 INFO - mozversion application_buildid: 20160426062558 13:45:30 INFO - mozversion application_changeset: cbeae0c4410bef3864b3d3f4ad939321c61cb15b 13:45:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:45:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:45:30 INFO - mozversion application_name: Firefox 13:45:30 INFO - mozversion application_remotingname: firefox-dev 13:45:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:45:30 INFO - mozversion application_vendor: Mozilla 13:45:30 INFO - mozversion application_version: 48.0a2 13:45:30 INFO - mozversion platform_buildid: 20160426062558 13:45:30 INFO - mozversion platform_changeset: cbeae0c4410bef3864b3d3f4ad939321c61cb15b 13:45:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:45:30 INFO - mozversion platform_version: 48.0a2 13:45:30 INFO - using testdate: 1461703530 13:45:30 INFO - actual date: 1461703530 13:45:30 INFO - starting webserver on 'localhost:51798' 13:45:30 INFO - SUITE-START | Running 2 tests 13:45:30 INFO - TEST-START | dromaeo_css 13:45:30 INFO - operating with platform_type : linux_ 13:45:30 INFO - Initialising browser for dromaeo_css test... 13:45:30 INFO - TEST-INFO | started process 13592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBBC08k/profile http://localhost:51798/getInfo.html) 13:45:34 INFO - PROCESS | 13592 | 13:45:34 INFO - PROCESS | 13592 | (process:13671): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:45:35 INFO - PROCESS | 13592 | __metrics Screen width/height:1600/1200 13:45:35 INFO - PROCESS | 13592 | colorDepth:24 13:45:35 INFO - PROCESS | 13592 | Browser inner width/height: 1024/697 13:45:35 INFO - PROCESS | 13592 | __metrics 13:45:35 ERROR - PROCESS | 13592 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:45:36 INFO - TEST-INFO | 13592: exit 0 13:45:36 INFO - Browser initialized. 13:45:36 INFO - Running cycle 1/1 for dromaeo_css test... 13:45:36 INFO - TEST-INFO | started process 13722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBBC08k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:38 INFO - PROCESS | 13722 | 13:45:38 INFO - PROCESS | 13722 | (process:13789): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:45:48 INFO - PROCESS | 13722 | RSS: Main: 152576000 13:45:48 INFO - PROCESS | 13722 | 13:46:38 INFO - PROCESS | 13722 | 1461703598160 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:48:45 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51798/tests/dromaeo/cssquery-ext.html) 13:48:46 INFO - PROCESS | 13722 | RSS: Main: 155496448 13:48:46 INFO - PROCESS | 13722 | 13:51:48 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-ext.html (next: http://localhost:51798/tests/dromaeo/cssquery-jquery.html) 13:51:49 INFO - PROCESS | 13722 | RSS: Main: 154238976 13:51:49 INFO - PROCESS | 13722 | 13:54:51 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51798/tests/dromaeo/cssquery-mootools.html) 13:54:51 INFO - PROCESS | 13722 | RSS: Main: 153772032 13:54:51 INFO - PROCESS | 13722 | 13:57:53 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51798/tests/dromaeo/cssquery-prototype.html) 13:57:54 INFO - PROCESS | 13722 | RSS: Main: 153518080 13:57:54 INFO - PROCESS | 13722 | 14:00:56 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51798/tests/dromaeo/cssquery-yui.html) 14:00:56 INFO - PROCESS | 13722 | RSS: Main: 154746880 14:00:56 INFO - PROCESS | 13722 | 14:03:59 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-yui.html (next: http://localhost:51798/tests/dromaeo/cssquery-dojo.html) 14:03:59 INFO - PROCESS | 13722 | RSS: Main: 156016640 14:03:59 INFO - PROCESS | 13722 | 14:03:59 INFO - PROCESS | 13722 | __start_tp_report 14:03:59 INFO - PROCESS | 13722 | _x_x_mozilla_page_load 14:03:59 INFO - PROCESS | 13722 | _x_x_mozilla_page_load_details 14:03:59 INFO - PROCESS | 13722 | |i|pagename|runs| 14:03:59 INFO - PROCESS | 13722 | |0;dojo.html;3265.0857759827245;3296.703296703297;3371.2414706690984;3388.3053973935343;3393.762436629434;5656.406077361874;5670.064439367505;5686.687232202227;5694.829155125342;5717.571182161334;5668.801591944282;5700.543956483481;5700.800471983482;5706.201131841545;5715.571332150095;5135.666181698178;5170.482951704837;5196.974015129919;5223.921641175385;5261.473852614746;4998.050370429607;5110.744462776865;5305.708186049766;5307.893842123155;5310.893782124374;5186.2220666900075;5208.765605547759;5255.973720131394;5258.50044245796;5281.498257665516;5192.506711862367;5195.06488832012;5214.60890433219;5219.19102539107;5253.711045892474;4904.852854414374;5062.873428164326;5125.8718532037;5186.092433824066;5195.766190521435;5537.169424586304;5579.9163012554845;5620.960122377373;5637.633553818989;5666.320041594994;6039.667818269993;6060.030395136801;6075.726592303313;6077.513798896122;6087.634741915499;5938.6436813791315;6018.217631707894;6122.938770612326;6131.14164017038;6150;5670.688112153871;5677.858053548653;5679.574031947579;5689.630174038715;5720.256366672306;6180.103884936659;6180.969095154585;6182.536309776785;6199.070139479114;6200.937990620036;5769;5898.852528686817;5922;5922.111683247461;6004.159417681528;6022.096685497123;6061.909071363933;6066.241719785027;6067.180930574316;6114.969425152845;5962.25471816023;5972.701364931736;5981.222441082631;6024.759009639653;6068.150458935753;5735.168400581976;5997.1304160896425;6044.546659000593;6069.2110025696375;6080.422359875804;4621.722696638212;4644.419447569054;4655.092257009851;4667.603253723403;4690.695104818176;4134.255833949857;4139.4204811326435;4161.126163505698;4163.812628431728;4181.414601955728;5552.139418390156;5686.57350698691;5737.3688894221605;5773.191753154478;5777.682227477445;5844.970775146182;5877.853053673607;5892.204552385459;5893.263342082239;5996.13056106862;5723.942760572424;5775.422457754275;5782.826515204551;5784.161296611967;5785.913211301834;5012.924806127911;5203.9219411708855;5259.973700131475;5261.921071183935;5266.526012658879;6110.144579758838;6113.510919126459;6120.632762034292;6132.4521822465285;6133.671320645534;6034.607750496204;6045.455908968214;6046.818595442144;6053.061775424816;6075.088736689355;5920.555958303231;6047.455728984412;6094.177286066324;6116.694165291628;6191.380861913773;5960.672163031075;5970.134330521963;5972.581919265784;5973.074173503114;5999.4900433463645;6003.339632640319;6030.7889223876955;6049.425304596057;6081.331053584014;6087.969560152348;5702.942970570407;5823.301203855395;5873.618214816194;5880.323762767336;5914.556408269311;5892.057270836817;5930.080837470199;5932.199153114447;5937.703114844154;5944.346121926671;5821.79623713168;5836.387179346108;5839.970800145972;5841.620294680833;5843.357230704704;5700.600957932905;5811.4479124483105;5954.583179177416;5962.284525856925;6053.485453736482;5779.653220806765;5826.650400975955;5833.649981001154;5836.066229403275;5837.620554663933 14:03:59 INFO - PROCESS | 13722 | |1;ext.html;642.5534253693681;657.615295052394;672.2101530701425;723.6851969393317;732.8424388756416;40546.797266013666;41303;41437.99999999996;41607.79196104015;41638.791806041;45087.774561127146;45776.313355299695;45907;46164.76917615416;46297.768511157396;8922.732318030454;9117;9143.679971201009;9151.267898568098;9154.267658587298;9041.819163616723;9225.815483690356;9231.123043310909;9234.168924796766;9239.769005774842;9225.308101892386;9259.861102083474;9273.953630231874;9300.604909263631;9305.581248843819;9118.452892826419;9232.6306947722;9258.490783006966;9288.489133097677;9298.674546390912;9001.954990225073;9082.31882608807;9153.313501487348;9167;9176.770580735469;31498.842505787554;40850;41001.17997640031;41208.1758364834;41310;3542.4509201073615;3615.2950174715943;3647.908802279938;3697.8705745298785;3805.5813860475328;29971.25071873199;31137.22156946072;31190.22024449384;31383.215419614466;31779.682203177905;4283.678724095706;4357.281048626973;4495.977520112411;4504.076664283814;4551.613112885409;234585;236019;236192;236555;237885;37321.440178397344;59468.40531594715;60257;60323.09515357273;60541.394586053575;39258.214835703126;39289.2142157161;39305.80347098303;39321.2135757289;39443.60556394457;14330.57008289732;14356.712865742627;14390.352434140488;14449.494267700791;14540.49108281205;14167.929160354339;14259.500917467838;14288.785668214985;14290.49983250602;14330.426782928565;9537.332386732862;9585.329026968046;9614.375065620712;9675.951620241995;9717.56270967808;3625.6011838697723;3645.1616128290643;3666.6883314917995;3694.556653201579;3695.8891233263043;1097.8737445193744;1122.4836575175348;1142.9142814288962;1153.6250718516517;1161.8298325045253;34032.82983585116;34057.65942340545;34268.82865585656;34297.31405371879;35203.29593408117;1223.7858374784378;1228.263042174688;1241.74544218435;1287;1380.061558140454;18201.18094685716;18205;18235.361762338256;18284.54288642768;18451.538711532052;352620;357900;360566;360821;518361;58077;59193.40806591965;59642.70178649079;59734.103988440205;59941;1452.469848505309;1461.5176991592748;1473.7052589482146;1499.7600383938736;1566.7023265579503;33338.166545836546;35085.47371789476;35134.297314054085;35155.64844351524;35674.643253567134;56405.71797140988;56799.71600141973;56805.431945680015;57282.14076788768;57600.13599795922;469277;477158;477756;478823;479699;31832.840835795672;31991;32164.356712865145;32311.192220194684;32317.192070198435;52807.735961319944;53497.46502534925;53623.19565206447;53845;53984.19023714569;39674.801625991684;43618.78190609027;44164.11671766482;44540.331895022246;44658.3301250475;41351.58648413477;41659.7917010413;42217.78891105648;42293.36559951542;42547.57452425436;43185.78407107944;43552.56447435612;44149.33775993427;44909.326360105275;45072.54927450815;45834.539339075905;46438.071238575714;46859.53140468552;46995;47333.52666473291;35055.47416788801;35776.82111589425;36195.276094477435;36470.8176459116;36575.817120914224 14:03:59 INFO - PROCESS | 13722 | |2;jquery.html;421.2627901172949;421.3553263506832;422.5943094629156;423.8791944295874;425.55316917236905;18771.906140469295;19247.807521924795;19377.128029238684;20099.196032158732;20132.798672013276;19579.412617621496;20137.093830777612;20192.19231230753;20987.790122098813;21123;5835.620684655505;5972.104184372335;6022.96988515059;6025.939740602604;6029.758809647609;4364.563543645641;5936.257967754031;5987.98204305267;6204.069389591552;6524.412802847743;6428.614283143003;6465.450436712885;6481;6489.1239682642945;6506.772262970797;6260.09228661846;6422.197225346832;6453.257875344349;6503.219613646369;6542.574732642363;5579.442055794429;5730.541556675456;5737.168110623978;5744.511716504102;5761.452661997104;21249.57500849974;23179.3046208614;24383.02467901282;24526;24596.877015614988;2557.989594110316;2585.870706464688;2587.0815860369485;2601.206631977246;2664.920052398412;15041.247937603077;15054.924725376413;15135.091894486366;15277.465288714842;15709.842901571066;2057.681059435775;2100.06547086545;2135.1139277199945;2143;2162.1243396424475;79869;80478.59760701217;80738;82502.58748706218;83294.16705832924;10979.505922233519;11222.214444988773;11247;11348.659540213806;11591.652250432331;15394.307256173499;15439.073655580702;15452;15454.227288635524;15474.303656335493;8599.95700021496;8698.782530436789;8813.91186088131;8824.338174636929;8849;8546.188112129337;8574.314054875595;8643.35174861888;8654.307655387554;8689.782755431039;7050.365467107882;7070.222275549685;7153.89269160963;7234.927650723531;7299.41604671625;2056.6606509925996;2061.690746388024;2069.182672844218;2095.685647152939;2142.539354038858;997.8652881860855;1083.8590983172294;1099.5656715597295;1138.3397629374942;1211.5638370186725;18859.90570047141;20203.39389818308;20205;20214.191432342835;20565.074571644313;1044.2637940252105;1085.6634443322596;1097.7530055737554;1127.0757978457586;1131.338167172197;11417.543298267976;11447.198696091195;11500.769984600262;11508.827367589492;11599.246049006788;512159;517702;518206;518614;528174;94199;99100.50449747706;101442;101909;105960;1100.658795773313;1120.3110087296254;1150.1718762490993;1174.8707642159357;1175.1538891997748;17987.10064496744;18082.367117150836;18266.81733182651;18353.253917493083;18456.723149152505;40916;41373;42742;42950;43252.13495730131;60509.39490605037;61503;62132.37867621266;62164;63151.6842415785;8955.820883582423;9411.85882211781;9469.763255918382;9513.33406661527;9652.131308182297;14325.928370358082;14480.131192128507;14620.122792632475;14671;14806.925965370536;12232.510699571918;12378.149623019584;12433.316167610506;12545.31000794965;12877.613671589866;11783.646490605295;12029;12130.75738485243;12218.877811221773;12293.692657683629;12758.61724148277;12806.807897881725;12814.55149069778;12925.482980680668;13114.278714670785;8961.596728147379;9215.585298661443;9244.768880778034;9380.015098414568;9423.670171543963;9158.313126515404;12086.637400877988;12621.93689031549;12627.368631568568;12805.87194128084 14:03:59 INFO - PROCESS | 13722 | |3;mootools.html;1512.4026009726156;1557.478244787996;1704.9573760655983;1790.1407324484255;1836.3572749537655;7124.465665075127;7704.92295077049;7742.496737712059;8060.395470339733;8070.3140233080185;7712.537247765138;7718.343940765042;7788.454808163431;7795.766127016184;7802.375809935205;2269.8524595901213;2284.543091381722;2287.462446325112;2307.3078076577044;2307.5846347657416;2164.39396968849;2205.889705514726;2246.84272100953;2259.6158653029024;2272.8068114210314;2232.151782322715;2234.6089434348924;2256.5599708056934;2265.1732117777055;2290.7480177180496;2196.890155492219;2204.1183526589334;2205.5699138667806;2211.7456492503325;2212.2920665387082;2208.6355751301016;2221.600111979843;2222.866628002325;2223.9332820015265;2226.142934970032;7901.762947111596;7977.960110199469;7995.720149794729;8027.879581806277;8027.879581806277;4804.303376010494;4981.302617633534;5004.574611158056;5011.674241174348;5014.498550144956;3137.4666306727913;3168.904932852018;3279.6392396836327;3342.097633638904;3345;1084.159776173464;1106.1924794899687;1112.7663190729957;1141.6232643227715;1144.3820337018;10296.124829389437;10305.072543471124;10330.380177189469;10340.069393754524;10344.689659310232;4194.203101410722;4269.444972153662;4334.32817913224;4340.739555626673;4413.558644135561;8957.059508751618;8972.102789720975;8977.506237157018;8988.685396011238;8992.955035224782;4795.496472870368;4910.140725373046;4941.975290123526;4948.529889660476;4969.378827646544;3992.7604343739467;4436.068425630589;4515.577593058242;4571.977140114344;4589.10512450069;3718.2377612589353;3772.1512659651908;3798.639129282714;3836.405357169643;3838.1747924196434;1180.8937195652431;1206.4450352837619;1216.3249396584981;1226.4358395138336;1230.132756406731;937.2127412972999;1065.073386154051;1069.9786004280027;1071.8820929697727;1082.1883587309517;5645.379008309083;5647.943520564741;5805.245318108618;5930.614510056833;6015.187949626832;1000.9699709008742;1007.9395236285847;1024.7079582319004;1036.8859425463193;1052.6683048152663;4278.4010238566625;4324.740515569013;4324.935125973113;4333.566643335641;4343.413639158736;9460.24318054554;9862.556184971694;9927.2058235341;9936.652217172365;10071.395716257048;9796.118349348593;9837.163841073445;9889.456079915673;9897.851532227023;10022.699319020441;7547.320741133324;7569.47013709035;7716.151223365426;7758.030246219223;7772.300492955661;5891.469767720926;5952.851178720567;5974.790882319098;5978.671173085522;6118.265808103056;9026.503542305236;9148.725538233864;9273.258139348702;9277.768055798659;9278.211352035152;9145.63417463294;9147.725568232963;9386.718398448058;9476.336656433983;9480.95259523698;6459.515536334699;6636.83407914806;6810.387065164159;6985.301469852974;7157.141143062866;7724.343430808444;7741.496802707806;7795.337396321376;7810.297073263434;7824.413169012233;6931.618760967994;6997.405220556309;7069.045678833498;7098.112735908012;7249.420046396381;7031.191412987572;7039.084918960502;7085.468589855678;7089.149302083783;7153.141623005273;6489.805305840832;6661.600303981777;6711.899321510084;6712.563683360566;6768.898466523105;5119.872003199801;5223.764930578057;5232.058229518723;5317.335333083364;5478.506934375925;4928.334674818997;5147.40804807452;5167.095758242368;5271.262023316815;5274.393444753902 14:03:59 INFO - PROCESS | 13722 | |4;prototype.html;338.5159222312094;342.7155460967397;350.58105563851205;351.1834983662984;353.1630036812754;5448.318960129984;5564.666120032801;5683.431656834319;5689.5448364130825;5770.3075630924295;5564.1931919871695;5584.664920104797;5586.6368686035485;5616.971915140429;5644.588852786793;4344.456942882148;4355.537347808484;4363.650907927374;4384.473863136428;4407.405000324947;4116;4350.586694264056;4363.9999999999845;4405.273129933557;4420.160169567788;4302.20409224293;4309.978450107745;4325.221460137174;4327.956720432802;4339.218940590692;4313.978430107845;4314.482262128549;4328.285832837578;4351.608355248011;4361.4112094867105;3721.6836568891677;3744.8765370389046;3775.3015692096774;3793.867214647474;3809.561900381464;5345.5990800689715;5365.436629153961;5372.301600791872;5379.569634429236;5381;4954.355933728628;4961.156603377399;4973.52751488608;4974.7512624369;5003.5997120230295;5580.414056524047;5883.205767221413;5924.58527903047;5952.523798096142;5954.779270249588;4176.227397931392;4186.706930514865;4193.853215137486;4210.768407737573;4222.915541689149;6087.543434242405;6115.942028985507;6144.692765361759;6150.753969841201;6205.565610407273;4153.127843152912;4253.234417804763;4258.339957306623;4273.444452221192;4285.61429471349;4271.231178387858;4304.375865499485;4315.568443155722;4318.093200427946;4320.200762858881;4881.877953051202;4945.982950400253;4962.106820772224;4984.327115839315;4999.500049994971;5717.071132620727;5922.733476993546;5944.821655350346;5962.2249107615735;5970.6417614942375;1544.698783737183;1559.7816305717208;1570.3640025789573;1578.3742744972697;1580.936762529509;1027.5735569738474;1033.0857191385528;1035.471909326234;1042.7497400623795;1049.2130901823632;6003.729832157564;6012.849678757979;6020.397960204032;6033.909491357633;6069.484093851984;6456.903146452807;6494.9675251624385;6500.967495162494;6558.475321974231;6576.276609572943;5872.823815285548;6026.186464827279;6032.577719559588;6033.155358249848;6061.605995610271;3461.3077384523194;3481.398556663963;3489.842957066938;3509.596396414394;3511.2626348466597;6358.841028974312;6513.283538810727;6559.081728558006;6588.308227636125;6591.736330546821;6670.699818508082;6673.632950187786;6675.3324667533825;6691.76578819739;6710.959801230817;6449.290937901366;6506.739730410825;6557.180352455943;6574.671266436659;6594.835129121714;6469.385408386196;6472;6482.708278127401;6486.870262594816;6501.772437964649;6283.7746639406705;6301.243850737941;6420.293767685457;6447.4197322241225;6461.870762584816;6017.548683848641;6203.906941395792;6504.1869766279215;6551.80344589663;6593;4159;4180.352045432963;4189.832406703819;4238.88055972014;4243.787810609519;6159.23009623797;6188.535859810622;6216.197302782142;6216.627002379872;6224.657643829451;5776.162456443876;5947.732352044082;5952.940470595238;5979.4618484336615;5999.940000599938;5941.851453713692;5957;5961.314448838439;5982.341942386247;6016.157737916783;5808.39011903744;5914.521369657586;5936.13925980739;5936.703164841827;5938.940610593839;5946.910796337972;6050.15297858309;6051.848703782441;6053.788117415869;6071.848203794941;5865.706714664165;5887.911681324698;5892.351841297368;5907;5912.674802885883 14:03:59 INFO - PROCESS | 13722 | |5;yui.html;752.2702978111232;860.7245681381957;880.2561835249214;898.1961144775422;922.5202894494867;13820.792688109674;14658;14663.266836658164;14707.26463676816;14713.043652162602;13439.462421503129;13582.728345433085;13648.181109133458;13653.590392288248;14618.853811461882;885.7608445719684;910.5356268303146;917.3807679816131;919.1176470588243;921.3412410126791;910.3263584947125;912.4981260306838;914.7530166854946;921.5023887100957;922.1009515722184;957.1242313283337;959.1271942532297;959.4291396619035;961.8028304197622;963.109124060245;950.3964982236295;954.3224310739314;954.3891909178132;954.5465903695758;954.9856752148688;702.8559145375237;703.3388614702163;704.1936982155455;704.5702121705756;706.5619316024047;14287.428502859873;14326.283685815668;14357.210353430557;14364.497242596564;14372.64068398288;13299.468021279137;13356;13438.260895650736;13556.254406007665;13652.180869147884;11613.361265130414;11634.360110193937;11641.76716465666;11734.413279335999;11763.588274410355;3780.5652349979555;3805.0677583991824;3846.8461261549505;3851.056491159684;3853.190829925719;54262.72868635671;54330.45669543333;55704;55759.442405576236;55982;10387.68836934893;10401.895981040245;10438.68683939483;10458.790824183474;10475.47622618866;18230.45308640743;18273.17770700322;18285.908570457064;18329.7250541242;18345.81654183441;7985.121636619967;8011.639476223584;8127.959360203161;8140.470869393471;8207;4663.114008338405;4730.1958667026;4743;4755.334253204554;4772.570468657837;3520.978916114298;3592.76647017943;3629.383004889175;3630.709543236535;3637.7817330959697;662.1689779326914;668.9197296324472;673.7305077968851;676.2662511175331;697.052009267396;688;714.0895358417955;723.2405973727565;741.5921243316262;798.3373799746197;9308.20880225175;9650.71047868565;9655.903440965641;9744.951275243578;9746.561404736804;672.831792051987;691.4587997543197;700.7127077898037;710.0024465625804;711.8362776561316;4217.283061879488;4339.262325404688;4422.314541246112;4464.084862603158;4480.879780054986;67555.66222168956;69178.65410673014;69187;69884;70528.64735676392;58435.123473147934;58483.70758146182;58759.412405875395;58834;60172;54613.72693136509;55072.17391739127;55198;55557;55672.99999999919;8738.432001919855;8856.64573417056;8935.553222338727;9059.094090590888;9127.543622818699;34258.48612270868;34552.30895382129;34843.82578087093;35122.47316290309;35755.821220894766;44445.77777111094;48682;48835.26747098725;49093.50906491032;49489.50510494993;11058.612948546763;11097.889021110008;11255.785742340095;11326.207165498336;11344.149188810707;11731.061515078944;11885.702857428634;11959.342236176746;12225.327606981346;12591.24452532851;11405.657830265105;11543.711407214887;11603.709907252387;11749.118816088656;11934.104942129548;11319.490622921823;11459.48432320531;11475.426228688366;11649.359285239054;11806.937375636235;11067.335959842436;11630.302181869114;11904.285742855456;12085.75828483443;12207.328596927255;10437.843432348369;10538.473076346;10667.253292269466;10693.8930610696;10875.347479151276;10370.377777333384;10592.258541901992;10643.787124257626;10883.12934965185;10927.945360273148 14:03:59 INFO - PROCESS | 13722 | __end_tp_report 14:03:59 INFO - PROCESS | 13722 | __start_cc_report 14:03:59 INFO - PROCESS | 13722 | _x_x_mozilla_cycle_collect,325 14:03:59 INFO - PROCESS | 13722 | __end_cc_report 14:03:59 INFO - PROCESS | 13722 | __startTimestamp1461704639324__endTimestamp 14:03:59 INFO - PROCESS | 13722 | 14:03:59 INFO - PROCESS | 13722 | ------- Summary: start ------- 14:03:59 INFO - PROCESS | 13722 | Number of tests: 6 14:03:59 INFO - PROCESS | 13722 | 14:03:59 INFO - PROCESS | 13722 | [#0] dojo.html Cycles:165 Average:5613.51 Median:5823.30 stddev:608.89 (10.5%) stddev-sans-first:582.22 14:03:59 INFO - PROCESS | 13722 | Values: 3265.1 3296.7 3371.2 3388.3 3393.8 5656.4 5670.1 5686.7 5694.8 5717.6 5668.8 5700.5 5700.8 5706.2 5715.6 5135.7 5170.5 5197.0 5223.9 5261.5 4998.1 5110.7 5305.7 5307.9 5310.9 5186.2 5208.8 5256.0 5258.5 5281.5 5192.5 5195.1 5214.6 5219.2 5253.7 4904.9 5062.9 5125.9 5186.1 5195.8 5537.2 5579.9 5621.0 5637.6 5666.3 6039.7 6060.0 6075.7 6077.5 6087.6 5938.6 6018.2 6122.9 6131.1 6150.0 5670.7 5677.9 5679.6 5689.6 5720.3 6180.1 6181.0 6182.5 6199.1 6200.9 5769.0 5898.9 5922.0 5922.1 6004.2 6022.1 6061.9 6066.2 6067.2 6115.0 5962.3 5972.7 5981.2 6024.8 6068.2 5735.2 5997.1 6044.5 6069.2 6080.4 4621.7 4644.4 4655.1 4667.6 4690.7 4134.3 4139.4 4161.1 4163.8 4181.4 5552.1 5686.6 5737.4 5773.2 5777.7 5845.0 5877.9 5892.2 5893.3 5996.1 5723.9 5775.4 5782.8 5784.2 5785.9 5012.9 5203.9 5260.0 5261.9 5266.5 6110.1 6113.5 6120.6 6132.5 6133.7 6034.6 6045.5 6046.8 6053.1 6075.1 5920.6 6047.5 6094.2 6116.7 6191.4 5960.7 5970.1 5972.6 5973.1 5999.5 6003.3 6030.8 6049.4 6081.3 6088.0 5702.9 5823.3 5873.6 5880.3 5914.6 5892.1 5930.1 5932.2 5937.7 5944.3 5821.8 5836.4 5840.0 5841.6 5843.4 5700.6 5811.4 5954.6 5962.3 6053.5 5779.7 5826.7 5833.6 5836.1 5837.6 14:03:59 INFO - PROCESS | 13722 | 14:03:59 INFO - PROCESS | 13722 | [#1] ext.html Cycles:180 Average:54374.16 Median:41623.29 stddev:101283.34 (243.3%) stddev-sans-first:101487.12 14:03:59 INFO - PROCESS | 13722 | Values: 642.6 657.6 672.2 723.7 732.8 40546.8 41303.0 41438.0 41607.8 41638.8 45087.8 45776.3 45907.0 46164.8 46297.8 8922.7 9117.0 9143.7 9151.3 9154.3 9041.8 9225.8 9231.1 9234.2 9239.8 9225.3 9259.9 9274.0 9300.6 9305.6 9118.5 9232.6 9258.5 9288.5 9298.7 9002.0 9082.3 9153.3 9167.0 9176.8 31498.8 40850.0 41001.2 41208.2 41310.0 3542.5 3615.3 3647.9 3697.9 3805.6 29971.3 31137.2 31190.2 31383.2 31779.7 4283.7 4357.3 4496.0 4504.1 4551.6 234585.0 236019.0 236192.0 236555.0 237885.0 37321.4 59468.4 60257.0 60323.1 60541.4 39258.2 39289.2 39305.8 39321.2 39443.6 14330.6 14356.7 14390.4 14449.5 14540.5 14167.9 14259.5 14288.8 14290.5 14330.4 9537.3 9585.3 9614.4 9676.0 9717.6 3625.6 3645.2 3666.7 3694.6 3695.9 1097.9 1122.5 1142.9 1153.6 1161.8 34032.8 34057.7 34268.8 34297.3 35203.3 1223.8 1228.3 1241.7 1287.0 1380.1 18201.2 18205.0 18235.4 18284.5 18451.5 352620.0 357900.0 360566.0 360821.0 518361.0 58077.0 59193.4 59642.7 59734.1 59941.0 1452.5 1461.5 1473.7 1499.8 1566.7 33338.2 35085.5 35134.3 35155.6 35674.6 56405.7 56799.7 56805.4 57282.1 57600.1 469277.0 477158.0 477756.0 478823.0 479699.0 31832.8 31991.0 32164.4 32311.2 32317.2 52807.7 53497.5 53623.2 53845.0 53984.2 39674.8 43618.8 44164.1 44540.3 44658.3 41351.6 41659.8 42217.8 42293.4 42547.6 43185.8 43552.6 44149.3 44909.3 45072.5 45834.5 46438.1 46859.5 46995.0 47333.5 35055.5 35776.8 36195.3 36470.8 36575.8 14:03:59 INFO - PROCESS | 13722 | 14:03:59 INFO - PROCESS | 13722 | [#2] jquery.html Cycles:180 Average:30785.97 Median:2152.56 stddev:85518.92 (3972.9%) stddev-sans-first:85728.43 14:03:59 INFO - PROCESS | 13722 | Values: 421.3 421.4 422.6 423.9 425.6 18771.9 19247.8 19377.1 20099.2 20132.8 19579.4 20137.1 20192.2 20987.8 21123.0 5835.6 5972.1 6023.0 6025.9 6029.8 4364.6 5936.3 5988.0 6204.1 6524.4 6428.6 6465.5 6481.0 6489.1 6506.8 6260.1 6422.2 6453.3 6503.2 6542.6 5579.4 5730.5 5737.2 5744.5 5761.5 21249.6 23179.3 24383.0 24526.0 24596.9 2558.0 2585.9 2587.1 2601.2 2664.9 15041.2 15054.9 15135.1 15277.5 15709.8 2057.7 2100.1 2135.1 2143.0 2162.1 79869.0 80478.6 80738.0 82502.6 83294.2 10979.5 11222.2 11247.0 11348.7 11591.7 15394.3 15439.1 15452.0 15454.2 15474.3 8600.0 8698.8 8813.9 8824.3 8849.0 8546.2 8574.3 8643.4 8654.3 8689.8 7050.4 7070.2 7153.9 7234.9 7299.4 2056.7 2061.7 2069.2 2095.7 2142.5 997.9 1083.9 1099.6 1138.3 1211.6 18859.9 20203.4 20205.0 20214.2 20565.1 1044.3 1085.7 1097.8 1127.1 1131.3 11417.5 11447.2 11500.8 11508.8 11599.2 512159.0 517702.0 518206.0 518614.0 528174.0 94199.0 99100.5 101442.0 101909.0 105960.0 1100.7 1120.3 1150.2 1174.9 1175.2 17987.1 18082.4 18266.8 18353.3 18456.7 40916.0 41373.0 42742.0 42950.0 43252.1 60509.4 61503.0 62132.4 62164.0 63151.7 8955.8 9411.9 9469.8 9513.3 9652.1 14325.9 14480.1 14620.1 14671.0 14806.9 12232.5 12378.1 12433.3 12545.3 12877.6 11783.6 12029.0 12130.8 12218.9 12293.7 12758.6 12806.8 12814.6 12925.5 13114.3 8961.6 9215.6 9244.8 9380.0 9423.7 9158.3 12086.6 12621.9 12627.4 12805.9 14:03:59 INFO - PROCESS | 13722 | 14:03:59 INFO - PROCESS | 13722 | [#3] mootools.html Cycles:180 Average:5378.43 Median:5013.09 stddev:2867.31 (57.2%) stddev-sans-first:2860.63 14:03:59 INFO - PROCESS | 13722 | Values: 1512.4 1557.5 1705.0 1790.1 1836.4 7124.5 7704.9 7742.5 8060.4 8070.3 7712.5 7718.3 7788.5 7795.8 7802.4 2269.9 2284.5 2287.5 2307.3 2307.6 2164.4 2205.9 2246.8 2259.6 2272.8 2232.2 2234.6 2256.6 2265.2 2290.7 2196.9 2204.1 2205.6 2211.7 2212.3 2208.6 2221.6 2222.9 2223.9 2226.1 7901.8 7978.0 7995.7 8027.9 8027.9 4804.3 4981.3 5004.6 5011.7 5014.5 3137.5 3168.9 3279.6 3342.1 3345.0 1084.2 1106.2 1112.8 1141.6 1144.4 10296.1 10305.1 10330.4 10340.1 10344.7 4194.2 4269.4 4334.3 4340.7 4413.6 8957.1 8972.1 8977.5 8988.7 8993.0 4795.5 4910.1 4942.0 4948.5 4969.4 3992.8 4436.1 4515.6 4572.0 4589.1 3718.2 3772.2 3798.6 3836.4 3838.2 1180.9 1206.4 1216.3 1226.4 1230.1 937.2 1065.1 1070.0 1071.9 1082.2 5645.4 5647.9 5805.2 5930.6 6015.2 1001.0 1007.9 1024.7 1036.9 1052.7 4278.4 4324.7 4324.9 4333.6 4343.4 9460.2 9862.6 9927.2 9936.7 10071.4 9796.1 9837.2 9889.5 9897.9 10022.7 7547.3 7569.5 7716.2 7758.0 7772.3 5891.5 5952.9 5974.8 5978.7 6118.3 9026.5 9148.7 9273.3 9277.8 9278.2 9145.6 9147.7 9386.7 9476.3 9481.0 6459.5 6636.8 6810.4 6985.3 7157.1 7724.3 7741.5 7795.3 7810.3 7824.4 6931.6 6997.4 7069.0 7098.1 7249.4 7031.2 7039.1 7085.5 7089.1 7153.1 6489.8 6661.6 6711.9 6712.6 6768.9 5119.9 5223.8 5232.1 5317.3 5478.5 4928.3 5147.4 5167.1 5271.3 5274.4 14:03:59 INFO - PROCESS | 13722 | 14:03:59 INFO - PROCESS | 13722 | [#4] prototype.html Cycles:180 Average:5067.32 Median:5743.69 stddev:1537.05 (26.8%) stddev-sans-first:1499.82 14:03:59 INFO - PROCESS | 13722 | Values: 338.5 342.7 350.6 351.2 353.2 5448.3 5564.7 5683.4 5689.5 5770.3 5564.2 5584.7 5586.6 5617.0 5644.6 4344.5 4355.5 4363.7 4384.5 4407.4 4116.0 4350.6 4364.0 4405.3 4420.2 4302.2 4310.0 4325.2 4328.0 4339.2 4314.0 4314.5 4328.3 4351.6 4361.4 3721.7 3744.9 3775.3 3793.9 3809.6 5345.6 5365.4 5372.3 5379.6 5381.0 4954.4 4961.2 4973.5 4974.8 5003.6 5580.4 5883.2 5924.6 5952.5 5954.8 4176.2 4186.7 4193.9 4210.8 4222.9 6087.5 6115.9 6144.7 6150.8 6205.6 4153.1 4253.2 4258.3 4273.4 4285.6 4271.2 4304.4 4315.6 4318.1 4320.2 4881.9 4946.0 4962.1 4984.3 4999.5 5717.1 5922.7 5944.8 5962.2 5970.6 1544.7 1559.8 1570.4 1578.4 1580.9 1027.6 1033.1 1035.5 1042.7 1049.2 6003.7 6012.8 6020.4 6033.9 6069.5 6456.9 6495.0 6501.0 6558.5 6576.3 5872.8 6026.2 6032.6 6033.2 6061.6 3461.3 3481.4 3489.8 3509.6 3511.3 6358.8 6513.3 6559.1 6588.3 6591.7 6670.7 6673.6 6675.3 6691.8 6711.0 6449.3 6506.7 6557.2 6574.7 6594.8 6469.4 6472.0 6482.7 6486.9 6501.8 6283.8 6301.2 6420.3 6447.4 6461.9 6017.5 6203.9 6504.2 6551.8 6593.0 4159.0 4180.4 4189.8 4238.9 4243.8 6159.2 6188.5 6216.2 6216.6 6224.7 5776.2 5947.7 5952.9 5979.5 5999.9 5941.9 5957.0 5961.3 5982.3 6016.2 5808.4 5914.5 5936.1 5936.7 5938.9 5946.9 6050.2 6051.8 6053.8 6071.8 5865.7 5887.9 5892.4 5907.0 5912.7 14:03:59 INFO - PROCESS | 13722 | 14:03:59 INFO - PROCESS | 13722 | [#5] yui.html Cycles:180 Average:15232.39 Median:4572.00 stddev:18417.27 (402.8%) stddev-sans-first:18436.84 14:03:59 INFO - PROCESS | 13722 | Values: 752.3 860.7 880.3 898.2 922.5 13820.8 14658.0 14663.3 14707.3 14713.0 13439.5 13582.7 13648.2 13653.6 14618.9 885.8 910.5 917.4 919.1 921.3 910.3 912.5 914.8 921.5 922.1 957.1 959.1 959.4 961.8 963.1 950.4 954.3 954.4 954.5 955.0 702.9 703.3 704.2 704.6 706.6 14287.4 14326.3 14357.2 14364.5 14372.6 13299.5 13356.0 13438.3 13556.3 13652.2 11613.4 11634.4 11641.8 11734.4 11763.6 3780.6 3805.1 3846.8 3851.1 3853.2 54262.7 54330.5 55704.0 55759.4 55982.0 10387.7 10401.9 10438.7 10458.8 10475.5 18230.5 18273.2 18285.9 18329.7 18345.8 7985.1 8011.6 8128.0 8140.5 8207.0 4663.1 4730.2 4743.0 4755.3 4772.6 3521.0 3592.8 3629.4 3630.7 3637.8 662.2 668.9 673.7 676.3 697.1 688.0 714.1 723.2 741.6 798.3 9308.2 9650.7 9655.9 9745.0 9746.6 672.8 691.5 700.7 710.0 711.8 4217.3 4339.3 4422.3 4464.1 4480.9 67555.7 69178.7 69187.0 69884.0 70528.6 58435.1 58483.7 58759.4 58834.0 60172.0 54613.7 55072.2 55198.0 55557.0 55673.0 8738.4 8856.6 8935.6 9059.1 9127.5 34258.5 34552.3 34843.8 35122.5 35755.8 44445.8 48682.0 48835.3 49093.5 49489.5 11058.6 11097.9 11255.8 11326.2 11344.1 11731.1 11885.7 11959.3 12225.3 12591.2 11405.7 11543.7 11603.7 11749.1 11934.1 11319.5 11459.5 11475.4 11649.4 11806.9 11067.3 11630.3 11904.3 12085.8 12207.3 10437.8 10538.5 10667.3 10693.9 10875.3 10370.4 10592.3 10643.8 10883.1 10927.9 14:03:59 INFO - PROCESS | 13722 | -------- Summary: end -------- 14:03:59 INFO - PROCESS | 13722 | 14:03:59 INFO - TEST-INFO | 13722: exit 0 14:03:59 INFO - TEST-OK | dromaeo_css | took 1109642ms 14:03:59 INFO - TEST-START | kraken 14:03:59 INFO - operating with platform_type : linux_ 14:03:59 INFO - Initialising browser for kraken test... 14:03:59 INFO - TEST-INFO | started process 13964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGqqpnb/profile http://localhost:51798/getInfo.html) 14:04:03 INFO - PROCESS | 13964 | 14:04:03 INFO - PROCESS | 13964 | (process:14039): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:04:04 INFO - PROCESS | 13964 | __metrics Screen width/height:1600/1200 14:04:04 INFO - PROCESS | 13964 | colorDepth:24 14:04:04 INFO - PROCESS | 13964 | Browser inner width/height: 1024/697 14:04:04 INFO - PROCESS | 13964 | __metrics 14:04:05 ERROR - PROCESS | 13964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:04:05 INFO - TEST-INFO | 13964: exit 0 14:04:05 INFO - Browser initialized. 14:04:05 INFO - Running cycle 1/1 for kraken test... 14:04:05 INFO - TEST-INFO | started process 14090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGqqpnb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:07 INFO - PROCESS | 14090 | 14:04:07 INFO - PROCESS | 14090 | (process:14161): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:04:17 INFO - PROCESS | 14090 | RSS: Main: 152506368 14:04:17 INFO - PROCESS | 14090 | 14:04:20 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51798/tests/kraken/driver.html?testName=audio-beat-detection) 14:04:21 INFO - PROCESS | 14090 | RSS: Main: 157081600 14:04:21 INFO - PROCESS | 14090 | 14:04:23 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51798/tests/kraken/driver.html?testName=audio-dft) 14:04:24 INFO - PROCESS | 14090 | RSS: Main: 157827072 14:04:24 INFO - PROCESS | 14090 | 14:04:27 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51798/tests/kraken/driver.html?testName=audio-fft) 14:04:27 INFO - PROCESS | 14090 | RSS: Main: 157683712 14:04:27 INFO - PROCESS | 14090 | 14:04:30 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51798/tests/kraken/driver.html?testName=audio-oscillator) 14:04:30 INFO - PROCESS | 14090 | RSS: Main: 157753344 14:04:30 INFO - PROCESS | 14090 | 14:04:32 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51798/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:04:33 INFO - PROCESS | 14090 | RSS: Main: 157986816 14:04:33 INFO - PROCESS | 14090 | 14:04:36 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51798/tests/kraken/driver.html?testName=imaging-darkroom) 14:04:37 INFO - PROCESS | 14090 | RSS: Main: 157642752 14:04:37 INFO - PROCESS | 14090 | 14:04:40 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51798/tests/kraken/driver.html?testName=imaging-desaturate) 14:04:41 INFO - PROCESS | 14090 | RSS: Main: 157876224 14:04:41 INFO - PROCESS | 14090 | 14:04:43 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51798/tests/kraken/driver.html?testName=json-parse-financial) 14:04:44 INFO - PROCESS | 14090 | RSS: Main: 157478912 14:04:44 INFO - PROCESS | 14090 | 14:04:46 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51798/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:04:46 INFO - PROCESS | 14090 | RSS: Main: 157298688 14:04:46 INFO - PROCESS | 14090 | 14:04:48 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:04:49 INFO - PROCESS | 14090 | RSS: Main: 157638656 14:04:49 INFO - PROCESS | 14090 | 14:04:51 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:04:51 INFO - PROCESS | 14090 | RSS: Main: 157671424 14:04:51 INFO - PROCESS | 14090 | 14:04:54 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:04:54 INFO - PROCESS | 14090 | RSS: Main: 158072832 14:04:54 INFO - PROCESS | 14090 | 14:04:57 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:04:58 INFO - PROCESS | 14090 | RSS: Main: 157962240 14:04:58 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51798/tests/kraken/driver.html?testName=ai-astar) 14:05:00 INFO - PROCESS | 14090 | RSS: Main: 159199232 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | __start_tp_report 14:05:00 INFO - PROCESS | 14090 | _x_x_mozilla_page_load 14:05:00 INFO - PROCESS | 14090 | _x_x_mozilla_page_load_details 14:05:00 INFO - PROCESS | 14090 | |i|pagename|runs| 14:05:00 INFO - PROCESS | 14090 | |0;ai-astar;112;107;112;112;113;123;110;110;111;112 14:05:00 INFO - PROCESS | 14090 | |1;audio-beat-detection;148;127;152;172;129;158;158;128;193;128 14:05:00 INFO - PROCESS | 14090 | |2;audio-dft;164;165;162;160;163;163;161;169;166;162 14:05:00 INFO - PROCESS | 14090 | |3;audio-fft;73;78;75;175;78;77;76;74;170;78 14:05:00 INFO - PROCESS | 14090 | |4;audio-oscillator;93;93;144;93;91;93;150;93;91;144 14:05:00 INFO - PROCESS | 14090 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;118;118;117 14:05:00 INFO - PROCESS | 14090 | |6;imaging-darkroom;146;147;150;146;147;146;147;146;146;146 14:05:00 INFO - PROCESS | 14090 | |7;imaging-desaturate;95;96;96;96;95;95;96;95;95;95 14:05:00 INFO - PROCESS | 14090 | |8;json-parse-financial;57;57;56;57;61;60;56;78;55;56 14:05:00 INFO - PROCESS | 14090 | |9;json-stringify-tinderbox;57;57;56;58;57;56;56;57;57;59 14:05:00 INFO - PROCESS | 14090 | |10;stanford-crypto-aes;73;74;73;74;75;76;83;75;75;75 14:05:00 INFO - PROCESS | 14090 | |11;stanford-crypto-ccm;117;119;118;124;116;137;119;120;149;123 14:05:00 INFO - PROCESS | 14090 | |12;stanford-crypto-pbkdf2;163;174;164;158;166;167;161;163;164;165 14:05:00 INFO - PROCESS | 14090 | |13;stanford-crypto-sha256-iterative;68;67;70;66;68;65;69;78;67;66 14:05:00 INFO - PROCESS | 14090 | __end_tp_report 14:05:00 INFO - PROCESS | 14090 | __start_cc_report 14:05:00 INFO - PROCESS | 14090 | _x_x_mozilla_cycle_collect,851 14:05:00 INFO - PROCESS | 14090 | __end_cc_report 14:05:00 INFO - PROCESS | 14090 | __startTimestamp1461704700271__endTimestamp 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | ------- Summary: start ------- 14:05:00 INFO - PROCESS | 14090 | Number of tests: 14 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.16 (3.7%) stddev-sans-first:4.41 14:05:00 INFO - PROCESS | 14090 | Values: 112.0 107.0 112.0 112.0 113.0 123.0 110.0 110.0 111.0 112.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:155.00 stddev:22.12 (14.3%) stddev-sans-first:23.45 14:05:00 INFO - PROCESS | 14090 | Values: 148.0 127.0 152.0 172.0 129.0 158.0 158.0 128.0 193.0 128.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.64 (1.6%) stddev-sans-first:2.79 14:05:00 INFO - PROCESS | 14090 | Values: 164.0 165.0 162.0 160.0 163.0 163.0 161.0 169.0 166.0 162.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.50 stddev:40.69 (53.2%) stddev-sans-first:42.34 14:05:00 INFO - PROCESS | 14090 | Values: 73.0 78.0 75.0 175.0 78.0 77.0 76.0 74.0 170.0 78.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.00 stddev:25.94 (27.9%) stddev-sans-first:26.90 14:05:00 INFO - PROCESS | 14090 | Values: 93.0 93.0 144.0 93.0 91.0 93.0 150.0 93.0 91.0 144.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:05:00 INFO - PROCESS | 14090 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:1.25 (0.9%) stddev-sans-first:1.30 14:05:00 INFO - PROCESS | 14090 | Values: 146.0 147.0 150.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:05:00 INFO - PROCESS | 14090 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:57.00 stddev:6.83 (12.0%) stddev-sans-first:7.20 14:05:00 INFO - PROCESS | 14090 | Values: 57.0 57.0 56.0 57.0 61.0 60.0 56.0 78.0 55.0 56.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.00 stddev:0.94 (1.7%) stddev-sans-first:1.00 14:05:00 INFO - PROCESS | 14090 | Values: 57.0 57.0 56.0 58.0 57.0 56.0 56.0 57.0 57.0 59.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:2.87 (3.8%) stddev-sans-first:2.92 14:05:00 INFO - PROCESS | 14090 | Values: 73.0 74.0 73.0 74.0 75.0 76.0 83.0 75.0 75.0 75.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:121.50 stddev:10.59 (8.7%) stddev-sans-first:10.91 14:05:00 INFO - PROCESS | 14090 | Values: 117.0 119.0 118.0 124.0 116.0 137.0 119.0 120.0 149.0 123.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:164.50 stddev:4.20 (2.6%) stddev-sans-first:4.42 14:05:00 INFO - PROCESS | 14090 | Values: 163.0 174.0 164.0 158.0 166.0 167.0 161.0 163.0 164.0 165.0 14:05:00 INFO - PROCESS | 14090 | 14:05:00 INFO - PROCESS | 14090 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:3.69 (5.4%) stddev-sans-first:3.91 14:05:00 INFO - PROCESS | 14090 | Values: 68.0 67.0 70.0 66.0 68.0 65.0 69.0 78.0 67.0 66.0 14:05:00 INFO - PROCESS | 14090 | -------- Summary: end -------- 14:05:00 INFO - PROCESS | 14090 | 14:05:01 INFO - TEST-INFO | 14090: exit 0 14:05:01 INFO - TEST-OK | kraken | took 61240ms 14:05:01 INFO - SUITE-END | took 1170s 14:05:01 INFO - Completed test suite (00:19:31) 14:05:01 INFO - javascript benchmark 14:05:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.0857759827245, 3296.703296703297, 3371.2414706690984, 3388.3053973935343, 3393.762436629434, 5656.406077361874, 5670.064439367505, 5686.687232202227, 5694.829155125342, 5717.571182161334, 5668.801591944282, 5700.543956483481, 5700.800471983482, 5706.201131841545, 5715.571332150095, 5135.666181698178, 5170.482951704837, 5196.974015129919, 5223.921641175385, 5261.473852614746, 4998.050370429607, 5110.744462776865, 5305.708186049766, 5307.893842123155, 5310.893782124374, 5186.2220666900075, 5208.765605547759, 5255.973720131394, 5258.50044245796, 5281.498257665516, 5192.506711862367, 5195.06488832012, 5214.60890433219, 5219.19102539107, 5253.711045892474, 4904.852854414374, 5062.873428164326, 5125.8718532037, 5186.092433824066, 5195.766190521435, 5537.169424586304, 5579.9163012554845, 5620.960122377373, 5637.633553818989, 5666.320041594994, 6039.667818269993, 6060.030395136801, 6075.726592303313, 6077.513798896122, 6087.634741915499, 5938.6436813791315, 6018.217631707894, 6122.938770612326, 6131.14164017038, 6150.0, 5670.688112153871, 5677.858053548653, 5679.574031947579, 5689.630174038715, 5720.256366672306, 6180.103884936659, 6180.969095154585, 6182.536309776785, 6199.070139479114, 6200.937990620036, 5769.0, 5898.852528686817, 5922.0, 5922.111683247461, 6004.159417681528, 6022.096685497123, 6061.909071363933, 6066.241719785027, 6067.180930574316, 6114.969425152845, 5962.25471816023, 5972.701364931736, 5981.222441082631, 6024.759009639653, 6068.150458935753, 5735.168400581976, 5997.1304160896425, 6044.546659000593, 6069.2110025696375, 6080.422359875804, 4621.722696638212, 4644.419447569054, 4655.092257009851, 4667.603253723403, 4690.695104818176, 4134.255833949857, 4139.4204811326435, 4161.126163505698, 4163.812628431728, 4181.414601955728, 5552.139418390156, 5686.57350698691, 5737.3688894221605, 5773.191753154478, 5777.682227477445, 5844.970775146182, 5877.853053673607, 5892.204552385459, 5893.263342082239, 5996.13056106862, 5723.942760572424, 5775.422457754275, 5782.826515204551, 5784.161296611967, 5785.913211301834, 5012.924806127911, 5203.9219411708855, 5259.973700131475, 5261.921071183935, 5266.526012658879, 6110.144579758838, 6113.510919126459, 6120.632762034292, 6132.4521822465285, 6133.671320645534, 6034.607750496204, 6045.455908968214, 6046.818595442144, 6053.061775424816, 6075.088736689355, 5920.555958303231, 6047.455728984412, 6094.177286066324, 6116.694165291628, 6191.380861913773, 5960.672163031075, 5970.134330521963, 5972.581919265784, 5973.074173503114, 5999.4900433463645, 6003.339632640319, 6030.7889223876955, 6049.425304596057, 6081.331053584014, 6087.969560152348, 5702.942970570407, 5823.301203855395, 5873.618214816194, 5880.323762767336, 5914.556408269311, 5892.057270836817, 5930.080837470199, 5932.199153114447, 5937.703114844154, 5944.346121926671, 5821.79623713168, 5836.387179346108, 5839.970800145972, 5841.620294680833, 5843.357230704704, 5700.600957932905, 5811.4479124483105, 5954.583179177416, 5962.284525856925, 6053.485453736482, 5779.653220806765, 5826.650400975955, 5833.649981001154, 5836.066229403275, 5837.620554663933], "value": 5574.339619652496, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.5534253693681, 657.615295052394, 672.2101530701425, 723.6851969393317, 732.8424388756416, 40546.797266013666, 41303.0, 41437.99999999996, 41607.79196104015, 41638.791806041, 45087.774561127146, 45776.313355299695, 45907.0, 46164.76917615416, 46297.768511157396, 8922.732318030454, 9117.0, 9143.679971201009, 9151.267898568098, 9154.267658587298, 9041.819163616723, 9225.815483690356, 9231.123043310909, 9234.168924796766, 9239.769005774842, 9225.308101892386, 9259.861102083474, 9273.953630231874, 9300.604909263631, 9305.581248843819, 9118.452892826419, 9232.6306947722, 9258.490783006966, 9288.489133097677, 9298.674546390912, 9001.954990225073, 9082.31882608807, 9153.313501487348, 9167.0, 9176.770580735469, 31498.842505787554, 40850.0, 41001.17997640031, 41208.1758364834, 41310.0, 3542.4509201073615, 3615.2950174715943, 3647.908802279938, 3697.8705745298785, 3805.5813860475328, 29971.25071873199, 31137.22156946072, 31190.22024449384, 31383.215419614466, 31779.682203177905, 4283.678724095706, 4357.281048626973, 4495.977520112411, 4504.076664283814, 4551.613112885409, 234585.0, 236019.0, 236192.0, 236555.0, 237885.0, 37321.440178397344, 59468.40531594715, 60257.0, 60323.09515357273, 60541.394586053575, 39258.214835703126, 39289.2142157161, 39305.80347098303, 39321.2135757289, 39443.60556394457, 14330.57008289732, 14356.712865742627, 14390.352434140488, 14449.494267700791, 14540.49108281205, 14167.929160354339, 14259.500917467838, 14288.785668214985, 14290.49983250602, 14330.426782928565, 9537.332386732862, 9585.329026968046, 9614.375065620712, 9675.951620241995, 9717.56270967808, 3625.6011838697723, 3645.1616128290643, 3666.6883314917995, 3694.556653201579, 3695.8891233263043, 1097.8737445193744, 1122.4836575175348, 1142.9142814288962, 1153.6250718516517, 1161.8298325045253, 34032.82983585116, 34057.65942340545, 34268.82865585656, 34297.31405371879, 35203.29593408117, 1223.7858374784378, 1228.263042174688, 1241.74544218435, 1287.0, 1380.061558140454, 18201.18094685716, 18205.0, 18235.361762338256, 18284.54288642768, 18451.538711532052, 352620.0, 357900.0, 360566.0, 360821.0, 518361.0, 58077.0, 59193.40806591965, 59642.70178649079, 59734.103988440205, 59941.0, 1452.469848505309, 1461.5176991592748, 1473.7052589482146, 1499.7600383938736, 1566.7023265579503, 33338.166545836546, 35085.47371789476, 35134.297314054085, 35155.64844351524, 35674.643253567134, 56405.71797140988, 56799.71600141973, 56805.431945680015, 57282.14076788768, 57600.13599795922, 469277.0, 477158.0, 477756.0, 478823.0, 479699.0, 31832.840835795672, 31991.0, 32164.356712865145, 32311.192220194684, 32317.192070198435, 52807.735961319944, 53497.46502534925, 53623.19565206447, 53845.0, 53984.19023714569, 39674.801625991684, 43618.78190609027, 44164.11671766482, 44540.331895022246, 44658.3301250475, 41351.58648413477, 41659.7917010413, 42217.78891105648, 42293.36559951542, 42547.57452425436, 43185.78407107944, 43552.56447435612, 44149.33775993427, 44909.326360105275, 45072.54927450815, 45834.539339075905, 46438.071238575714, 46859.53140468552, 46995.0, 47333.52666473291, 35055.47416788801, 35776.82111589425, 36195.276094477435, 36470.8176459116, 36575.817120914224], "value": 19748.62541713292, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.2627901172949, 421.3553263506832, 422.5943094629156, 423.8791944295874, 425.55316917236905, 18771.906140469295, 19247.807521924795, 19377.128029238684, 20099.196032158732, 20132.798672013276, 19579.412617621496, 20137.093830777612, 20192.19231230753, 20987.790122098813, 21123.0, 5835.620684655505, 5972.104184372335, 6022.96988515059, 6025.939740602604, 6029.758809647609, 4364.563543645641, 5936.257967754031, 5987.98204305267, 6204.069389591552, 6524.412802847743, 6428.614283143003, 6465.450436712885, 6481.0, 6489.1239682642945, 6506.772262970797, 6260.09228661846, 6422.197225346832, 6453.257875344349, 6503.219613646369, 6542.574732642363, 5579.442055794429, 5730.541556675456, 5737.168110623978, 5744.511716504102, 5761.452661997104, 21249.57500849974, 23179.3046208614, 24383.02467901282, 24526.0, 24596.877015614988, 2557.989594110316, 2585.870706464688, 2587.0815860369485, 2601.206631977246, 2664.920052398412, 15041.247937603077, 15054.924725376413, 15135.091894486366, 15277.465288714842, 15709.842901571066, 2057.681059435775, 2100.06547086545, 2135.1139277199945, 2143.0, 2162.1243396424475, 79869.0, 80478.59760701217, 80738.0, 82502.58748706218, 83294.16705832924, 10979.505922233519, 11222.214444988773, 11247.0, 11348.659540213806, 11591.652250432331, 15394.307256173499, 15439.073655580702, 15452.0, 15454.227288635524, 15474.303656335493, 8599.95700021496, 8698.782530436789, 8813.91186088131, 8824.338174636929, 8849.0, 8546.188112129337, 8574.314054875595, 8643.35174861888, 8654.307655387554, 8689.782755431039, 7050.365467107882, 7070.222275549685, 7153.89269160963, 7234.927650723531, 7299.41604671625, 2056.6606509925996, 2061.690746388024, 2069.182672844218, 2095.685647152939, 2142.539354038858, 997.8652881860855, 1083.8590983172294, 1099.5656715597295, 1138.3397629374942, 1211.5638370186725, 18859.90570047141, 20203.39389818308, 20205.0, 20214.191432342835, 20565.074571644313, 1044.2637940252105, 1085.6634443322596, 1097.7530055737554, 1127.0757978457586, 1131.338167172197, 11417.543298267976, 11447.198696091195, 11500.769984600262, 11508.827367589492, 11599.246049006788, 512159.0, 517702.0, 518206.0, 518614.0, 528174.0, 94199.0, 99100.50449747706, 101442.0, 101909.0, 105960.0, 1100.658795773313, 1120.3110087296254, 1150.1718762490993, 1174.8707642159357, 1175.1538891997748, 17987.10064496744, 18082.367117150836, 18266.81733182651, 18353.253917493083, 18456.723149152505, 40916.0, 41373.0, 42742.0, 42950.0, 43252.13495730131, 60509.39490605037, 61503.0, 62132.37867621266, 62164.0, 63151.6842415785, 8955.820883582423, 9411.85882211781, 9469.763255918382, 9513.33406661527, 9652.131308182297, 14325.928370358082, 14480.131192128507, 14620.122792632475, 14671.0, 14806.925965370536, 12232.510699571918, 12378.149623019584, 12433.316167610506, 12545.31000794965, 12877.613671589866, 11783.646490605295, 12029.0, 12130.75738485243, 12218.877811221773, 12293.692657683629, 12758.61724148277, 12806.807897881725, 12814.55149069778, 12925.482980680668, 13114.278714670785, 8961.596728147379, 9215.585298661443, 9244.768880778034, 9380.015098414568, 9423.670171543963, 9158.313126515404, 12086.637400877988, 12621.93689031549, 12627.368631568568, 12805.87194128084], "value": 10007.755183234734, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.4026009726156, 1557.478244787996, 1704.9573760655983, 1790.1407324484255, 1836.3572749537655, 7124.465665075127, 7704.92295077049, 7742.496737712059, 8060.395470339733, 8070.3140233080185, 7712.537247765138, 7718.343940765042, 7788.454808163431, 7795.766127016184, 7802.375809935205, 2269.8524595901213, 2284.543091381722, 2287.462446325112, 2307.3078076577044, 2307.5846347657416, 2164.39396968849, 2205.889705514726, 2246.84272100953, 2259.6158653029024, 2272.8068114210314, 2232.151782322715, 2234.6089434348924, 2256.5599708056934, 2265.1732117777055, 2290.7480177180496, 2196.890155492219, 2204.1183526589334, 2205.5699138667806, 2211.7456492503325, 2212.2920665387082, 2208.6355751301016, 2221.600111979843, 2222.866628002325, 2223.9332820015265, 2226.142934970032, 7901.762947111596, 7977.960110199469, 7995.720149794729, 8027.879581806277, 8027.879581806277, 4804.303376010494, 4981.302617633534, 5004.574611158056, 5011.674241174348, 5014.498550144956, 3137.4666306727913, 3168.904932852018, 3279.6392396836327, 3342.097633638904, 3345.0, 1084.159776173464, 1106.1924794899687, 1112.7663190729957, 1141.6232643227715, 1144.3820337018, 10296.124829389437, 10305.072543471124, 10330.380177189469, 10340.069393754524, 10344.689659310232, 4194.203101410722, 4269.444972153662, 4334.32817913224, 4340.739555626673, 4413.558644135561, 8957.059508751618, 8972.102789720975, 8977.506237157018, 8988.685396011238, 8992.955035224782, 4795.496472870368, 4910.140725373046, 4941.975290123526, 4948.529889660476, 4969.378827646544, 3992.7604343739467, 4436.068425630589, 4515.577593058242, 4571.977140114344, 4589.10512450069, 3718.2377612589353, 3772.1512659651908, 3798.639129282714, 3836.405357169643, 3838.1747924196434, 1180.8937195652431, 1206.4450352837619, 1216.3249396584981, 1226.4358395138336, 1230.132756406731, 937.2127412972999, 1065.073386154051, 1069.9786004280027, 1071.8820929697727, 1082.1883587309517, 5645.379008309083, 5647.943520564741, 5805.245318108618, 5930.614510056833, 6015.187949626832, 1000.9699709008742, 1007.9395236285847, 1024.7079582319004, 1036.8859425463193, 1052.6683048152663, 4278.4010238566625, 4324.740515569013, 4324.935125973113, 4333.566643335641, 4343.413639158736, 9460.24318054554, 9862.556184971694, 9927.2058235341, 9936.652217172365, 10071.395716257048, 9796.118349348593, 9837.163841073445, 9889.456079915673, 9897.851532227023, 10022.699319020441, 7547.320741133324, 7569.47013709035, 7716.151223365426, 7758.030246219223, 7772.300492955661, 5891.469767720926, 5952.851178720567, 5974.790882319098, 5978.671173085522, 6118.265808103056, 9026.503542305236, 9148.725538233864, 9273.258139348702, 9277.768055798659, 9278.211352035152, 9145.63417463294, 9147.725568232963, 9386.718398448058, 9476.336656433983, 9480.95259523698, 6459.515536334699, 6636.83407914806, 6810.387065164159, 6985.301469852974, 7157.141143062866, 7724.343430808444, 7741.496802707806, 7795.337396321376, 7810.297073263434, 7824.413169012233, 6931.618760967994, 6997.405220556309, 7069.045678833498, 7098.112735908012, 7249.420046396381, 7031.191412987572, 7039.084918960502, 7085.468589855678, 7089.149302083783, 7153.141623005273, 6489.805305840832, 6661.600303981777, 6711.899321510084, 6712.563683360566, 6768.898466523105, 5119.872003199801, 5223.764930578057, 5232.058229518723, 5317.335333083364, 5478.506934375925, 4928.334674818997, 5147.40804807452, 5167.095758242368, 5271.262023316815, 5274.393444753902], "value": 4413.63548649779, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.5159222312094, 342.7155460967397, 350.58105563851205, 351.1834983662984, 353.1630036812754, 5448.318960129984, 5564.666120032801, 5683.431656834319, 5689.5448364130825, 5770.3075630924295, 5564.1931919871695, 5584.664920104797, 5586.6368686035485, 5616.971915140429, 5644.588852786793, 4344.456942882148, 4355.537347808484, 4363.650907927374, 4384.473863136428, 4407.405000324947, 4116.0, 4350.586694264056, 4363.9999999999845, 4405.273129933557, 4420.160169567788, 4302.20409224293, 4309.978450107745, 4325.221460137174, 4327.956720432802, 4339.218940590692, 4313.978430107845, 4314.482262128549, 4328.285832837578, 4351.608355248011, 4361.4112094867105, 3721.6836568891677, 3744.8765370389046, 3775.3015692096774, 3793.867214647474, 3809.561900381464, 5345.5990800689715, 5365.436629153961, 5372.301600791872, 5379.569634429236, 5381.0, 4954.355933728628, 4961.156603377399, 4973.52751488608, 4974.7512624369, 5003.5997120230295, 5580.414056524047, 5883.205767221413, 5924.58527903047, 5952.523798096142, 5954.779270249588, 4176.227397931392, 4186.706930514865, 4193.853215137486, 4210.768407737573, 4222.915541689149, 6087.543434242405, 6115.942028985507, 6144.692765361759, 6150.753969841201, 6205.565610407273, 4153.127843152912, 4253.234417804763, 4258.339957306623, 4273.444452221192, 4285.61429471349, 4271.231178387858, 4304.375865499485, 4315.568443155722, 4318.093200427946, 4320.200762858881, 4881.877953051202, 4945.982950400253, 4962.106820772224, 4984.327115839315, 4999.500049994971, 5717.071132620727, 5922.733476993546, 5944.821655350346, 5962.2249107615735, 5970.6417614942375, 1544.698783737183, 1559.7816305717208, 1570.3640025789573, 1578.3742744972697, 1580.936762529509, 1027.5735569738474, 1033.0857191385528, 1035.471909326234, 1042.7497400623795, 1049.2130901823632, 6003.729832157564, 6012.849678757979, 6020.397960204032, 6033.909491357633, 6069.484093851984, 6456.903146452807, 6494.9675251624385, 6500.967495162494, 6558.475321974231, 6576.276609572943, 5872.823815285548, 6026.186464827279, 6032.577719559588, 6033.155358249848, 6061.605995610271, 3461.3077384523194, 3481.398556663963, 3489.842957066938, 3509.596396414394, 3511.2626348466597, 6358.841028974312, 6513.283538810727, 6559.081728558006, 6588.308227636125, 6591.736330546821, 6670.699818508082, 6673.632950187786, 6675.3324667533825, 6691.76578819739, 6710.959801230817, 6449.290937901366, 6506.739730410825, 6557.180352455943, 6574.671266436659, 6594.835129121714, 6469.385408386196, 6472.0, 6482.708278127401, 6486.870262594816, 6501.772437964649, 6283.7746639406705, 6301.243850737941, 6420.293767685457, 6447.4197322241225, 6461.870762584816, 6017.548683848641, 6203.906941395792, 6504.1869766279215, 6551.80344589663, 6593.0, 4159.0, 4180.352045432963, 4189.832406703819, 4238.88055972014, 4243.787810609519, 6159.23009623797, 6188.535859810622, 6216.197302782142, 6216.627002379872, 6224.657643829451, 5776.162456443876, 5947.732352044082, 5952.940470595238, 5979.4618484336615, 5999.940000599938, 5941.851453713692, 5957.0, 5961.314448838439, 5982.341942386247, 6016.157737916783, 5808.39011903744, 5914.521369657586, 5936.13925980739, 5936.703164841827, 5938.940610593839, 5946.910796337972, 6050.15297858309, 6051.848703782441, 6053.788117415869, 6071.848203794941, 5865.706714664165, 5887.911681324698, 5892.351841297368, 5907.0, 5912.674802885883], "value": 4579.825241593824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.2702978111232, 860.7245681381957, 880.2561835249214, 898.1961144775422, 922.5202894494867, 13820.792688109674, 14658.0, 14663.266836658164, 14707.26463676816, 14713.043652162602, 13439.462421503129, 13582.728345433085, 13648.181109133458, 13653.590392288248, 14618.853811461882, 885.7608445719684, 910.5356268303146, 917.3807679816131, 919.1176470588243, 921.3412410126791, 910.3263584947125, 912.4981260306838, 914.7530166854946, 921.5023887100957, 922.1009515722184, 957.1242313283337, 959.1271942532297, 959.4291396619035, 961.8028304197622, 963.109124060245, 950.3964982236295, 954.3224310739314, 954.3891909178132, 954.5465903695758, 954.9856752148688, 702.8559145375237, 703.3388614702163, 704.1936982155455, 704.5702121705756, 706.5619316024047, 14287.428502859873, 14326.283685815668, 14357.210353430557, 14364.497242596564, 14372.64068398288, 13299.468021279137, 13356.0, 13438.260895650736, 13556.254406007665, 13652.180869147884, 11613.361265130414, 11634.360110193937, 11641.76716465666, 11734.413279335999, 11763.588274410355, 3780.5652349979555, 3805.0677583991824, 3846.8461261549505, 3851.056491159684, 3853.190829925719, 54262.72868635671, 54330.45669543333, 55704.0, 55759.442405576236, 55982.0, 10387.68836934893, 10401.895981040245, 10438.68683939483, 10458.790824183474, 10475.47622618866, 18230.45308640743, 18273.17770700322, 18285.908570457064, 18329.7250541242, 18345.81654183441, 7985.121636619967, 8011.639476223584, 8127.959360203161, 8140.470869393471, 8207.0, 4663.114008338405, 4730.1958667026, 4743.0, 4755.334253204554, 4772.570468657837, 3520.978916114298, 3592.76647017943, 3629.383004889175, 3630.709543236535, 3637.7817330959697, 662.1689779326914, 668.9197296324472, 673.7305077968851, 676.2662511175331, 697.052009267396, 688.0, 714.0895358417955, 723.2405973727565, 741.5921243316262, 798.3373799746197, 9308.20880225175, 9650.71047868565, 9655.903440965641, 9744.951275243578, 9746.561404736804, 672.831792051987, 691.4587997543197, 700.7127077898037, 710.0024465625804, 711.8362776561316, 4217.283061879488, 4339.262325404688, 4422.314541246112, 4464.084862603158, 4480.879780054986, 67555.66222168956, 69178.65410673014, 69187.0, 69884.0, 70528.64735676392, 58435.123473147934, 58483.70758146182, 58759.412405875395, 58834.0, 60172.0, 54613.72693136509, 55072.17391739127, 55198.0, 55557.0, 55672.99999999919, 8738.432001919855, 8856.64573417056, 8935.553222338727, 9059.094090590888, 9127.543622818699, 34258.48612270868, 34552.30895382129, 34843.82578087093, 35122.47316290309, 35755.821220894766, 44445.77777111094, 48682.0, 48835.26747098725, 49093.50906491032, 49489.50510494993, 11058.612948546763, 11097.889021110008, 11255.785742340095, 11326.207165498336, 11344.149188810707, 11731.061515078944, 11885.702857428634, 11959.342236176746, 12225.327606981346, 12591.24452532851, 11405.657830265105, 11543.711407214887, 11603.709907252387, 11749.118816088656, 11934.104942129548, 11319.490622921823, 11459.48432320531, 11475.426228688366, 11649.359285239054, 11806.937375636235, 11067.335959842436, 11630.302181869114, 11904.285742855456, 12085.75828483443, 12207.328596927255, 10437.843432348369, 10538.473076346, 10667.253292269466, 10693.8930610696, 10875.347479151276, 10370.377777333384, 10592.258541901992, 10643.787124257626, 10883.12934965185, 10927.945360273148], "value": 6878.895484812063, "unit": "score"}], "name": "dromaeo_css", "value": 7314.9676856823335, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 112.0, 112.0, 113.0, 123.0, 110.0, 110.0, 111.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 127.0, 152.0, 172.0, 129.0, 158.0, 158.0, 128.0, 193.0, 128.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 160.0, 163.0, 163.0, 161.0, 169.0, 166.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 75.0, 175.0, 78.0, 77.0, 76.0, 74.0, 170.0, 78.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 144.0, 93.0, 91.0, 93.0, 150.0, 93.0, 91.0, 144.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 150.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 57.0, 61.0, 60.0, 56.0, 78.0, 55.0, 56.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 58.0, 57.0, 56.0, 56.0, 57.0, 57.0, 59.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 74.0, 75.0, 76.0, 83.0, 75.0, 75.0, 75.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 124.0, 116.0, 137.0, 119.0, 120.0, 149.0, 123.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 174.0, 164.0, 158.0, 166.0, 167.0, 161.0, 163.0, 164.0, 165.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 70.0, 66.0, 68.0, 65.0, 69.0, 78.0, 67.0, 66.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1537.0, "alertThreshold": 2.0}]} 14:05:01 INFO - Return code: 0 14:05:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:05:01 ERROR - # TBPL SUCCESS # 14:05:01 INFO - Running post-action listener: _resource_record_post_action 14:05:01 INFO - Running post-run listener: _resource_record_post_run 14:05:02 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 270336; Write bytes: 348905472; Read time: 32; Write time: 283296 14:05:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 104714240; Read time: 0; Write time: 84516 14:05:02 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 270336; Write bytes: 244191232; Read time: 32; Write time: 198780 14:05:02 INFO - Running post-run listener: _upload_blobber_files 14:05:02 INFO - Blob upload gear active. 14:05:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:05:02 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:05:02 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:05:02 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:05:03 INFO - (blobuploader) - INFO - Open directory for files ... 14:05:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:05:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:05:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:03 INFO - (blobuploader) - INFO - Done attempting. 14:05:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:05:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:05:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:04 INFO - (blobuploader) - INFO - Done attempting. 14:05:04 INFO - (blobuploader) - INFO - Iteration through files over. 14:05:04 INFO - Return code: 0 14:05:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:05:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:05:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd311ac58078dad492985c92aabecc11ff930ed80950559f84c8fa21f0ad33f42926d6b2602091fb23c8b706fb087df8cd76ac05b9eb7c1a98281a9d3dbc6a48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e025897e6048c037044622beed30aaae2f34bac4babbe3964af248bfce90f920b67cf2f7e048f2316d037fef78343eb22893a76da6ae255de6b221849b00dc19"} 14:05:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:05:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:05:04 INFO - Contents: 14:05:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd311ac58078dad492985c92aabecc11ff930ed80950559f84c8fa21f0ad33f42926d6b2602091fb23c8b706fb087df8cd76ac05b9eb7c1a98281a9d3dbc6a48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e025897e6048c037044622beed30aaae2f34bac4babbe3964af248bfce90f920b67cf2f7e048f2316d037fef78343eb22893a76da6ae255de6b221849b00dc19"} 14:05:04 INFO - Running post-run listener: copy_logs_to_upload_dir 14:05:04 INFO - Copying logs to upload dir... 14:05:04 INFO - mkdir: /builds/slave/test/build/upload/logs 14:05:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1517.017476 ========= master_lag: 30.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 47 secs) (at 2016-04-26 14:05:35.418473) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 14:05:35.422461) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd311ac58078dad492985c92aabecc11ff930ed80950559f84c8fa21f0ad33f42926d6b2602091fb23c8b706fb087df8cd76ac05b9eb7c1a98281a9d3dbc6a48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e025897e6048c037044622beed30aaae2f34bac4babbe3964af248bfce90f920b67cf2f7e048f2316d037fef78343eb22893a76da6ae255de6b221849b00dc19"} 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.011282 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd311ac58078dad492985c92aabecc11ff930ed80950559f84c8fa21f0ad33f42926d6b2602091fb23c8b706fb087df8cd76ac05b9eb7c1a98281a9d3dbc6a48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e025897e6048c037044622beed30aaae2f34bac4babbe3964af248bfce90f920b67cf2f7e048f2316d037fef78343eb22893a76da6ae255de6b221849b00dc19"}' ========= master_lag: 0.34 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 14:05:35.769322) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 14:05:35.769673) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1461703185.133830-1996617599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 14:05:35.789253) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 14:05:35.789593) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 14:05:35.790810) ========= ========= Total master_lag: 31.30 =========