builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1468844700.17 results: success (0) buildid: 20160718024654 builduid: 4fe111412e5d4b0399b6d1fa08301555 revision: 85112a93cf1ddde17cc60cb9edd2b6b90218fcaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:00.173159) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:00.173718) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:00.174037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:00.190571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:00.190965) ========= 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=db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 05:25:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 233M=0s 2016-07-18 05:25:00 (233 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159708 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:00.364978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:00.365389) ========= 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=db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015854 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:00.418042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 05:25:00.418840) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 85112a93cf1ddde17cc60cb9edd2b6b90218fcaf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 85112a93cf1ddde17cc60cb9edd2b6b90218fcaf --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=db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 05:25:00,647 truncating revision to first 12 chars 2016-07-18 05:25:00,648 Setting DEBUG logging. 2016-07-18 05:25:00,648 attempt 1/10 2016-07-18 05:25:00,648 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/85112a93cf1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 05:25:01,635 unpacking tar archive at: mozilla-beta-85112a93cf1d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.312645 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 05:25:01.745459) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:01.745826) ========= script_repo_revision: 85112a93cf1ddde17cc60cb9edd2b6b90218fcaf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:01.746361) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:01.746659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:25:01.757529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-18 05:25:01.757856) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:25:02 INFO - MultiFileLogger online at 20160718 05:25:02 in /builds/slave/test 05:25:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:25:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:02 INFO - {'append_to_log': False, 05:25:02 INFO - 'base_work_dir': '/builds/slave/test', 05:25:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:25:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:02 INFO - 'branch': 'Mozilla-Beta', 05:25:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:02 INFO - 'config_files': ('talos/linux_config.py',), 05:25:02 INFO - 'default_actions': ('clobber', 05:25:02 INFO - 'read-buildbot-config', 05:25:02 INFO - 'download-and-extract', 05:25:02 INFO - 'populate-webroot', 05:25:02 INFO - 'create-virtualenv', 05:25:02 INFO - 'install', 05:25:02 INFO - 'run-tests'), 05:25:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:02 INFO - 'download_minidump_stackwalk': True, 05:25:02 INFO - 'download_symbols': 'ondemand', 05:25:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:02 INFO - 'installer_path': 'installer.exe', 05:25:02 INFO - 'log_level': 'info', 05:25:02 INFO - 'log_name': 'talos', 05:25:02 INFO - 'log_to_console': True, 05:25:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:25:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:25:02 INFO - 'opt_config_files': (), 05:25:02 INFO - 'pip_index': False, 05:25:02 INFO - 'sps_profile': False, 05:25:02 INFO - 'sps_profile_interval': 0, 05:25:02 INFO - 'suite': 'dromaeojs', 05:25:02 INFO - 'system_bits': '32', 05:25:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:02 INFO - 'title': 'talos-linux64-ix-049', 05:25:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:02 INFO - 'use_talos_json': True, 05:25:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:02 INFO - 'work_dir': 'build'} 05:25:02 INFO - ##### 05:25:02 INFO - ##### Running clobber step. 05:25:02 INFO - ##### 05:25:02 INFO - Running pre-action listener: _resource_record_pre_action 05:25:02 INFO - Running main action method: clobber 05:25:02 INFO - rmtree: /builds/slave/test/build 05:25:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:02 INFO - Running post-action listener: _resource_record_post_action 05:25:02 INFO - ##### 05:25:02 INFO - ##### Running read-buildbot-config step. 05:25:02 INFO - ##### 05:25:02 INFO - Running pre-action listener: _resource_record_pre_action 05:25:02 INFO - Running main action method: read_buildbot_config 05:25:02 INFO - Using buildbot properties: 05:25:02 INFO - { 05:25:02 INFO - "project": "", 05:25:02 INFO - "product": "firefox", 05:25:02 INFO - "script_repo_revision": "production", 05:25:02 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:25:02 INFO - "repository": "", 05:25:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:25:02 INFO - "buildid": "20160718024654", 05:25:02 INFO - "pgo_build": "True", 05:25:02 INFO - "basedir": "/builds/slave/test", 05:25:02 INFO - "buildnumber": 107, 05:25:02 INFO - "slavename": "talos-linux64-ix-049", 05:25:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:25:02 INFO - "platform": "ubuntu64_hw", 05:25:02 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:25:02 INFO - "branch": "mozilla-beta", 05:25:02 INFO - "repo_path": "releases/mozilla-beta", 05:25:02 INFO - "revision": "85112a93cf1ddde17cc60cb9edd2b6b90218fcaf", 05:25:02 INFO - "stage_platform": "linux64-pgo", 05:25:02 INFO - "builduid": "4fe111412e5d4b0399b6d1fa08301555", 05:25:02 INFO - "slavebuilddir": "test" 05:25:02 INFO - } 05:25:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 05:25:02 INFO - Running post-action listener: _resource_record_post_action 05:25:02 INFO - ##### 05:25:02 INFO - ##### Running download-and-extract step. 05:25:02 INFO - ##### 05:25:02 INFO - Running pre-action listener: _resource_record_pre_action 05:25:02 INFO - Running main action method: download_and_extract 05:25:02 INFO - mkdir: /builds/slave/test/build/tests 05:25:02 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')]} 05:25:02 INFO - https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:25:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:25:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:25:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:25:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:25:03 INFO - Downloaded 1327 bytes. 05:25:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:25:03 INFO - Using the following test package requirements: 05:25:03 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:25:03 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:25:03 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:25:03 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:25:03 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 05:25:03 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:25:03 INFO - u'jsshell-linux-x86_64.zip'], 05:25:03 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:25:03 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:25:03 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:25:03 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:25:03 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 05:25:03 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:25:03 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 05:25:03 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:25:03 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:25:03 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:25:03 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:25:03 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:25: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')]} 05:25:03 INFO - https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:25:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:25:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:25:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:25:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:25:09 INFO - Downloaded 24200404 bytes. 05:25:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:25:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:25:10 INFO - Return code: 0 05:25:10 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:25: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')]} 05:25:10 INFO - https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:25:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:25:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:25:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:25:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:25:11 INFO - Downloaded 24200404 bytes. 05:25:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:25:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:25:12 INFO - Return code: 0 05:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:12 INFO - https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:25:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:25:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:25:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:25:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:25:13 INFO - Downloaded 10840145 bytes. 05:25:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:25:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:25:14 INFO - Return code: 0 05:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:14 INFO - https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:25:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:25:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:25:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:25:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:25:15 INFO - Downloaded 56041146 bytes. 05:25:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:25:15 INFO - mkdir: /builds/slave/test/properties 05:25:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:25:15 INFO - Writing to file /builds/slave/test/properties/build_url 05:25:15 INFO - Contents: 05:25:15 INFO - build_url:https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:25:16 INFO - Running post-action listener: _resource_record_post_action 05:25:16 INFO - Running post-action listener: set_extra_try_arguments 05:25:16 INFO - ##### 05:25:16 INFO - ##### Running populate-webroot step. 05:25:16 INFO - ##### 05:25:16 INFO - Running pre-action listener: _resource_record_pre_action 05:25:16 INFO - Running main action method: populate_webroot 05:25:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:25:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:25:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:25:16 INFO - '--tppagecycles', 05:25:16 INFO - '7'], 05:25:16 INFO - 'tests': ['tsvgm']}}, 05:25:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:25:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:25:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:25:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:25:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:25:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:25:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:16 INFO - 'talos_options': ['--disable-e10s'], 05:25:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:16 INFO - 'talos_options': ['--disable-e10s'], 05:25:16 INFO - 'tests': ['damp', 'tps']}, 05:25:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:16 INFO - 'tests': ['damp', 'tps']}, 05:25:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:25:16 INFO - 'tests': ['dromaeo_dom']}, 05:25:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:25:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:25:16 INFO - 'tests': ['a11yr', 05:25:16 INFO - 'ts_paint', 05:25:16 INFO - 'tpaint', 05:25:16 INFO - 'sessionrestore', 05:25:16 INFO - 'sessionrestore_no_auto_restore', 05:25:16 INFO - 'tabpaint']}, 05:25:16 INFO - 'other-e10s': {'tests': ['a11yr', 05:25:16 INFO - 'ts_paint', 05:25:16 INFO - 'tpaint', 05:25:16 INFO - 'sessionrestore', 05:25:16 INFO - 'sessionrestore_no_auto_restore', 05:25:16 INFO - 'tabpaint']}, 05:25:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:25:16 INFO - 'ts_paint', 05:25:16 INFO - 'tpaint', 05:25:16 INFO - 'sessionrestore', 05:25:16 INFO - 'sessionrestore_no_auto_restore', 05:25:16 INFO - 'tabpaint']}, 05:25:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:25:16 INFO - 'ts_paint', 05:25:16 INFO - 'tpaint', 05:25:16 INFO - 'sessionrestore', 05:25:16 INFO - 'sessionrestore_no_auto_restore', 05:25:16 INFO - 'tabpaint']}, 05:25:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:25:16 INFO - 'tests': ['a11yr', 05:25:16 INFO - 'ts_paint', 05:25:16 INFO - 'tpaint', 05:25:16 INFO - 'sessionrestore', 05:25:16 INFO - 'sessionrestore_no_auto_restore', 05:25:16 INFO - 'tabpaint']}, 05:25:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:25:16 INFO - 'tests': ['a11yr', 05:25:16 INFO - 'ts_paint', 05:25:16 INFO - 'tpaint', 05:25:16 INFO - 'sessionrestore', 05:25:16 INFO - 'sessionrestore_no_auto_restore', 05:25:16 INFO - 'tabpaint']}, 05:25:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:25:16 INFO - 'tests': ['tsvgx', 05:25:16 INFO - 'tsvgr_opacity', 05:25:16 INFO - 'tart', 05:25:16 INFO - 'tscrollx', 05:25:16 INFO - 'cart']}, 05:25:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:25:16 INFO - 'tsvgr_opacity', 05:25:16 INFO - 'tart', 05:25:16 INFO - 'tscrollx', 05:25:16 INFO - 'cart']}, 05:25:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:16 INFO - 'talos_options': ['--disable-e10s'], 05:25:16 INFO - 'tests': ['tp5o']}, 05:25:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:16 INFO - 'tests': ['tp5o']}, 05:25:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:16 INFO - 'talos_options': ['--disable-e10s', 05:25:16 INFO - '--xperf_path', 05:25:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:16 INFO - 'tests': ['tp5n']}, 05:25:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:16 INFO - 'talos_options': ['--xperf_path', 05:25:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:16 INFO - 'tests': ['tp5n']}}, 05:25:16 INFO - 'talos.zip': {'path': '', 05:25:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:25:16 INFO - Running post-action listener: _resource_record_post_action 05:25:16 INFO - ##### 05:25:16 INFO - ##### Running create-virtualenv step. 05:25:16 INFO - ##### 05:25:16 INFO - Running pre-action listener: _resource_record_pre_action 05:25:16 INFO - Running main action method: create_virtualenv 05:25:16 INFO - Creating virtualenv /builds/slave/test/build/venv 05:25:16 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 05:25:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:25:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:25:16 INFO - Using real prefix '/usr' 05:25:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:25:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:25:18 INFO - Installing pip.................done. 05:25:18 INFO - Return code: 0 05:25:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5eee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb410>, '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 0x12ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', '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 05:25:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:25:18 INFO - Using env: {'DISPLAY': ':0', 05:25:18 INFO - 'HOME': '/home/cltbld', 05:25:18 INFO - 'LANG': 'en_US.UTF-8', 05:25:18 INFO - 'LANGUAGE': 'en_US:en', 05:25:18 INFO - 'LOGNAME': 'cltbld', 05:25:18 INFO - 'MAIL': '/var/mail/cltbld', 05:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:18 INFO - 'MOZ_NO_REMOTE': '1', 05:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:18 INFO - 'NO_EM_RESTART': '1', 05:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:18 INFO - 'PWD': '/builds/slave/test', 05:25:18 INFO - 'SHELL': '/bin/bash', 05:25:18 INFO - 'SHLVL': '1', 05:25:18 INFO - 'TERM': 'linux', 05:25:18 INFO - 'TMOUT': '86400', 05:25:18 INFO - 'USER': 'cltbld', 05:25:18 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', 05:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:18 INFO - '_': '/tools/buildbot/bin/python'} 05:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:19 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 05:25:19 INFO - Cleaning up... 05:25:19 INFO - Return code: 0 05:25:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:25:19 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')]} 05:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:19 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')]} 05:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:19 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 0x7fee5eee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb410>, '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 0x12ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', '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 05:25:19 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 05:25:19 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 05:25:19 INFO - Using env: {'DISPLAY': ':0', 05:25:19 INFO - 'HOME': '/home/cltbld', 05:25:19 INFO - 'LANG': 'en_US.UTF-8', 05:25:19 INFO - 'LANGUAGE': 'en_US:en', 05:25:19 INFO - 'LOGNAME': 'cltbld', 05:25:19 INFO - 'MAIL': '/var/mail/cltbld', 05:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:19 INFO - 'MOZ_NO_REMOTE': '1', 05:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:19 INFO - 'NO_EM_RESTART': '1', 05:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:19 INFO - 'PWD': '/builds/slave/test', 05:25:19 INFO - 'SHELL': '/bin/bash', 05:25:19 INFO - 'SHLVL': '1', 05:25:19 INFO - 'TERM': 'linux', 05:25:19 INFO - 'TMOUT': '86400', 05:25:19 INFO - 'USER': 'cltbld', 05:25:19 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', 05:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:19 INFO - '_': '/tools/buildbot/bin/python'} 05:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:19 INFO - Downloading/unpacking psutil>=0.7.1 05:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:25:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:21 INFO - Installing collected packages: psutil 05:25:21 INFO - Running setup.py install for psutil 05:25:21 INFO - building 'psutil._psutil_linux' extension 05:25:21 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 05:25:21 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 05:25:21 INFO - building 'psutil._psutil_posix' extension 05:25:21 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 05:25:21 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 05:25:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:21 INFO - Successfully installed psutil 05:25:21 INFO - Cleaning up... 05:25:21 INFO - Return code: 0 05:25:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fee5eee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb410>, '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 0x12ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', '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 05:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:25:21 INFO - Using env: {'DISPLAY': ':0', 05:25:21 INFO - 'HOME': '/home/cltbld', 05:25:21 INFO - 'LANG': 'en_US.UTF-8', 05:25:21 INFO - 'LANGUAGE': 'en_US:en', 05:25:21 INFO - 'LOGNAME': 'cltbld', 05:25:21 INFO - 'MAIL': '/var/mail/cltbld', 05:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:21 INFO - 'MOZ_NO_REMOTE': '1', 05:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:21 INFO - 'NO_EM_RESTART': '1', 05:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:21 INFO - 'PWD': '/builds/slave/test', 05:25:21 INFO - 'SHELL': '/bin/bash', 05:25:21 INFO - 'SHLVL': '1', 05:25:21 INFO - 'TERM': 'linux', 05:25:21 INFO - 'TMOUT': '86400', 05:25:21 INFO - 'USER': 'cltbld', 05:25:21 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', 05:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:21 INFO - '_': '/tools/buildbot/bin/python'} 05:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:25:24 INFO - Installing collected packages: mozsystemmonitor 05:25:24 INFO - Running setup.py install for mozsystemmonitor 05:25:24 INFO - Successfully installed mozsystemmonitor 05:25:24 INFO - Cleaning up... 05:25:24 INFO - Return code: 0 05:25:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fee5eee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb410>, '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 0x12ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', '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 05:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:25:24 INFO - Using env: {'DISPLAY': ':0', 05:25:24 INFO - 'HOME': '/home/cltbld', 05:25:24 INFO - 'LANG': 'en_US.UTF-8', 05:25:24 INFO - 'LANGUAGE': 'en_US:en', 05:25:24 INFO - 'LOGNAME': 'cltbld', 05:25:24 INFO - 'MAIL': '/var/mail/cltbld', 05:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:24 INFO - 'MOZ_NO_REMOTE': '1', 05:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:24 INFO - 'NO_EM_RESTART': '1', 05:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:24 INFO - 'PWD': '/builds/slave/test', 05:25:24 INFO - 'SHELL': '/bin/bash', 05:25:24 INFO - 'SHLVL': '1', 05:25:24 INFO - 'TERM': 'linux', 05:25:24 INFO - 'TMOUT': '86400', 05:25:24 INFO - 'USER': 'cltbld', 05:25:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', 05:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:24 INFO - '_': '/tools/buildbot/bin/python'} 05:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:26 INFO - Downloading blobuploader-1.2.4.tar.gz 05:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:25:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:25:26 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 05:25:26 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 05:25:26 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 05:25:26 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 05:25:26 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 05:25:26 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 05:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:25:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:25:26 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 05:25:26 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 05:25:26 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 05:25:26 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 05:25:26 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 05:25:26 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 05:25:26 INFO - Downloading docopt-0.6.1.tar.gz 05:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:25:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:25:27 INFO - Running setup.py install for blobuploader 05:25:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:25:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:25:27 INFO - Running setup.py install for requests 05:25:27 INFO - Running setup.py install for docopt 05:25:27 INFO - Successfully installed blobuploader requests docopt 05:25:27 INFO - Cleaning up... 05:25:27 INFO - Return code: 0 05:25:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:27 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')]} 05:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:27 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')]} 05:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:27 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 0x7fee5eee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb410>, '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 0x12ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', '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 05:25:27 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 05:25:27 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 05:25:27 INFO - Using env: {'DISPLAY': ':0', 05:25:27 INFO - 'HOME': '/home/cltbld', 05:25:27 INFO - 'LANG': 'en_US.UTF-8', 05:25:27 INFO - 'LANGUAGE': 'en_US:en', 05:25:27 INFO - 'LOGNAME': 'cltbld', 05:25:27 INFO - 'MAIL': '/var/mail/cltbld', 05:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:27 INFO - 'MOZ_NO_REMOTE': '1', 05:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:27 INFO - 'NO_EM_RESTART': '1', 05:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:27 INFO - 'PWD': '/builds/slave/test', 05:25:27 INFO - 'SHELL': '/bin/bash', 05:25:27 INFO - 'SHLVL': '1', 05:25:27 INFO - 'TERM': 'linux', 05:25:27 INFO - 'TMOUT': '86400', 05:25:27 INFO - 'USER': 'cltbld', 05:25:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', 05:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:27 INFO - '_': '/tools/buildbot/bin/python'} 05:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:27 INFO - Running setup.py (path:/tmp/pip-m_5kvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:27 INFO - Running setup.py (path:/tmp/pip-iq9DI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:28 INFO - Running setup.py (path:/tmp/pip-stSsB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:28 INFO - Running setup.py (path:/tmp/pip-5ZH8g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:28 INFO - Running setup.py (path:/tmp/pip-vdyfT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:28 INFO - Running setup.py (path:/tmp/pip-WXQbng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:28 INFO - Running setup.py (path:/tmp/pip-JYBKcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:28 INFO - Running setup.py (path:/tmp/pip-geiy9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:28 INFO - Running setup.py (path:/tmp/pip-BrviDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:28 INFO - Running setup.py (path:/tmp/pip-M9H8cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:28 INFO - Running setup.py (path:/tmp/pip-ZrQm3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:28 INFO - Running setup.py (path:/tmp/pip-g818Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:28 INFO - Running setup.py (path:/tmp/pip-f_Qriu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:28 INFO - Running setup.py (path:/tmp/pip-dJBfO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:28 INFO - Running setup.py (path:/tmp/pip-07aYvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:28 INFO - Running setup.py (path:/tmp/pip-hSzMGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:28 INFO - Running setup.py (path:/tmp/pip-91VwrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:25:29 INFO - Running setup.py install for manifestparser 05:25:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:25:29 INFO - Running setup.py install for mozcrash 05:25:29 INFO - Running setup.py install for mozdebug 05:25:29 INFO - Running setup.py install for mozdevice 05:25:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:25:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:25:29 INFO - Running setup.py install for mozfile 05:25:29 INFO - Running setup.py install for mozhttpd 05:25:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:25:29 INFO - Running setup.py install for mozinfo 05:25:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:25:29 INFO - Running setup.py install for mozInstall 05:25:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:25:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:25:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:25:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:25:29 INFO - Running setup.py install for mozleak 05:25:29 INFO - Running setup.py install for mozlog 05:25:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:25:30 INFO - Running setup.py install for moznetwork 05:25:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:25:30 INFO - Running setup.py install for mozprocess 05:25:30 INFO - Running setup.py install for mozprofile 05:25:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:25:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:25:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:25:30 INFO - Running setup.py install for mozrunner 05:25:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:25:30 INFO - Running setup.py install for mozscreenshot 05:25:30 INFO - Running setup.py install for moztest 05:25:30 INFO - Running setup.py install for mozversion 05:25:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:25:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:25:30 INFO - Cleaning up... 05:25:30 INFO - Return code: 0 05:25:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:30 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')]} 05:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:30 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')]} 05:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:30 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 0x7fee5eee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb410>, '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 0x12ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', '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 05:25:30 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 05:25:30 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 05:25:30 INFO - Using env: {'DISPLAY': ':0', 05:25:30 INFO - 'HOME': '/home/cltbld', 05:25:30 INFO - 'LANG': 'en_US.UTF-8', 05:25:30 INFO - 'LANGUAGE': 'en_US:en', 05:25:30 INFO - 'LOGNAME': 'cltbld', 05:25:30 INFO - 'MAIL': '/var/mail/cltbld', 05:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:30 INFO - 'MOZ_NO_REMOTE': '1', 05:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:30 INFO - 'NO_EM_RESTART': '1', 05:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:30 INFO - 'PWD': '/builds/slave/test', 05:25:30 INFO - 'SHELL': '/bin/bash', 05:25:30 INFO - 'SHLVL': '1', 05:25:30 INFO - 'TERM': 'linux', 05:25:30 INFO - 'TMOUT': '86400', 05:25:30 INFO - 'USER': 'cltbld', 05:25:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', 05:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:30 INFO - '_': '/tools/buildbot/bin/python'} 05:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:31 INFO - Running setup.py (path:/tmp/pip-PRRMLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:31 INFO - Running setup.py (path:/tmp/pip-CtmzDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:31 INFO - Running setup.py (path:/tmp/pip-mmX_Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:31 INFO - Running setup.py (path:/tmp/pip-YAGIAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:31 INFO - Running setup.py (path:/tmp/pip-AroxDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:31 INFO - Running setup.py (path:/tmp/pip-DI1S9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:31 INFO - Running setup.py (path:/tmp/pip-3zOWmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:31 INFO - Running setup.py (path:/tmp/pip-Qi8oq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:31 INFO - Running setup.py (path:/tmp/pip-DDj0uH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:31 INFO - Running setup.py (path:/tmp/pip-V_qtVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:31 INFO - Running setup.py (path:/tmp/pip-b2c6sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:31 INFO - Running setup.py (path:/tmp/pip-zzVHsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:31 INFO - Running setup.py (path:/tmp/pip-9TMhNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:32 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)) 05:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:32 INFO - Running setup.py (path:/tmp/pip-rX5qCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:32 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)) 05:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:32 INFO - Running setup.py (path:/tmp/pip-94yCHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:32 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)) 05:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:32 INFO - Running setup.py (path:/tmp/pip-IUJ0hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:32 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)) 05:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:32 INFO - Running setup.py (path:/tmp/pip-P3OXCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:32 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)) 05:25:32 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)) 05:25:32 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)) 05:25:32 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)) 05:25:32 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)) 05:25:32 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)) 05:25:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:25:32 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 05:25:32 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 05:25:32 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 05:25:32 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 05:25:32 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 05:25:32 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 05:25:34 INFO - Downloading blessings-1.6.tar.gz 05:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:25:34 INFO - Installing collected packages: blessings 05:25:34 INFO - Running setup.py install for blessings 05:25:34 INFO - Successfully installed blessings 05:25:34 INFO - Cleaning up... 05:25:34 INFO - Return code: 0 05:25:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:25:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:34 INFO - Reading from file tmpfile_stdout 05:25:34 INFO - Current package versions: 05:25:34 INFO - argparse == 1.2.1 05:25:34 INFO - blessings == 1.6 05:25:34 INFO - blobuploader == 1.2.4 05:25:34 INFO - docopt == 0.6.1 05:25:34 INFO - manifestparser == 1.1 05:25:34 INFO - mozInstall == 1.12 05:25:34 INFO - mozcrash == 0.17 05:25:34 INFO - mozdebug == 0.1 05:25:34 INFO - mozdevice == 0.48 05:25:34 INFO - mozfile == 1.2 05:25:34 INFO - mozhttpd == 0.7 05:25:34 INFO - mozinfo == 0.9 05:25:34 INFO - mozleak == 0.1 05:25:34 INFO - mozlog == 3.1 05:25:34 INFO - moznetwork == 0.27 05:25:34 INFO - mozprocess == 0.22 05:25:34 INFO - mozprofile == 0.28 05:25:34 INFO - mozrunner == 6.11 05:25:34 INFO - mozscreenshot == 0.1 05:25:34 INFO - mozsystemmonitor == 0.0 05:25:34 INFO - moztest == 0.7 05:25:34 INFO - mozversion == 1.4 05:25:34 INFO - psutil == 3.1.1 05:25:34 INFO - requests == 1.2.3 05:25:34 INFO - wsgiref == 0.1.2 05:25:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:34 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')]} 05:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:34 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')]} 05:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:34 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 0x7fee5eee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb410>, '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 0x12ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', '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 05:25:34 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 05:25:34 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 05:25:34 INFO - Using env: {'DISPLAY': ':0', 05:25:34 INFO - 'HOME': '/home/cltbld', 05:25:34 INFO - 'LANG': 'en_US.UTF-8', 05:25:34 INFO - 'LANGUAGE': 'en_US:en', 05:25:34 INFO - 'LOGNAME': 'cltbld', 05:25:34 INFO - 'MAIL': '/var/mail/cltbld', 05:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:34 INFO - 'MOZ_NO_REMOTE': '1', 05:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:34 INFO - 'NO_EM_RESTART': '1', 05:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:34 INFO - 'PWD': '/builds/slave/test', 05:25:34 INFO - 'SHELL': '/bin/bash', 05:25:34 INFO - 'SHLVL': '1', 05:25:34 INFO - 'TERM': 'linux', 05:25:34 INFO - 'TMOUT': '86400', 05:25:34 INFO - 'USER': 'cltbld', 05:25:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', 05:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:34 INFO - '_': '/tools/buildbot/bin/python'} 05:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 INFO - Cleaning up... 05:25:34 INFO - Return code: 0 05:25:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:25:34 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')]} 05:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:34 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')]} 05:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:34 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 0x7fee5eee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb410>, '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 0x12ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', '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 05:25:34 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 05:25:34 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 05:25:34 INFO - Using env: {'DISPLAY': ':0', 05:25:34 INFO - 'HOME': '/home/cltbld', 05:25:34 INFO - 'LANG': 'en_US.UTF-8', 05:25:34 INFO - 'LANGUAGE': 'en_US:en', 05:25:34 INFO - 'LOGNAME': 'cltbld', 05:25:34 INFO - 'MAIL': '/var/mail/cltbld', 05:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:34 INFO - 'MOZ_NO_REMOTE': '1', 05:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:34 INFO - 'NO_EM_RESTART': '1', 05:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:34 INFO - 'PWD': '/builds/slave/test', 05:25:34 INFO - 'SHELL': '/bin/bash', 05:25:34 INFO - 'SHLVL': '1', 05:25:34 INFO - 'TERM': 'linux', 05:25:34 INFO - 'TMOUT': '86400', 05:25:34 INFO - 'USER': 'cltbld', 05:25:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', 05:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:34 INFO - '_': '/tools/buildbot/bin/python'} 05:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:35 INFO - Downloading/unpacking jsonschema 05:25:35 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 05:25:35 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 05:25:35 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 05:25:35 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 05:25:35 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 05:25:35 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 05:25:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:25:37 INFO - Downloading/unpacking functools32 (from jsonschema) 05:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:25:37 INFO - warning: no files found matching '*.txt' 05:25:37 INFO - no previously-included directories found matching 'build' 05:25:37 INFO - no previously-included directories found matching 'dist' 05:25:37 INFO - no previously-included directories found matching '.git*' 05:25:37 INFO - Installing collected packages: jsonschema, functools32 05:25:37 INFO - Running setup.py install for functools32 05:25:37 INFO - warning: no files found matching '*.txt' 05:25:37 INFO - no previously-included directories found matching 'build' 05:25:37 INFO - no previously-included directories found matching 'dist' 05:25:37 INFO - no previously-included directories found matching '.git*' 05:25:37 INFO - Successfully installed jsonschema functools32 05:25:37 INFO - Cleaning up... 05:25:37 INFO - Return code: 0 05:25:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5eee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb410>, '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 0x12ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', '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 05:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:25:37 INFO - Using env: {'DISPLAY': ':0', 05:25:37 INFO - 'HOME': '/home/cltbld', 05:25:37 INFO - 'LANG': 'en_US.UTF-8', 05:25:37 INFO - 'LANGUAGE': 'en_US:en', 05:25:37 INFO - 'LOGNAME': 'cltbld', 05:25:37 INFO - 'MAIL': '/var/mail/cltbld', 05:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:37 INFO - 'MOZ_NO_REMOTE': '1', 05:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:37 INFO - 'NO_EM_RESTART': '1', 05:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:37 INFO - 'PWD': '/builds/slave/test', 05:25:37 INFO - 'SHELL': '/bin/bash', 05:25:37 INFO - 'SHLVL': '1', 05:25:37 INFO - 'TERM': 'linux', 05:25:37 INFO - 'TMOUT': '86400', 05:25:37 INFO - 'USER': 'cltbld', 05:25:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', 05:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:37 INFO - '_': '/tools/buildbot/bin/python'} 05:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:37 INFO - Downloading/unpacking flake8 05:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:25:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:25:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:25:41 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 05:25:41 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 05:25:41 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 05:25:41 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 05:25:41 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 05:25:41 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 05:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:25:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:25:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:25:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:25:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:25:41 INFO - no previously-included directories found matching 'docs/_build' 05:25:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:25:41 INFO - Running setup.py install for pep8 05:25:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:25:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:25:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:25:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:25:41 INFO - no previously-included directories found matching 'docs/_build' 05:25:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:25:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:25:41 INFO - Cleaning up... 05:25:41 INFO - Return code: 0 05:25:41 INFO - Running post-action listener: _resource_record_post_action 05:25:41 INFO - Running post-action listener: _start_resource_monitoring 05:25:41 INFO - Starting resource monitoring. 05:25:41 INFO - ##### 05:25:41 INFO - ##### Running install step. 05:25:41 INFO - ##### 05:25:41 INFO - Running pre-action listener: _resource_record_pre_action 05:25:41 INFO - Running main action method: install 05:25:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:41 INFO - Reading from file tmpfile_stdout 05:25:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:25:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:25:41 INFO - Reading from file tmpfile_stdout 05:25:41 INFO - Output received: 05:25:41 INFO - Usage: mozinstall [options] installer 05:25:41 INFO - Options: 05:25:41 INFO - -h, --help show this help message and exit 05:25:41 INFO - -d DEST, --destination=DEST 05:25:41 INFO - Directory to install application into. [default: 05:25:41 INFO - "/builds/slave/test"] 05:25:41 INFO - --app=APP Application being installed. [default: firefox] 05:25:41 INFO - mkdir: /builds/slave/test/build/application 05:25:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:25:55 INFO - Reading from file tmpfile_stdout 05:25:55 INFO - Output received: 05:25:55 INFO - /builds/slave/test/build/application/firefox/firefox 05:25:55 INFO - Running post-action listener: _resource_record_post_action 05:25:55 INFO - ##### 05:25:55 INFO - ##### Running run-tests step. 05:25:55 INFO - ##### 05:25:55 INFO - Running pre-action listener: _resource_record_pre_action 05:25:55 INFO - Running main action method: run_tests 05:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:25:55 INFO - Python 2.7.3 05:25:55 INFO - Return code: 0 05:25:55 INFO - grabbing minidump binary from tooltool 05:25:55 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')]} 05:25:55 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 0x12eb410>, '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 0x12ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:25:55 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 05:25:55 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 05:25:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:25:55 INFO - Return code: 0 05:25:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:25:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:25:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:25:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:25:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:25:56 INFO - Return code: 0 05:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:25:56 INFO - Using env: {'DISPLAY': ':0', 05:25:56 INFO - 'HOME': '/home/cltbld', 05:25:56 INFO - 'LANG': 'en_US.UTF-8', 05:25:56 INFO - 'LANGUAGE': 'en_US:en', 05:25:56 INFO - 'LOGNAME': 'cltbld', 05:25:56 INFO - 'MAIL': '/var/mail/cltbld', 05:25:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:25:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:56 INFO - 'MOZ_NO_REMOTE': '1', 05:25:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:56 INFO - 'NO_EM_RESTART': '1', 05:25:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:56 INFO - 'PWD': '/builds/slave/test', 05:25:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:25:56 INFO - 'SHELL': '/bin/bash', 05:25:56 INFO - 'SHLVL': '1', 05:25:56 INFO - 'TERM': 'linux', 05:25:56 INFO - 'TMOUT': '86400', 05:25:56 INFO - 'USER': 'cltbld', 05:25:56 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518', 05:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:56 INFO - '_': '/tools/buildbot/bin/python'} 05:25:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:25:56 INFO - mozversion application_buildid: 20160718024654 05:25:56 INFO - mozversion application_changeset: 85112a93cf1ddde17cc60cb9edd2b6b90218fcaf 05:25:56 INFO - mozversion application_display_name: Firefox 05:25:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:25:56 INFO - mozversion application_name: Firefox 05:25:56 INFO - mozversion application_remotingname: firefox 05:25:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:25:56 INFO - mozversion application_vendor: Mozilla 05:25:56 INFO - mozversion application_version: 48.0 05:25:56 INFO - mozversion platform_buildid: 20160718024654 05:25:56 INFO - mozversion platform_changeset: 85112a93cf1ddde17cc60cb9edd2b6b90218fcaf 05:25:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:25:56 INFO - mozversion platform_version: 48.0 05:25:56 INFO - using testdate: 1468844756 05:25:56 INFO - actual date: 1468844756 05:25:56 INFO - starting webserver on 'localhost:34444' 05:25:56 INFO - SUITE-START | Running 2 tests 05:25:56 INFO - TEST-START | dromaeo_css 05:25:56 INFO - operating with platform_type : linux_ 05:25:56 INFO - Initialising browser for dromaeo_css test... 05:25:56 INFO - TEST-INFO | started process 30777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIugBCB/profile http://localhost:34444/getInfo.html) 05:26:00 INFO - PROCESS | 30777 | __metrics Screen width/height:1600/1200 05:26:00 INFO - PROCESS | 30777 | colorDepth:24 05:26:00 INFO - PROCESS | 30777 | Browser inner width/height: 1024/697 05:26:00 INFO - PROCESS | 30777 | __metrics 05:26:01 INFO - PROCESS | 30777 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:26:01 ERROR - PROCESS | 30777 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:26:02 INFO - TEST-INFO | 30777: exit 0 05:26:02 INFO - Browser initialized. 05:26:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:02 INFO - TEST-INFO | started process 30865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIugBCB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:13 INFO - PROCESS | 30865 | RSS: Main: 139427840 05:26:13 INFO - PROCESS | 30865 | 05:27:04 INFO - PROCESS | 30865 | 1468844824860 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] 05:29:12 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34444/tests/dromaeo/cssquery-ext.html) 05:29:13 INFO - PROCESS | 30865 | RSS: Main: 242745344 05:29:13 INFO - PROCESS | 30865 | 05:32:15 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-ext.html (next: http://localhost:34444/tests/dromaeo/cssquery-jquery.html) 05:32:16 INFO - PROCESS | 30865 | RSS: Main: 215654400 05:32:16 INFO - PROCESS | 30865 | 05:35:17 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34444/tests/dromaeo/cssquery-mootools.html) 05:35:18 INFO - PROCESS | 30865 | RSS: Main: 215801856 05:35:18 INFO - PROCESS | 30865 | 05:38:20 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34444/tests/dromaeo/cssquery-prototype.html) 05:38:20 INFO - PROCESS | 30865 | RSS: Main: 217907200 05:38:20 INFO - PROCESS | 30865 | 05:41:23 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34444/tests/dromaeo/cssquery-yui.html) 05:41:23 INFO - PROCESS | 30865 | RSS: Main: 210325504 05:41:23 INFO - PROCESS | 30865 | 05:44:26 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-yui.html (next: http://localhost:34444/tests/dromaeo/cssquery-dojo.html) 05:44:26 INFO - PROCESS | 30865 | RSS: Main: 254738432 05:44:26 INFO - PROCESS | 30865 | 05:44:26 INFO - PROCESS | 30865 | __start_tp_report 05:44:26 INFO - PROCESS | 30865 | _x_x_mozilla_page_load 05:44:26 INFO - PROCESS | 30865 | _x_x_mozilla_page_load_details 05:44:26 INFO - PROCESS | 30865 | |i|pagename|runs| 05:44:26 INFO - PROCESS | 30865 | |0;dojo.html;3267.852946617402;3311.1556553078976;3317.386283537545;3350.229447227136;3364.8990530284086;5335.466453354663;5351.598630102739;5353.0899747042995;5359.946400535993;5360.115580929152;5353.330833645794;5373.543248823855;5378.489043540867;5381.623286369956;5385.057614917384;4822.22844344904;4852.611791056707;4853.490383509734;4913.901721965559;4979.751012449381;4913.31213630092;5001.299818025461;5003.974980125113;5005.624578156653;5006.399232092154;4877.902441951159;4928.088303663816;4959.900801983977;4962.280469331945;4994.875128121808;4986.152354099811;5012.348394708701;5012.649114561964;5020.046191223656;5027.698338099707;4792.904141917142;4819.855404337875;4858.708477491362;4923.75381230937;4959.528844759742;5214.7914083437;5225.660332078441;5238.92141617876;5245.868853278698;5266.7629956652045;5785.132230165509;5807.535397168259;5815.389384114649;5817.476427121579;5818.767249310023;5755.625884317506;5829.329627092854;5841.9776539105915;5872.853178670524;5882.705864706791;5377.5429088527135;5402.702851343214;5409.756560954766;5419.051665958442;5420.972895135538;5820.447057529528;5906.291245050621;5908.763649453974;5919.378465261172;5920.8815823684145;5676.148577713294;5721.5708821838525;5742.253507044141;5758.827235182951;5775.220345253337;5713.857153571111;5733.856653583611;5737.340205876294;5747.712614369265;5751.511121554631;5662.858428539237;5721.485066344049;5724.313082430135;5731.226284451629;5744.684042377626;5751.6549007058875;5751.827445176651;5760.193572899798;5764.452377024176;5787.2187254720075;4440.533743956838;4450.599446049871;4452.4211852458975;4452.977735111303;4480.551944805558;3922.6077392260545;3950.4074388841905;3959.8020098994934;3990.0423898264207;4011.0774521859553;5521.558275337963;5532.336119665666;5542.944570554243;5546.500814926676;5574.275344205227;5775.768969241268;5791.971040144772;5792.768289268382;5797.536197104221;5803.042497987784;5368.624196306221;5527.53015993645;5527.695976721319;5536.058869992111;5581.7209139543675;5021.598272138293;5045.924311135336;5048.1418158913075;5051.621128415383;5077.466865979093;6046.637201767908;6063.696815159225;6076.3316035236085;6107.908381374283;6110;5608.85977850557;5746.051901436216;5756.251687280626;5796.536277097906;5819.679917604572;6041.365656605993;6073.787417440369;6090.573659843769;6090.786822461193;6098.664573448503;5680.261565996394;5680.630759000652;5681.971590142023;5688.175214593944;5688.459596338341;5670.376258611467;5784.190213370048;5826.94173058264;5908.468237858613;5917.644941303363;5652.349979752381;5673.716314184357;5680.261565996394;5682.488576028178;5688.857778555569;5649.067903795828;5665.150227465913;5669.064604340238;5669.34802497718;5675.971620141873;5491.972540137273;5571;5620.887582248414;5646.632968857011;5655.095184770417;5607.607467477401;5672.12082127271;5674.375818659862;5683.971580142238;5710.914336284876;5408.54027407659;5584.86037849057;5592.776288948559;5599.972000139973;5602.0196465619165 05:44:26 INFO - PROCESS | 30865 | |1;ext.html;655.6131882189508;668.7358493395112;681.2710399872136;739.9297066778654;767.202109805802;31064.223394415152;31938.84030579847;31969.040928772145;37652.81173594135;38350.42474362887;40943.543387396705;41212;41392.586074139246;41417.58582414175;41429;8156.0212774467145;8867.246284065846;9035.051319611444;9047.638094476246;9052.909470905306;8172.509649421054;10656.467176641176;10949.890501095006;10966.945165274163;10968.780624387507;10681.305715128492;10750.946245268762;10753.731156721105;10771.676849694522;10776.19178561607;10576.312539684934;10655.627053053184;10662.253642245047;10665.680029599085;10668.14654827612;10439.582416703322;10540.104091152261;10558.577656893714;10561.68314950545;10831.512581933832;42216.57783422157;42425;42746;42788.144237115084;42857.14285714299;3617.656322649344;3677.9816100919593;4085.6935729820384;4093.836246550164;4099.036726369301;33041.50437743436;33256.6674333256;33274.83362583196;34692.13269668253;34866.12834679128;4523.344115103291;4598.379218805452;4654.697444666086;4669.766511674403;4729.408823897013;323479;325495;326262.3686881574;326497;327009.9999999976;39317.41023884644;39948.80025599853;39959.20081598352;39989.80005099956;60416.093758593655;37542.24915501675;37730.62269377326;37777.81111094427;37886.43170352447;37913.431298530544;15605.68788624221;15733.842661573466;15758.212089395485;15764.921175394278;15772;12205.084618653636;12851.421686023965;13021.088523803242;13068.281244531452;13073.477060917647;9201.677941272023;9281.30390220736;9286.164245217962;9298.395604285699;9341.065893410605;3502.842372093262;3563.6080031196548;3598.784072955631;3623.796396180418;3636.9272614547563;1074.7957888001254;1124.775044991005;1173.1142987044727;1177.9587714430124;1213.5267245774155;30648.846755766077;33296.3340733184;33518.32963340719;33603.82386616457;34490.48264276038;1194.4326444938758;1211.5396149463147;1238.4179435665224;1292.0826213388411;1315.6579289384829;12475.937620312023;15792.92103539475;17119.22963466647;17892.73117124112;18082.367117150836;327830;334785;335001;335467;336043;59641;60204.39795601988;60372.39627603756;60396;60504;1489.5382431446287;1521.7717342398728;1534.7697845323069;1599.2003998001;1612.999940037161;29210;29823;30120.397592047597;30197.245068873453;31688.683113169496;42654.146917062106;43197.568024320615;43450.13099738051;43567;43579.34630980474;242982;243093;244528;244821;245326;26763.86618066897;28311.575326370534;30346.69653303439;30706.389956853916;30856;43024;43619.345709813744;43653.56346436622;43913.121737564434;44795.77602111969;36345.81827090848;36501.26997460089;36647;36861.26277474489;36949.63050369462;35640.465393019644;35761;36034;36058;36068.63931360653;40890.38664420095;41199.58800411958;41267;41719.7914010428;42254.577454225066;34695.93817792812;35919.28161436809;36358.81820590986;36548.451773223955;36573.541658405295;27898.581521276792;27991.14802198108;28042.71957280401;28138.2965425866;28323.858380707963 05:44:26 INFO - PROCESS | 30865 | |2;jquery.html;432.0344031090512;434.7587089165516;437.6498800959234;440.7363473478889;448.50888277336327;18377.54056148597;18610.16254268558;19087.713684294748;19144.23423063076;19229.903850480747;17863.464096077107;17984.100794960264;18255.817441825577;18290.725639115422;18324.725129123042;5315.627906046579;5603.075492543725;5605.411431799664;5849.590528662995;5850.88298234035;5586.636868603528;5601.187827764971;5606.467385598362;5634.464725851058;5638.267025286707;5849.473547380735;6395.136656551375;6401.03984402341;6404.6797660117045;6408.038794180887;6152.907706384408;6239.376062393747;6310.116583678288;6312.684365781715;6316.178896743417;5806.303243610751;5814.389489103668;5832.037713777222;5832.854178645525;5840.503557197643;14050.227237501933;14286.64283392913;19835.702464463044;22930.77069229303;23018.884905575364;2491.7134529528976;2533.8226324157317;2560.2703229579665;2574.6266791315343;2779.4441111777724;10179.491025448699;10323.63867264642;10544.367337959748;10587.84118238227;13937.641650259595;2001.7397738293928;2009.1059478532059;2017.213286818142;2040.5204776877422;2058.53682921343;59738.701306493625;62096.68951655258;65464.01803972944;69542.34456422259;75616.62191689006;10391.116755075753;10592.570003049645;10758.838617420744;10844.349339039683;10855.891441085647;13823.170609763447;14575.125492470486;15345.9232703838;15365.692686146214;15385.615359615875;8005.199480052064;8085.595720213966;8101.6354264058255;8310.54292013945;8341.624626891684;7852.921470785333;7932.36541076724;7948.443608947434;7993.440459167919;8061.435699500978;4778;4851.835559465703;4853.514648535118;4858.149823780895;5069.225770980202;1981.0779100826167;1996.4509759816167;2037.5619241863071;2110.3457928042358;2115.6403411420097;1006.9144122749502;1070.4273213830563;1110.3837370259423;1123.3484578944192;1128.8532490776147;16599.585010374838;17841.107944602718;18354.541136471697;18360.81639183618;18934.05329733508;1067.1405101427927;1081.561967403203;1104.6023431564631;1119.9384033878052;1139.7777433400408;10239.539220735085;10680.679579612468;10704.518296676668;10749.83875241872;10809.973052559993;341189.55584927107;346777;348374;349240;350578;52352.47647523552;54405.45594544083;88261;97657;99536;1173.1142987044557;1175.7413369058793;1180.3095189314176;1185.6206014075412;1230.2434003088035;16777.1611419431;16833.494995150166;16840;17053;17190.656186876444;36395.27209455743;39343.21313573655;40139.397909030806;40157.19685606213;40470.79764601158;48750.756246218545;50082.74958625183;50561.747191265276;50916.23625645544;51467.227991580905;8451.704190353308;8511.276541493795;8738.432001919855;8791.428557143765;9156.496392698466;11284.379359135326;13098.821106100497;13105.606831795061;13196.80204796948;13214.801777973145;10939;11259.831102533632;11455.942720286344;11510.769784604094;11543.191976561897;10328.896711033094;11120.388378639253;11136.33182009082;11277.492512836778;11471.713207169887;11125.499352528994;11455;11891.227070240408;11994.460249288977;12541.811872822098;8575.056743758307;8983.505907174907;9048.321375896703;9136.223421009288;9301;11704.824427633423;11753.236039657395;11763.353015584225;11847.881521184678;11914.16600837933 05:44:26 INFO - PROCESS | 30865 | |3;mootools.html;1359.6057143428407;1502.744533429317;1534.3248970453;1732.3676857946853;1870.6539290231308;8404.243618074372;8605.268552173065;8608.440451370656;8612.052674205832;8621.353398495114;8452.535110568931;8618.655253789857;8622.870656940151;8623.827523449527;8630.309575233981;2363.645453182019;2383.7616238376195;2385.3678775124604;2386.6300723387817;2387.689600351952;2369.4668699542553;2389.569877422063;2445.682061332024;2465.630155476675;2465.827392082555;2373.8694371809543;2403.9519209615796;2404.5311164322966;2406.0496104038893;2429.307647320514;2347.260612906929;2380.809535237177;2395.413123784675;2412.107520217522;2413.8913748881255;2396.352984694123;2447.05788271515;2464.112919349033;2464.4208610976407;2468.271859801363;7540;8089.797755056112;8745.47527148373;8751.081136480705;8770.122987701243;5306.257124002643;5391.3799913009725;5393.649412788156;5426.782928682848;5433.1850222466555;3370.6629337066097;3371.578552680915;3389.694927456516;3412;3468.8265586720813;1073.897979691928;1081.9567217311298;1085.5115198160781;1092.6448904106119;1103.8454616353717;11814.46834892432;12415.503379864795;12450.439730212072;12507.49970001199;12508.374581270991;4695.647826412965;4765.428148622187;4782.450018247877;4851.126797176472;4924.384451943507;10714.73213169677;10722.731931701614;10735.83896241557;10743.89256107429;10756.892431075745;5427.728613569306;5469.124940009579;5473.616846820684;5478.506934375846;5481.671099734029;4902.583280421204;4906.705597664151;4950.133726597831;4958.305837182797;4959.280904268933;4124.6906482013965;4145.067359844011;4148.79256037197;4205.600467955539;4231.322988321854;1321.1610627251764;1325.5426877727168;1339.4173534512518;1343.0464370297002;1354.8441929178073;850.7958090058465;922.5064590444081;978.0708327089294;984.9655262065793;993.2103977338033;5520.593680911431;5629.915551266734;5702.201691763156;5703;5802.854928626818;929.800092979999;982.5578489679673;1006.8137394581879;1034.7051090439188;1036.8030074285862;3722.3858063419775;3748.3440397930253;3750.3811871041516;3774.3960966245268;3807.6192380761704;10819.67540973772;10993.505292261867;11018.50416731249;11026.779464410667;11119.72200694989;10922.344659320466;10935.56257749697;10949.014588687056;10954;10954.890451095547;8246.09292977772;8500.40497165205;8506.276966457797;8552.871706924401;8579.541477948638;5559.332880054258;5567;5589.748461319169;5688.232088667977;5725.0267454531995;9658.9034109658;9748.415095094317;9858.112769850748;9928.652497162564;9949.054839790208;9899.20806335477;10074.899251007397;10088.89911100909;10111.64609238673;10186.847197292194;7454.664540095817;7584.431167662337;7624.885626715714;7628.0464941882265;7632.656530456254;8504.744857654281;8557.35819813504;8565.100664430394;8572;8573.099824518336;7488.400927925644;7663.27198916102;7718;7828.882566761389;7870.527768333918;7471.327580517779;7617.390608751176;7714.845703086019;7854.764357069297;7902.723404680809;6712.295209002984;6833.58998460094;6864.553804002724;6891.207511136284;6891.793246202622;4514.210013247734;5048.318477005557;5082.263071854634;5164.32863727713;5212.947870521246;5008.549230569266;5041;5146;5212.921806172834;5243 05:44:26 INFO - PROCESS | 30865 | |4;prototype.html;359.6655110747006;362.912900903783;366.45032451323016;367.5662717992769;374.0349897265055;6178.196834411526;6184.938150618498;6237.563370564062;6239.750409983607;6266.404691554295;6135.938640613604;6149.354317796634;6149.784757533487;6158.84602884927;6165.828492586405;4515.119551687422;4604.470485894131;4712.670113092067;4729.172394830908;4751.16854550454;4705.29420586913;4723.149833030053;4739.431268247798;4746.169420351442;4749.145153872301;4482.574155455227;4693.530646935296;4697.295405689157;4700.553447422507;4702.694324868889;4571.062932098912;4615.676902616819;4625.4911959684405;4661.790219440133;4742.5731684148595;4160.791960401998;4171.10321280923;4191.517975432834;4199.908023913774;4201.642860356873;5922.3781502942;5924.9703751480965;5925.674087925162;5927.170196172539;5933.732982015819;5500.697461639608;5503.3395992480755;5507.752151153208;5512.944870551323;5513.476219759116;6332.746690132389;6461.741530338781;6461.773837915651;6464.321246269168;6468.223813142406;4628.699134556243;4657.18499262631;4658.557437043475;4662.836800711959;4665.020345727401;6747.696353664097;6769.255381908036;6781.423578995791;6783;6783.830404239884;4758.595519380891;4766.118268120409;4772.331873537708;4773.76131193439;4778.259369797617;4821.2045012573235;4826.493218212107;4827.975860120747;4830.082284365959;4830.2513110467235;5482.5613950883835;5486.451354864482;5486.807961721321;5491.2312276281355;5497.120460726344;6301.779437719658;6528.54300198991;6540.901886471706;6544.705488252945;6553.246376666649;1636.1573789498418;1644.3093900561794;1651.4962936304303;1652.8512433881008;1652.9338826446808;1039.622500187255;1045.0698877998586;1060.490964337107;1062.914966802654;1093.0435868614961;6346.30190679025;6487.740490380332;6496.22045354551;6498.577592456475;6500.5449618526245;6783.423409010289;6812.318768123148;6816.386525212655;6867.175938887365;6869.0383346330555;6460.353964603502;6461.709223084972;6466.932956062291;6482.157319548429;6490.350964903472;3616.439451884962;3648.7993160376436;3652.3060618482405;3661.5972243053243;3661.9267614648093;6986.476014298846;7170.641467926583;7283.526570772883;7289.052423184952;7291.8906216406795;6949.409300209438;6952.096227490394;6961.443084553223;6975.651217439107;6982.61595612236;7135.5361901476235;7154.4634152438775;7156.320149585781;7156.928430715626;7192.208857025723;6781.7287308509085;6783.762568310085;6784.151981002375;6787.151606049244;6863;6501.902471463027;6696.296888826603;6703.3296670332575;6706.295838937037;6728.293529179366;7114.723288547615;7155.640428318603;7159.928400715926;7160.677769500281;7162.104736907887;4644.210484217623;4650.5116962719785;4678.836240731558;4685.835995740133;4695.9530404695515;6756.594604323756;6760.3239676032;6768.120144381199;6796.456283497408;6849.691763870538;6360.268569114611;6547;6597.208334999831;6599.835004124935;6606.966965165144;6554.770583029571;6589.703463344065;6599.8020059398295;6605.372489613479;6606.10817539626;6491.513136514686;6493.577917435352;6498.610083395011;6500.447461965786;6504.739810407531;6634.568753031038;6634.635095069624;6637.568558043712;6643.800685979235;6648.933510664831;6366.6180029198395;6500.837479063061;6513.609183449008;6516.967415162894;6521.902171467526 05:44:26 INFO - PROCESS | 30865 | |5;yui.html;819.9549024803633;842.469244376043;889.492988996272;895.2703546609513;951.6288647427505;15391;15395.307211175495;15495.535133945972;15569.610759730998;15603.141827199499;14032.228227447511;14350.282485875716;14369.066010709297;14376.784348234785;14400.279986000683;747.2564798025971;872.8210716803072;874.4971641306242;892.8839250897374;900.8468560344758;892.7411050795262;893.1024320557831;896.1218006353777;897.1611543207122;899.0964081098487;940.8917974432959;943.0333907744548;946.9905300946971;949.6818565780471;950.0546955778975;779.185750890321;918.7427520294328;936.2182577547755;938.7324612485409;942.8067246214509;690.4545409126783;690.6684791300204;691.401937324216;692.390696187357;692.9341712537301;15542.5337239883;15545.378184872592;15677.372905083783;15688.843111568853;15704.921475392664;15170.772438413433;15275.770863437057;15417.768733469007;15617.219139043002;15649.843501564952;12173.695657608541;12310.938445307716;12321.445534950948;12441.75116497674;12521.874781252161;4072.1041370898356;4111.71218014739;4140.585941405865;4183.49798024239;4270.274053410928;54954.725226374016;55170.44829551734;55495.89008219813;55611.72194139044;55771.44228557703;11171.44142792857;11171.608993685182;11193.328400295846;11228.606998755004;11429.142814288962;19585.1186696599;19623.50941226452;19633.116509757096;19641.607167856564;19657.213711451666;8157.673693052211;8399.790005249917;8693.782655433664;8908.643654253758;8944.552772361356;4704.1767690654;4780.545848144421;5035.931757090345;5058.342415485963;5207.947920520822;3497.0557949353533;3561.6260292669413;3564.144605294711;3565.090901820019;3567.2152126532123;664.7221064745902;665.3612531969363;670.4435318685479;674.4873895839099;675.3415419965593;800.1998001998002;820.979475513117;829.5644786487143;829.7966998085387;841.7096101844854;10193.643222487177;10429.37423754562;10574.577016919391;10771.89228107709;10785.191110666574;767.117814513303;800.1238643685156;811.6469335838929;861.0829466618031;862.8748831419409;4731.195696731564;4954.256861470736;5002.724850133205;5009.223570346602;5054.09026375256;63902;64724.67637661876;64964.675176623816;65083;65085;55431.44568554343;55647.16529252064;56001.43998560044;56610.15084773731;57000;47270.5272947273;47927;48154;48183.27725084127;52484.47515524872;9982.500874956368;10400.47997600102;10433.9478302608;10538.156947444033;10663.466826658481;37319.81340093282;39627.405588915615;39933;40329.596704032585;41018.58981410148;41313.79343103385;41577.58422415858;45972.540274596824;50232.74883625558;50838.49161508486;12197.634070977885;12230.816537752118;13062.869371306166;13121.409536571067;13549.390277437342;12235.93882030584;12941.223526588436;13314;13692.52076177329;13832.930835345758;13345.914398829698;13479.258640774458;13935;13949.511767088103;13960.371783269575;13869.930650346683;13921.930390347983;13997.090189137674;14171.220582867629;14180.361883715052;12440.37798110109;13111.14777539457;13140.605781826178;13252.933735331262;13458.730825383242;11057.391843448688;11240.4379781009;11330.886691133313;11394.145439092266;11443.14176436754;11058.834117488404;11331.603393881174;11399.658010259705;11435.59975400857;11570.884291157317 05:44:26 INFO - PROCESS | 30865 | __end_tp_report 05:44:26 INFO - PROCESS | 30865 | __start_cc_report 05:44:26 INFO - PROCESS | 30865 | _x_x_mozilla_cycle_collect,839 05:44:26 INFO - PROCESS | 30865 | __end_cc_report 05:44:26 INFO - PROCESS | 30865 | __startTimestamp1468845866535__endTimestamp 05:44:26 INFO - PROCESS | 30865 | 05:44:26 INFO - PROCESS | 30865 | ------- Summary: start ------- 05:44:26 INFO - PROCESS | 30865 | Number of tests: 6 05:44:26 INFO - PROCESS | 30865 | 05:44:26 INFO - PROCESS | 30865 | [#0] dojo.html Cycles:165 Average:5387.12 Median:5607.61 stddev:588.71 (10.5%) stddev-sans-first:566.55 05:44:26 INFO - PROCESS | 30865 | Values: 3267.9 3311.2 3317.4 3350.2 3364.9 5335.5 5351.6 5353.1 5359.9 5360.1 5353.3 5373.5 5378.5 5381.6 5385.1 4822.2 4852.6 4853.5 4913.9 4979.8 4913.3 5001.3 5004.0 5005.6 5006.4 4877.9 4928.1 4959.9 4962.3 4994.9 4986.2 5012.3 5012.6 5020.0 5027.7 4792.9 4819.9 4858.7 4923.8 4959.5 5214.8 5225.7 5238.9 5245.9 5266.8 5785.1 5807.5 5815.4 5817.5 5818.8 5755.6 5829.3 5842.0 5872.9 5882.7 5377.5 5402.7 5409.8 5419.1 5421.0 5820.4 5906.3 5908.8 5919.4 5920.9 5676.1 5721.6 5742.3 5758.8 5775.2 5713.9 5733.9 5737.3 5747.7 5751.5 5662.9 5721.5 5724.3 5731.2 5744.7 5751.7 5751.8 5760.2 5764.5 5787.2 4440.5 4450.6 4452.4 4453.0 4480.6 3922.6 3950.4 3959.8 3990.0 4011.1 5521.6 5532.3 5542.9 5546.5 5574.3 5775.8 5792.0 5792.8 5797.5 5803.0 5368.6 5527.5 5527.7 5536.1 5581.7 5021.6 5045.9 5048.1 5051.6 5077.5 6046.6 6063.7 6076.3 6107.9 6110.0 5608.9 5746.1 5756.3 5796.5 5819.7 6041.4 6073.8 6090.6 6090.8 6098.7 5680.3 5680.6 5682.0 5688.2 5688.5 5670.4 5784.2 5826.9 5908.5 5917.6 5652.3 5673.7 5680.3 5682.5 5688.9 5649.1 5665.2 5669.1 5669.3 5676.0 5492.0 5571.0 5620.9 5646.6 5655.1 5607.6 5672.1 5674.4 5684.0 5710.9 5408.5 5584.9 5592.8 5600.0 5602.0 05:44:26 INFO - PROCESS | 30865 | 05:44:26 INFO - PROCESS | 30865 | [#1] ext.html Cycles:180 Average:46599.08 Median:34694.04 stddev:79515.78 (229.2%) stddev-sans-first:79664.02 05:44:26 INFO - PROCESS | 30865 | Values: 655.6 668.7 681.3 739.9 767.2 31064.2 31938.8 31969.0 37652.8 38350.4 40943.5 41212.0 41392.6 41417.6 41429.0 8156.0 8867.2 9035.1 9047.6 9052.9 8172.5 10656.5 10949.9 10966.9 10968.8 10681.3 10750.9 10753.7 10771.7 10776.2 10576.3 10655.6 10662.3 10665.7 10668.1 10439.6 10540.1 10558.6 10561.7 10831.5 42216.6 42425.0 42746.0 42788.1 42857.1 3617.7 3678.0 4085.7 4093.8 4099.0 33041.5 33256.7 33274.8 34692.1 34866.1 4523.3 4598.4 4654.7 4669.8 4729.4 323479.0 325495.0 326262.4 326497.0 327010.0 39317.4 39948.8 39959.2 39989.8 60416.1 37542.2 37730.6 37777.8 37886.4 37913.4 15605.7 15733.8 15758.2 15764.9 15772.0 12205.1 12851.4 13021.1 13068.3 13073.5 9201.7 9281.3 9286.2 9298.4 9341.1 3502.8 3563.6 3598.8 3623.8 3636.9 1074.8 1124.8 1173.1 1178.0 1213.5 30648.8 33296.3 33518.3 33603.8 34490.5 1194.4 1211.5 1238.4 1292.1 1315.7 12475.9 15792.9 17119.2 17892.7 18082.4 327830.0 334785.0 335001.0 335467.0 336043.0 59641.0 60204.4 60372.4 60396.0 60504.0 1489.5 1521.8 1534.8 1599.2 1613.0 29210.0 29823.0 30120.4 30197.2 31688.7 42654.1 43197.6 43450.1 43567.0 43579.3 242982.0 243093.0 244528.0 244821.0 245326.0 26763.9 28311.6 30346.7 30706.4 30856.0 43024.0 43619.3 43653.6 43913.1 44795.8 36345.8 36501.3 36647.0 36861.3 36949.6 35640.5 35761.0 36034.0 36058.0 36068.6 40890.4 41199.6 41267.0 41719.8 42254.6 34695.9 35919.3 36358.8 36548.5 36573.5 27898.6 27991.1 28042.7 28138.3 28323.9 05:44:26 INFO - PROCESS | 30865 | 05:44:26 INFO - PROCESS | 30865 | [#2] jquery.html Cycles:180 Average:23823.13 Median:2084.44 stddev:57585.67 (2762.6%) stddev-sans-first:57720.43 05:44:26 INFO - PROCESS | 30865 | Values: 432.0 434.8 437.6 440.7 448.5 18377.5 18610.2 19087.7 19144.2 19229.9 17863.5 17984.1 18255.8 18290.7 18324.7 5315.6 5603.1 5605.4 5849.6 5850.9 5586.6 5601.2 5606.5 5634.5 5638.3 5849.5 6395.1 6401.0 6404.7 6408.0 6152.9 6239.4 6310.1 6312.7 6316.2 5806.3 5814.4 5832.0 5832.9 5840.5 14050.2 14286.6 19835.7 22930.8 23018.9 2491.7 2533.8 2560.3 2574.6 2779.4 10179.5 10323.6 10544.4 10587.8 13937.6 2001.7 2009.1 2017.2 2040.5 2058.5 59738.7 62096.7 65464.0 69542.3 75616.6 10391.1 10592.6 10758.8 10844.3 10855.9 13823.2 14575.1 15345.9 15365.7 15385.6 8005.2 8085.6 8101.6 8310.5 8341.6 7852.9 7932.4 7948.4 7993.4 8061.4 4778.0 4851.8 4853.5 4858.1 5069.2 1981.1 1996.5 2037.6 2110.3 2115.6 1006.9 1070.4 1110.4 1123.3 1128.9 16599.6 17841.1 18354.5 18360.8 18934.1 1067.1 1081.6 1104.6 1119.9 1139.8 10239.5 10680.7 10704.5 10749.8 10810.0 341189.6 346777.0 348374.0 349240.0 350578.0 52352.5 54405.5 88261.0 97657.0 99536.0 1173.1 1175.7 1180.3 1185.6 1230.2 16777.2 16833.5 16840.0 17053.0 17190.7 36395.3 39343.2 40139.4 40157.2 40470.8 48750.8 50082.7 50561.7 50916.2 51467.2 8451.7 8511.3 8738.4 8791.4 9156.5 11284.4 13098.8 13105.6 13196.8 13214.8 10939.0 11259.8 11455.9 11510.8 11543.2 10328.9 11120.4 11136.3 11277.5 11471.7 11125.5 11455.0 11891.2 11994.5 12541.8 8575.1 8983.5 9048.3 9136.2 9301.0 11704.8 11753.2 11763.4 11847.9 11914.2 05:44:26 INFO - PROCESS | 30865 | 05:44:26 INFO - PROCESS | 30865 | [#3] mootools.html Cycles:180 Average:5797.63 Median:4954.22 stddev:3273.43 (66.1%) stddev-sans-first:3265.62 05:44:26 INFO - PROCESS | 30865 | Values: 1359.6 1502.7 1534.3 1732.4 1870.7 8404.2 8605.3 8608.4 8612.1 8621.4 8452.5 8618.7 8622.9 8623.8 8630.3 2363.6 2383.8 2385.4 2386.6 2387.7 2369.5 2389.6 2445.7 2465.6 2465.8 2373.9 2404.0 2404.5 2406.0 2429.3 2347.3 2380.8 2395.4 2412.1 2413.9 2396.4 2447.1 2464.1 2464.4 2468.3 7540.0 8089.8 8745.5 8751.1 8770.1 5306.3 5391.4 5393.6 5426.8 5433.2 3370.7 3371.6 3389.7 3412.0 3468.8 1073.9 1082.0 1085.5 1092.6 1103.8 11814.5 12415.5 12450.4 12507.5 12508.4 4695.6 4765.4 4782.5 4851.1 4924.4 10714.7 10722.7 10735.8 10743.9 10756.9 5427.7 5469.1 5473.6 5478.5 5481.7 4902.6 4906.7 4950.1 4958.3 4959.3 4124.7 4145.1 4148.8 4205.6 4231.3 1321.2 1325.5 1339.4 1343.0 1354.8 850.8 922.5 978.1 985.0 993.2 5520.6 5629.9 5702.2 5703.0 5802.9 929.8 982.6 1006.8 1034.7 1036.8 3722.4 3748.3 3750.4 3774.4 3807.6 10819.7 10993.5 11018.5 11026.8 11119.7 10922.3 10935.6 10949.0 10954.0 10954.9 8246.1 8500.4 8506.3 8552.9 8579.5 5559.3 5567.0 5589.7 5688.2 5725.0 9658.9 9748.4 9858.1 9928.7 9949.1 9899.2 10074.9 10088.9 10111.6 10186.8 7454.7 7584.4 7624.9 7628.0 7632.7 8504.7 8557.4 8565.1 8572.0 8573.1 7488.4 7663.3 7718.0 7828.9 7870.5 7471.3 7617.4 7714.8 7854.8 7902.7 6712.3 6833.6 6864.6 6891.2 6891.8 4514.2 5048.3 5082.3 5164.3 5212.9 5008.5 5041.0 5146.0 5212.9 5243.0 05:44:26 INFO - PROCESS | 30865 | 05:44:26 INFO - PROCESS | 30865 | [#4] prototype.html Cycles:180 Average:5521.65 Median:6317.26 stddev:1673.71 (26.5%) stddev-sans-first:1632.94 05:44:26 INFO - PROCESS | 30865 | Values: 359.7 362.9 366.5 367.6 374.0 6178.2 6184.9 6237.6 6239.8 6266.4 6135.9 6149.4 6149.8 6158.8 6165.8 4515.1 4604.5 4712.7 4729.2 4751.2 4705.3 4723.1 4739.4 4746.2 4749.1 4482.6 4693.5 4697.3 4700.6 4702.7 4571.1 4615.7 4625.5 4661.8 4742.6 4160.8 4171.1 4191.5 4199.9 4201.6 5922.4 5925.0 5925.7 5927.2 5933.7 5500.7 5503.3 5507.8 5512.9 5513.5 6332.7 6461.7 6461.8 6464.3 6468.2 4628.7 4657.2 4658.6 4662.8 4665.0 6747.7 6769.3 6781.4 6783.0 6783.8 4758.6 4766.1 4772.3 4773.8 4778.3 4821.2 4826.5 4828.0 4830.1 4830.3 5482.6 5486.5 5486.8 5491.2 5497.1 6301.8 6528.5 6540.9 6544.7 6553.2 1636.2 1644.3 1651.5 1652.9 1652.9 1039.6 1045.1 1060.5 1062.9 1093.0 6346.3 6487.7 6496.2 6498.6 6500.5 6783.4 6812.3 6816.4 6867.2 6869.0 6460.4 6461.7 6466.9 6482.2 6490.4 3616.4 3648.8 3652.3 3661.6 3661.9 6986.5 7170.6 7283.5 7289.1 7291.9 6949.4 6952.1 6961.4 6975.7 6982.6 7135.5 7154.5 7156.3 7156.9 7192.2 6781.7 6783.8 6784.2 6787.2 6863.0 6501.9 6696.3 6703.3 6706.3 6728.3 7114.7 7155.6 7159.9 7160.7 7162.1 4644.2 4650.5 4678.8 4685.8 4696.0 6756.6 6760.3 6768.1 6796.5 6849.7 6360.3 6547.0 6597.2 6599.8 6607.0 6554.8 6589.7 6599.8 6605.4 6606.1 6491.5 6493.6 6498.6 6500.4 6504.7 6634.6 6634.6 6637.6 6643.8 6648.9 6366.6 6500.8 6513.6 6517.0 6521.9 05:44:26 INFO - PROCESS | 30865 | 05:44:26 INFO - PROCESS | 30865 | [#5] yui.html Cycles:180 Average:15528.14 Median:22712.75 stddev:17486.91 (77.0%) stddev-sans-first:17501.08 05:44:26 INFO - PROCESS | 30865 | Values: 820.0 842.5 889.5 895.3 951.6 15391.0 15395.3 15495.5 15569.6 15603.1 14032.2 14350.3 14369.1 14376.8 14400.3 747.3 872.8 874.5 892.9 900.8 892.7 893.1 896.1 897.2 899.1 940.9 943.0 947.0 949.7 950.1 779.2 918.7 936.2 938.7 942.8 690.5 690.7 691.4 692.4 692.9 15542.5 15545.4 15677.4 15688.8 15704.9 15170.8 15275.8 15417.8 15617.2 15649.8 12173.7 12310.9 12321.4 12441.8 12521.9 4072.1 4111.7 4140.6 4183.5 4270.3 54954.7 55170.4 55495.9 55611.7 55771.4 11171.4 11171.6 11193.3 11228.6 11429.1 19585.1 19623.5 19633.1 19641.6 19657.2 8157.7 8399.8 8693.8 8908.6 8944.6 4704.2 4780.5 5035.9 5058.3 5207.9 3497.1 3561.6 3564.1 3565.1 3567.2 664.7 665.4 670.4 674.5 675.3 800.2 821.0 829.6 829.8 841.7 10193.6 10429.4 10574.6 10771.9 10785.2 767.1 800.1 811.6 861.1 862.9 4731.2 4954.3 5002.7 5009.2 5054.1 63902.0 64724.7 64964.7 65083.0 65085.0 55431.4 55647.2 56001.4 56610.2 57000.0 47270.5 47927.0 48154.0 48183.3 52484.5 9982.5 10400.5 10433.9 10538.2 10663.5 37319.8 39627.4 39933.0 40329.6 41018.6 41313.8 41577.6 45972.5 50232.7 50838.5 12197.6 12230.8 13062.9 13121.4 13549.4 12235.9 12941.2 13314.0 13692.5 13832.9 13345.9 13479.3 13935.0 13949.5 13960.4 13869.9 13921.9 13997.1 14171.2 14180.4 12440.4 13111.1 13140.6 13252.9 13458.7 11057.4 11240.4 11330.9 11394.1 11443.1 11058.8 11331.6 11399.7 11435.6 11570.9 05:44:26 INFO - PROCESS | 30865 | -------- Summary: end -------- 05:44:26 INFO - PROCESS | 30865 | 05:44:27 INFO - TEST-INFO | 30865: exit 0 05:44:27 INFO - TEST-OK | dromaeo_css | took 1110916ms 05:44:27 INFO - TEST-START | kraken 05:44:27 INFO - operating with platform_type : linux_ 05:44:27 INFO - Initialising browser for kraken test... 05:44:27 INFO - TEST-INFO | started process 31049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6oIKQg/profile http://localhost:34444/getInfo.html) 05:44:31 INFO - PROCESS | 31049 | __metrics Screen width/height:1600/1200 05:44:31 INFO - PROCESS | 31049 | colorDepth:24 05:44:31 INFO - PROCESS | 31049 | Browser inner width/height: 1024/697 05:44:31 INFO - PROCESS | 31049 | __metrics 05:44:32 INFO - PROCESS | 31049 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:44:32 ERROR - PROCESS | 31049 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:44:32 INFO - TEST-INFO | 31049: exit 0 05:44:32 INFO - Browser initialized. 05:44:32 INFO - Running cycle 1/1 for kraken test... 05:44:32 INFO - TEST-INFO | started process 31141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6oIKQg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:44 INFO - PROCESS | 31141 | RSS: Main: 139079680 05:44:44 INFO - PROCESS | 31141 | 05:44:47 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34444/tests/kraken/driver.html?testName=audio-beat-detection) 05:44:47 INFO - PROCESS | 31141 | RSS: Main: 197263360 05:44:47 INFO - PROCESS | 31141 | 05:44:50 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34444/tests/kraken/driver.html?testName=audio-dft) 05:44:51 INFO - PROCESS | 31141 | RSS: Main: 184532992 05:44:51 INFO - PROCESS | 31141 | 05:44:53 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34444/tests/kraken/driver.html?testName=audio-fft) 05:44:54 INFO - PROCESS | 31141 | RSS: Main: 273133568 05:44:54 INFO - PROCESS | 31141 | 05:44:56 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34444/tests/kraken/driver.html?testName=audio-oscillator) 05:44:57 INFO - PROCESS | 31141 | RSS: Main: 179789824 05:44:57 INFO - PROCESS | 31141 | 05:44:59 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34444/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:44:59 INFO - PROCESS | 31141 | RSS: Main: 178065408 05:44:59 INFO - PROCESS | 31141 | 05:45:02 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34444/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:03 INFO - PROCESS | 31141 | RSS: Main: 212066304 05:45:03 INFO - PROCESS | 31141 | 05:45:06 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34444/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:07 INFO - PROCESS | 31141 | RSS: Main: 211976192 05:45:07 INFO - PROCESS | 31141 | 05:45:10 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34444/tests/kraken/driver.html?testName=json-parse-financial) 05:45:10 INFO - PROCESS | 31141 | RSS: Main: 212336640 05:45:10 INFO - PROCESS | 31141 | 05:45:12 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34444/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:45:12 INFO - PROCESS | 31141 | RSS: Main: 193740800 05:45:12 INFO - PROCESS | 31141 | 05:45:14 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:45:15 INFO - PROCESS | 31141 | RSS: Main: 199335936 05:45:15 INFO - PROCESS | 31141 | 05:45:17 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:45:17 INFO - PROCESS | 31141 | RSS: Main: 211296256 05:45:17 INFO - PROCESS | 31141 | 05:45:20 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:45:20 INFO - PROCESS | 31141 | RSS: Main: 218419200 05:45:20 INFO - PROCESS | 31141 | 05:45:23 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:45:24 INFO - PROCESS | 31141 | RSS: Main: 213454848 05:45:24 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34444/tests/kraken/driver.html?testName=ai-astar) 05:45:25 INFO - PROCESS | 31141 | RSS: Main: 273854464 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | __start_tp_report 05:45:25 INFO - PROCESS | 31141 | _x_x_mozilla_page_load 05:45:25 INFO - PROCESS | 31141 | _x_x_mozilla_page_load_details 05:45:25 INFO - PROCESS | 31141 | |i|pagename|runs| 05:45:25 INFO - PROCESS | 31141 | |0;ai-astar;110;111;110;110;111;111;109;111;109;109 05:45:25 INFO - PROCESS | 31141 | |1;audio-beat-detection;154;126;150;173;126;149;147;126;185;127 05:45:25 INFO - PROCESS | 31141 | |2;audio-dft;162;161;160;161;160;160;162;162;159;161 05:45:25 INFO - PROCESS | 31141 | |3;audio-fft;74;76;75;168;75;75;73;76;157;76 05:45:25 INFO - PROCESS | 31141 | |4;audio-oscillator;90;92;158;92;92;92;153;93;91;147 05:45:25 INFO - PROCESS | 31141 | |5;imaging-gaussian-blur;118;116;117;118;117;116;118;118;120;117 05:45:25 INFO - PROCESS | 31141 | |6;imaging-darkroom;146;146;146;145;146;145;145;147;147;147 05:45:25 INFO - PROCESS | 31141 | |7;imaging-desaturate;95;94;95;94;95;94;95;94;95;95 05:45:25 INFO - PROCESS | 31141 | |8;json-parse-financial;54;55;55;56;57;56;57;78;53;53 05:45:25 INFO - PROCESS | 31141 | |9;json-stringify-tinderbox;58;57;58;57;58;57;59;58;59;57 05:45:25 INFO - PROCESS | 31141 | |10;stanford-crypto-aes;72;71;72;73;79;72;73;73;72;72 05:45:25 INFO - PROCESS | 31141 | |11;stanford-crypto-ccm;114;121;119;112;111;110;113;112;129;128 05:45:25 INFO - PROCESS | 31141 | |12;stanford-crypto-pbkdf2;159;157;155;167;163;160;158;157;157;157 05:45:25 INFO - PROCESS | 31141 | |13;stanford-crypto-sha256-iterative;65;67;67;67;70;67;67;66;68;67 05:45:25 INFO - PROCESS | 31141 | __end_tp_report 05:45:25 INFO - PROCESS | 31141 | __start_cc_report 05:45:25 INFO - PROCESS | 31141 | _x_x_mozilla_cycle_collect,1586 05:45:25 INFO - PROCESS | 31141 | __end_cc_report 05:45:25 INFO - PROCESS | 31141 | __startTimestamp1468845925962__endTimestamp 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | ------- Summary: start ------- 05:45:25 INFO - PROCESS | 31141 | Number of tests: 14 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:0.88 (0.8%) stddev-sans-first:0.93 05:45:25 INFO - PROCESS | 31141 | Values: 110.0 111.0 110.0 110.0 111.0 111.0 109.0 111.0 109.0 109.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:149.50 stddev:20.82 (13.9%) stddev-sans-first:21.89 05:45:25 INFO - PROCESS | 31141 | Values: 154.0 126.0 150.0 173.0 126.0 149.0 147.0 126.0 185.0 127.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 05:45:25 INFO - PROCESS | 31141 | Values: 162.0 161.0 160.0 161.0 160.0 160.0 162.0 162.0 159.0 161.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:37.00 (49.3%) stddev-sans-first:38.63 05:45:25 INFO - PROCESS | 31141 | Values: 74.0 76.0 75.0 168.0 75.0 75.0 73.0 76.0 157.0 76.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:29.57 (32.1%) stddev-sans-first:30.46 05:45:25 INFO - PROCESS | 31141 | Values: 90.0 92.0 158.0 92.0 92.0 92.0 153.0 93.0 91.0 147.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:1.18 (1.0%) stddev-sans-first:1.24 05:45:25 INFO - PROCESS | 31141 | Values: 118.0 116.0 117.0 118.0 117.0 116.0 118.0 118.0 120.0 117.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 05:45:25 INFO - PROCESS | 31141 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 145.0 147.0 147.0 147.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:45:25 INFO - PROCESS | 31141 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.00 stddev:7.38 (13.2%) stddev-sans-first:7.73 05:45:25 INFO - PROCESS | 31141 | Values: 54.0 55.0 55.0 56.0 57.0 56.0 57.0 78.0 53.0 53.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 05:45:25 INFO - PROCESS | 31141 | Values: 58.0 57.0 58.0 57.0 58.0 57.0 59.0 58.0 59.0 57.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:72.50 stddev:2.23 (3.1%) stddev-sans-first:2.35 05:45:25 INFO - PROCESS | 31141 | Values: 72.0 71.0 72.0 73.0 79.0 72.0 73.0 73.0 72.0 72.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:116.50 stddev:7.03 (6.0%) stddev-sans-first:7.38 05:45:25 INFO - PROCESS | 31141 | Values: 114.0 121.0 119.0 112.0 111.0 110.0 113.0 112.0 129.0 128.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:158.50 stddev:3.56 (2.2%) stddev-sans-first:3.77 05:45:25 INFO - PROCESS | 31141 | Values: 159.0 157.0 155.0 167.0 163.0 160.0 158.0 157.0 157.0 157.0 05:45:25 INFO - PROCESS | 31141 | 05:45:25 INFO - PROCESS | 31141 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.29 (1.9%) stddev-sans-first:1.12 05:45:25 INFO - PROCESS | 31141 | Values: 65.0 67.0 67.0 67.0 70.0 67.0 67.0 66.0 68.0 67.0 05:45:25 INFO - PROCESS | 31141 | -------- Summary: end -------- 05:45:25 INFO - PROCESS | 31141 | 05:45:27 INFO - TEST-INFO | 31141: exit 0 05:45:27 INFO - TEST-OK | kraken | took 59808ms 05:45:27 INFO - SUITE-END | took 1170s 05:45:27 INFO - Completed test suite (00:19:30) 05:45:27 INFO - javascript benchmark 05:45:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3267.852946617402, 3311.1556553078976, 3317.386283537545, 3350.229447227136, 3364.8990530284086, 5335.466453354663, 5351.598630102739, 5353.0899747042995, 5359.946400535993, 5360.115580929152, 5353.330833645794, 5373.543248823855, 5378.489043540867, 5381.623286369956, 5385.057614917384, 4822.22844344904, 4852.611791056707, 4853.490383509734, 4913.901721965559, 4979.751012449381, 4913.31213630092, 5001.299818025461, 5003.974980125113, 5005.624578156653, 5006.399232092154, 4877.902441951159, 4928.088303663816, 4959.900801983977, 4962.280469331945, 4994.875128121808, 4986.152354099811, 5012.348394708701, 5012.649114561964, 5020.046191223656, 5027.698338099707, 4792.904141917142, 4819.855404337875, 4858.708477491362, 4923.75381230937, 4959.528844759742, 5214.7914083437, 5225.660332078441, 5238.92141617876, 5245.868853278698, 5266.7629956652045, 5785.132230165509, 5807.535397168259, 5815.389384114649, 5817.476427121579, 5818.767249310023, 5755.625884317506, 5829.329627092854, 5841.9776539105915, 5872.853178670524, 5882.705864706791, 5377.5429088527135, 5402.702851343214, 5409.756560954766, 5419.051665958442, 5420.972895135538, 5820.447057529528, 5906.291245050621, 5908.763649453974, 5919.378465261172, 5920.8815823684145, 5676.148577713294, 5721.5708821838525, 5742.253507044141, 5758.827235182951, 5775.220345253337, 5713.857153571111, 5733.856653583611, 5737.340205876294, 5747.712614369265, 5751.511121554631, 5662.858428539237, 5721.485066344049, 5724.313082430135, 5731.226284451629, 5744.684042377626, 5751.6549007058875, 5751.827445176651, 5760.193572899798, 5764.452377024176, 5787.2187254720075, 4440.533743956838, 4450.599446049871, 4452.4211852458975, 4452.977735111303, 4480.551944805558, 3922.6077392260545, 3950.4074388841905, 3959.8020098994934, 3990.0423898264207, 4011.0774521859553, 5521.558275337963, 5532.336119665666, 5542.944570554243, 5546.500814926676, 5574.275344205227, 5775.768969241268, 5791.971040144772, 5792.768289268382, 5797.536197104221, 5803.042497987784, 5368.624196306221, 5527.53015993645, 5527.695976721319, 5536.058869992111, 5581.7209139543675, 5021.598272138293, 5045.924311135336, 5048.1418158913075, 5051.621128415383, 5077.466865979093, 6046.637201767908, 6063.696815159225, 6076.3316035236085, 6107.908381374283, 6110.0, 5608.85977850557, 5746.051901436216, 5756.251687280626, 5796.536277097906, 5819.679917604572, 6041.365656605993, 6073.787417440369, 6090.573659843769, 6090.786822461193, 6098.664573448503, 5680.261565996394, 5680.630759000652, 5681.971590142023, 5688.175214593944, 5688.459596338341, 5670.376258611467, 5784.190213370048, 5826.94173058264, 5908.468237858613, 5917.644941303363, 5652.349979752381, 5673.716314184357, 5680.261565996394, 5682.488576028178, 5688.857778555569, 5649.067903795828, 5665.150227465913, 5669.064604340238, 5669.34802497718, 5675.971620141873, 5491.972540137273, 5571.0, 5620.887582248414, 5646.632968857011, 5655.095184770417, 5607.607467477401, 5672.12082127271, 5674.375818659862, 5683.971580142238, 5710.914336284876, 5408.54027407659, 5584.86037849057, 5592.776288948559, 5599.972000139973, 5602.0196465619165], "value": 5349.793044629425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.6131882189508, 668.7358493395112, 681.2710399872136, 739.9297066778654, 767.202109805802, 31064.223394415152, 31938.84030579847, 31969.040928772145, 37652.81173594135, 38350.42474362887, 40943.543387396705, 41212.0, 41392.586074139246, 41417.58582414175, 41429.0, 8156.0212774467145, 8867.246284065846, 9035.051319611444, 9047.638094476246, 9052.909470905306, 8172.509649421054, 10656.467176641176, 10949.890501095006, 10966.945165274163, 10968.780624387507, 10681.305715128492, 10750.946245268762, 10753.731156721105, 10771.676849694522, 10776.19178561607, 10576.312539684934, 10655.627053053184, 10662.253642245047, 10665.680029599085, 10668.14654827612, 10439.582416703322, 10540.104091152261, 10558.577656893714, 10561.68314950545, 10831.512581933832, 42216.57783422157, 42425.0, 42746.0, 42788.144237115084, 42857.14285714299, 3617.656322649344, 3677.9816100919593, 4085.6935729820384, 4093.836246550164, 4099.036726369301, 33041.50437743436, 33256.6674333256, 33274.83362583196, 34692.13269668253, 34866.12834679128, 4523.344115103291, 4598.379218805452, 4654.697444666086, 4669.766511674403, 4729.408823897013, 323479.0, 325495.0, 326262.3686881574, 326497.0, 327009.9999999976, 39317.41023884644, 39948.80025599853, 39959.20081598352, 39989.80005099956, 60416.093758593655, 37542.24915501675, 37730.62269377326, 37777.81111094427, 37886.43170352447, 37913.431298530544, 15605.68788624221, 15733.842661573466, 15758.212089395485, 15764.921175394278, 15772.0, 12205.084618653636, 12851.421686023965, 13021.088523803242, 13068.281244531452, 13073.477060917647, 9201.677941272023, 9281.30390220736, 9286.164245217962, 9298.395604285699, 9341.065893410605, 3502.842372093262, 3563.6080031196548, 3598.784072955631, 3623.796396180418, 3636.9272614547563, 1074.7957888001254, 1124.775044991005, 1173.1142987044727, 1177.9587714430124, 1213.5267245774155, 30648.846755766077, 33296.3340733184, 33518.32963340719, 33603.82386616457, 34490.48264276038, 1194.4326444938758, 1211.5396149463147, 1238.4179435665224, 1292.0826213388411, 1315.6579289384829, 12475.937620312023, 15792.92103539475, 17119.22963466647, 17892.73117124112, 18082.367117150836, 327830.0, 334785.0, 335001.0, 335467.0, 336043.0, 59641.0, 60204.39795601988, 60372.39627603756, 60396.0, 60504.0, 1489.5382431446287, 1521.7717342398728, 1534.7697845323069, 1599.2003998001, 1612.999940037161, 29210.0, 29823.0, 30120.397592047597, 30197.245068873453, 31688.683113169496, 42654.146917062106, 43197.568024320615, 43450.13099738051, 43567.0, 43579.34630980474, 242982.0, 243093.0, 244528.0, 244821.0, 245326.0, 26763.86618066897, 28311.575326370534, 30346.69653303439, 30706.389956853916, 30856.0, 43024.0, 43619.345709813744, 43653.56346436622, 43913.121737564434, 44795.77602111969, 36345.81827090848, 36501.26997460089, 36647.0, 36861.26277474489, 36949.63050369462, 35640.465393019644, 35761.0, 36034.0, 36058.0, 36068.63931360653, 40890.38664420095, 41199.58800411958, 41267.0, 41719.7914010428, 42254.577454225066, 34695.93817792812, 35919.28161436809, 36358.81820590986, 36548.451773223955, 36573.541658405295, 27898.581521276792, 27991.14802198108, 28042.71957280401, 28138.2965425866, 28323.858380707963], "value": 18668.57888435694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.0344031090512, 434.7587089165516, 437.6498800959234, 440.7363473478889, 448.50888277336327, 18377.54056148597, 18610.16254268558, 19087.713684294748, 19144.23423063076, 19229.903850480747, 17863.464096077107, 17984.100794960264, 18255.817441825577, 18290.725639115422, 18324.725129123042, 5315.627906046579, 5603.075492543725, 5605.411431799664, 5849.590528662995, 5850.88298234035, 5586.636868603528, 5601.187827764971, 5606.467385598362, 5634.464725851058, 5638.267025286707, 5849.473547380735, 6395.136656551375, 6401.03984402341, 6404.6797660117045, 6408.038794180887, 6152.907706384408, 6239.376062393747, 6310.116583678288, 6312.684365781715, 6316.178896743417, 5806.303243610751, 5814.389489103668, 5832.037713777222, 5832.854178645525, 5840.503557197643, 14050.227237501933, 14286.64283392913, 19835.702464463044, 22930.77069229303, 23018.884905575364, 2491.7134529528976, 2533.8226324157317, 2560.2703229579665, 2574.6266791315343, 2779.4441111777724, 10179.491025448699, 10323.63867264642, 10544.367337959748, 10587.84118238227, 13937.641650259595, 2001.7397738293928, 2009.1059478532059, 2017.213286818142, 2040.5204776877422, 2058.53682921343, 59738.701306493625, 62096.68951655258, 65464.01803972944, 69542.34456422259, 75616.62191689006, 10391.116755075753, 10592.570003049645, 10758.838617420744, 10844.349339039683, 10855.891441085647, 13823.170609763447, 14575.125492470486, 15345.9232703838, 15365.692686146214, 15385.615359615875, 8005.199480052064, 8085.595720213966, 8101.6354264058255, 8310.54292013945, 8341.624626891684, 7852.921470785333, 7932.36541076724, 7948.443608947434, 7993.440459167919, 8061.435699500978, 4778.0, 4851.835559465703, 4853.514648535118, 4858.149823780895, 5069.225770980202, 1981.0779100826167, 1996.4509759816167, 2037.5619241863071, 2110.3457928042358, 2115.6403411420097, 1006.9144122749502, 1070.4273213830563, 1110.3837370259423, 1123.3484578944192, 1128.8532490776147, 16599.585010374838, 17841.107944602718, 18354.541136471697, 18360.81639183618, 18934.05329733508, 1067.1405101427927, 1081.561967403203, 1104.6023431564631, 1119.9384033878052, 1139.7777433400408, 10239.539220735085, 10680.679579612468, 10704.518296676668, 10749.83875241872, 10809.973052559993, 341189.55584927107, 346777.0, 348374.0, 349240.0, 350578.0, 52352.47647523552, 54405.45594544083, 88261.0, 97657.0, 99536.0, 1173.1142987044557, 1175.7413369058793, 1180.3095189314176, 1185.6206014075412, 1230.2434003088035, 16777.1611419431, 16833.494995150166, 16840.0, 17053.0, 17190.656186876444, 36395.27209455743, 39343.21313573655, 40139.397909030806, 40157.19685606213, 40470.79764601158, 48750.756246218545, 50082.74958625183, 50561.747191265276, 50916.23625645544, 51467.227991580905, 8451.704190353308, 8511.276541493795, 8738.432001919855, 8791.428557143765, 9156.496392698466, 11284.379359135326, 13098.821106100497, 13105.606831795061, 13196.80204796948, 13214.801777973145, 10939.0, 11259.831102533632, 11455.942720286344, 11510.769784604094, 11543.191976561897, 10328.896711033094, 11120.388378639253, 11136.33182009082, 11277.492512836778, 11471.713207169887, 11125.499352528994, 11455.0, 11891.227070240408, 11994.460249288977, 12541.811872822098, 8575.056743758307, 8983.505907174907, 9048.321375896703, 9136.223421009288, 9301.0, 11704.824427633423, 11753.236039657395, 11763.353015584225, 11847.881521184678, 11914.16600837933], "value": 9120.728724148188, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.6057143428407, 1502.744533429317, 1534.3248970453, 1732.3676857946853, 1870.6539290231308, 8404.243618074372, 8605.268552173065, 8608.440451370656, 8612.052674205832, 8621.353398495114, 8452.535110568931, 8618.655253789857, 8622.870656940151, 8623.827523449527, 8630.309575233981, 2363.645453182019, 2383.7616238376195, 2385.3678775124604, 2386.6300723387817, 2387.689600351952, 2369.4668699542553, 2389.569877422063, 2445.682061332024, 2465.630155476675, 2465.827392082555, 2373.8694371809543, 2403.9519209615796, 2404.5311164322966, 2406.0496104038893, 2429.307647320514, 2347.260612906929, 2380.809535237177, 2395.413123784675, 2412.107520217522, 2413.8913748881255, 2396.352984694123, 2447.05788271515, 2464.112919349033, 2464.4208610976407, 2468.271859801363, 7540.0, 8089.797755056112, 8745.47527148373, 8751.081136480705, 8770.122987701243, 5306.257124002643, 5391.3799913009725, 5393.649412788156, 5426.782928682848, 5433.1850222466555, 3370.6629337066097, 3371.578552680915, 3389.694927456516, 3412.0, 3468.8265586720813, 1073.897979691928, 1081.9567217311298, 1085.5115198160781, 1092.6448904106119, 1103.8454616353717, 11814.46834892432, 12415.503379864795, 12450.439730212072, 12507.49970001199, 12508.374581270991, 4695.647826412965, 4765.428148622187, 4782.450018247877, 4851.126797176472, 4924.384451943507, 10714.73213169677, 10722.731931701614, 10735.83896241557, 10743.89256107429, 10756.892431075745, 5427.728613569306, 5469.124940009579, 5473.616846820684, 5478.506934375846, 5481.671099734029, 4902.583280421204, 4906.705597664151, 4950.133726597831, 4958.305837182797, 4959.280904268933, 4124.6906482013965, 4145.067359844011, 4148.79256037197, 4205.600467955539, 4231.322988321854, 1321.1610627251764, 1325.5426877727168, 1339.4173534512518, 1343.0464370297002, 1354.8441929178073, 850.7958090058465, 922.5064590444081, 978.0708327089294, 984.9655262065793, 993.2103977338033, 5520.593680911431, 5629.915551266734, 5702.201691763156, 5703.0, 5802.854928626818, 929.800092979999, 982.5578489679673, 1006.8137394581879, 1034.7051090439188, 1036.8030074285862, 3722.3858063419775, 3748.3440397930253, 3750.3811871041516, 3774.3960966245268, 3807.6192380761704, 10819.67540973772, 10993.505292261867, 11018.50416731249, 11026.779464410667, 11119.72200694989, 10922.344659320466, 10935.56257749697, 10949.014588687056, 10954.0, 10954.890451095547, 8246.09292977772, 8500.40497165205, 8506.276966457797, 8552.871706924401, 8579.541477948638, 5559.332880054258, 5567.0, 5589.748461319169, 5688.232088667977, 5725.0267454531995, 9658.9034109658, 9748.415095094317, 9858.112769850748, 9928.652497162564, 9949.054839790208, 9899.20806335477, 10074.899251007397, 10088.89911100909, 10111.64609238673, 10186.847197292194, 7454.664540095817, 7584.431167662337, 7624.885626715714, 7628.0464941882265, 7632.656530456254, 8504.744857654281, 8557.35819813504, 8565.100664430394, 8572.0, 8573.099824518336, 7488.400927925644, 7663.27198916102, 7718.0, 7828.882566761389, 7870.527768333918, 7471.327580517779, 7617.390608751176, 7714.845703086019, 7854.764357069297, 7902.723404680809, 6712.295209002984, 6833.58998460094, 6864.553804002724, 6891.207511136284, 6891.793246202622, 4514.210013247734, 5048.318477005557, 5082.263071854634, 5164.32863727713, 5212.947870521246, 5008.549230569266, 5041.0, 5146.0, 5212.921806172834, 5243.0], "value": 4664.150331355968, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.6655110747006, 362.912900903783, 366.45032451323016, 367.5662717992769, 374.0349897265055, 6178.196834411526, 6184.938150618498, 6237.563370564062, 6239.750409983607, 6266.404691554295, 6135.938640613604, 6149.354317796634, 6149.784757533487, 6158.84602884927, 6165.828492586405, 4515.119551687422, 4604.470485894131, 4712.670113092067, 4729.172394830908, 4751.16854550454, 4705.29420586913, 4723.149833030053, 4739.431268247798, 4746.169420351442, 4749.145153872301, 4482.574155455227, 4693.530646935296, 4697.295405689157, 4700.553447422507, 4702.694324868889, 4571.062932098912, 4615.676902616819, 4625.4911959684405, 4661.790219440133, 4742.5731684148595, 4160.791960401998, 4171.10321280923, 4191.517975432834, 4199.908023913774, 4201.642860356873, 5922.3781502942, 5924.9703751480965, 5925.674087925162, 5927.170196172539, 5933.732982015819, 5500.697461639608, 5503.3395992480755, 5507.752151153208, 5512.944870551323, 5513.476219759116, 6332.746690132389, 6461.741530338781, 6461.773837915651, 6464.321246269168, 6468.223813142406, 4628.699134556243, 4657.18499262631, 4658.557437043475, 4662.836800711959, 4665.020345727401, 6747.696353664097, 6769.255381908036, 6781.423578995791, 6783.0, 6783.830404239884, 4758.595519380891, 4766.118268120409, 4772.331873537708, 4773.76131193439, 4778.259369797617, 4821.2045012573235, 4826.493218212107, 4827.975860120747, 4830.082284365959, 4830.2513110467235, 5482.5613950883835, 5486.451354864482, 5486.807961721321, 5491.2312276281355, 5497.120460726344, 6301.779437719658, 6528.54300198991, 6540.901886471706, 6544.705488252945, 6553.246376666649, 1636.1573789498418, 1644.3093900561794, 1651.4962936304303, 1652.8512433881008, 1652.9338826446808, 1039.622500187255, 1045.0698877998586, 1060.490964337107, 1062.914966802654, 1093.0435868614961, 6346.30190679025, 6487.740490380332, 6496.22045354551, 6498.577592456475, 6500.5449618526245, 6783.423409010289, 6812.318768123148, 6816.386525212655, 6867.175938887365, 6869.0383346330555, 6460.353964603502, 6461.709223084972, 6466.932956062291, 6482.157319548429, 6490.350964903472, 3616.439451884962, 3648.7993160376436, 3652.3060618482405, 3661.5972243053243, 3661.9267614648093, 6986.476014298846, 7170.641467926583, 7283.526570772883, 7289.052423184952, 7291.8906216406795, 6949.409300209438, 6952.096227490394, 6961.443084553223, 6975.651217439107, 6982.61595612236, 7135.5361901476235, 7154.4634152438775, 7156.320149585781, 7156.928430715626, 7192.208857025723, 6781.7287308509085, 6783.762568310085, 6784.151981002375, 6787.151606049244, 6863.0, 6501.902471463027, 6696.296888826603, 6703.3296670332575, 6706.295838937037, 6728.293529179366, 7114.723288547615, 7155.640428318603, 7159.928400715926, 7160.677769500281, 7162.104736907887, 4644.210484217623, 4650.5116962719785, 4678.836240731558, 4685.835995740133, 4695.9530404695515, 6756.594604323756, 6760.3239676032, 6768.120144381199, 6796.456283497408, 6849.691763870538, 6360.268569114611, 6547.0, 6597.208334999831, 6599.835004124935, 6606.966965165144, 6554.770583029571, 6589.703463344065, 6599.8020059398295, 6605.372489613479, 6606.10817539626, 6491.513136514686, 6493.577917435352, 6498.610083395011, 6500.447461965786, 6504.739810407531, 6634.568753031038, 6634.635095069624, 6637.568558043712, 6643.800685979235, 6648.933510664831, 6366.6180029198395, 6500.837479063061, 6513.609183449008, 6516.967415162894, 6521.902171467526], "value": 4977.472456593909, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.9549024803633, 842.469244376043, 889.492988996272, 895.2703546609513, 951.6288647427505, 15391.0, 15395.307211175495, 15495.535133945972, 15569.610759730998, 15603.141827199499, 14032.228227447511, 14350.282485875716, 14369.066010709297, 14376.784348234785, 14400.279986000683, 747.2564798025971, 872.8210716803072, 874.4971641306242, 892.8839250897374, 900.8468560344758, 892.7411050795262, 893.1024320557831, 896.1218006353777, 897.1611543207122, 899.0964081098487, 940.8917974432959, 943.0333907744548, 946.9905300946971, 949.6818565780471, 950.0546955778975, 779.185750890321, 918.7427520294328, 936.2182577547755, 938.7324612485409, 942.8067246214509, 690.4545409126783, 690.6684791300204, 691.401937324216, 692.390696187357, 692.9341712537301, 15542.5337239883, 15545.378184872592, 15677.372905083783, 15688.843111568853, 15704.921475392664, 15170.772438413433, 15275.770863437057, 15417.768733469007, 15617.219139043002, 15649.843501564952, 12173.695657608541, 12310.938445307716, 12321.445534950948, 12441.75116497674, 12521.874781252161, 4072.1041370898356, 4111.71218014739, 4140.585941405865, 4183.49798024239, 4270.274053410928, 54954.725226374016, 55170.44829551734, 55495.89008219813, 55611.72194139044, 55771.44228557703, 11171.44142792857, 11171.608993685182, 11193.328400295846, 11228.606998755004, 11429.142814288962, 19585.1186696599, 19623.50941226452, 19633.116509757096, 19641.607167856564, 19657.213711451666, 8157.673693052211, 8399.790005249917, 8693.782655433664, 8908.643654253758, 8944.552772361356, 4704.1767690654, 4780.545848144421, 5035.931757090345, 5058.342415485963, 5207.947920520822, 3497.0557949353533, 3561.6260292669413, 3564.144605294711, 3565.090901820019, 3567.2152126532123, 664.7221064745902, 665.3612531969363, 670.4435318685479, 674.4873895839099, 675.3415419965593, 800.1998001998002, 820.979475513117, 829.5644786487143, 829.7966998085387, 841.7096101844854, 10193.643222487177, 10429.37423754562, 10574.577016919391, 10771.89228107709, 10785.191110666574, 767.117814513303, 800.1238643685156, 811.6469335838929, 861.0829466618031, 862.8748831419409, 4731.195696731564, 4954.256861470736, 5002.724850133205, 5009.223570346602, 5054.09026375256, 63902.0, 64724.67637661876, 64964.675176623816, 65083.0, 65085.0, 55431.44568554343, 55647.16529252064, 56001.43998560044, 56610.15084773731, 57000.0, 47270.5272947273, 47927.0, 48154.0, 48183.27725084127, 52484.47515524872, 9982.500874956368, 10400.47997600102, 10433.9478302608, 10538.156947444033, 10663.466826658481, 37319.81340093282, 39627.405588915615, 39933.0, 40329.596704032585, 41018.58981410148, 41313.79343103385, 41577.58422415858, 45972.540274596824, 50232.74883625558, 50838.49161508486, 12197.634070977885, 12230.816537752118, 13062.869371306166, 13121.409536571067, 13549.390277437342, 12235.93882030584, 12941.223526588436, 13314.0, 13692.52076177329, 13832.930835345758, 13345.914398829698, 13479.258640774458, 13935.0, 13949.511767088103, 13960.371783269575, 13869.930650346683, 13921.930390347983, 13997.090189137674, 14171.220582867629, 14180.361883715052, 12440.37798110109, 13111.14777539457, 13140.605781826178, 13252.933735331262, 13458.730825383242, 11057.391843448688, 11240.4379781009, 11330.886691133313, 11394.145439092266, 11443.14176436754, 11058.834117488404, 11331.603393881174, 11399.658010259705, 11435.59975400857, 11570.884291157317], "value": 7240.404187686382, "unit": "score"}], "name": "dromaeo_css", "value": 7314.360419147984, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 110.0, 111.0, 111.0, 109.0, 111.0, 109.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 150.0, 173.0, 126.0, 149.0, 147.0, 126.0, 185.0, 127.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 160.0, 160.0, 162.0, 162.0, 159.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 168.0, 75.0, 75.0, 73.0, 76.0, 157.0, 76.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 158.0, 92.0, 92.0, 92.0, 153.0, 93.0, 91.0, 147.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 118.0, 117.0, 116.0, 118.0, 118.0, 120.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 147.0, 147.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 56.0, 57.0, 56.0, 57.0, 78.0, 53.0, 53.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 57.0, 58.0, 57.0, 59.0, 58.0, 59.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 73.0, 79.0, 72.0, 73.0, 73.0, 72.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 119.0, 112.0, 111.0, 110.0, 113.0, 112.0, 129.0, 128.0], "value": 116.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 155.0, 167.0, 163.0, 160.0, 158.0, 157.0, 157.0, 157.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 67.0, 70.0, 67.0, 67.0, 66.0, 68.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1508.9, "alertThreshold": 2.0}]} 05:45:27 INFO - Return code: 0 05:45:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:45:27 ERROR - # TBPL SUCCESS # 05:45:27 INFO - Running post-action listener: _resource_record_post_action 05:45:27 INFO - Running post-run listener: _resource_record_post_run 05:45:28 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 24576; Write bytes: 471052288; Read time: 4; Write time: 523524 05:45:28 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 254238720; Read time: 0; Write time: 352308 05:45:28 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 216813568; Read time: 0; Write time: 171216 05:45:28 INFO - Running post-run listener: _upload_blobber_files 05:45:28 INFO - Blob upload gear active. 05:45:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:45:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:45:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:45:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:45:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:45:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:29 INFO - (blobuploader) - INFO - Done attempting. 05:45:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:45:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:45:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:30 INFO - (blobuploader) - INFO - Done attempting. 05:45:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:45:30 INFO - Return code: 0 05:45:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:45:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:45:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deb707504be627dd38428b4aa1120d91d9f203ddc6f8697475d646ff5f3fc988000c4dffc9f5903c2f368713480dcf1df08b83ee21c5daa48646399e21961aef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b131a0a7deaca9f36968ea74319db111960837e927fbafaa32b2ed92002e5a0b8804c15fc24b52aabd1e9b243d47f6bbcac0087121cbf7b62e19d7c6a2f64c7"} 05:45:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:45:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:45:30 INFO - Contents: 05:45:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deb707504be627dd38428b4aa1120d91d9f203ddc6f8697475d646ff5f3fc988000c4dffc9f5903c2f368713480dcf1df08b83ee21c5daa48646399e21961aef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b131a0a7deaca9f36968ea74319db111960837e927fbafaa32b2ed92002e5a0b8804c15fc24b52aabd1e9b243d47f6bbcac0087121cbf7b62e19d7c6a2f64c7"} 05:45:30 INFO - Running post-run listener: copy_logs_to_upload_dir 05:45:30 INFO - Copying logs to upload dir... 05:45:30 INFO - mkdir: /builds/slave/test/build/upload/logs 05:45:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.905173 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-18 05:45:30.674281) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:45:30.677660) ========= 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=db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deb707504be627dd38428b4aa1120d91d9f203ddc6f8697475d646ff5f3fc988000c4dffc9f5903c2f368713480dcf1df08b83ee21c5daa48646399e21961aef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b131a0a7deaca9f36968ea74319db111960837e927fbafaa32b2ed92002e5a0b8804c15fc24b52aabd1e9b243d47f6bbcac0087121cbf7b62e19d7c6a2f64c7"} build_url:https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/SeiL8eXPQEu8lRRffsvJBg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deb707504be627dd38428b4aa1120d91d9f203ddc6f8697475d646ff5f3fc988000c4dffc9f5903c2f368713480dcf1df08b83ee21c5daa48646399e21961aef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b131a0a7deaca9f36968ea74319db111960837e927fbafaa32b2ed92002e5a0b8804c15fc24b52aabd1e9b243d47f6bbcac0087121cbf7b62e19d7c6a2f64c7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:45:30.703574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:45:30.703896) ========= 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=db7e7c15f3ca076d53731445000001ba-1468844671.920141-1446555518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:45:30.786514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:45:30.786886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:45:30.787264) ========= ========= Total master_lag: 0.17 =========