builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1460682013.79 results: success (0) buildid: 20160414152344 builduid: bb0e29c7e0964319b3f18880000e6ad6 revision: 076bf6a0ac85ec6a4f3ee7c3efe653964d92b9f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:13.785946) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:13.786464) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:13.786795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:13.805370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:13.805747) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 18:00:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-04-14 18:00:14 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137359 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:13.958401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:13.958744) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019646 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:14.011868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:14.012261) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 076bf6a0ac85ec6a4f3ee7c3efe653964d92b9f2 --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 076bf6a0ac85ec6a4f3ee7c3efe653964d92b9f2 --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=337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 18:00:14,205 truncating revision to first 12 chars 2016-04-14 18:00:14,206 Setting DEBUG logging. 2016-04-14 18:00:14,206 attempt 1/10 2016-04-14 18:00:14,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/076bf6a0ac85?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 18:00:14,492 unpacking tar archive at: mozilla-beta-076bf6a0ac85/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589817 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:14.615430) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:14.615791) ========= script_repo_revision: 076bf6a0ac85ec6a4f3ee7c3efe653964d92b9f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:14.616235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:14.616553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 18:00:14.629446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-14 18:00:14.629762) ========= /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=337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:00:14 INFO - MultiFileLogger online at 20160414 18:00:14 in /builds/slave/test 18:00:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 18:00:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:00:14 INFO - {'append_to_log': False, 18:00:14 INFO - 'base_work_dir': '/builds/slave/test', 18:00:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:00:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:00:14 INFO - 'branch': 'Mozilla-Beta', 18:00:14 INFO - 'buildbot_json_path': 'buildprops.json', 18:00:14 INFO - 'config_files': ('talos/linux_config.py',), 18:00:14 INFO - 'default_actions': ('clobber', 18:00:14 INFO - 'read-buildbot-config', 18:00:14 INFO - 'download-and-extract', 18:00:14 INFO - 'populate-webroot', 18:00:14 INFO - 'create-virtualenv', 18:00:14 INFO - 'install', 18:00:14 INFO - 'run-tests'), 18:00:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:00:14 INFO - 'download_minidump_stackwalk': True, 18:00:14 INFO - 'download_symbols': 'ondemand', 18:00:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:00:14 INFO - 'tooltool.py': '/tools/tooltool.py', 18:00:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:00:14 INFO - '/tools/misc-python/virtualenv.py')}, 18:00:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:00:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:00:14 INFO - 'installer_path': 'installer.exe', 18:00:14 INFO - 'log_level': 'info', 18:00:14 INFO - 'log_name': 'talos', 18:00:14 INFO - 'log_to_console': True, 18:00:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:00:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:00:14 INFO - 'opt_config_files': (), 18:00:14 INFO - 'pip_index': False, 18:00:14 INFO - 'sps_profile': False, 18:00:14 INFO - 'sps_profile_interval': 0, 18:00:14 INFO - 'suite': 'dromaeojs', 18:00:14 INFO - 'system_bits': '32', 18:00:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:00:14 INFO - 'title': 'talos-linux64-ix-060', 18:00:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:00:14 INFO - 'use_talos_json': True, 18:00:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:00:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:00:14 INFO - 'work_dir': 'build'} 18:00:14 INFO - ##### 18:00:14 INFO - ##### Running clobber step. 18:00:14 INFO - ##### 18:00:14 INFO - Running pre-action listener: _resource_record_pre_action 18:00:14 INFO - Running main action method: clobber 18:00:14 INFO - rmtree: /builds/slave/test/build 18:00:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:00:15 INFO - Running post-action listener: _resource_record_post_action 18:00:15 INFO - ##### 18:00:15 INFO - ##### Running read-buildbot-config step. 18:00:15 INFO - ##### 18:00:15 INFO - Running pre-action listener: _resource_record_pre_action 18:00:15 INFO - Running main action method: read_buildbot_config 18:00:15 INFO - Using buildbot properties: 18:00:15 INFO - { 18:00:15 INFO - "project": "", 18:00:15 INFO - "product": "firefox", 18:00:15 INFO - "script_repo_revision": "production", 18:00:15 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 18:00:15 INFO - "repository": "", 18:00:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 18:00:15 INFO - "buildid": "20160414152344", 18:00:15 INFO - "pgo_build": "True", 18:00:15 INFO - "basedir": "/builds/slave/test", 18:00:15 INFO - "buildnumber": 167, 18:00:15 INFO - "slavename": "talos-linux64-ix-060", 18:00:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:00:15 INFO - "platform": "ubuntu64_hw", 18:00:15 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 18:00:15 INFO - "branch": "mozilla-beta", 18:00:15 INFO - "repo_path": "releases/mozilla-beta", 18:00:15 INFO - "revision": "076bf6a0ac85ec6a4f3ee7c3efe653964d92b9f2", 18:00:15 INFO - "stage_platform": "linux64-pgo", 18:00:15 INFO - "builduid": "bb0e29c7e0964319b3f18880000e6ad6", 18:00:15 INFO - "slavebuilddir": "test" 18:00:15 INFO - } 18:00:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 18:00:15 INFO - Running post-action listener: _resource_record_post_action 18:00:15 INFO - ##### 18:00:15 INFO - ##### Running download-and-extract step. 18:00:15 INFO - ##### 18:00:15 INFO - Running pre-action listener: _resource_record_pre_action 18:00:15 INFO - Running main action method: download_and_extract 18:00:15 INFO - mkdir: /builds/slave/test/build/tests 18:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:15 INFO - https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:00:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/test_packages.json 18:00:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/test_packages.json 18:00:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:00:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:00:25 INFO - Downloaded 1412 bytes. 18:00:25 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:00:25 INFO - Using the following test package requirements: 18:00:25 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 18:00:25 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:00:25 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 18:00:25 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:00:25 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 18:00:25 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:00:25 INFO - u'jsshell-linux-x86_64.zip'], 18:00:25 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:00:25 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 18:00:25 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 18:00:25 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:00:25 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 18:00:25 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:00:25 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 18:00:25 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:00:25 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 18:00:25 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 18:00:25 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:00:25 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 18:00:25 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:25 INFO - https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:00:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 18:00:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 18:00:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 18:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:00:27 INFO - Downloaded 23147564 bytes. 18:00:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:00:28 INFO - Return code: 0 18:00:28 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:28 INFO - https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 18:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 18:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 18:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:00:30 INFO - Downloaded 23147564 bytes. 18:00:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:00:31 INFO - Return code: 0 18:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:31 INFO - https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:00:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 18:00:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 18:00:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 18:00:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:00:32 INFO - Downloaded 10801548 bytes. 18:00:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:00:32 INFO - Return code: 0 18:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:32 INFO - https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 18:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 18:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 18:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:00:34 INFO - Downloaded 52878012 bytes. 18:00:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 18:00:34 INFO - mkdir: /builds/slave/test/properties 18:00:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:00:34 INFO - Writing to file /builds/slave/test/properties/build_url 18:00:34 INFO - Contents: 18:00:34 INFO - build_url:https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 18:00:35 INFO - Running post-action listener: _resource_record_post_action 18:00:35 INFO - Running post-action listener: set_extra_try_arguments 18:00:35 INFO - ##### 18:00:35 INFO - ##### Running populate-webroot step. 18:00:35 INFO - ##### 18:00:35 INFO - Running pre-action listener: _resource_record_pre_action 18:00:35 INFO - Running main action method: populate_webroot 18:00:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:00:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:00:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:00:35 INFO - '--tppagecycles', 18:00:35 INFO - '7'], 18:00:35 INFO - 'tests': ['tsvgm']}}, 18:00:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:00:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:00:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:00:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:00:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:00:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:00:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:35 INFO - 'talos_options': ['--e10s'], 18:00:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:35 INFO - 'tests': ['damp', 'tps']}, 18:00:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:35 INFO - 'talos_options': ['--e10s'], 18:00:35 INFO - 'tests': ['damp', 'tps']}, 18:00:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:00:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:00:35 INFO - 'other': {'tests': ['a11yr', 18:00:35 INFO - 'ts_paint', 18:00:35 INFO - 'tpaint', 18:00:35 INFO - 'sessionrestore', 18:00:35 INFO - 'sessionrestore_no_auto_restore']}, 18:00:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:00:35 INFO - 'tests': ['a11yr', 18:00:35 INFO - 'ts_paint', 18:00:35 INFO - 'tpaint', 18:00:35 INFO - 'sessionrestore', 18:00:35 INFO - 'sessionrestore_no_auto_restore']}, 18:00:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:00:35 INFO - 'tests': ['a11yr', 18:00:35 INFO - 'ts_paint', 18:00:35 INFO - 'tpaint', 18:00:35 INFO - 'sessionrestore', 18:00:35 INFO - 'sessionrestore_no_auto_restore']}, 18:00:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:00:35 INFO - 'tests': ['a11yr', 18:00:35 INFO - 'ts_paint', 18:00:35 INFO - 'tpaint', 18:00:35 INFO - 'sessionrestore', 18:00:35 INFO - 'sessionrestore_no_auto_restore']}, 18:00:35 INFO - 'other_l64': {'tests': ['a11yr', 18:00:35 INFO - 'ts_paint', 18:00:35 INFO - 'tpaint', 18:00:35 INFO - 'sessionrestore', 18:00:35 INFO - 'sessionrestore_no_auto_restore']}, 18:00:35 INFO - 'other_nol64': {'tests': ['a11yr', 18:00:35 INFO - 'ts_paint', 18:00:35 INFO - 'tpaint', 18:00:35 INFO - 'sessionrestore', 18:00:35 INFO - 'sessionrestore_no_auto_restore']}, 18:00:35 INFO - 'svgr': {'tests': ['tsvgx', 18:00:35 INFO - 'tsvgr_opacity', 18:00:35 INFO - 'tart', 18:00:35 INFO - 'tscrollx', 18:00:35 INFO - 'cart']}, 18:00:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:00:35 INFO - 'tests': ['tsvgx', 18:00:35 INFO - 'tsvgr_opacity', 18:00:35 INFO - 'tart', 18:00:35 INFO - 'tscrollx', 18:00:35 INFO - 'cart']}, 18:00:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:35 INFO - 'tests': ['tp5o']}, 18:00:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:35 INFO - 'talos_options': ['--e10s'], 18:00:35 INFO - 'tests': ['tp5o']}, 18:00:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:35 INFO - 'talos_options': ['--xperf_path', 18:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:35 INFO - 'tests': ['tp5n']}, 18:00:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:35 INFO - 'talos_options': ['--e10s', 18:00:35 INFO - '--xperf_path', 18:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:35 INFO - 'tests': ['tp5n']}}, 18:00:35 INFO - 'talos.zip': {'path': '', 18:00:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:00:35 INFO - Running post-action listener: _resource_record_post_action 18:00:35 INFO - ##### 18:00:35 INFO - ##### Running create-virtualenv step. 18:00:35 INFO - ##### 18:00:35 INFO - Running pre-action listener: _resource_record_pre_action 18:00:35 INFO - Running main action method: create_virtualenv 18:00:35 INFO - Creating virtualenv /builds/slave/test/build/venv 18:00:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:00:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:00:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:00:35 INFO - Using real prefix '/usr' 18:00:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:00:36 INFO - Installing distribute.............................................................................................................................................................................................done. 18:00:38 INFO - Installing pip.................done. 18:00:38 INFO - Return code: 0 18:00:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:38 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 0x7fba4fb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2905430>, '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 0x2870f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28713c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:00:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:00:38 INFO - Using env: {'DISPLAY': ':0', 18:00:38 INFO - 'HOME': '/home/cltbld', 18:00:38 INFO - 'LANG': 'en_US.UTF-8', 18:00:38 INFO - 'LANGUAGE': 'en_US:en', 18:00:38 INFO - 'LOGNAME': 'cltbld', 18:00:38 INFO - 'MAIL': '/var/mail/cltbld', 18:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:38 INFO - 'MOZ_NO_REMOTE': '1', 18:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:38 INFO - 'NO_EM_RESTART': '1', 18:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:38 INFO - 'PWD': '/builds/slave/test', 18:00:38 INFO - 'SHELL': '/bin/bash', 18:00:38 INFO - 'SHLVL': '1', 18:00:38 INFO - 'TERM': 'linux', 18:00:38 INFO - 'TMOUT': '86400', 18:00:38 INFO - 'USER': 'cltbld', 18:00:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 18:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:38 INFO - '_': '/tools/buildbot/bin/python'} 18:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:00:38 INFO - Cleaning up... 18:00:38 INFO - Return code: 0 18:00:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:38 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 0x7fba4fb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2905430>, '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 0x2870f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28713c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:00:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:00:38 INFO - Using env: {'DISPLAY': ':0', 18:00:38 INFO - 'HOME': '/home/cltbld', 18:00:38 INFO - 'LANG': 'en_US.UTF-8', 18:00:38 INFO - 'LANGUAGE': 'en_US:en', 18:00:38 INFO - 'LOGNAME': 'cltbld', 18:00:38 INFO - 'MAIL': '/var/mail/cltbld', 18:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:38 INFO - 'MOZ_NO_REMOTE': '1', 18:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:38 INFO - 'NO_EM_RESTART': '1', 18:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:38 INFO - 'PWD': '/builds/slave/test', 18:00:38 INFO - 'SHELL': '/bin/bash', 18:00:38 INFO - 'SHLVL': '1', 18:00:38 INFO - 'TERM': 'linux', 18:00:38 INFO - 'TMOUT': '86400', 18:00:38 INFO - 'USER': 'cltbld', 18:00:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 18:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:38 INFO - '_': '/tools/buildbot/bin/python'} 18:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:38 INFO - Downloading/unpacking psutil>=0.7.1 18:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:00:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:40 INFO - Installing collected packages: psutil 18:00:40 INFO - Running setup.py install for psutil 18:00:40 INFO - building 'psutil._psutil_linux' extension 18:00:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:00:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:00:40 INFO - building 'psutil._psutil_posix' extension 18:00:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:00:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:00:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:40 INFO - Successfully installed psutil 18:00:40 INFO - Cleaning up... 18:00:41 INFO - Return code: 0 18:00:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:41 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 0x7fba4fb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2905430>, '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 0x2870f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28713c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:00:41 INFO - Using env: {'DISPLAY': ':0', 18:00:41 INFO - 'HOME': '/home/cltbld', 18:00:41 INFO - 'LANG': 'en_US.UTF-8', 18:00:41 INFO - 'LANGUAGE': 'en_US:en', 18:00:41 INFO - 'LOGNAME': 'cltbld', 18:00:41 INFO - 'MAIL': '/var/mail/cltbld', 18:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:41 INFO - 'MOZ_NO_REMOTE': '1', 18:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:41 INFO - 'NO_EM_RESTART': '1', 18:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:41 INFO - 'PWD': '/builds/slave/test', 18:00:41 INFO - 'SHELL': '/bin/bash', 18:00:41 INFO - 'SHLVL': '1', 18:00:41 INFO - 'TERM': 'linux', 18:00:41 INFO - 'TMOUT': '86400', 18:00:41 INFO - 'USER': 'cltbld', 18:00:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 18:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:41 INFO - '_': '/tools/buildbot/bin/python'} 18:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:00:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:00:43 INFO - Installing collected packages: mozsystemmonitor 18:00:43 INFO - Running setup.py install for mozsystemmonitor 18:00:43 INFO - Successfully installed mozsystemmonitor 18:00:43 INFO - Cleaning up... 18:00:43 INFO - Return code: 0 18:00:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:43 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 0x7fba4fb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2905430>, '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 0x2870f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28713c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:00:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:00:43 INFO - Using env: {'DISPLAY': ':0', 18:00:43 INFO - 'HOME': '/home/cltbld', 18:00:43 INFO - 'LANG': 'en_US.UTF-8', 18:00:43 INFO - 'LANGUAGE': 'en_US:en', 18:00:43 INFO - 'LOGNAME': 'cltbld', 18:00:43 INFO - 'MAIL': '/var/mail/cltbld', 18:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:43 INFO - 'MOZ_NO_REMOTE': '1', 18:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:43 INFO - 'NO_EM_RESTART': '1', 18:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:43 INFO - 'PWD': '/builds/slave/test', 18:00:43 INFO - 'SHELL': '/bin/bash', 18:00:43 INFO - 'SHLVL': '1', 18:00:43 INFO - 'TERM': 'linux', 18:00:43 INFO - 'TMOUT': '86400', 18:00:43 INFO - 'USER': 'cltbld', 18:00:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 18:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:43 INFO - '_': '/tools/buildbot/bin/python'} 18:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:43 INFO - Downloading/unpacking blobuploader==1.2.4 18:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:45 INFO - Downloading blobuploader-1.2.4.tar.gz 18:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:00:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:00:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:46 INFO - Downloading docopt-0.6.1.tar.gz 18:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:00:46 INFO - Installing collected packages: blobuploader, requests, docopt 18:00:46 INFO - Running setup.py install for blobuploader 18:00:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:00:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:00:46 INFO - Running setup.py install for requests 18:00:46 INFO - Running setup.py install for docopt 18:00:46 INFO - Successfully installed blobuploader requests docopt 18:00:46 INFO - Cleaning up... 18:00:46 INFO - Return code: 0 18:00:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba4fb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2905430>, '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 0x2870f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28713c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:00:46 INFO - Using env: {'DISPLAY': ':0', 18:00:46 INFO - 'HOME': '/home/cltbld', 18:00:46 INFO - 'LANG': 'en_US.UTF-8', 18:00:46 INFO - 'LANGUAGE': 'en_US:en', 18:00:46 INFO - 'LOGNAME': 'cltbld', 18:00:46 INFO - 'MAIL': '/var/mail/cltbld', 18:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:46 INFO - 'MOZ_NO_REMOTE': '1', 18:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:46 INFO - 'NO_EM_RESTART': '1', 18:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:46 INFO - 'PWD': '/builds/slave/test', 18:00:46 INFO - 'SHELL': '/bin/bash', 18:00:46 INFO - 'SHLVL': '1', 18:00:46 INFO - 'TERM': 'linux', 18:00:46 INFO - 'TMOUT': '86400', 18:00:46 INFO - 'USER': 'cltbld', 18:00:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 18:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:46 INFO - '_': '/tools/buildbot/bin/python'} 18:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:46 INFO - Running setup.py (path:/tmp/pip-06xShD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:47 INFO - Running setup.py (path:/tmp/pip-nrMvaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:47 INFO - Running setup.py (path:/tmp/pip-LUniOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:47 INFO - Running setup.py (path:/tmp/pip-i00dR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:47 INFO - Running setup.py (path:/tmp/pip-b0L0vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:47 INFO - Running setup.py (path:/tmp/pip-vtBiiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:47 INFO - Running setup.py (path:/tmp/pip-tR9kzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:47 INFO - Running setup.py (path:/tmp/pip-fmdagA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:47 INFO - Running setup.py (path:/tmp/pip-omuRfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:47 INFO - Running setup.py (path:/tmp/pip-0IhGtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:47 INFO - Running setup.py (path:/tmp/pip-5BGfZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:47 INFO - Running setup.py (path:/tmp/pip-6m6DPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:47 INFO - Running setup.py (path:/tmp/pip-RGzkve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:47 INFO - Running setup.py (path:/tmp/pip-8jijpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:47 INFO - Running setup.py (path:/tmp/pip-dSeEhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:48 INFO - Running setup.py (path:/tmp/pip-bbCN6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:48 INFO - Running setup.py (path:/tmp/pip-WDHFIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:00:48 INFO - Running setup.py install for manifestparser 18:00:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:00:48 INFO - Running setup.py install for mozcrash 18:00:48 INFO - Running setup.py install for mozdebug 18:00:48 INFO - Running setup.py install for mozdevice 18:00:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:00:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:00:48 INFO - Running setup.py install for mozfile 18:00:48 INFO - Running setup.py install for mozhttpd 18:00:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:00:48 INFO - Running setup.py install for mozinfo 18:00:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:00:48 INFO - Running setup.py install for mozInstall 18:00:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:00:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:00:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:00:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:00:48 INFO - Running setup.py install for mozleak 18:00:49 INFO - Running setup.py install for mozlog 18:00:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:00:49 INFO - Running setup.py install for moznetwork 18:00:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:00:49 INFO - Running setup.py install for mozprocess 18:00:49 INFO - Running setup.py install for mozprofile 18:00:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:00:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:00:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:00:49 INFO - Running setup.py install for mozrunner 18:00:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:00:49 INFO - Running setup.py install for mozscreenshot 18:00:49 INFO - Running setup.py install for moztest 18:00:49 INFO - Running setup.py install for mozversion 18:00:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:00:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:00:49 INFO - Cleaning up... 18:00:49 INFO - Return code: 0 18:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba4fb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2905430>, '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 0x2870f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28713c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:00:49 INFO - Using env: {'DISPLAY': ':0', 18:00:49 INFO - 'HOME': '/home/cltbld', 18:00:49 INFO - 'LANG': 'en_US.UTF-8', 18:00:49 INFO - 'LANGUAGE': 'en_US:en', 18:00:49 INFO - 'LOGNAME': 'cltbld', 18:00:49 INFO - 'MAIL': '/var/mail/cltbld', 18:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:49 INFO - 'MOZ_NO_REMOTE': '1', 18:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:49 INFO - 'NO_EM_RESTART': '1', 18:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:49 INFO - 'PWD': '/builds/slave/test', 18:00:49 INFO - 'SHELL': '/bin/bash', 18:00:49 INFO - 'SHLVL': '1', 18:00:49 INFO - 'TERM': 'linux', 18:00:49 INFO - 'TMOUT': '86400', 18:00:49 INFO - 'USER': 'cltbld', 18:00:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 18:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:49 INFO - '_': '/tools/buildbot/bin/python'} 18:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:50 INFO - Running setup.py (path:/tmp/pip-l5eu9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:50 INFO - Running setup.py (path:/tmp/pip-Qfx4dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:50 INFO - Running setup.py (path:/tmp/pip-6H9EYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:50 INFO - Running setup.py (path:/tmp/pip-la0RWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:50 INFO - Running setup.py (path:/tmp/pip-c75vxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:50 INFO - Running setup.py (path:/tmp/pip-9kNuNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:50 INFO - Running setup.py (path:/tmp/pip-PIptNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:50 INFO - Running setup.py (path:/tmp/pip-voo3Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:50 INFO - Running setup.py (path:/tmp/pip-MiHhYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:50 INFO - Running setup.py (path:/tmp/pip-mOL4in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:50 INFO - Running setup.py (path:/tmp/pip-IEGtZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:50 INFO - Running setup.py (path:/tmp/pip-0QIvWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:51 INFO - Running setup.py (path:/tmp/pip-ZmFvuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:51 INFO - Running setup.py (path:/tmp/pip-ExTbmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:51 INFO - Running setup.py (path:/tmp/pip-_be9ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:51 INFO - Running setup.py (path:/tmp/pip-nb_nCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:51 INFO - Running setup.py (path:/tmp/pip-q5cN7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:00:51 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:00:51 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:00:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:53 INFO - Downloading blessings-1.6.tar.gz 18:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:00:53 INFO - Installing collected packages: blessings 18:00:53 INFO - Running setup.py install for blessings 18:00:53 INFO - Successfully installed blessings 18:00:53 INFO - Cleaning up... 18:00:53 INFO - Return code: 0 18:00:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:00:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:53 INFO - Reading from file tmpfile_stdout 18:00:53 INFO - Current package versions: 18:00:53 INFO - argparse == 1.2.1 18:00:53 INFO - blessings == 1.6 18:00:53 INFO - blobuploader == 1.2.4 18:00:53 INFO - docopt == 0.6.1 18:00:53 INFO - manifestparser == 1.1 18:00:53 INFO - mozInstall == 1.12 18:00:53 INFO - mozcrash == 0.16 18:00:53 INFO - mozdebug == 0.1 18:00:53 INFO - mozdevice == 0.48 18:00:53 INFO - mozfile == 1.2 18:00:53 INFO - mozhttpd == 0.7 18:00:53 INFO - mozinfo == 0.9 18:00:53 INFO - mozleak == 0.1 18:00:53 INFO - mozlog == 3.1 18:00:53 INFO - moznetwork == 0.27 18:00:53 INFO - mozprocess == 0.22 18:00:53 INFO - mozprofile == 0.28 18:00:53 INFO - mozrunner == 6.11 18:00:53 INFO - mozscreenshot == 0.1 18:00:53 INFO - mozsystemmonitor == 0.0 18:00:53 INFO - moztest == 0.7 18:00:53 INFO - mozversion == 1.4 18:00:53 INFO - psutil == 3.1.1 18:00:53 INFO - requests == 1.2.3 18:00:53 INFO - wsgiref == 0.1.2 18:00:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba4fb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2905430>, '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 0x2870f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28713c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:00:53 INFO - Using env: {'DISPLAY': ':0', 18:00:53 INFO - 'HOME': '/home/cltbld', 18:00:53 INFO - 'LANG': 'en_US.UTF-8', 18:00:53 INFO - 'LANGUAGE': 'en_US:en', 18:00:53 INFO - 'LOGNAME': 'cltbld', 18:00:53 INFO - 'MAIL': '/var/mail/cltbld', 18:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:53 INFO - 'MOZ_NO_REMOTE': '1', 18:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:53 INFO - 'NO_EM_RESTART': '1', 18:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:53 INFO - 'PWD': '/builds/slave/test', 18:00:53 INFO - 'SHELL': '/bin/bash', 18:00:53 INFO - 'SHLVL': '1', 18:00:53 INFO - 'TERM': 'linux', 18:00:53 INFO - 'TMOUT': '86400', 18:00:53 INFO - 'USER': 'cltbld', 18:00:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 18:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:53 INFO - '_': '/tools/buildbot/bin/python'} 18:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:00:53 INFO - Cleaning up... 18:00:54 INFO - Return code: 0 18:00:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba4fb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2905430>, '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 0x2870f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28713c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:00:54 INFO - Using env: {'DISPLAY': ':0', 18:00:54 INFO - 'HOME': '/home/cltbld', 18:00:54 INFO - 'LANG': 'en_US.UTF-8', 18:00:54 INFO - 'LANGUAGE': 'en_US:en', 18:00:54 INFO - 'LOGNAME': 'cltbld', 18:00:54 INFO - 'MAIL': '/var/mail/cltbld', 18:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:54 INFO - 'MOZ_NO_REMOTE': '1', 18:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:54 INFO - 'NO_EM_RESTART': '1', 18:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:54 INFO - 'PWD': '/builds/slave/test', 18:00:54 INFO - 'SHELL': '/bin/bash', 18:00:54 INFO - 'SHLVL': '1', 18:00:54 INFO - 'TERM': 'linux', 18:00:54 INFO - 'TMOUT': '86400', 18:00:54 INFO - 'USER': 'cltbld', 18:00:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 18:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:54 INFO - '_': '/tools/buildbot/bin/python'} 18:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:54 INFO - Downloading/unpacking jsonschema 18:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:00:56 INFO - Downloading/unpacking functools32 (from jsonschema) 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:56 INFO - Downloading functools32-3.2.3-2.tar.gz 18:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:00:56 INFO - warning: no files found matching '*.txt' 18:00:56 INFO - no previously-included directories found matching 'build' 18:00:56 INFO - no previously-included directories found matching 'dist' 18:00:56 INFO - no previously-included directories found matching '.git*' 18:00:56 INFO - Installing collected packages: jsonschema, functools32 18:00:56 INFO - Running setup.py install for functools32 18:00:56 INFO - warning: no files found matching '*.txt' 18:00:56 INFO - no previously-included directories found matching 'build' 18:00:56 INFO - no previously-included directories found matching 'dist' 18:00:56 INFO - no previously-included directories found matching '.git*' 18:00:56 INFO - Successfully installed jsonschema functools32 18:00:56 INFO - Cleaning up... 18:00:56 INFO - Return code: 0 18:00:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba4fb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2905430>, '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 0x2870f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28713c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:00:56 INFO - Using env: {'DISPLAY': ':0', 18:00:56 INFO - 'HOME': '/home/cltbld', 18:00:56 INFO - 'LANG': 'en_US.UTF-8', 18:00:56 INFO - 'LANGUAGE': 'en_US:en', 18:00:56 INFO - 'LOGNAME': 'cltbld', 18:00:56 INFO - 'MAIL': '/var/mail/cltbld', 18:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:56 INFO - 'MOZ_NO_REMOTE': '1', 18:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:56 INFO - 'NO_EM_RESTART': '1', 18:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:56 INFO - 'PWD': '/builds/slave/test', 18:00:56 INFO - 'SHELL': '/bin/bash', 18:00:56 INFO - 'SHLVL': '1', 18:00:56 INFO - 'TERM': 'linux', 18:00:56 INFO - 'TMOUT': '86400', 18:00:56 INFO - 'USER': 'cltbld', 18:00:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 18:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:56 INFO - '_': '/tools/buildbot/bin/python'} 18:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:56 INFO - Downloading/unpacking flake8 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:00:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:00:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:00:59 INFO - no previously-included directories found matching 'docs/_build' 18:00:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:00:59 INFO - Running setup.py install for pep8 18:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:00:59 INFO - no previously-included directories found matching 'docs/_build' 18:00:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:00:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:00:59 INFO - Cleaning up... 18:00:59 INFO - Return code: 0 18:00:59 INFO - Running post-action listener: _resource_record_post_action 18:00:59 INFO - Running post-action listener: _start_resource_monitoring 18:00:59 INFO - Starting resource monitoring. 18:00:59 INFO - ##### 18:00:59 INFO - ##### Running install step. 18:00:59 INFO - ##### 18:00:59 INFO - Running pre-action listener: _resource_record_pre_action 18:00:59 INFO - Running main action method: install 18:00:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:59 INFO - Reading from file tmpfile_stdout 18:00:59 INFO - Detecting whether we're running mozinstall >=1.0... 18:00:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:00:59 INFO - Reading from file tmpfile_stdout 18:00:59 INFO - Output received: 18:00:59 INFO - Usage: mozinstall [options] installer 18:00:59 INFO - Options: 18:00:59 INFO - -h, --help show this help message and exit 18:00:59 INFO - -d DEST, --destination=DEST 18:00:59 INFO - Directory to install application into. [default: 18:00:59 INFO - "/builds/slave/test"] 18:00:59 INFO - --app=APP Application being installed. [default: firefox] 18:00:59 INFO - mkdir: /builds/slave/test/build/application 18:00:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:01:12 INFO - Reading from file tmpfile_stdout 18:01:12 INFO - Output received: 18:01:12 INFO - /builds/slave/test/build/application/firefox/firefox 18:01:12 INFO - Running post-action listener: _resource_record_post_action 18:01:12 INFO - ##### 18:01:12 INFO - ##### Running run-tests step. 18:01:12 INFO - ##### 18:01:12 INFO - Running pre-action listener: _resource_record_pre_action 18:01:12 INFO - Running main action method: run_tests 18:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:01:12 INFO - Python 2.7.3 18:01:12 INFO - Return code: 0 18:01:12 INFO - grabbing minidump binary from tooltool 18:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2905430>, '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 0x2870f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28713c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:01:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:01:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:01:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:01:12 INFO - Return code: 0 18:01:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:01:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:01:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:01:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:01:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:01:13 INFO - Return code: 0 18:01:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:01:13 INFO - Using env: {'DISPLAY': ':0', 18:01:13 INFO - 'HOME': '/home/cltbld', 18:01:13 INFO - 'LANG': 'en_US.UTF-8', 18:01:13 INFO - 'LANGUAGE': 'en_US:en', 18:01:13 INFO - 'LOGNAME': 'cltbld', 18:01:13 INFO - 'MAIL': '/var/mail/cltbld', 18:01:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:01:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:13 INFO - 'MOZ_NO_REMOTE': '1', 18:01:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:13 INFO - 'NO_EM_RESTART': '1', 18:01:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:13 INFO - 'PWD': '/builds/slave/test', 18:01:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:01:13 INFO - 'SHELL': '/bin/bash', 18:01:13 INFO - 'SHLVL': '1', 18:01:13 INFO - 'TERM': 'linux', 18:01:13 INFO - 'TMOUT': '86400', 18:01:13 INFO - 'USER': 'cltbld', 18:01:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308', 18:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:13 INFO - '_': '/tools/buildbot/bin/python'} 18:01:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:01:13 INFO - mozversion application_buildid: 20160414152344 18:01:13 INFO - mozversion application_changeset: 076bf6a0ac85ec6a4f3ee7c3efe653964d92b9f2 18:01:13 INFO - mozversion application_display_name: Firefox 18:01:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:01:13 INFO - mozversion application_name: Firefox 18:01:13 INFO - mozversion application_remotingname: firefox 18:01:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:01:13 INFO - mozversion application_vendor: Mozilla 18:01:13 INFO - mozversion application_version: 46.0 18:01:13 INFO - mozversion platform_buildid: 20160414152344 18:01:13 INFO - mozversion platform_changeset: 076bf6a0ac85ec6a4f3ee7c3efe653964d92b9f2 18:01:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:01:13 INFO - mozversion platform_version: 46.0 18:01:13 INFO - using testdate: 1460682073 18:01:13 INFO - actual date: 1460682073 18:01:13 INFO - starting webserver on 'localhost:34256' 18:01:13 INFO - SUITE-START | Running 3 tests 18:01:13 INFO - TEST-START | dromaeo_css 18:01:13 INFO - operating with platform_type : linux_ 18:01:13 INFO - Initialising browser for dromaeo_css test... 18:01:13 INFO - TEST-INFO | started process 23068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_77li/profile http://localhost:34256/getInfo.html) 18:01:17 INFO - PROCESS | 23068 | __metrics Screen width/height:1600/1200 18:01:17 INFO - PROCESS | 23068 | colorDepth:24 18:01:17 INFO - PROCESS | 23068 | Browser inner width/height: 1024/697 18:01:17 INFO - PROCESS | 23068 | __metrics 18:01:17 INFO - PROCESS | 23068 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:01:19 INFO - TEST-INFO | 23068: exit 0 18:01:19 INFO - Browser initialized. 18:01:19 INFO - Running cycle 1/1 for dromaeo_css test... 18:01:19 INFO - TEST-INFO | started process 23158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_77li/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:30 INFO - PROCESS | 23158 | RSS: Main: 137003008 18:01:30 INFO - PROCESS | 23158 | 18:02:22 INFO - PROCESS | 23158 | 1460682142435 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:04:29 INFO - PROCESS | 23158 | Cycle 1(1): loaded http://localhost:34256/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34256/tests/dromaeo/cssquery-ext.html) 18:04:30 INFO - PROCESS | 23158 | RSS: Main: 225996800 18:04:30 INFO - PROCESS | 23158 | 18:07:32 INFO - PROCESS | 23158 | Cycle 1(1): loaded http://localhost:34256/tests/dromaeo/cssquery-ext.html (next: http://localhost:34256/tests/dromaeo/cssquery-jquery.html) 18:07:32 INFO - PROCESS | 23158 | RSS: Main: 221028352 18:07:32 INFO - PROCESS | 23158 | 18:10:34 INFO - PROCESS | 23158 | Cycle 1(1): loaded http://localhost:34256/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34256/tests/dromaeo/cssquery-mootools.html) 18:10:35 INFO - PROCESS | 23158 | RSS: Main: 227860480 18:10:35 INFO - PROCESS | 23158 | 18:13:37 INFO - PROCESS | 23158 | Cycle 1(1): loaded http://localhost:34256/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34256/tests/dromaeo/cssquery-prototype.html) 18:13:37 INFO - PROCESS | 23158 | RSS: Main: 199196672 18:13:37 INFO - PROCESS | 23158 | 18:16:40 INFO - PROCESS | 23158 | Cycle 1(1): loaded http://localhost:34256/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34256/tests/dromaeo/cssquery-yui.html) 18:16:40 INFO - PROCESS | 23158 | RSS: Main: 201957376 18:16:40 INFO - PROCESS | 23158 | 18:19:43 INFO - PROCESS | 23158 | Cycle 1(1): loaded http://localhost:34256/tests/dromaeo/cssquery-yui.html (next: http://localhost:34256/tests/dromaeo/cssquery-dojo.html) 18:19:43 INFO - PROCESS | 23158 | RSS: Main: 244592640 18:19:43 INFO - PROCESS | 23158 | 18:19:43 INFO - PROCESS | 23158 | __start_tp_report 18:19:43 INFO - PROCESS | 23158 | _x_x_mozilla_page_load 18:19:43 INFO - PROCESS | 23158 | _x_x_mozilla_page_load_details 18:19:43 INFO - PROCESS | 23158 | |i|pagename|runs| 18:19:43 INFO - PROCESS | 23158 | |0;dojo.html;3220.500822372532;3266.5100234964766;3272.7381809455246;3285.310084882173;3312.602487701476;5240.449752775956;5287.947120528794;5345.919811202835;5348.973255133719;5385.4614538546175;5279.234510995903;5312.362516498016;5335.093034184189;5336.759845806938;5366.91949620756;4745.881352966169;4871.391076115495;4872.926906096412;4921.434035085975;4942.505749425047;4763.095011947737;4856.781444834991;4861.489543597907;4865.294532292815;4866.853994380174;4874.2444921037295;4877.902441951159;4885.804567817283;4967.453580106186;4971.428285747131;4941.160002799515;4957.5042495750495;4969.875753106165;4973.303737476756;4995.5753760930365;4677.789499472532;4752.5485078917445;4913.31213630092;4938.432080310774;4948.925766113512;5120.871978200537;5228.660137091115;5230.947690523122;5246.23929530216;5254.0805359062015;5716;5737.08206686928;5767.36558978512;5770.307563092414;5776.537876969833;5599.412061733541;5678.4037676044245;5694.402087780765;5748.223989761371;5804.245448091721;5322.627416080837;5322.813701520428;5341.7297648499625;5354.892902141974;5378.085725426687;5827.504662103769;5835.008048631743;5836.095405212199;5837.6497410155525;5838.8540286492325;5482.23248745176;5561.6663000220115;5611.7474713637985;5630.155476678531;5632.408597097327;5795.88408231833;5802.535797136219;5805.912911306334;5807.361190269067;5823.563232757476;5758.913616295759;5783.942160578425;5784.248047753765;5784.768609255582;5785.739641716133;5572.749226284827;5638.971805140948;5645.71771411436;5719.971400142973;5766;4420.602145806893;4423.248047831877;4424.292113261927;4435.423394958635;4458.398116254329;3971.8411263549133;3972.3445631471063;3979.900502487461;3983.980080099639;4018.3771515415156;5077.162268225701;5192.4547922468355;5341.359036915595;5392.299001129828;5393.541548968382;5778.971105144531;5788.565857560699;5802.1296805479515;5805.912911306334;5813.88372232553;5428.185772134211;5457.808976685797;5471.261379713687;5472.589555783332;5481.534069604048;4813.687110337887;4893.779779909913;4904.632152588499;4959.454460009396;4997.600191984632;5831.88336233273;5855.502282306052;5863.560232982543;5871.089981052944;5872.207252021008;5423.213634022965;5674.1488776684655;5697.686627235542;5702;5704.3725190228215;5754.741036653444;5833.154192642128;5891.764329426775;5897.292324921037;5921.259842519685;5657.434256574475;5658.122990936411;5663.4053424391495;5665.971670141623;5667.744951477276;5512.310961129859;5568.248286481436;5715.428457154251;5732.570057245806;5741.655500669973;5533.031719449;5536.806211782568;5536.972315138399;5541.722913854372;5574.470425309589;5504.972475137759;5508.779648814003;5510.173473978935;5515.172724091419;5534.529564987021;5359.169328754049;5433;5452.863678408072;5458.235846981346;5481.780728770805;5578.246936663499;5583.330000399978;5585.776568937359;5600.439956004367;5619.438056194512;5453.400125986218;5475.863103422446;5482.122860342326;5482.945170548243;5512.779488820403 18:19:43 INFO - PROCESS | 23158 | |1;ext.html;516.6796586116606;540.1789280293956;553.239295968044;573.2748073686786;587.1867463562967;32036.199095022635;39185.21629567407;39194.412083818694;39200.80399598005;39814.80092599537;40606;41001.58998410015;41007.38488922668;41072.38391424131;41141.58858411415;8754.693585724484;8994.775130621754;9017.504037277948;9032.954835225848;9041.547922603844;8743;8862.911370886306;8867.911320886806;8894.24398926092;8896.644134234622;8870.201681848632;9059.95470022649;9157.679481218158;9161.221296189799;9166.633334666605;9065.773355666095;9123.087691230858;9152.4966126863;9159.084091590854;9168.40405373652;8947.910520894773;9091.31815113869;9091.409058411182;9093.909060909438;9096.545172741337;42900.3564946526;43290.783546082384;43461.78269108666;43522.347164792554;43536;3502.0719509330047;3544.680978711928;3571.8214089295693;3687.907802304937;3749.1751814600743;29445.263868403246;29512;29926.102216933527;30582.69417305843;30711.2322191947;4338.696291259613;4372.737635741833;4421.867343979686;4430.623397011258;4442.644588432918;283515;285947.57026214944;286149;286447;286697;61451.38548614546;62005.68997154985;69391;69920.65039674871;69940.65029674921;64881.67559162174;67309.3269067303;67448.66275668591;67464.66267668728;67665;18111.45665630033;18258.543536411697;18271;18276.817231827776;18278;14349.139051656934;14480.855191448161;14481.855181448262;14558.272086395638;14613.707725845423;22357.664635030487;22676.88661556682;22778.65832012521;22802.65796013061;22843.885780571323;8448.254317346888;8469.915300846913;8478.022993789364;8699.913000870038;8784.341174411944;1002.5112707629165;1064.723171975292;1074.435921141407;1121.669107613256;1189.8096304591224;29873.551896721565;30245.848770756005;30302;30444;30675.079747607608;1095.6165342130191;1100.4387762241315;1105.1379923659558;1167.5621641884293;1187.804012337972;15833.52499425019;15901.284442200129;15991.520254392386;16011.359545618045;16317.184140792913;345339;349279;349509;350395;350402;57000;57150.428495714514;57329.14006289909;57520.137197942066;57548.71225643845;1385.9514916977857;1431.4560467022466;1441.3946142620125;1442.1347191684906;1446.8408475067945;29592.556111657912;30349.491095417972;30700;31050.534241985937;31224.531632025082;51350;51475.742621286656;51858.481415185364;51876.481235187166;51897.48102518926;323942;325467;325713;326108;450534;31980.20049498781;36866.26267474582;37359.25281494409;37497;37805;45070.32394514151;45215.77392113018;45472.54527454815;45494.54505454903;45897.31154032759;37827.24345513019;38072;38276.80861595674;42726;42741.35887961621;37393.813030934674;37673.62326376811;38188.809055954545;38223.617763822;39422.60577394304;39299.410508842964;42259.7887010563;42324.36513452239;42395.7880210597;42795;30940.53589196119;34237;34541.30917381689;34620;34708.65291347054;25932.611010834476;26272.34319142037;26404.075857344902;26485.470290593694;26544.070957516393 18:19:43 INFO - PROCESS | 23158 | |2;jquery.html;397.25118152282954;398.33080424886197;399.070166512027;401.21962782388255;401.69270508061356;17168.055756933365;17672.20475078621;17692.115394230284;18621.90689046556;19446.319378821743;17599.91200043998;17698.292068317285;17926.282948682037;18126.546836329064;18130.093495325214;5584.162375643646;5765.1352297155345;5781.103928891008;5783.190353350535;5785.16115163301;5530.281063461744;5751.942480575203;5754.395788442216;5761.991651460999;5763.049096899007;4247.957520424787;4283.100548884738;5727.713614319288;5730;6226.813195604139;6219.129321894939;6224.751009959597;6225.221847269068;6226.87546249077;6228;5338.145896656555;5527.50252477279;5529.391766905637;5532.695701736403;5533.446655334475;11372.260803047859;11680.766384672259;13152.605421837361;13562.79655805154;13575.864241357558;2247.269637367862;2313.4447732544068;2319.1998760427628;2406.4946361264156;2417.8670173140645;9689.467079310634;10248.282620216587;10285.074343309137;12327.815082773766;12551.748965020739;1841.2450895132931;1957.109515170594;1961.4507937777446;1978.6339527187372;2000.5598768270956;58798.41201587972;60069.39930600682;60909;61020.38979610192;61922.69038654823;10950.890491095146;10983.835242471368;10986.57174567301;11009.779804403866;11082.335059896432;14429.494967676292;14495.347709353104;14537.200453975132;14580.63548411277;14599.343029563695;7987.9201207988335;8102.473339232931;8499.702510412106;8581.95709021451;8598.226159645661;8406.621702023423;8489.915100849035;8509.191626795444;8576.356773242032;8585.18440748128;4740.075685241345;4762.476127626028;4827.493113223061;4829.710217386968;4869.975650121798;1826.4977131289002;1832.6059897121916;1859.6094820087933;1920.5390706230405;1925.0374812593702;831.1314676163423;917.738444543302;948.8813898262717;987.6790043235977;1007.8790545134631;11313;11699.590514331958;12008;12103.455344509519;15984.280707368196;492.38206051405257;492.6034542193497;494.23393739704034;495.1928356778428;498.7855222254393;5414.620976531605;5997.220361352996;6248.31268560458;6262.5616206866;6263.906041409383;421130;423519;425491;426529;617213;79984.20015799884;81664.18335816685;82027.5898620515;82185.58907205425;85214;532.6378062917254;540.9891802163935;544.4256309593338;545.4436474795687;546.1725485888882;11167.944160279147;11457.713557161138;11485.138614603771;11587.652370428901;11616.186866919235;34166.487502686985;34920.82539587286;36125.638743612224;36770.26459470849;37079.25841483209;45615.54384456246;46736.29895551501;48026.27960580664;48272.758636208;48400.5159948396;7719.498232614862;7797.41519386037;7807.180246074307;7829;8009.5995200238585;11071.72320691989;11379.146564007568;11600.419979001184;11645.184837061324;11884.227525210834;9657.3239873211;9971.152452041368;10002;10125.949370253102;10730.08794252466;10351.171906247633;10370.274080814572;10418.270721049454;10543.857292801367;10718.73203169927;10207.387556746618;10675.306105103144;10724.839127412939;10740.979606937328;10746.08658264025;6153.6000159991245;7575.810604734926;7658.425618078778;7968.362530997622;8009.959950200445;9574.664886728931;10159.23805714589;10310.587576496857;10532.157427405637;10629.096526795309 18:19:43 INFO - PROCESS | 23158 | |3;mootools.html;1524.3292951101514;1532.1955973114113;1719.8968061916287;1817.409341963862;1836.8255015773505;8256.711015114472;8465.66137354505;8471.745847624574;8478.152184781526;8487.872681909761;8301.83774271601;8353.457025293366;8355.582220888962;8356.83286334273;8357.582120893961;2449.3264352303127;2453.264020793764;2477.0339567568662;2477.1082410332265;2477.826552141351;2463.334899577113;2476.1333533263396;2486.191987604027;2505.498900219954;2506.4360518883286;2088.3943656339643;2145.549434618732;2343.6836027136374;2476.987615061931;2486.2416962826333;2317.478567322356;2327.3716096653893;2342.5314937012495;2343.074485578204;2343.753905839888;2271.2731925783755;2347.941301467477;2350.753170917046;2351.353377821096;2353.9411514712097;6890.173179218526;7037.085178926707;7727.072751269883;7897.24976127267;7902.644381002869;4855.805767769285;5042.193249080166;5045.066662667382;5050;5051.090803655341;3283.950740738891;3291.7860339077884;3341.4987751837175;3400.1669590950128;3402.8808991685173;1102.8125218712757;1110.8666959964776;1132.1848269246211;1178.393127539318;1210.056156198158;11300.94349528247;11311.490982905707;11330.093592512661;11374.829377559343;11405.14461415397;4516.07420478801;4529;4529.184746745552;4538.069695712371;4540.273556230987;9384.24926005918;9403.858942115874;9406.811863762687;9426.575804088832;9432.386894851812;5042.2184561392305;5059.569936555434;5090.9236361454605;5091.5489085610425;5092;4698.248280275139;4704.1767690654;4705.60002399793;4709.340692303081;4709.646776491777;3940.704447166474;3990.082281075369;4016.477857878457;4031.5363733170475;4059.2084543513733;1226.1171956191529;1227.6623928419579;1240.4294024748535;1242.4719494214924;1252.2298786246392;1110.7889500994786;1136.8351589019546;1139.014752239307;1347.2994043097535;1427.6502256946906;7639.923600763921;7649.235076492307;7705.922940770521;7965;7978.6409611567615;534.834201397568;538.4722971487964;538.8545092824916;546.4535464535464;547.0535972767135;5711.8857622848145;5822.155787410887;6057.273127224673;6080.2399700037495;6084.330723620398;8843.823123537493;9847.50762461874;9901.851472227921;10043.949780251052;10048.79902401948;9803.16673082796;9812.116909478182;9892.901070989343;10141.898581014242;10212.285140040125;7604.467687261949;7644.312011918954;7702.3453006493955;7717.151113377524;7723.420743444264;7965.283124518821;8000.919990800017;8045.919540804517;8065.677372905018;8083.110857805755;9043;9051.411658242194;9076.183143517115;9093.136152065543;9257.537123143951;9476.241900648069;9656.95171524138;9697.9030209697;9730.659426920023;9757.658481953098;6862.142232220973;6970.372666460043;7002.719891204295;7534.095908491016;7657.34912532441;7479.401647868266;7537.660805263667;7540.698372065056;7543.811404714926;7548.886766698613;7011.859762804614;7036.226015138228;7089.184743754328;7157.928420715726;7218.314260145278;7056;7104.254053324326;7138.714451421885;7148.606826624586;7221.133463984145;7327.1207455103595;7508.099028116442;7685.308322251024;7691.1155217150745;7698.615069246627;6879.96800479932;6925.549839260432;6957.721691132298;6973.442124630119;6982.68577913985;7011.3339232772805;7015.929840701528;7147.070880785673;7147.249538798559;7158.105236845395 18:19:43 INFO - PROCESS | 23158 | |4;prototype.html;366.36435783914914;368.701351904957;372.517589721311;376.5142965574409;384.1740258444346;6013.939860601398;6020.428059334367;6028.638281703101;6054.848628784277;6057.151998720177;5714.000049991245;5834.387389324123;5886.882262354761;5894.4989675877605;5967.343592204865;4669.112868554964;4673.2756422754355;4684.695494792828;4691.225947718623;4703.459102203256;4442.444694413199;4671.27595222741;4686.765661716918;4690.061987602493;4693.5541123593375;4556.977215113936;4581.060882519076;4617.515160908107;4643.907121857561;4644.349791029259;4615.307703844416;4616.792244349012;4626.1441633297945;4656.301554766778;4665.136949664289;4158.91682166355;4171.97914010431;4185.560516145822;4186.832526698929;4190.141021090669;5620.9437905620825;5685;5690.829275121753;5695.34503532095;5699;5504.697241651707;5505.449455054502;5509.201165830932;5513.531349835269;5519.530839878616;6419.550631455753;6428.678566071678;6433.9678301608665;6437;6437.388448097423;4675.18184317743;4675.4155730533685;4678.789454474523;4679.766011699436;4689.601383882374;6479.5788273762055;6581.86836263272;6635.535512514126;6645.900311495331;6648.501362397839;4641.3734145889875;4642.883927901829;4646.697964632288;4648.163330600524;4696.38946936896;4742.834000809955;4758.571728544448;4760.166970780099;4763.3807605011125;4765.785539650655;5376.542993845489;5407.405185429599;5407.513323800877;5409.810656627078;5410.567154627621;6209.316975132731;6365.045243213555;6402.679866006681;6409.134766806515;6425.485961123099;1702.2254874032285;1719.9226034828462;1721.3372851452032;1722.1647500962024;1723.603571178636;1177.7703347847087;1196.3958201108558;1198.1433275208094;1214.107630891294;1226.7791797476361;6151.231096112986;6151.507879369639;6151.84620384494;6152.3540028297275;6157.84605384869;6369.904451433232;6566.212054553484;6580.80257592273;6604.438622717027;6657.400833924873;6035.6076855004285;6050.48570871472;6188.226471691039;6221.3156552779155;6221.471174950089;3546.184377593168;3556.8399422026073;3573.6247693992277;3574.2315402188656;3579.0336609115393;6680.933190668031;6789.386086356788;6797.320267973163;6806.081179040865;6806.965965170241;6765.188177418741;6790.117284752951;6794.048833163361;6794.048833163361;6798.66006699663;6769.3907548320885;6786.4910131739325;6792.490563207779;6792.660366981631;6796.490263230277;6469.77355792545;6593.934060659332;6612.867742645217;6616.569922954993;6617.371349721769;6559.180102487189;6561.376669216417;6564.770233041821;6609.966950165219;6614.735410583715;6721.1598550181225;6769.763058292936;6773.762918297836;6796.320367963164;6804.693788779417;4810.302506136521;4812.085703716282;4814.253790662453;4815.277708343777;4819;6498.545101842826;6616.239132499824;6617.338266173344;6621.569597976116;6629.602223866584;6480.513961452815;6480.643564603992;6497.675116244263;6497.740090396331;6498;6269.529785266214;6470.029495575702;6472.126262954441;6475.579087359307;6477.287498375269;6325.335839736761;6338.524610654127;6343.270523889627;6350.650714210763;6383.074454204021;6508.576942498722;6509.153810004669;6513.934860651333;6514.869702606016;6550.246721627074;6139.079138129317;6273.592216505913;6274.905876411949;6276.592021518587;6341.651209183355 18:19:43 INFO - PROCESS | 23158 | |5;yui.html;894.9060348663394;897.7028194259295;907.3285768531284;918.0681608167708;926.2451102351583;13346.66633334167;13591.252481113546;13610.659733506667;13632.931835340822;13675.658108547292;13375.799363009563;13473.528426505074;13475.797863032063;13499.25754083525;13634.727305453885;731.1555153797347;735.7572001239578;861.267922266072;867.0635713429481;868.5961028121922;861.1732736572898;863.2230992107122;866.3588944181292;866.7486428935632;866.8743032260319;920.4017388697333;921.8478950973081;921.9585118669676;922.3820040572832;922.575615217001;759.3962799574324;764.5947647746704;898.1736802142012;912.2838571721234;916.0244339778116;669.1301308299192;669.8358902068976;675.9459243260527;676.3844901139988;677.0250838792124;12185.634430967086;12206.08454365926;12245;12260.44827982734;12278.140530162802;12911.935440322739;13507.66230844227;13619.591412257649;13682.31588420585;13869.167849929037;10949;10949.890501095046;10955.616553420672;10997.230193886431;11182.16133789969;3766.510353654035;3778.282126395976;3785.5646600641003;3809.3524100902914;3811.9237615247816;48625.75687121542;49074.50925490735;50616;51427.228591571155;51586.22620660693;10527.578896844041;10547.338014841407;10653.84019239712;10841.349519028883;10966.725831854268;18610.906945465456;18791.90604046971;18814.05929703509;18821.905890470734;18833.340833070775;7445.516041457288;7516.473846830779;7945.443818932619;8096.51420914747;8172.918270817216;4472.508024117345;4498.730076195438;4679.81280748773;4715.386999690087;4724.740139292372;3013.2617508710505;3044.2998110434723;3045.8172509649494;3047.6647568767416;3055.648600410981;520.7682581251382;535.799075346745;540.4919375786748;545.4572700163284;545.9208414779835;586.3286536915208;627.7995625333178;700.2083716674254;712.0743034055707;729.1250499400741;8728.214460698568;8820.647174112964;8874.112588741074;8942.821143577092;9076.183143517115;597.5369088956007;611.2023808929301;627.7112528236971;710.7796583059268;747.3386053342831;4116.794160291974;4206.116715489781;4274.2092712848225;4291.806868690916;4355.237833379146;54690;55084.44915550793;55195.72402137964;60472;60893;48882.77793055202;49755.004899902524;50294.748526257135;50738;51398.486015140115;46164.7691761539;47690;47791;48106;48522.75738621284;8628.956855215934;8754.781130471789;8759.518226497348;8828.735137945872;8924.643014279356;35389.115272118404;35820.820895895355;35927.10182245465;36459.81770091133;36851.81574092113;40982;45098.0980380384;46243.306350405444;46860;46969;11606.4961210105;11635.127365447795;11707.356095414834;11720.824187637021;11851.881481185423;12257.509699611915;12295.07786915967;12317.260964342167;12375.814362784746;12804.61586152417;11169.944150279196;11265.155113366367;11532.59635912739;12155.939220303842;12577.559785407468;11903.702407439883;11907.82138267944;11990.760184796429;12126;12210.87789122133;11158.330500170016;11414.029807466126;11713.941430292794;11842.526298947945;12232.327222002876;9961.701148965543;10288;10439.53022114022;10557.683269501927;10619.415932123808;9244.168024877794;9706.417614943126;9721.513924303898;9810.65662701802;9822.901770982198 18:19:43 INFO - PROCESS | 23158 | __end_tp_report 18:19:43 INFO - PROCESS | 23158 | __start_cc_report 18:19:43 INFO - PROCESS | 23158 | _x_x_mozilla_cycle_collect,708 18:19:43 INFO - PROCESS | 23158 | __end_cc_report 18:19:43 INFO - PROCESS | 23158 | __startTimestamp1460683183315__endTimestamp 18:19:43 INFO - PROCESS | 23158 | 18:19:43 INFO - PROCESS | 23158 | ------- Summary: start ------- 18:19:43 INFO - PROCESS | 23158 | Number of tests: 6 18:19:43 INFO - PROCESS | 23158 | 18:19:43 INFO - PROCESS | 23158 | [#0] dojo.html Cycles:165 Average:5308.24 Median:5481.78 stddev:567.82 (10.4%) stddev-sans-first:545.43 18:19:43 INFO - PROCESS | 23158 | Values: 3220.5 3266.5 3272.7 3285.3 3312.6 5240.4 5287.9 5345.9 5349.0 5385.5 5279.2 5312.4 5335.1 5336.8 5366.9 4745.9 4871.4 4872.9 4921.4 4942.5 4763.1 4856.8 4861.5 4865.3 4866.9 4874.2 4877.9 4885.8 4967.5 4971.4 4941.2 4957.5 4969.9 4973.3 4995.6 4677.8 4752.5 4913.3 4938.4 4948.9 5120.9 5228.7 5230.9 5246.2 5254.1 5716.0 5737.1 5767.4 5770.3 5776.5 5599.4 5678.4 5694.4 5748.2 5804.2 5322.6 5322.8 5341.7 5354.9 5378.1 5827.5 5835.0 5836.1 5837.6 5838.9 5482.2 5561.7 5611.7 5630.2 5632.4 5795.9 5802.5 5805.9 5807.4 5823.6 5758.9 5783.9 5784.2 5784.8 5785.7 5572.7 5639.0 5645.7 5720.0 5766.0 4420.6 4423.2 4424.3 4435.4 4458.4 3971.8 3972.3 3979.9 3984.0 4018.4 5077.2 5192.5 5341.4 5392.3 5393.5 5779.0 5788.6 5802.1 5805.9 5813.9 5428.2 5457.8 5471.3 5472.6 5481.5 4813.7 4893.8 4904.6 4959.5 4997.6 5831.9 5855.5 5863.6 5871.1 5872.2 5423.2 5674.1 5697.7 5702.0 5704.4 5754.7 5833.2 5891.8 5897.3 5921.3 5657.4 5658.1 5663.4 5666.0 5667.7 5512.3 5568.2 5715.4 5732.6 5741.7 5533.0 5536.8 5537.0 5541.7 5574.5 5505.0 5508.8 5510.2 5515.2 5534.5 5359.2 5433.0 5452.9 5458.2 5481.8 5578.2 5583.3 5585.8 5600.4 5619.4 5453.4 5475.9 5482.1 5482.9 5512.8 18:19:43 INFO - PROCESS | 23158 | 18:19:43 INFO - PROCESS | 23158 | [#1] ext.html Cycles:180 Average:51106.54 Median:38250.21 stddev:86712.79 (226.7%) stddev-sans-first:86872.84 18:19:43 INFO - PROCESS | 23158 | Values: 516.7 540.2 553.2 573.3 587.2 32036.2 39185.2 39194.4 39200.8 39814.8 40606.0 41001.6 41007.4 41072.4 41141.6 8754.7 8994.8 9017.5 9033.0 9041.5 8743.0 8862.9 8867.9 8894.2 8896.6 8870.2 9060.0 9157.7 9161.2 9166.6 9065.8 9123.1 9152.5 9159.1 9168.4 8947.9 9091.3 9091.4 9093.9 9096.5 42900.4 43290.8 43461.8 43522.3 43536.0 3502.1 3544.7 3571.8 3687.9 3749.2 29445.3 29512.0 29926.1 30582.7 30711.2 4338.7 4372.7 4421.9 4430.6 4442.6 283515.0 285947.6 286149.0 286447.0 286697.0 61451.4 62005.7 69391.0 69920.7 69940.7 64881.7 67309.3 67448.7 67464.7 67665.0 18111.5 18258.5 18271.0 18276.8 18278.0 14349.1 14480.9 14481.9 14558.3 14613.7 22357.7 22676.9 22778.7 22802.7 22843.9 8448.3 8469.9 8478.0 8699.9 8784.3 1002.5 1064.7 1074.4 1121.7 1189.8 29873.6 30245.8 30302.0 30444.0 30675.1 1095.6 1100.4 1105.1 1167.6 1187.8 15833.5 15901.3 15991.5 16011.4 16317.2 345339.0 349279.0 349509.0 350395.0 350402.0 57000.0 57150.4 57329.1 57520.1 57548.7 1386.0 1431.5 1441.4 1442.1 1446.8 29592.6 30349.5 30700.0 31050.5 31224.5 51350.0 51475.7 51858.5 51876.5 51897.5 323942.0 325467.0 325713.0 326108.0 450534.0 31980.2 36866.3 37359.3 37497.0 37805.0 45070.3 45215.8 45472.5 45494.5 45897.3 37827.2 38072.0 38276.8 42726.0 42741.4 37393.8 37673.6 38188.8 38223.6 39422.6 39299.4 42259.8 42324.4 42395.8 42795.0 30940.5 34237.0 34541.3 34620.0 34708.7 25932.6 26272.3 26404.1 26485.5 26544.1 18:19:43 INFO - PROCESS | 23158 | 18:19:43 INFO - PROCESS | 23158 | [#2] jquery.html Cycles:180 Average:25861.07 Median:426010.00 stddev:77067.67 (18.1%) stddev-sans-first:77260.15 18:19:43 INFO - PROCESS | 23158 | Values: 397.3 398.3 399.1 401.2 401.7 17168.1 17672.2 17692.1 18621.9 19446.3 17599.9 17698.3 17926.3 18126.5 18130.1 5584.2 5765.1 5781.1 5783.2 5785.2 5530.3 5751.9 5754.4 5762.0 5763.0 4248.0 4283.1 5727.7 5730.0 6226.8 6219.1 6224.8 6225.2 6226.9 6228.0 5338.1 5527.5 5529.4 5532.7 5533.4 11372.3 11680.8 13152.6 13562.8 13575.9 2247.3 2313.4 2319.2 2406.5 2417.9 9689.5 10248.3 10285.1 12327.8 12551.7 1841.2 1957.1 1961.5 1978.6 2000.6 58798.4 60069.4 60909.0 61020.4 61922.7 10950.9 10983.8 10986.6 11009.8 11082.3 14429.5 14495.3 14537.2 14580.6 14599.3 7987.9 8102.5 8499.7 8582.0 8598.2 8406.6 8489.9 8509.2 8576.4 8585.2 4740.1 4762.5 4827.5 4829.7 4870.0 1826.5 1832.6 1859.6 1920.5 1925.0 831.1 917.7 948.9 987.7 1007.9 11313.0 11699.6 12008.0 12103.5 15984.3 492.4 492.6 494.2 495.2 498.8 5414.6 5997.2 6248.3 6262.6 6263.9 421130.0 423519.0 425491.0 426529.0 617213.0 79984.2 81664.2 82027.6 82185.6 85214.0 532.6 541.0 544.4 545.4 546.2 11167.9 11457.7 11485.1 11587.7 11616.2 34166.5 34920.8 36125.6 36770.3 37079.3 45615.5 46736.3 48026.3 48272.8 48400.5 7719.5 7797.4 7807.2 7829.0 8009.6 11071.7 11379.1 11600.4 11645.2 11884.2 9657.3 9971.2 10002.0 10125.9 10730.1 10351.2 10370.3 10418.3 10543.9 10718.7 10207.4 10675.3 10724.8 10741.0 10746.1 6153.6 7575.8 7658.4 7968.4 8010.0 9574.7 10159.2 10310.6 10532.2 10629.1 18:19:43 INFO - PROCESS | 23158 | 18:19:43 INFO - PROCESS | 23158 | [#3] mootools.html Cycles:180 Average:5777.57 Median:5939.71 stddev:3017.64 (50.8%) stddev-sans-first:3009.17 18:19:43 INFO - PROCESS | 23158 | Values: 1524.3 1532.2 1719.9 1817.4 1836.8 8256.7 8465.7 8471.7 8478.2 8487.9 8301.8 8353.5 8355.6 8356.8 8357.6 2449.3 2453.3 2477.0 2477.1 2477.8 2463.3 2476.1 2486.2 2505.5 2506.4 2088.4 2145.5 2343.7 2477.0 2486.2 2317.5 2327.4 2342.5 2343.1 2343.8 2271.3 2347.9 2350.8 2351.4 2353.9 6890.2 7037.1 7727.1 7897.2 7902.6 4855.8 5042.2 5045.1 5050.0 5051.1 3284.0 3291.8 3341.5 3400.2 3402.9 1102.8 1110.9 1132.2 1178.4 1210.1 11300.9 11311.5 11330.1 11374.8 11405.1 4516.1 4529.0 4529.2 4538.1 4540.3 9384.2 9403.9 9406.8 9426.6 9432.4 5042.2 5059.6 5090.9 5091.5 5092.0 4698.2 4704.2 4705.6 4709.3 4709.6 3940.7 3990.1 4016.5 4031.5 4059.2 1226.1 1227.7 1240.4 1242.5 1252.2 1110.8 1136.8 1139.0 1347.3 1427.7 7639.9 7649.2 7705.9 7965.0 7978.6 534.8 538.5 538.9 546.5 547.1 5711.9 5822.2 6057.3 6080.2 6084.3 8843.8 9847.5 9901.9 10043.9 10048.8 9803.2 9812.1 9892.9 10141.9 10212.3 7604.5 7644.3 7702.3 7717.2 7723.4 7965.3 8000.9 8045.9 8065.7 8083.1 9043.0 9051.4 9076.2 9093.1 9257.5 9476.2 9657.0 9697.9 9730.7 9757.7 6862.1 6970.4 7002.7 7534.1 7657.3 7479.4 7537.7 7540.7 7543.8 7548.9 7011.9 7036.2 7089.2 7157.9 7218.3 7056.0 7104.3 7138.7 7148.6 7221.1 7327.1 7508.1 7685.3 7691.1 7698.6 6880.0 6925.5 6957.7 6973.4 6982.7 7011.3 7015.9 7147.1 7147.2 7158.1 18:19:43 INFO - PROCESS | 23158 | 18:19:43 INFO - PROCESS | 23158 | [#4] prototype.html Cycles:180 Average:5393.89 Median:6056.00 stddev:1577.52 (26.0%) stddev-sans-first:1536.15 18:19:43 INFO - PROCESS | 23158 | Values: 366.4 368.7 372.5 376.5 384.2 6013.9 6020.4 6028.6 6054.8 6057.2 5714.0 5834.4 5886.9 5894.5 5967.3 4669.1 4673.3 4684.7 4691.2 4703.5 4442.4 4671.3 4686.8 4690.1 4693.6 4557.0 4581.1 4617.5 4643.9 4644.3 4615.3 4616.8 4626.1 4656.3 4665.1 4158.9 4172.0 4185.6 4186.8 4190.1 5620.9 5685.0 5690.8 5695.3 5699.0 5504.7 5505.4 5509.2 5513.5 5519.5 6419.6 6428.7 6434.0 6437.0 6437.4 4675.2 4675.4 4678.8 4679.8 4689.6 6479.6 6581.9 6635.5 6645.9 6648.5 4641.4 4642.9 4646.7 4648.2 4696.4 4742.8 4758.6 4760.2 4763.4 4765.8 5376.5 5407.4 5407.5 5409.8 5410.6 6209.3 6365.0 6402.7 6409.1 6425.5 1702.2 1719.9 1721.3 1722.2 1723.6 1177.8 1196.4 1198.1 1214.1 1226.8 6151.2 6151.5 6151.8 6152.4 6157.8 6369.9 6566.2 6580.8 6604.4 6657.4 6035.6 6050.5 6188.2 6221.3 6221.5 3546.2 3556.8 3573.6 3574.2 3579.0 6680.9 6789.4 6797.3 6806.1 6807.0 6765.2 6790.1 6794.0 6794.0 6798.7 6769.4 6786.5 6792.5 6792.7 6796.5 6469.8 6593.9 6612.9 6616.6 6617.4 6559.2 6561.4 6564.8 6610.0 6614.7 6721.2 6769.8 6773.8 6796.3 6804.7 4810.3 4812.1 4814.3 4815.3 4819.0 6498.5 6616.2 6617.3 6621.6 6629.6 6480.5 6480.6 6497.7 6497.7 6498.0 6269.5 6470.0 6472.1 6475.6 6477.3 6325.3 6338.5 6343.3 6350.7 6383.1 6508.6 6509.2 6513.9 6514.9 6550.2 6139.1 6273.6 6274.9 6276.6 6341.7 18:19:43 INFO - PROCESS | 23158 | 18:19:43 INFO - PROCESS | 23158 | [#5] yui.html Cycles:180 Average:14103.27 Median:25769.91 stddev:16106.04 (62.5%) stddev-sans-first:16120.68 18:19:43 INFO - PROCESS | 23158 | Values: 894.9 897.7 907.3 918.1 926.2 13346.7 13591.3 13610.7 13632.9 13675.7 13375.8 13473.5 13475.8 13499.3 13634.7 731.2 735.8 861.3 867.1 868.6 861.2 863.2 866.4 866.7 866.9 920.4 921.8 922.0 922.4 922.6 759.4 764.6 898.2 912.3 916.0 669.1 669.8 675.9 676.4 677.0 12185.6 12206.1 12245.0 12260.4 12278.1 12911.9 13507.7 13619.6 13682.3 13869.2 10949.0 10949.9 10955.6 10997.2 11182.2 3766.5 3778.3 3785.6 3809.4 3811.9 48625.8 49074.5 50616.0 51427.2 51586.2 10527.6 10547.3 10653.8 10841.3 10966.7 18610.9 18791.9 18814.1 18821.9 18833.3 7445.5 7516.5 7945.4 8096.5 8172.9 4472.5 4498.7 4679.8 4715.4 4724.7 3013.3 3044.3 3045.8 3047.7 3055.6 520.8 535.8 540.5 545.5 545.9 586.3 627.8 700.2 712.1 729.1 8728.2 8820.6 8874.1 8942.8 9076.2 597.5 611.2 627.7 710.8 747.3 4116.8 4206.1 4274.2 4291.8 4355.2 54690.0 55084.4 55195.7 60472.0 60893.0 48882.8 49755.0 50294.7 50738.0 51398.5 46164.8 47690.0 47791.0 48106.0 48522.8 8629.0 8754.8 8759.5 8828.7 8924.6 35389.1 35820.8 35927.1 36459.8 36851.8 40982.0 45098.1 46243.3 46860.0 46969.0 11606.5 11635.1 11707.4 11720.8 11851.9 12257.5 12295.1 12317.3 12375.8 12804.6 11169.9 11265.2 11532.6 12155.9 12577.6 11903.7 11907.8 11990.8 12126.0 12210.9 11158.3 11414.0 11713.9 11842.5 12232.3 9961.7 10288.0 10439.5 10557.7 10619.4 9244.2 9706.4 9721.5 9810.7 9822.9 18:19:43 INFO - PROCESS | 23158 | -------- Summary: end -------- 18:19:43 INFO - PROCESS | 23158 | 18:19:43 INFO - TEST-INFO | 23158: exit 0 18:19:43 INFO - TEST-OK | dromaeo_css | took 1110185ms 18:19:43 INFO - TEST-START | kraken 18:19:43 INFO - operating with platform_type : linux_ 18:19:43 INFO - Initialising browser for kraken test... 18:19:43 INFO - TEST-INFO | started process 23350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBupegS/profile http://localhost:34256/getInfo.html) 18:19:47 INFO - PROCESS | 23350 | __metrics Screen width/height:1600/1200 18:19:47 INFO - PROCESS | 23350 | colorDepth:24 18:19:47 INFO - PROCESS | 23350 | Browser inner width/height: 1024/697 18:19:47 INFO - PROCESS | 23350 | __metrics 18:19:47 INFO - PROCESS | 23350 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:19:49 INFO - TEST-INFO | 23350: exit 0 18:19:49 INFO - Browser initialized. 18:19:49 INFO - Running cycle 1/1 for kraken test... 18:19:49 INFO - TEST-INFO | started process 23440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBupegS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:00 INFO - PROCESS | 23440 | RSS: Main: 136757248 18:20:00 INFO - PROCESS | 23440 | 18:20:03 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34256/tests/kraken/driver.html?testName=audio-beat-detection) 18:20:03 INFO - PROCESS | 23440 | RSS: Main: 170872832 18:20:03 INFO - PROCESS | 23440 | 18:20:06 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34256/tests/kraken/driver.html?testName=audio-dft) 18:20:07 INFO - PROCESS | 23440 | RSS: Main: 168632320 18:20:07 INFO - PROCESS | 23440 | 18:20:09 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34256/tests/kraken/driver.html?testName=audio-fft) 18:20:10 INFO - PROCESS | 23440 | RSS: Main: 165015552 18:20:10 INFO - PROCESS | 23440 | 18:20:12 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34256/tests/kraken/driver.html?testName=audio-oscillator) 18:20:13 INFO - PROCESS | 23440 | RSS: Main: 166162432 18:20:13 INFO - PROCESS | 23440 | 18:20:15 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34256/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:20:15 INFO - PROCESS | 23440 | RSS: Main: 164012032 18:20:15 INFO - PROCESS | 23440 | 18:20:18 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34256/tests/kraken/driver.html?testName=imaging-darkroom) 18:20:19 INFO - PROCESS | 23440 | RSS: Main: 165228544 18:20:19 INFO - PROCESS | 23440 | 18:20:22 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34256/tests/kraken/driver.html?testName=imaging-desaturate) 18:20:23 INFO - PROCESS | 23440 | RSS: Main: 165257216 18:20:23 INFO - PROCESS | 23440 | 18:20:26 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34256/tests/kraken/driver.html?testName=json-parse-financial) 18:20:26 INFO - PROCESS | 23440 | RSS: Main: 165031936 18:20:26 INFO - PROCESS | 23440 | 18:20:28 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34256/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:20:28 INFO - PROCESS | 23440 | RSS: Main: 166649856 18:20:28 INFO - PROCESS | 23440 | 18:20:30 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34256/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:20:31 INFO - PROCESS | 23440 | RSS: Main: 164577280 18:20:31 INFO - PROCESS | 23440 | 18:20:33 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34256/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:20:33 INFO - PROCESS | 23440 | RSS: Main: 170381312 18:20:33 INFO - PROCESS | 23440 | 18:20:35 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:20:36 INFO - PROCESS | 23440 | RSS: Main: 174522368 18:20:36 INFO - PROCESS | 23440 | 18:20:39 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:20:39 INFO - PROCESS | 23440 | RSS: Main: 174354432 18:20:39 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:34256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34256/tests/kraken/driver.html?testName=ai-astar) 18:20:41 INFO - PROCESS | 23440 | RSS: Main: 235094016 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | __start_tp_report 18:20:41 INFO - PROCESS | 23440 | _x_x_mozilla_page_load 18:20:41 INFO - PROCESS | 23440 | _x_x_mozilla_page_load_details 18:20:41 INFO - PROCESS | 23440 | |i|pagename|runs| 18:20:41 INFO - PROCESS | 23440 | |0;ai-astar;109;110;104;108;109;120;102;108;109;109 18:20:41 INFO - PROCESS | 23440 | |1;audio-beat-detection;150;126;151;161;123;145;151;129;161;135 18:20:41 INFO - PROCESS | 23440 | |2;audio-dft;163;161;161;162;161;163;161;161;161;162 18:20:41 INFO - PROCESS | 23440 | |3;audio-fft;73;74;77;144;73;74;72;73;143;73 18:20:41 INFO - PROCESS | 23440 | |4;audio-oscillator;95;96;146;95;96;95;138;95;96;137 18:20:41 INFO - PROCESS | 23440 | |5;imaging-gaussian-blur;109;109;109;109;110;110;109;109;110;110 18:20:41 INFO - PROCESS | 23440 | |6;imaging-darkroom;147;147;145;146;145;146;146;146;147;144 18:20:41 INFO - PROCESS | 23440 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;96;95 18:20:41 INFO - PROCESS | 23440 | |8;json-parse-financial;54;55;55;54;54;54;54;55;53;53 18:20:41 INFO - PROCESS | 23440 | |9;json-stringify-tinderbox;64;64;65;66;65;66;67;66;64;64 18:20:41 INFO - PROCESS | 23440 | |10;stanford-crypto-aes;77;81;79;86;78;79;80;79;78;80 18:20:41 INFO - PROCESS | 23440 | |11;stanford-crypto-ccm;116;115;117;111;116;113;110;111;109;112 18:20:41 INFO - PROCESS | 23440 | |12;stanford-crypto-pbkdf2;148;143;144;143;144;133;141;145;145;144 18:20:41 INFO - PROCESS | 23440 | |13;stanford-crypto-sha256-iterative;67;66;67;65;64;64;65;65;62;64 18:20:41 INFO - PROCESS | 23440 | __end_tp_report 18:20:41 INFO - PROCESS | 23440 | __start_cc_report 18:20:41 INFO - PROCESS | 23440 | _x_x_mozilla_cycle_collect,929 18:20:41 INFO - PROCESS | 23440 | __end_cc_report 18:20:41 INFO - PROCESS | 23440 | __startTimestamp1460683241532__endTimestamp 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | ------- Summary: start ------- 18:20:41 INFO - PROCESS | 23440 | Number of tests: 14 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:4.69 (4.3%) stddev-sans-first:4.97 18:20:41 INFO - PROCESS | 23440 | Values: 109.0 110.0 104.0 108.0 109.0 120.0 102.0 108.0 109.0 109.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:150.50 stddev:14.05 (9.3%) stddev-sans-first:14.69 18:20:41 INFO - PROCESS | 23440 | Values: 150.0 126.0 151.0 161.0 123.0 145.0 151.0 129.0 161.0 135.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.73 18:20:41 INFO - PROCESS | 23440 | Values: 163.0 161.0 161.0 162.0 161.0 163.0 161.0 161.0 161.0 162.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#3] audio-fft Cycles:10 Average:87.60 Median:73.00 stddev:29.49 (40.4%) stddev-sans-first:30.80 18:20:41 INFO - PROCESS | 23440 | Values: 73.0 74.0 77.0 144.0 73.0 74.0 72.0 73.0 143.0 73.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.00 stddev:21.82 (23.0%) stddev-sans-first:22.56 18:20:41 INFO - PROCESS | 23440 | Values: 95.0 96.0 146.0 95.0 96.0 95.0 138.0 95.0 96.0 137.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:20:41 INFO - PROCESS | 23440 | Values: 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 110.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 18:20:41 INFO - PROCESS | 23440 | Values: 147.0 147.0 145.0 146.0 145.0 146.0 146.0 146.0 147.0 144.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:20:41 INFO - PROCESS | 23440 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 18:20:41 INFO - PROCESS | 23440 | Values: 54.0 55.0 55.0 54.0 54.0 54.0 54.0 55.0 53.0 53.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.50 stddev:1.10 (1.7%) stddev-sans-first:1.09 18:20:41 INFO - PROCESS | 23440 | Values: 64.0 64.0 65.0 66.0 65.0 66.0 67.0 66.0 64.0 64.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:2.50 (3.1%) stddev-sans-first:2.45 18:20:41 INFO - PROCESS | 23440 | Values: 77.0 81.0 79.0 86.0 78.0 79.0 80.0 79.0 78.0 80.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#11] stanford-crypto-ccm Cycles:10 Average:113.00 Median:114.00 stddev:2.83 (2.5%) stddev-sans-first:2.78 18:20:41 INFO - PROCESS | 23440 | Values: 116.0 115.0 117.0 111.0 116.0 113.0 110.0 111.0 109.0 112.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:144.00 stddev:3.94 (2.7%) stddev-sans-first:3.75 18:20:41 INFO - PROCESS | 23440 | Values: 148.0 143.0 144.0 143.0 144.0 133.0 141.0 145.0 145.0 144.0 18:20:41 INFO - PROCESS | 23440 | 18:20:41 INFO - PROCESS | 23440 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.52 (2.3%) stddev-sans-first:1.41 18:20:41 INFO - PROCESS | 23440 | Values: 67.0 66.0 67.0 65.0 64.0 64.0 65.0 65.0 62.0 64.0 18:20:41 INFO - PROCESS | 23440 | -------- Summary: end -------- 18:20:41 INFO - PROCESS | 23440 | 18:20:42 INFO - TEST-INFO | 23440: exit 0 18:20:42 INFO - TEST-OK | kraken | took 58427ms 18:20:42 INFO - TEST-START | v8_7 18:20:42 INFO - operating with platform_type : linux_ 18:20:42 INFO - Initialising browser for v8_7 test... 18:20:42 INFO - TEST-INFO | started process 23698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJxD5hE/profile http://localhost:34256/getInfo.html) 18:20:46 INFO - PROCESS | 23698 | __metrics Screen width/height:1600/1200 18:20:46 INFO - PROCESS | 23698 | colorDepth:24 18:20:46 INFO - PROCESS | 23698 | Browser inner width/height: 1024/697 18:20:46 INFO - PROCESS | 23698 | __metrics 18:20:46 INFO - PROCESS | 23698 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:20:47 INFO - TEST-INFO | 23698: exit 0 18:20:47 INFO - Browser initialized. 18:20:47 INFO - Running cycle 1/1 for v8_7 test... 18:20:47 INFO - TEST-INFO | started process 23791 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJxD5hE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:59 INFO - PROCESS | 23791 | RSS: Main: 136830976 18:20:59 INFO - PROCESS | 23791 | 18:21:21 INFO - PROCESS | 23791 | Cycle 1(1): loaded http://localhost:34256/tests/v8_7/run.html (next: http://localhost:34256/tests/v8_7/run.html) 18:21:22 INFO - PROCESS | 23791 | RSS: Main: 413462528 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | __start_tp_report 18:21:22 INFO - PROCESS | 23791 | _x_x_mozilla_page_load 18:21:22 INFO - PROCESS | 23791 | _x_x_mozilla_page_load_details 18:21:22 INFO - PROCESS | 23791 | |i|pagename|runs| 18:21:22 INFO - PROCESS | 23791 | |0;Richards;165.89250165892503 18:21:22 INFO - PROCESS | 23791 | |1;DeltaBlue;168.89039013680122 18:21:22 INFO - PROCESS | 23791 | |2;Encrypt;278.9400278940028 18:21:22 INFO - PROCESS | 23791 | |3;Decrypt;5196.891191709845 18:21:22 INFO - PROCESS | 23791 | |4;RayTrace;946.969696969697 18:21:22 INFO - PROCESS | 23791 | |5;Earley;559.5970900951315 18:21:22 INFO - PROCESS | 23791 | |6;Boyer;10784.946236559139 18:21:22 INFO - PROCESS | 23791 | |7;RegExp;40019.60784313725 18:21:22 INFO - PROCESS | 23791 | |8;Splay;526.0389268805892 18:21:22 INFO - PROCESS | 23791 | |9;NavierStokes;4830.917874396136 18:21:22 INFO - PROCESS | 23791 | __end_tp_report 18:21:22 INFO - PROCESS | 23791 | __startTimestamp1460683282015__endTimestamp 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | ------- Summary: start ------- 18:21:22 INFO - PROCESS | 23791 | Number of tests: 10 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | [#0] Richards Cycles:1 Average:165.89 Median:165.89 stddev:0.00 (0.0%) 18:21:22 INFO - PROCESS | 23791 | Values: 165.9 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | [#1] DeltaBlue Cycles:1 Average:168.89 Median:168.89 stddev:0.00 (0.0%) 18:21:22 INFO - PROCESS | 23791 | Values: 168.9 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 18:21:22 INFO - PROCESS | 23791 | Values: 278.9 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 18:21:22 INFO - PROCESS | 23791 | Values: 5196.9 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | [#4] RayTrace Cycles:1 Average:946.97 Median:946.97 stddev:0.00 (0.0%) 18:21:22 INFO - PROCESS | 23791 | Values: 947.0 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | [#5] Earley Cycles:1 Average:559.60 Median:559.60 stddev:0.00 (0.0%) 18:21:22 INFO - PROCESS | 23791 | Values: 559.6 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | [#6] Boyer Cycles:1 Average:10784.95 Median:10784.95 stddev:0.00 (0.0%) 18:21:22 INFO - PROCESS | 23791 | Values: 10784.9 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | [#7] RegExp Cycles:1 Average:40019.61 Median:40019.61 stddev:0.00 (0.0%) 18:21:22 INFO - PROCESS | 23791 | Values: 40019.6 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | [#8] Splay Cycles:1 Average:526.04 Median:526.04 stddev:0.00 (0.0%) 18:21:22 INFO - PROCESS | 23791 | Values: 526.0 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - PROCESS | 23791 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 18:21:22 INFO - PROCESS | 23791 | Values: 4830.9 18:21:22 INFO - PROCESS | 23791 | -------- Summary: end -------- 18:21:22 INFO - PROCESS | 23791 | 18:21:22 INFO - TEST-INFO | 23791: exit 0 18:21:22 INFO - TEST-OK | v8_7 | took 40496ms 18:21:22 INFO - SUITE-END | took 1209s 18:21:23 INFO - Completed test suite (00:20:09) 18:21:23 INFO - Working with test: dromaeo_css 18:21:23 INFO - Generating results file: dromaeo_css 18:21:23 INFO - Working with test: kraken 18:21:23 INFO - Generating results file: kraken 18:21:23 INFO - javascript benchmark 18:21:23 INFO - Working with test: v8_7 18:21:23 INFO - Generating results file: v8_7 18:21:23 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:21:23 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 18:21:23 INFO - process_Request line: dromaeo_css 7076.75 graph.html#tests=[[72,53,35]] 18:21:23 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:21:23 INFO - process_Request line: kraken 1481.00 graph.html#tests=[[232,53,35]] 18:21:23 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:21:23 INFO - process_Request line: v8_7 22015.84 graph.html#tests=[[230,53,35]] 18:21:23 INFO - RETURN: dromaeo_css: 7076.75 18:21:23 INFO - RETURN: kraken: 1481.00 18:21:23 INFO - RETURN: v8_7: 22015.84 18:21:23 INFO - javascript benchmark 18:21:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3220.500822372532, 3266.5100234964766, 3272.7381809455246, 3285.310084882173, 3312.602487701476, 5240.449752775956, 5287.947120528794, 5345.919811202835, 5348.973255133719, 5385.4614538546175, 5279.234510995903, 5312.362516498016, 5335.093034184189, 5336.759845806938, 5366.91949620756, 4745.881352966169, 4871.391076115495, 4872.926906096412, 4921.434035085975, 4942.505749425047, 4763.095011947737, 4856.781444834991, 4861.489543597907, 4865.294532292815, 4866.853994380174, 4874.2444921037295, 4877.902441951159, 4885.804567817283, 4967.453580106186, 4971.428285747131, 4941.160002799515, 4957.5042495750495, 4969.875753106165, 4973.303737476756, 4995.5753760930365, 4677.789499472532, 4752.5485078917445, 4913.31213630092, 4938.432080310774, 4948.925766113512, 5120.871978200537, 5228.660137091115, 5230.947690523122, 5246.23929530216, 5254.0805359062015, 5716.0, 5737.08206686928, 5767.36558978512, 5770.307563092414, 5776.537876969833, 5599.412061733541, 5678.4037676044245, 5694.402087780765, 5748.223989761371, 5804.245448091721, 5322.627416080837, 5322.813701520428, 5341.7297648499625, 5354.892902141974, 5378.085725426687, 5827.504662103769, 5835.008048631743, 5836.095405212199, 5837.6497410155525, 5838.8540286492325, 5482.23248745176, 5561.6663000220115, 5611.7474713637985, 5630.155476678531, 5632.408597097327, 5795.88408231833, 5802.535797136219, 5805.912911306334, 5807.361190269067, 5823.563232757476, 5758.913616295759, 5783.942160578425, 5784.248047753765, 5784.768609255582, 5785.739641716133, 5572.749226284827, 5638.971805140948, 5645.71771411436, 5719.971400142973, 5766.0, 4420.602145806893, 4423.248047831877, 4424.292113261927, 4435.423394958635, 4458.398116254329, 3971.8411263549133, 3972.3445631471063, 3979.900502487461, 3983.980080099639, 4018.3771515415156, 5077.162268225701, 5192.4547922468355, 5341.359036915595, 5392.299001129828, 5393.541548968382, 5778.971105144531, 5788.565857560699, 5802.1296805479515, 5805.912911306334, 5813.88372232553, 5428.185772134211, 5457.808976685797, 5471.261379713687, 5472.589555783332, 5481.534069604048, 4813.687110337887, 4893.779779909913, 4904.632152588499, 4959.454460009396, 4997.600191984632, 5831.88336233273, 5855.502282306052, 5863.560232982543, 5871.089981052944, 5872.207252021008, 5423.213634022965, 5674.1488776684655, 5697.686627235542, 5702.0, 5704.3725190228215, 5754.741036653444, 5833.154192642128, 5891.764329426775, 5897.292324921037, 5921.259842519685, 5657.434256574475, 5658.122990936411, 5663.4053424391495, 5665.971670141623, 5667.744951477276, 5512.310961129859, 5568.248286481436, 5715.428457154251, 5732.570057245806, 5741.655500669973, 5533.031719449, 5536.806211782568, 5536.972315138399, 5541.722913854372, 5574.470425309589, 5504.972475137759, 5508.779648814003, 5510.173473978935, 5515.172724091419, 5534.529564987021, 5359.169328754049, 5433.0, 5452.863678408072, 5458.235846981346, 5481.780728770805, 5578.246936663499, 5583.330000399978, 5585.776568937359, 5600.439956004367, 5619.438056194512, 5453.400125986218, 5475.863103422446, 5482.122860342326, 5482.945170548243, 5512.779488820403], "unit": "score", "name": "dojo.html", "value": 5273.083566575276}, {"lowerIsBetter": false, "replicates": [516.6796586116606, 540.1789280293956, 553.239295968044, 573.2748073686786, 587.1867463562967, 32036.199095022635, 39185.21629567407, 39194.412083818694, 39200.80399598005, 39814.80092599537, 40606.0, 41001.58998410015, 41007.38488922668, 41072.38391424131, 41141.58858411415, 8754.693585724484, 8994.775130621754, 9017.504037277948, 9032.954835225848, 9041.547922603844, 8743.0, 8862.911370886306, 8867.911320886806, 8894.24398926092, 8896.644134234622, 8870.201681848632, 9059.95470022649, 9157.679481218158, 9161.221296189799, 9166.633334666605, 9065.773355666095, 9123.087691230858, 9152.4966126863, 9159.084091590854, 9168.40405373652, 8947.910520894773, 9091.31815113869, 9091.409058411182, 9093.909060909438, 9096.545172741337, 42900.3564946526, 43290.783546082384, 43461.78269108666, 43522.347164792554, 43536.0, 3502.0719509330047, 3544.680978711928, 3571.8214089295693, 3687.907802304937, 3749.1751814600743, 29445.263868403246, 29512.0, 29926.102216933527, 30582.69417305843, 30711.2322191947, 4338.696291259613, 4372.737635741833, 4421.867343979686, 4430.623397011258, 4442.644588432918, 283515.0, 285947.57026214944, 286149.0, 286447.0, 286697.0, 61451.38548614546, 62005.68997154985, 69391.0, 69920.65039674871, 69940.65029674921, 64881.67559162174, 67309.3269067303, 67448.66275668591, 67464.66267668728, 67665.0, 18111.45665630033, 18258.543536411697, 18271.0, 18276.817231827776, 18278.0, 14349.139051656934, 14480.855191448161, 14481.855181448262, 14558.272086395638, 14613.707725845423, 22357.664635030487, 22676.88661556682, 22778.65832012521, 22802.65796013061, 22843.885780571323, 8448.254317346888, 8469.915300846913, 8478.022993789364, 8699.913000870038, 8784.341174411944, 1002.5112707629165, 1064.723171975292, 1074.435921141407, 1121.669107613256, 1189.8096304591224, 29873.551896721565, 30245.848770756005, 30302.0, 30444.0, 30675.079747607608, 1095.6165342130191, 1100.4387762241315, 1105.1379923659558, 1167.5621641884293, 1187.804012337972, 15833.52499425019, 15901.284442200129, 15991.520254392386, 16011.359545618045, 16317.184140792913, 345339.0, 349279.0, 349509.0, 350395.0, 350402.0, 57000.0, 57150.428495714514, 57329.14006289909, 57520.137197942066, 57548.71225643845, 1385.9514916977857, 1431.4560467022466, 1441.3946142620125, 1442.1347191684906, 1446.8408475067945, 29592.556111657912, 30349.491095417972, 30700.0, 31050.534241985937, 31224.531632025082, 51350.0, 51475.742621286656, 51858.481415185364, 51876.481235187166, 51897.48102518926, 323942.0, 325467.0, 325713.0, 326108.0, 450534.0, 31980.20049498781, 36866.26267474582, 37359.25281494409, 37497.0, 37805.0, 45070.32394514151, 45215.77392113018, 45472.54527454815, 45494.54505454903, 45897.31154032759, 37827.24345513019, 38072.0, 38276.80861595674, 42726.0, 42741.35887961621, 37393.813030934674, 37673.62326376811, 38188.809055954545, 38223.617763822, 39422.60577394304, 39299.410508842964, 42259.7887010563, 42324.36513452239, 42395.7880210597, 42795.0, 30940.53589196119, 34237.0, 34541.30917381689, 34620.0, 34708.65291347054, 25932.611010834476, 26272.34319142037, 26404.075857344902, 26485.470290593694, 26544.070957516393], "unit": "score", "name": "ext.html", "value": 19943.092224787568}, {"lowerIsBetter": false, "replicates": [397.25118152282954, 398.33080424886197, 399.070166512027, 401.21962782388255, 401.69270508061356, 17168.055756933365, 17672.20475078621, 17692.115394230284, 18621.90689046556, 19446.319378821743, 17599.91200043998, 17698.292068317285, 17926.282948682037, 18126.546836329064, 18130.093495325214, 5584.162375643646, 5765.1352297155345, 5781.103928891008, 5783.190353350535, 5785.16115163301, 5530.281063461744, 5751.942480575203, 5754.395788442216, 5761.991651460999, 5763.049096899007, 4247.957520424787, 4283.100548884738, 5727.713614319288, 5730.0, 6226.813195604139, 6219.129321894939, 6224.751009959597, 6225.221847269068, 6226.87546249077, 6228.0, 5338.145896656555, 5527.50252477279, 5529.391766905637, 5532.695701736403, 5533.446655334475, 11372.260803047859, 11680.766384672259, 13152.605421837361, 13562.79655805154, 13575.864241357558, 2247.269637367862, 2313.4447732544068, 2319.1998760427628, 2406.4946361264156, 2417.8670173140645, 9689.467079310634, 10248.282620216587, 10285.074343309137, 12327.815082773766, 12551.748965020739, 1841.2450895132931, 1957.109515170594, 1961.4507937777446, 1978.6339527187372, 2000.5598768270956, 58798.41201587972, 60069.39930600682, 60909.0, 61020.38979610192, 61922.69038654823, 10950.890491095146, 10983.835242471368, 10986.57174567301, 11009.779804403866, 11082.335059896432, 14429.494967676292, 14495.347709353104, 14537.200453975132, 14580.63548411277, 14599.343029563695, 7987.9201207988335, 8102.473339232931, 8499.702510412106, 8581.95709021451, 8598.226159645661, 8406.621702023423, 8489.915100849035, 8509.191626795444, 8576.356773242032, 8585.18440748128, 4740.075685241345, 4762.476127626028, 4827.493113223061, 4829.710217386968, 4869.975650121798, 1826.4977131289002, 1832.6059897121916, 1859.6094820087933, 1920.5390706230405, 1925.0374812593702, 831.1314676163423, 917.738444543302, 948.8813898262717, 987.6790043235977, 1007.8790545134631, 11313.0, 11699.590514331958, 12008.0, 12103.455344509519, 15984.280707368196, 492.38206051405257, 492.6034542193497, 494.23393739704034, 495.1928356778428, 498.7855222254393, 5414.620976531605, 5997.220361352996, 6248.31268560458, 6262.5616206866, 6263.906041409383, 421130.0, 423519.0, 425491.0, 426529.0, 617213.0, 79984.20015799884, 81664.18335816685, 82027.5898620515, 82185.58907205425, 85214.0, 532.6378062917254, 540.9891802163935, 544.4256309593338, 545.4436474795687, 546.1725485888882, 11167.944160279147, 11457.713557161138, 11485.138614603771, 11587.652370428901, 11616.186866919235, 34166.487502686985, 34920.82539587286, 36125.638743612224, 36770.26459470849, 37079.25841483209, 45615.54384456246, 46736.29895551501, 48026.27960580664, 48272.758636208, 48400.5159948396, 7719.498232614862, 7797.41519386037, 7807.180246074307, 7829.0, 8009.5995200238585, 11071.72320691989, 11379.146564007568, 11600.419979001184, 11645.184837061324, 11884.227525210834, 9657.3239873211, 9971.152452041368, 10002.0, 10125.949370253102, 10730.08794252466, 10351.171906247633, 10370.274080814572, 10418.270721049454, 10543.857292801367, 10718.73203169927, 10207.387556746618, 10675.306105103144, 10724.839127412939, 10740.979606937328, 10746.08658264025, 6153.6000159991245, 7575.810604734926, 7658.425618078778, 7968.362530997622, 8009.959950200445, 9574.664886728931, 10159.23805714589, 10310.587576496857, 10532.157427405637, 10629.096526795309], "unit": "score", "name": "jquery.html", "value": 8005.865096385001}, {"lowerIsBetter": false, "replicates": [1524.3292951101514, 1532.1955973114113, 1719.8968061916287, 1817.409341963862, 1836.8255015773505, 8256.711015114472, 8465.66137354505, 8471.745847624574, 8478.152184781526, 8487.872681909761, 8301.83774271601, 8353.457025293366, 8355.582220888962, 8356.83286334273, 8357.582120893961, 2449.3264352303127, 2453.264020793764, 2477.0339567568662, 2477.1082410332265, 2477.826552141351, 2463.334899577113, 2476.1333533263396, 2486.191987604027, 2505.498900219954, 2506.4360518883286, 2088.3943656339643, 2145.549434618732, 2343.6836027136374, 2476.987615061931, 2486.2416962826333, 2317.478567322356, 2327.3716096653893, 2342.5314937012495, 2343.074485578204, 2343.753905839888, 2271.2731925783755, 2347.941301467477, 2350.753170917046, 2351.353377821096, 2353.9411514712097, 6890.173179218526, 7037.085178926707, 7727.072751269883, 7897.24976127267, 7902.644381002869, 4855.805767769285, 5042.193249080166, 5045.066662667382, 5050.0, 5051.090803655341, 3283.950740738891, 3291.7860339077884, 3341.4987751837175, 3400.1669590950128, 3402.8808991685173, 1102.8125218712757, 1110.8666959964776, 1132.1848269246211, 1178.393127539318, 1210.056156198158, 11300.94349528247, 11311.490982905707, 11330.093592512661, 11374.829377559343, 11405.14461415397, 4516.07420478801, 4529.0, 4529.184746745552, 4538.069695712371, 4540.273556230987, 9384.24926005918, 9403.858942115874, 9406.811863762687, 9426.575804088832, 9432.386894851812, 5042.2184561392305, 5059.569936555434, 5090.9236361454605, 5091.5489085610425, 5092.0, 4698.248280275139, 4704.1767690654, 4705.60002399793, 4709.340692303081, 4709.646776491777, 3940.704447166474, 3990.082281075369, 4016.477857878457, 4031.5363733170475, 4059.2084543513733, 1226.1171956191529, 1227.6623928419579, 1240.4294024748535, 1242.4719494214924, 1252.2298786246392, 1110.7889500994786, 1136.8351589019546, 1139.014752239307, 1347.2994043097535, 1427.6502256946906, 7639.923600763921, 7649.235076492307, 7705.922940770521, 7965.0, 7978.6409611567615, 534.834201397568, 538.4722971487964, 538.8545092824916, 546.4535464535464, 547.0535972767135, 5711.8857622848145, 5822.155787410887, 6057.273127224673, 6080.2399700037495, 6084.330723620398, 8843.823123537493, 9847.50762461874, 9901.851472227921, 10043.949780251052, 10048.79902401948, 9803.16673082796, 9812.116909478182, 9892.901070989343, 10141.898581014242, 10212.285140040125, 7604.467687261949, 7644.312011918954, 7702.3453006493955, 7717.151113377524, 7723.420743444264, 7965.283124518821, 8000.919990800017, 8045.919540804517, 8065.677372905018, 8083.110857805755, 9043.0, 9051.411658242194, 9076.183143517115, 9093.136152065543, 9257.537123143951, 9476.241900648069, 9656.95171524138, 9697.9030209697, 9730.659426920023, 9757.658481953098, 6862.142232220973, 6970.372666460043, 7002.719891204295, 7534.095908491016, 7657.34912532441, 7479.401647868266, 7537.660805263667, 7540.698372065056, 7543.811404714926, 7548.886766698613, 7011.859762804614, 7036.226015138228, 7089.184743754328, 7157.928420715726, 7218.314260145278, 7056.0, 7104.254053324326, 7138.714451421885, 7148.606826624586, 7221.133463984145, 7327.1207455103595, 7508.099028116442, 7685.308322251024, 7691.1155217150745, 7698.615069246627, 6879.96800479932, 6925.549839260432, 6957.721691132298, 6973.442124630119, 6982.68577913985, 7011.3339232772805, 7015.929840701528, 7147.070880785673, 7147.249538798559, 7158.105236845395], "unit": "score", "name": "mootools.html", "value": 4672.253258562593}, {"lowerIsBetter": false, "replicates": [366.36435783914914, 368.701351904957, 372.517589721311, 376.5142965574409, 384.1740258444346, 6013.939860601398, 6020.428059334367, 6028.638281703101, 6054.848628784277, 6057.151998720177, 5714.000049991245, 5834.387389324123, 5886.882262354761, 5894.4989675877605, 5967.343592204865, 4669.112868554964, 4673.2756422754355, 4684.695494792828, 4691.225947718623, 4703.459102203256, 4442.444694413199, 4671.27595222741, 4686.765661716918, 4690.061987602493, 4693.5541123593375, 4556.977215113936, 4581.060882519076, 4617.515160908107, 4643.907121857561, 4644.349791029259, 4615.307703844416, 4616.792244349012, 4626.1441633297945, 4656.301554766778, 4665.136949664289, 4158.91682166355, 4171.97914010431, 4185.560516145822, 4186.832526698929, 4190.141021090669, 5620.9437905620825, 5685.0, 5690.829275121753, 5695.34503532095, 5699.0, 5504.697241651707, 5505.449455054502, 5509.201165830932, 5513.531349835269, 5519.530839878616, 6419.550631455753, 6428.678566071678, 6433.9678301608665, 6437.0, 6437.388448097423, 4675.18184317743, 4675.4155730533685, 4678.789454474523, 4679.766011699436, 4689.601383882374, 6479.5788273762055, 6581.86836263272, 6635.535512514126, 6645.900311495331, 6648.501362397839, 4641.3734145889875, 4642.883927901829, 4646.697964632288, 4648.163330600524, 4696.38946936896, 4742.834000809955, 4758.571728544448, 4760.166970780099, 4763.3807605011125, 4765.785539650655, 5376.542993845489, 5407.405185429599, 5407.513323800877, 5409.810656627078, 5410.567154627621, 6209.316975132731, 6365.045243213555, 6402.679866006681, 6409.134766806515, 6425.485961123099, 1702.2254874032285, 1719.9226034828462, 1721.3372851452032, 1722.1647500962024, 1723.603571178636, 1177.7703347847087, 1196.3958201108558, 1198.1433275208094, 1214.107630891294, 1226.7791797476361, 6151.231096112986, 6151.507879369639, 6151.84620384494, 6152.3540028297275, 6157.84605384869, 6369.904451433232, 6566.212054553484, 6580.80257592273, 6604.438622717027, 6657.400833924873, 6035.6076855004285, 6050.48570871472, 6188.226471691039, 6221.3156552779155, 6221.471174950089, 3546.184377593168, 3556.8399422026073, 3573.6247693992277, 3574.2315402188656, 3579.0336609115393, 6680.933190668031, 6789.386086356788, 6797.320267973163, 6806.081179040865, 6806.965965170241, 6765.188177418741, 6790.117284752951, 6794.048833163361, 6794.048833163361, 6798.66006699663, 6769.3907548320885, 6786.4910131739325, 6792.490563207779, 6792.660366981631, 6796.490263230277, 6469.77355792545, 6593.934060659332, 6612.867742645217, 6616.569922954993, 6617.371349721769, 6559.180102487189, 6561.376669216417, 6564.770233041821, 6609.966950165219, 6614.735410583715, 6721.1598550181225, 6769.763058292936, 6773.762918297836, 6796.320367963164, 6804.693788779417, 4810.302506136521, 4812.085703716282, 4814.253790662453, 4815.277708343777, 4819.0, 6498.545101842826, 6616.239132499824, 6617.338266173344, 6621.569597976116, 6629.602223866584, 6480.513961452815, 6480.643564603992, 6497.675116244263, 6497.740090396331, 6498.0, 6269.529785266214, 6470.029495575702, 6472.126262954441, 6475.579087359307, 6477.287498375269, 6325.335839736761, 6338.524610654127, 6343.270523889627, 6350.650714210763, 6383.074454204021, 6508.576942498722, 6509.153810004669, 6513.934860651333, 6514.869702606016, 6550.246721627074, 6139.079138129317, 6273.592216505913, 6274.905876411949, 6276.592021518587, 6341.651209183355], "unit": "score", "name": "prototype.html", "value": 4899.088386794555}, {"lowerIsBetter": false, "replicates": [894.9060348663394, 897.7028194259295, 907.3285768531284, 918.0681608167708, 926.2451102351583, 13346.66633334167, 13591.252481113546, 13610.659733506667, 13632.931835340822, 13675.658108547292, 13375.799363009563, 13473.528426505074, 13475.797863032063, 13499.25754083525, 13634.727305453885, 731.1555153797347, 735.7572001239578, 861.267922266072, 867.0635713429481, 868.5961028121922, 861.1732736572898, 863.2230992107122, 866.3588944181292, 866.7486428935632, 866.8743032260319, 920.4017388697333, 921.8478950973081, 921.9585118669676, 922.3820040572832, 922.575615217001, 759.3962799574324, 764.5947647746704, 898.1736802142012, 912.2838571721234, 916.0244339778116, 669.1301308299192, 669.8358902068976, 675.9459243260527, 676.3844901139988, 677.0250838792124, 12185.634430967086, 12206.08454365926, 12245.0, 12260.44827982734, 12278.140530162802, 12911.935440322739, 13507.66230844227, 13619.591412257649, 13682.31588420585, 13869.167849929037, 10949.0, 10949.890501095046, 10955.616553420672, 10997.230193886431, 11182.16133789969, 3766.510353654035, 3778.282126395976, 3785.5646600641003, 3809.3524100902914, 3811.9237615247816, 48625.75687121542, 49074.50925490735, 50616.0, 51427.228591571155, 51586.22620660693, 10527.578896844041, 10547.338014841407, 10653.84019239712, 10841.349519028883, 10966.725831854268, 18610.906945465456, 18791.90604046971, 18814.05929703509, 18821.905890470734, 18833.340833070775, 7445.516041457288, 7516.473846830779, 7945.443818932619, 8096.51420914747, 8172.918270817216, 4472.508024117345, 4498.730076195438, 4679.81280748773, 4715.386999690087, 4724.740139292372, 3013.2617508710505, 3044.2998110434723, 3045.8172509649494, 3047.6647568767416, 3055.648600410981, 520.7682581251382, 535.799075346745, 540.4919375786748, 545.4572700163284, 545.9208414779835, 586.3286536915208, 627.7995625333178, 700.2083716674254, 712.0743034055707, 729.1250499400741, 8728.214460698568, 8820.647174112964, 8874.112588741074, 8942.821143577092, 9076.183143517115, 597.5369088956007, 611.2023808929301, 627.7112528236971, 710.7796583059268, 747.3386053342831, 4116.794160291974, 4206.116715489781, 4274.2092712848225, 4291.806868690916, 4355.237833379146, 54690.0, 55084.44915550793, 55195.72402137964, 60472.0, 60893.0, 48882.77793055202, 49755.004899902524, 50294.748526257135, 50738.0, 51398.486015140115, 46164.7691761539, 47690.0, 47791.0, 48106.0, 48522.75738621284, 8628.956855215934, 8754.781130471789, 8759.518226497348, 8828.735137945872, 8924.643014279356, 35389.115272118404, 35820.820895895355, 35927.10182245465, 36459.81770091133, 36851.81574092113, 40982.0, 45098.0980380384, 46243.306350405444, 46860.0, 46969.0, 11606.4961210105, 11635.127365447795, 11707.356095414834, 11720.824187637021, 11851.881481185423, 12257.509699611915, 12295.07786915967, 12317.260964342167, 12375.814362784746, 12804.61586152417, 11169.944150279196, 11265.155113366367, 11532.59635912739, 12155.939220303842, 12577.559785407468, 11903.702407439883, 11907.82138267944, 11990.760184796429, 12126.0, 12210.87789122133, 11158.330500170016, 11414.029807466126, 11713.941430292794, 11842.526298947945, 12232.327222002876, 9961.701148965543, 10288.0, 10439.53022114022, 10557.683269501927, 10619.415932123808, 9244.168024877794, 9706.417614943126, 9721.513924303898, 9810.65662701802, 9822.901770982198], "unit": "score", "name": "yui.html", "value": 6517.164395473668}], "name": "dromaeo_css", "value": 7076.75277654877}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 108.0, 109.0, 120.0, 102.0, 108.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 151.0, 161.0, 123.0, 145.0, 151.0, 129.0, 161.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 162.0, 161.0, 163.0, 161.0, 161.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 77.0, 144.0, 73.0, 74.0, 72.0, 73.0, 143.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 146.0, 95.0, 96.0, 95.0, 138.0, 95.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 66.0, 65.0, 66.0, 67.0, 66.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [77.0, 81.0, 79.0, 86.0, 78.0, 79.0, 80.0, 79.0, 78.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 117.0, 111.0, 116.0, 113.0, 110.0, 111.0, 109.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.0}, {"lowerIsBetter": true, "replicates": [148.0, 143.0, 144.0, 143.0, 144.0, 133.0, 141.0, 145.0, 145.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.0}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 65.0, 64.0, 64.0, 65.0, 65.0, 62.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1481.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.89250165892503], "unit": "score", "name": "Richards", "value": 212.80045599999988}, {"lowerIsBetter": false, "replicates": [168.89039013680122], "unit": "score", "name": "DeltaBlue", "value": 391.4846780000002}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [946.969696969697], "unit": "score", "name": "RayTrace", "value": 781.4283840000004}, {"lowerIsBetter": false, "replicates": [559.5970900951315], "unit": "score", "name": "Earley", "value": 1190.9693809999999}, {"lowerIsBetter": false, "replicates": [10784.946236559139], "unit": "score", "name": "Boyer", "value": 61.79567198404785}, {"lowerIsBetter": false, "replicates": [40019.60784313725], "unit": "score", "name": "RegExp", "value": 22.763466438020597}, {"lowerIsBetter": false, "replicates": [526.0389268805892], "unit": "score", "name": "Splay", "value": 154.91439100000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 22015.83997319405}]} 18:21:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "22015.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1481.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7076.75"}}} 18:21:23 INFO - Return code: 0 18:21:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:21:23 INFO - # TBPL SUCCESS # 18:21:23 INFO - Running post-action listener: _resource_record_post_action 18:21:23 INFO - Running post-run listener: _resource_record_post_run 18:21:24 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 461414400; Read time: 12; Write time: 389944 18:21:24 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 234733568; Read time: 0; Write time: 262396 18:21:24 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 226680832; Read time: 12; Write time: 127548 18:21:24 INFO - Running post-run listener: _upload_blobber_files 18:21:24 INFO - Blob upload gear active. 18:21:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:21:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:21:25 INFO - (blobuploader) - INFO - Open directory for files ... 18:21:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:21:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:21:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:25 INFO - (blobuploader) - INFO - Done attempting. 18:21:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:21:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:21:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:26 INFO - (blobuploader) - INFO - Done attempting. 18:21:26 INFO - (blobuploader) - INFO - Iteration through files over. 18:21:26 INFO - Return code: 0 18:21:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:21:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:21:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d24b48ea14e802ecdb9df48174115410c0c061928c0c5f2e7e500988ff9fe73a9eba5e03a6dd7d7af55f60e46c413dc920fd2aac720979bf618983156c8defd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5c2d53c588424350b00ddf4b6f9dacb6d1cc1582858283e45db356ce724b554ce80c6ed5cf49668eff9c1f80bfc63a467664afc90b74d66ba54b956fb2611ff"} 18:21:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:21:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:21:26 INFO - Contents: 18:21:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d24b48ea14e802ecdb9df48174115410c0c061928c0c5f2e7e500988ff9fe73a9eba5e03a6dd7d7af55f60e46c413dc920fd2aac720979bf618983156c8defd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5c2d53c588424350b00ddf4b6f9dacb6d1cc1582858283e45db356ce724b554ce80c6ed5cf49668eff9c1f80bfc63a467664afc90b74d66ba54b956fb2611ff"} 18:21:26 INFO - Running post-run listener: copy_logs_to_upload_dir 18:21:26 INFO - Copying logs to upload dir... 18:21:26 INFO - mkdir: /builds/slave/test/build/upload/logs 18:21:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.031885 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-14 18:21:26.684503) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 18:21:26.688057) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308 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/d24b48ea14e802ecdb9df48174115410c0c061928c0c5f2e7e500988ff9fe73a9eba5e03a6dd7d7af55f60e46c413dc920fd2aac720979bf618983156c8defd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5c2d53c588424350b00ddf4b6f9dacb6d1cc1582858283e45db356ce724b554ce80c6ed5cf49668eff9c1f80bfc63a467664afc90b74d66ba54b956fb2611ff"} build_url:https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/XSEiYZpZS-iGqEbadX7jHA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d24b48ea14e802ecdb9df48174115410c0c061928c0c5f2e7e500988ff9fe73a9eba5e03a6dd7d7af55f60e46c413dc920fd2aac720979bf618983156c8defd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5c2d53c588424350b00ddf4b6f9dacb6d1cc1582858283e45db356ce724b554ce80c6ed5cf49668eff9c1f80bfc63a467664afc90b74d66ba54b956fb2611ff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 18:21:26.717542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 18:21:26.717885) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460681315.232388-1446492308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 18:21:26.801855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 18:21:26.802289) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 18:21:26.802648) ========= ========= Total master_lag: 0.18 =========