builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1467042305.08 results: success (0) buildid: 20160627060325 builduid: c795a5e100e14834ba0c65e4d75f47bf revision: b98e6837de52c839aa3f2a222c70c53038c63527 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:05.077580) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:05.078194) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:05.078552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:05.092365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:05.092664) ========= 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=836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 08:45:06-- 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% 227M=0s 2016-06-27 08:45:06 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104680 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:05.209026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:05.209367) ========= 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=836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020617 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:05.261671) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 08:45:05.262441) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b98e6837de52c839aa3f2a222c70c53038c63527 --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 b98e6837de52c839aa3f2a222c70c53038c63527 --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=836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 08:45:06,501 truncating revision to first 12 chars 2016-06-27 08:45:06,501 Setting DEBUG logging. 2016-06-27 08:45:06,501 attempt 1/10 2016-06-27 08:45:06,501 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b98e6837de52?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 08:45:07,469 unpacking tar archive at: mozilla-beta-b98e6837de52/testing/mozharness/ program finished with exit code 0 elapsedTime=1.327401 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 08:45:06.609431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:06.609917) ========= script_repo_revision: b98e6837de52c839aa3f2a222c70c53038c63527 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:06.610470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:06.610926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:45:06.621992) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2016-06-27 08:45:06.622321) ========= /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=836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:45:07 INFO - MultiFileLogger online at 20160627 08:45:07 in /builds/slave/test 08:45:07 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 08:45:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:45:07 INFO - {'append_to_log': False, 08:45:07 INFO - 'base_work_dir': '/builds/slave/test', 08:45:07 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:45:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:45:07 INFO - 'branch': 'Mozilla-Beta', 08:45:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:45:07 INFO - 'config_files': ('talos/linux_config.py',), 08:45:07 INFO - 'default_actions': ('clobber', 08:45:07 INFO - 'read-buildbot-config', 08:45:07 INFO - 'download-and-extract', 08:45:07 INFO - 'populate-webroot', 08:45:07 INFO - 'create-virtualenv', 08:45:07 INFO - 'install', 08:45:07 INFO - 'run-tests'), 08:45:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:45:07 INFO - 'download_minidump_stackwalk': True, 08:45:07 INFO - 'download_symbols': 'ondemand', 08:45:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:45:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:45:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:45:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:45:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:45:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:45:07 INFO - 'installer_path': 'installer.exe', 08:45:07 INFO - 'log_level': 'info', 08:45:07 INFO - 'log_name': 'talos', 08:45:07 INFO - 'log_to_console': True, 08:45:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:45:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:45:07 INFO - 'opt_config_files': (), 08:45:07 INFO - 'pip_index': False, 08:45:07 INFO - 'sps_profile': False, 08:45:07 INFO - 'sps_profile_interval': 0, 08:45:07 INFO - 'suite': 'dromaeojs', 08:45:07 INFO - 'system_bits': '32', 08:45:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:45:07 INFO - 'title': 'talos-linux64-ix-028', 08:45:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:45:07 INFO - 'use_talos_json': True, 08:45:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:45:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:45:07 INFO - 'work_dir': 'build'} 08:45:07 INFO - ##### 08:45:07 INFO - ##### Running clobber step. 08:45:07 INFO - ##### 08:45:07 INFO - Running pre-action listener: _resource_record_pre_action 08:45:07 INFO - Running main action method: clobber 08:45:07 INFO - rmtree: /builds/slave/test/build 08:45:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:45:08 INFO - Running post-action listener: _resource_record_post_action 08:45:08 INFO - ##### 08:45:08 INFO - ##### Running read-buildbot-config step. 08:45:08 INFO - ##### 08:45:08 INFO - Running pre-action listener: _resource_record_pre_action 08:45:08 INFO - Running main action method: read_buildbot_config 08:45:08 INFO - Using buildbot properties: 08:45:08 INFO - { 08:45:08 INFO - "project": "", 08:45:08 INFO - "product": "firefox", 08:45:08 INFO - "script_repo_revision": "production", 08:45:08 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:45:08 INFO - "repository": "", 08:45:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:45:08 INFO - "buildid": "20160627060325", 08:45:08 INFO - "pgo_build": "True", 08:45:08 INFO - "basedir": "/builds/slave/test", 08:45:08 INFO - "buildnumber": 275, 08:45:08 INFO - "slavename": "talos-linux64-ix-028", 08:45:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:45:08 INFO - "platform": "ubuntu64_hw", 08:45:08 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:45:08 INFO - "branch": "mozilla-beta", 08:45:08 INFO - "repo_path": "releases/mozilla-beta", 08:45:08 INFO - "revision": "b98e6837de52c839aa3f2a222c70c53038c63527", 08:45:08 INFO - "stage_platform": "linux64-pgo", 08:45:08 INFO - "builduid": "c795a5e100e14834ba0c65e4d75f47bf", 08:45:08 INFO - "slavebuilddir": "test" 08:45:08 INFO - } 08:45:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 08:45:08 INFO - Running post-action listener: _resource_record_post_action 08:45:08 INFO - ##### 08:45:08 INFO - ##### Running download-and-extract step. 08:45:08 INFO - ##### 08:45:08 INFO - Running pre-action listener: _resource_record_pre_action 08:45:08 INFO - Running main action method: download_and_extract 08:45:08 INFO - mkdir: /builds/slave/test/build/tests 08:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:08 INFO - https://queue.taskcluster.net/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:45:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:45:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:45:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:45:10 INFO - Downloaded 1327 bytes. 08:45:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:45:10 INFO - Using the following test package requirements: 08:45:10 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:45:10 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:45:10 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 08:45:10 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'jsshell-linux-x86_64.zip'], 08:45:10 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:45:10 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:45:10 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 08:45:10 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 08:45:10 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:45:10 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:45:10 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:10 INFO - https://queue.taskcluster.net/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:45:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:45:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:45:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:45:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:45:15 INFO - Downloaded 24235695 bytes. 08:45:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:45:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:45:16 INFO - Return code: 0 08:45:16 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:16 INFO - https://queue.taskcluster.net/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:45:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:45:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:45:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:45:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:45:18 INFO - Downloaded 24235695 bytes. 08:45:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:45:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:45:19 INFO - Return code: 0 08:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:19 INFO - https://queue.taskcluster.net/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:45:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:45:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:45:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:45:20 INFO - Downloaded 10840145 bytes. 08:45:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:45:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:45:20 INFO - Return code: 0 08:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:20 INFO - https://queue.taskcluster.net/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:45:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:45:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:45:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:46:18 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2: The read operation timed out 08:46:18 INFO - retry: attempt #1 caught exception: The read operation timed out 08:46:18 INFO - retry: Failed, sleeping 30 seconds before retrying 08:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 08:46:59 INFO - Downloaded 55988759 bytes. 08:46:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:46:59 INFO - mkdir: /builds/slave/test/properties 08:46:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:59 INFO - Contents: 08:46:59 INFO - build_url:https://queue.taskcluster.net/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:47:00 INFO - Running post-action listener: _resource_record_post_action 08:47:00 INFO - Running post-action listener: set_extra_try_arguments 08:47:00 INFO - ##### 08:47:00 INFO - ##### Running populate-webroot step. 08:47:00 INFO - ##### 08:47:00 INFO - Running pre-action listener: _resource_record_pre_action 08:47:00 INFO - Running main action method: populate_webroot 08:47:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:47:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:47:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:47:00 INFO - '--tppagecycles', 08:47:00 INFO - '7'], 08:47:00 INFO - 'tests': ['tsvgm']}}, 08:47:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:47:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:47:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:47:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:47:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:47:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:47:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'talos_options': ['--disable-e10s'], 08:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'talos_options': ['--disable-e10s'], 08:47:00 INFO - 'tests': ['damp', 'tps']}, 08:47:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'tests': ['damp', 'tps']}, 08:47:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:47:00 INFO - 'tests': ['dromaeo_dom']}, 08:47:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:47:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:47:00 INFO - 'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'other-e10s': {'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:47:00 INFO - 'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:47:00 INFO - 'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:47:00 INFO - 'tests': ['tsvgx', 08:47:00 INFO - 'tsvgr_opacity', 08:47:00 INFO - 'tart', 08:47:00 INFO - 'tscrollx', 08:47:00 INFO - 'cart']}, 08:47:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:47:00 INFO - 'tsvgr_opacity', 08:47:00 INFO - 'tart', 08:47:00 INFO - 'tscrollx', 08:47:00 INFO - 'cart']}, 08:47:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'talos_options': ['--disable-e10s'], 08:47:00 INFO - 'tests': ['tp5o']}, 08:47:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'tests': ['tp5o']}, 08:47:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'talos_options': ['--disable-e10s', 08:47:00 INFO - '--xperf_path', 08:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:00 INFO - 'tests': ['tp5n']}, 08:47:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'talos_options': ['--xperf_path', 08:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:00 INFO - 'tests': ['tp5n']}}, 08:47:00 INFO - 'talos.zip': {'path': '', 08:47:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:47:00 INFO - Running post-action listener: _resource_record_post_action 08:47:00 INFO - ##### 08:47:00 INFO - ##### Running create-virtualenv step. 08:47:00 INFO - ##### 08:47:00 INFO - Running pre-action listener: _resource_record_pre_action 08:47:00 INFO - Running main action method: create_virtualenv 08:47:00 INFO - Creating virtualenv /builds/slave/test/build/venv 08:47:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:47:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:47:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:47:00 INFO - Using real prefix '/usr' 08:47:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:47:00 INFO - Installing distribute.............................................................................................................................................................................................done. 08:47:02 INFO - Installing pip.................done. 08:47:02 INFO - Return code: 0 08:47:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:02 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 0x7f563ba07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285410>, '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 0x1286310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12867a0>, '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': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', '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 08:47:02 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 08:47:02 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 08:47:02 INFO - Using env: {'DISPLAY': ':0', 08:47:02 INFO - 'HOME': '/home/cltbld', 08:47:02 INFO - 'LANG': 'en_US.UTF-8', 08:47:02 INFO - 'LANGUAGE': 'en_US:en', 08:47:02 INFO - 'LOGNAME': 'cltbld', 08:47:02 INFO - 'MAIL': '/var/mail/cltbld', 08:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:02 INFO - 'MOZ_NO_REMOTE': '1', 08:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:02 INFO - 'NO_EM_RESTART': '1', 08:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:02 INFO - 'PWD': '/builds/slave/test', 08:47:02 INFO - 'SHELL': '/bin/bash', 08:47:02 INFO - 'SHLVL': '1', 08:47:02 INFO - 'TERM': 'linux', 08:47:02 INFO - 'TMOUT': '86400', 08:47:02 INFO - 'USER': 'cltbld', 08:47:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', 08:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:02 INFO - '_': '/tools/buildbot/bin/python'} 08:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:47:03 INFO - Cleaning up... 08:47:03 INFO - Return code: 0 08:47:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f563ba07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285410>, '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 0x1286310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12867a0>, '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': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', '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 08:47:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:47:03 INFO - Using env: {'DISPLAY': ':0', 08:47:03 INFO - 'HOME': '/home/cltbld', 08:47:03 INFO - 'LANG': 'en_US.UTF-8', 08:47:03 INFO - 'LANGUAGE': 'en_US:en', 08:47:03 INFO - 'LOGNAME': 'cltbld', 08:47:03 INFO - 'MAIL': '/var/mail/cltbld', 08:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:03 INFO - 'MOZ_NO_REMOTE': '1', 08:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:03 INFO - 'NO_EM_RESTART': '1', 08:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:03 INFO - 'PWD': '/builds/slave/test', 08:47:03 INFO - 'SHELL': '/bin/bash', 08:47:03 INFO - 'SHLVL': '1', 08:47:03 INFO - 'TERM': 'linux', 08:47:03 INFO - 'TMOUT': '86400', 08:47:03 INFO - 'USER': 'cltbld', 08:47:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', 08:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:03 INFO - '_': '/tools/buildbot/bin/python'} 08:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:03 INFO - Downloading/unpacking psutil>=0.7.1 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:05 INFO - Installing collected packages: psutil 08:47:05 INFO - Running setup.py install for psutil 08:47:05 INFO - building 'psutil._psutil_linux' extension 08:47:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:47:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:47:05 INFO - building 'psutil._psutil_posix' extension 08:47:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:47:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:05 INFO - Successfully installed psutil 08:47:05 INFO - Cleaning up... 08:47:05 INFO - Return code: 0 08:47:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f563ba07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285410>, '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 0x1286310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12867a0>, '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': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', '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 08:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:47:05 INFO - Using env: {'DISPLAY': ':0', 08:47:05 INFO - 'HOME': '/home/cltbld', 08:47:05 INFO - 'LANG': 'en_US.UTF-8', 08:47:05 INFO - 'LANGUAGE': 'en_US:en', 08:47:05 INFO - 'LOGNAME': 'cltbld', 08:47:05 INFO - 'MAIL': '/var/mail/cltbld', 08:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:05 INFO - 'MOZ_NO_REMOTE': '1', 08:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:05 INFO - 'NO_EM_RESTART': '1', 08:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:05 INFO - 'PWD': '/builds/slave/test', 08:47:05 INFO - 'SHELL': '/bin/bash', 08:47:05 INFO - 'SHLVL': '1', 08:47:05 INFO - 'TERM': 'linux', 08:47:05 INFO - 'TMOUT': '86400', 08:47:05 INFO - 'USER': 'cltbld', 08:47:05 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', 08:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:05 INFO - '_': '/tools/buildbot/bin/python'} 08:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:47:08 INFO - Installing collected packages: mozsystemmonitor 08:47:08 INFO - Running setup.py install for mozsystemmonitor 08:47:08 INFO - Successfully installed mozsystemmonitor 08:47:08 INFO - Cleaning up... 08:47:08 INFO - Return code: 0 08:47:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f563ba07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285410>, '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 0x1286310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12867a0>, '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': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', '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 08:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:47:08 INFO - Using env: {'DISPLAY': ':0', 08:47:08 INFO - 'HOME': '/home/cltbld', 08:47:08 INFO - 'LANG': 'en_US.UTF-8', 08:47:08 INFO - 'LANGUAGE': 'en_US:en', 08:47:08 INFO - 'LOGNAME': 'cltbld', 08:47:08 INFO - 'MAIL': '/var/mail/cltbld', 08:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:08 INFO - 'MOZ_NO_REMOTE': '1', 08:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:08 INFO - 'NO_EM_RESTART': '1', 08:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:08 INFO - 'PWD': '/builds/slave/test', 08:47:08 INFO - 'SHELL': '/bin/bash', 08:47:08 INFO - 'SHLVL': '1', 08:47:08 INFO - 'TERM': 'linux', 08:47:08 INFO - 'TMOUT': '86400', 08:47:08 INFO - 'USER': 'cltbld', 08:47:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', 08:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:08 INFO - '_': '/tools/buildbot/bin/python'} 08:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:08 INFO - Downloading/unpacking blobuploader==1.2.4 08:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:10 INFO - Downloading blobuploader-1.2.4.tar.gz 08:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:47:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:47:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:10 INFO - Downloading docopt-0.6.1.tar.gz 08:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:47:11 INFO - Installing collected packages: blobuploader, requests, docopt 08:47:11 INFO - Running setup.py install for blobuploader 08:47:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:47:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:47:11 INFO - Running setup.py install for requests 08:47:11 INFO - Running setup.py install for docopt 08:47:11 INFO - Successfully installed blobuploader requests docopt 08:47:11 INFO - Cleaning up... 08:47:11 INFO - Return code: 0 08:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f563ba07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285410>, '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 0x1286310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12867a0>, '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': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', '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 08:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:11 INFO - Using env: {'DISPLAY': ':0', 08:47:11 INFO - 'HOME': '/home/cltbld', 08:47:11 INFO - 'LANG': 'en_US.UTF-8', 08:47:11 INFO - 'LANGUAGE': 'en_US:en', 08:47:11 INFO - 'LOGNAME': 'cltbld', 08:47:11 INFO - 'MAIL': '/var/mail/cltbld', 08:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:11 INFO - 'MOZ_NO_REMOTE': '1', 08:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:11 INFO - 'NO_EM_RESTART': '1', 08:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:11 INFO - 'PWD': '/builds/slave/test', 08:47:11 INFO - 'SHELL': '/bin/bash', 08:47:11 INFO - 'SHLVL': '1', 08:47:11 INFO - 'TERM': 'linux', 08:47:11 INFO - 'TMOUT': '86400', 08:47:11 INFO - 'USER': 'cltbld', 08:47:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', 08:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:11 INFO - '_': '/tools/buildbot/bin/python'} 08:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:11 INFO - Running setup.py (path:/tmp/pip-gmqFlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:11 INFO - Running setup.py (path:/tmp/pip-34RaQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:12 INFO - Running setup.py (path:/tmp/pip-OKqi9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:12 INFO - Running setup.py (path:/tmp/pip-_1TSN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:12 INFO - Running setup.py (path:/tmp/pip-BrNs29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:12 INFO - Running setup.py (path:/tmp/pip-_yurm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:12 INFO - Running setup.py (path:/tmp/pip-EM5RkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:12 INFO - Running setup.py (path:/tmp/pip-0dy0Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:12 INFO - Running setup.py (path:/tmp/pip-ukdmec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:12 INFO - Running setup.py (path:/tmp/pip-r2d_wE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:12 INFO - Running setup.py (path:/tmp/pip-4xpXfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:12 INFO - Running setup.py (path:/tmp/pip-gknn9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:12 INFO - Running setup.py (path:/tmp/pip-cOJeO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:12 INFO - Running setup.py (path:/tmp/pip-NchenA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:12 INFO - Running setup.py (path:/tmp/pip-Gw7h66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:12 INFO - Running setup.py (path:/tmp/pip-Lhsa9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:13 INFO - Running setup.py (path:/tmp/pip-f6Gw0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:47:13 INFO - Running setup.py install for manifestparser 08:47:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Running setup.py install for mozcrash 08:47:13 INFO - Running setup.py install for mozdebug 08:47:13 INFO - Running setup.py install for mozdevice 08:47:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Running setup.py install for mozfile 08:47:13 INFO - Running setup.py install for mozhttpd 08:47:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Running setup.py install for mozinfo 08:47:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Running setup.py install for mozInstall 08:47:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Running setup.py install for mozleak 08:47:14 INFO - Running setup.py install for mozlog 08:47:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Running setup.py install for moznetwork 08:47:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Running setup.py install for mozprocess 08:47:14 INFO - Running setup.py install for mozprofile 08:47:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Running setup.py install for mozrunner 08:47:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Running setup.py install for mozscreenshot 08:47:14 INFO - Running setup.py install for moztest 08:47:14 INFO - Running setup.py install for mozversion 08:47:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:47:14 INFO - Cleaning up... 08:47:14 INFO - Return code: 0 08:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f563ba07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285410>, '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 0x1286310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12867a0>, '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': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', '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 08:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:14 INFO - Using env: {'DISPLAY': ':0', 08:47:14 INFO - 'HOME': '/home/cltbld', 08:47:14 INFO - 'LANG': 'en_US.UTF-8', 08:47:14 INFO - 'LANGUAGE': 'en_US:en', 08:47:14 INFO - 'LOGNAME': 'cltbld', 08:47:14 INFO - 'MAIL': '/var/mail/cltbld', 08:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:14 INFO - 'MOZ_NO_REMOTE': '1', 08:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:14 INFO - 'NO_EM_RESTART': '1', 08:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:14 INFO - 'PWD': '/builds/slave/test', 08:47:14 INFO - 'SHELL': '/bin/bash', 08:47:14 INFO - 'SHLVL': '1', 08:47:14 INFO - 'TERM': 'linux', 08:47:14 INFO - 'TMOUT': '86400', 08:47:14 INFO - 'USER': 'cltbld', 08:47:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', 08:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:14 INFO - '_': '/tools/buildbot/bin/python'} 08:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:15 INFO - Running setup.py (path:/tmp/pip-EfUhKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:15 INFO - Running setup.py (path:/tmp/pip-dXzW6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:15 INFO - Running setup.py (path:/tmp/pip-tbeHad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:15 INFO - Running setup.py (path:/tmp/pip-6izp_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:15 INFO - Running setup.py (path:/tmp/pip-QNcFZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:15 INFO - Running setup.py (path:/tmp/pip-YRv_XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:15 INFO - Running setup.py (path:/tmp/pip-A_Giu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:15 INFO - Running setup.py (path:/tmp/pip-EHkl5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:15 INFO - Running setup.py (path:/tmp/pip-33Xef9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:15 INFO - Running setup.py (path:/tmp/pip-_q_Ntm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:15 INFO - Running setup.py (path:/tmp/pip-bxkTkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:15 INFO - Running setup.py (path:/tmp/pip-xrS0W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:15 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)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:15 INFO - Running setup.py (path:/tmp/pip-3kDIvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:16 INFO - Running setup.py (path:/tmp/pip-5xkmuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:16 INFO - Running setup.py (path:/tmp/pip-Vn2GJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:16 INFO - Running setup.py (path:/tmp/pip-RyNeWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:16 INFO - Running setup.py (path:/tmp/pip-nFES_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:18 INFO - Downloading blessings-1.6.tar.gz 08:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:47:18 INFO - Installing collected packages: blessings 08:47:18 INFO - Running setup.py install for blessings 08:47:18 INFO - Successfully installed blessings 08:47:18 INFO - Cleaning up... 08:47:18 INFO - Return code: 0 08:47:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:47:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:18 INFO - Reading from file tmpfile_stdout 08:47:18 INFO - Current package versions: 08:47:18 INFO - argparse == 1.2.1 08:47:18 INFO - blessings == 1.6 08:47:18 INFO - blobuploader == 1.2.4 08:47:18 INFO - docopt == 0.6.1 08:47:18 INFO - manifestparser == 1.1 08:47:18 INFO - mozInstall == 1.12 08:47:18 INFO - mozcrash == 0.17 08:47:18 INFO - mozdebug == 0.1 08:47:18 INFO - mozdevice == 0.48 08:47:18 INFO - mozfile == 1.2 08:47:18 INFO - mozhttpd == 0.7 08:47:18 INFO - mozinfo == 0.9 08:47:18 INFO - mozleak == 0.1 08:47:18 INFO - mozlog == 3.1 08:47:18 INFO - moznetwork == 0.27 08:47:18 INFO - mozprocess == 0.22 08:47:18 INFO - mozprofile == 0.28 08:47:18 INFO - mozrunner == 6.11 08:47:18 INFO - mozscreenshot == 0.1 08:47:18 INFO - mozsystemmonitor == 0.0 08:47:18 INFO - moztest == 0.7 08:47:18 INFO - mozversion == 1.4 08:47:18 INFO - psutil == 3.1.1 08:47:18 INFO - requests == 1.2.3 08:47:18 INFO - wsgiref == 0.1.2 08:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f563ba07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285410>, '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 0x1286310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12867a0>, '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': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', '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 08:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:18 INFO - Using env: {'DISPLAY': ':0', 08:47:18 INFO - 'HOME': '/home/cltbld', 08:47:18 INFO - 'LANG': 'en_US.UTF-8', 08:47:18 INFO - 'LANGUAGE': 'en_US:en', 08:47:18 INFO - 'LOGNAME': 'cltbld', 08:47:18 INFO - 'MAIL': '/var/mail/cltbld', 08:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:18 INFO - 'MOZ_NO_REMOTE': '1', 08:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:18 INFO - 'NO_EM_RESTART': '1', 08:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:18 INFO - 'PWD': '/builds/slave/test', 08:47:18 INFO - 'SHELL': '/bin/bash', 08:47:18 INFO - 'SHLVL': '1', 08:47:18 INFO - 'TERM': 'linux', 08:47:18 INFO - 'TMOUT': '86400', 08:47:18 INFO - 'USER': 'cltbld', 08:47:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', 08:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:18 INFO - '_': '/tools/buildbot/bin/python'} 08:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:47:18 INFO - Cleaning up... 08:47:18 INFO - Return code: 0 08:47:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f563ba07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285410>, '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 0x1286310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12867a0>, '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': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', '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 08:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:47:18 INFO - Using env: {'DISPLAY': ':0', 08:47:18 INFO - 'HOME': '/home/cltbld', 08:47:18 INFO - 'LANG': 'en_US.UTF-8', 08:47:18 INFO - 'LANGUAGE': 'en_US:en', 08:47:18 INFO - 'LOGNAME': 'cltbld', 08:47:18 INFO - 'MAIL': '/var/mail/cltbld', 08:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:18 INFO - 'MOZ_NO_REMOTE': '1', 08:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:18 INFO - 'NO_EM_RESTART': '1', 08:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:18 INFO - 'PWD': '/builds/slave/test', 08:47:18 INFO - 'SHELL': '/bin/bash', 08:47:18 INFO - 'SHLVL': '1', 08:47:18 INFO - 'TERM': 'linux', 08:47:18 INFO - 'TMOUT': '86400', 08:47:18 INFO - 'USER': 'cltbld', 08:47:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', 08:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:18 INFO - '_': '/tools/buildbot/bin/python'} 08:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:19 INFO - Downloading/unpacking jsonschema 08:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:21 INFO - Downloading/unpacking functools32 (from jsonschema) 08:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:21 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:21 INFO - warning: no files found matching '*.txt' 08:47:21 INFO - no previously-included directories found matching 'build' 08:47:21 INFO - no previously-included directories found matching 'dist' 08:47:21 INFO - no previously-included directories found matching '.git*' 08:47:21 INFO - Installing collected packages: jsonschema, functools32 08:47:21 INFO - Running setup.py install for functools32 08:47:21 INFO - warning: no files found matching '*.txt' 08:47:21 INFO - no previously-included directories found matching 'build' 08:47:21 INFO - no previously-included directories found matching 'dist' 08:47:21 INFO - no previously-included directories found matching '.git*' 08:47:21 INFO - Successfully installed jsonschema functools32 08:47:21 INFO - Cleaning up... 08:47:21 INFO - Return code: 0 08:47:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f563ba07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285410>, '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 0x1286310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12867a0>, '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': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', '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 08:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:47:21 INFO - Using env: {'DISPLAY': ':0', 08:47:21 INFO - 'HOME': '/home/cltbld', 08:47:21 INFO - 'LANG': 'en_US.UTF-8', 08:47:21 INFO - 'LANGUAGE': 'en_US:en', 08:47:21 INFO - 'LOGNAME': 'cltbld', 08:47:21 INFO - 'MAIL': '/var/mail/cltbld', 08:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:21 INFO - 'MOZ_NO_REMOTE': '1', 08:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:21 INFO - 'NO_EM_RESTART': '1', 08:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:21 INFO - 'PWD': '/builds/slave/test', 08:47:21 INFO - 'SHELL': '/bin/bash', 08:47:21 INFO - 'SHLVL': '1', 08:47:21 INFO - 'TERM': 'linux', 08:47:21 INFO - 'TMOUT': '86400', 08:47:21 INFO - 'USER': 'cltbld', 08:47:21 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', 08:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:21 INFO - '_': '/tools/buildbot/bin/python'} 08:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:21 INFO - Downloading/unpacking flake8 08:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:47:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:47:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:47:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:24 INFO - no previously-included directories found matching 'docs/_build' 08:47:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:47:24 INFO - Running setup.py install for pep8 08:47:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:24 INFO - no previously-included directories found matching 'docs/_build' 08:47:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:47:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:47:24 INFO - Cleaning up... 08:47:24 INFO - Return code: 0 08:47:24 INFO - Running post-action listener: _resource_record_post_action 08:47:24 INFO - Running post-action listener: _start_resource_monitoring 08:47:24 INFO - Starting resource monitoring. 08:47:24 INFO - ##### 08:47:24 INFO - ##### Running install step. 08:47:24 INFO - ##### 08:47:24 INFO - Running pre-action listener: _resource_record_pre_action 08:47:24 INFO - Running main action method: install 08:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:24 INFO - Reading from file tmpfile_stdout 08:47:24 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:24 INFO - Reading from file tmpfile_stdout 08:47:24 INFO - Output received: 08:47:24 INFO - Usage: mozinstall [options] installer 08:47:24 INFO - Options: 08:47:24 INFO - -h, --help show this help message and exit 08:47:24 INFO - -d DEST, --destination=DEST 08:47:24 INFO - Directory to install application into. [default: 08:47:24 INFO - "/builds/slave/test"] 08:47:24 INFO - --app=APP Application being installed. [default: firefox] 08:47:24 INFO - mkdir: /builds/slave/test/build/application 08:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:47:38 INFO - Reading from file tmpfile_stdout 08:47:38 INFO - Output received: 08:47:38 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:38 INFO - Running post-action listener: _resource_record_post_action 08:47:38 INFO - ##### 08:47:38 INFO - ##### Running run-tests step. 08:47:38 INFO - ##### 08:47:38 INFO - Running pre-action listener: _resource_record_pre_action 08:47:38 INFO - Running main action method: run_tests 08:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:38 INFO - Python 2.7.3 08:47:38 INFO - Return code: 0 08:47:38 INFO - grabbing minidump binary from tooltool 08:47: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')]} 08:47:38 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 0x1285410>, '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 0x1286310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12867a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:38 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 08:47:38 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 08:47:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:38 INFO - Return code: 0 08:47:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:47:39 INFO - Return code: 0 08:47:39 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/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 08:47:39 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/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 08:47:39 INFO - Using env: {'DISPLAY': ':0', 08:47:39 INFO - 'HOME': '/home/cltbld', 08:47:39 INFO - 'LANG': 'en_US.UTF-8', 08:47:39 INFO - 'LANGUAGE': 'en_US:en', 08:47:39 INFO - 'LOGNAME': 'cltbld', 08:47:39 INFO - 'MAIL': '/var/mail/cltbld', 08:47:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:39 INFO - 'MOZ_NO_REMOTE': '1', 08:47:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:39 INFO - 'NO_EM_RESTART': '1', 08:47:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:39 INFO - 'PWD': '/builds/slave/test', 08:47:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:39 INFO - 'SHELL': '/bin/bash', 08:47:39 INFO - 'SHLVL': '1', 08:47:39 INFO - 'TERM': 'linux', 08:47:39 INFO - 'TMOUT': '86400', 08:47:39 INFO - 'USER': 'cltbld', 08:47:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823', 08:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:39 INFO - '_': '/tools/buildbot/bin/python'} 08:47:39 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/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 08:47:39 INFO - mozversion application_buildid: 20160627060325 08:47:39 INFO - mozversion application_changeset: b98e6837de52c839aa3f2a222c70c53038c63527 08:47:39 INFO - mozversion application_display_name: Firefox 08:47:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:39 INFO - mozversion application_name: Firefox 08:47:39 INFO - mozversion application_remotingname: firefox 08:47:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:47:39 INFO - mozversion application_vendor: Mozilla 08:47:39 INFO - mozversion application_version: 48.0 08:47:39 INFO - mozversion platform_buildid: 20160627060325 08:47:39 INFO - mozversion platform_changeset: b98e6837de52c839aa3f2a222c70c53038c63527 08:47:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:47:39 INFO - mozversion platform_version: 48.0 08:47:39 INFO - using testdate: 1467042459 08:47:39 INFO - actual date: 1467042459 08:47:39 INFO - starting webserver on 'localhost:42423' 08:47:39 INFO - SUITE-START | Running 2 tests 08:47:39 INFO - TEST-START | dromaeo_css 08:47:39 INFO - operating with platform_type : linux_ 08:47:39 INFO - Initialising browser for dromaeo_css test... 08:47:39 INFO - TEST-INFO | started process 8317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFfx54Y/profile http://localhost:42423/getInfo.html) 08:47:43 INFO - PROCESS | 8317 | __metrics Screen width/height:1600/1200 08:47:43 INFO - PROCESS | 8317 | colorDepth:24 08:47:43 INFO - PROCESS | 8317 | Browser inner width/height: 1024/697 08:47:43 INFO - PROCESS | 8317 | __metrics 08:47:44 ERROR - PROCESS | 8317 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:47:45 INFO - TEST-INFO | 8317: exit 0 08:47:45 INFO - Browser initialized. 08:47:45 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:45 INFO - TEST-INFO | started process 8410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFfx54Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:56 INFO - PROCESS | 8410 | RSS: Main: 139444224 08:47:56 INFO - PROCESS | 8410 | 08:48:47 INFO - PROCESS | 8410 | 1467042527959 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] 08:50:55 INFO - PROCESS | 8410 | Cycle 1(1): loaded http://localhost:42423/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42423/tests/dromaeo/cssquery-ext.html) 08:50:56 INFO - PROCESS | 8410 | RSS: Main: 252416000 08:50:56 INFO - PROCESS | 8410 | 08:53:58 INFO - PROCESS | 8410 | Cycle 1(1): loaded http://localhost:42423/tests/dromaeo/cssquery-ext.html (next: http://localhost:42423/tests/dromaeo/cssquery-jquery.html) 08:53:59 INFO - PROCESS | 8410 | RSS: Main: 223723520 08:53:59 INFO - PROCESS | 8410 | 08:57:01 INFO - PROCESS | 8410 | Cycle 1(1): loaded http://localhost:42423/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42423/tests/dromaeo/cssquery-mootools.html) 08:57:01 INFO - PROCESS | 8410 | RSS: Main: 221110272 08:57:01 INFO - PROCESS | 8410 | 09:00:03 INFO - PROCESS | 8410 | Cycle 1(1): loaded http://localhost:42423/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42423/tests/dromaeo/cssquery-prototype.html) 09:00:04 INFO - PROCESS | 8410 | RSS: Main: 215302144 09:00:04 INFO - PROCESS | 8410 | 09:03:06 INFO - PROCESS | 8410 | Cycle 1(1): loaded http://localhost:42423/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42423/tests/dromaeo/cssquery-yui.html) 09:03:07 INFO - PROCESS | 8410 | RSS: Main: 215334912 09:03:07 INFO - PROCESS | 8410 | 09:06:09 INFO - PROCESS | 8410 | Cycle 1(1): loaded http://localhost:42423/tests/dromaeo/cssquery-yui.html (next: http://localhost:42423/tests/dromaeo/cssquery-dojo.html) 09:06:09 INFO - PROCESS | 8410 | RSS: Main: 256237568 09:06:09 INFO - PROCESS | 8410 | 09:06:09 INFO - PROCESS | 8410 | __start_tp_report 09:06:09 INFO - PROCESS | 8410 | _x_x_mozilla_page_load 09:06:09 INFO - PROCESS | 8410 | _x_x_mozilla_page_load_details 09:06:09 INFO - PROCESS | 8410 | |i|pagename|runs| 09:06:09 INFO - PROCESS | 8410 | |0;dojo.html;3310.8675652973875;3353.463445848663;3365.19235383508;3377.324535092982;3405.8126803025825;5577.972110139449;5579.246801681772;5591.4688104630095;5604.103343465046;5611.9438805611935;5559.722013899299;5576.525995290395;5577.414371490996;5596.86007849804;5654.858628534289;5057.544820966113;5061.519155680214;5138.152204886189;5194.844154675366;5221.843344699665;5084.0594490019275;5105.897882042357;5143.717095559743;5145.459726728695;5155.613329000321;5075.441701412841;5131.897362052757;5154.149565321717;5154.278401023859;5191.351081114861;5239.659422137568;5257.815976440845;5273;5273.129933560957;5306.814261500867;4985.052839960396;5042.773075211624;5067.417247016603;5167.22491626259;5171.37943446785;5578.079616863253;5607.8878422431735;5615;5616.494515493584;5617.129344951539;5942.138389933435;5973.671448070354;5983.222181116471;5989.281286245635;5998.820035398901;5979.521638268928;6016.127661489103;6070.725743932259;6086.117512960596;6093.817185484399;5680.630759000652;5719.02776527987;5733;5739.368669446358;5745.482906538348;6018.277806663141;6252.062190671436;6271.78048768291;6273.027680709497;6278.591891527036;5795.1017592273265;5887.35239123696;5895.115732640053;5909.084091965752;5909.911351329733;6009.549283803644;6010.519158467312;6012.909806352821;6016.037434010537;6038.064100064497;5938.881222375615;6003.369646187175;6009.549283803644;6013.067974463965;6013.368596297413;6098.32918378978;6098.969505152446;6107.0228763397645;6110.953680641517;6136.9079463808075;4633.096546173464;4634.420697412824;4636.8145274188655;4638.0955713636195;4669.929951050737;4097.303458412077;4122.2786012447705;4145.150244199932;4164.250434921743;4193.056562273464;5788.160716696056;5795.536357091422;5795.710214489259;5797.275340582427;5801.158831969426;6062.090686397076;6084.056971169476;6107.541934354852;6121.632702037892;6128.111423843607;5700.201971723962;5770.88458230833;5788.392218817048;5845.590808643439;5848.795292164754;5222.7127507987425;5237.947620523746;5238.214267859851;5239.397469291081;5239.659422137549;6333.2400111985935;6341.3341599132345;6346.143270658495;6354.110424540568;6357.300696923335;6012.699365031818;6069.0592958091565;6125.632272693401;6141.240538582634;6144.003198960445;6320.778772742932;6353.872922541431;6364.109024736448;6370.140031095742;6378.87242255143;5806.129080637938;5990.820275391745;5998.88002239944;6004.42957918997;6004.819855404345;6028.728707208098;6109.236345456818;6110.1638887921135;6125.601835880653;6141;5818.44724751148;5832.154337621106;5836.358000620014;5842.591018628656;5853.970730146322;5806.622569532967;5855;5859.9121013183985;5874.118882167538;5892.440218179266;5890.705464726832;5895.557833162616;5943.138244954544;5945.762169513344;5994.760209591742;5997.250343707036;6020.668863212565;6052.455279024909;6057.909131362945;6059.121427392915;5745.569082318926;5830.883382332415;5927.170196172453;5941.1385349125;5945.970270148621 09:06:09 INFO - PROCESS | 8410 | |1;ext.html;660.9603423794573;689.2693744630692;698.4586945117536;750.7935317787609;768.258630421643;32463.350732985327;39000;39167.60832391675;39399.212015759666;39413;40832;41364.379534306936;41454.58545414545;41651.79174104133;41925.161496770044;7961.761147165595;8794.164554367357;8869.866951995726;8974.910250897505;10408.583656653725;10480.790384192349;10641.893581064207;10650.467476626138;10650.78698426031;10652.201084918623;10654.840177397346;10708.892911070907;10725.892741072606;10729.463526823627;10733.51699173539;10611.045005949463;10687.572497100107;10688.679339619785;10689.518971646217;10697.572097116106;10822.24244302899;10998;11009.2843965142;11009.449527523591;11013.118950483942;43698;44170;44191.55808441906;44219.557804421864;44226;3697.7411581189326;3866.168773713665;3995.900102497461;4119.011437255067;4257.8509752158525;33808.83095584531;33866;33867.661323386696;33892.83053584716;34169;4597.172508948388;4640.396748422683;4682.953170468286;4685.273782563708;4716.29255611661;336603.99999999756;337699;338580;338718;339050.99999999756;65622.34377656163;65652.34347656558;65696;66214.66892665505;66215;69763;70011.2998870015;70196.29803701898;71473;71490.64254678797;19750.40748777539;19938.302159424642;19958;19964.90017549932;19965.500862478264;13757.518486852912;15359.078455292718;15657.921710391374;15716.92141539285;15718.921405392899;19690.113944872515;19981.300654477312;20184.49538761543;20258.79741202569;20296.289629862884;7271.89092163618;7525.510841795266;7769.300762931251;7805.141434442206;7818.687252509836;1036.3832421422455;1065.893410658928;1141.4121727310442;1216.1304667163022;1229.5819421396768;33922.66077339245;33948.75640544932;34770.478442823376;35342.11644708851;35672.78944894972;1119.1885882734953;1156.9710757231137;1164.9825252621217;1194.5221911235576;1207.8429804125408;16620.085895275635;16845.157742112846;16868.831311686972;17070.658586828442;17263.3957811476;474038;478125;479834;480294;480994;61460.38539614636;62521.68739156275;62639.6868015657;62872.37127628665;63195;1415.9221242831536;1499.5576304990054;1512.954611361661;1557.268084000518;1624.796900387428;32154.35691286208;32840.34319313552;33205.66794332026;33845.661543385235;34124.65875341215;52618;53271;53329.733351332994;53452.19821702755;53465;360768;370416;370792;371610;371655;27949.16152515428;28532.286692832844;29406.264843379086;30770.538441923836;30949.535756963214;43146;43609.34585981276;43668.781656091516;44257.55742442663;44515;37039.81480092582;37166.814165929;37245.4413183797;37490.437643435915;37500.62499374971;38813.41779873248;40357.798211008754;40846.79576602098;41080;41302.1739565213;41457.1708565833;42078.15843683048;42188.578114218464;42568.78715606402;42588.78705606576;33909.830450847585;34804.129896752784;35404;35475.290494190485;35819.462708059924;28261.597764190275;28361.29096772515;28423.85788071129;28545.857270713514;28682 09:06:09 INFO - PROCESS | 8410 | |2;jquery.html;418.5333353311059;431.92051077572324;433.053777496171;440.92283850326197;444.182703824962;19073.71389429158;19244.90377548114;19252;19526.21895124193;19711.112999915003;19089.14098865551;19298.807011929875;20141.39575812728;20144.09351579179;20163.294284700038;5383.838484845451;5528.336599608033;5759.884802303952;5774.422557744234;5778.162166485878;4234;5716.114002329646;5784.3058832940105;6109.419605137505;6412.102305677209;6369.808905732835;6392.4886009119155;6397.296297407282;6406.1351717518;6407.551471397004;5492.862678433031;5770.711464426804;5779.988502012131;5784.942150578503;6350.364963503635;3897.7466464679987;5418.9458105418835;5631.8028868989795;5649.745761440745;5680.403557626472;14450.71098578033;14653.120812751162;14654.926725366306;14689.265536723227;22790.202342917917;2306.1467257114805;2332.043862016565;2359.905603775847;2362.208660098869;3059.174023013796;10625.203109766799;12695.619131426072;13605.591832245049;13828;13838.723225535434;2027.5336672565393;2058.5574101568236;2091.1948899673584;2119.9364019079453;2194.0565556810566;75655.62172189158;79723;80063.59968200122;82154.58922705348;83349;11383.601573944872;11704.53693288339;11706.35615041181;11787.115966302561;12036.157468977088;16457.588560286087;16620.418285359956;16739.832601674072;16749;16773.664526709643;9174.449533027906;9207.40151890125;9283.48940808262;9369.90630093704;9381.671641492652;9336.439813611205;9362.110599493037;9375.578098985561;9421.764455888657;9467.857982130274;5111.207762796773;5139.948600514022;5182.481751824787;5227.503387178212;5238.397584277857;1867.4771064102074;2083.3541602103396;2106.9157233710785;2110.767815540289;2170.1536400803698;1023.6212601337553;1038.1975544459906;1045.6706137566641;1055.171690223171;1120.7478317378525;18485.81514184841;18898.433047008613;19041.809581904003;19233.51916202106;19632.11655475507;1012.0436187802457;1107.3577325151393;1115.576081089181;1126.6676330482528;1134.8581427321585;10217.642382516577;10649.201309901788;10667.626633067961;10672.30630009047;10778;529339;541390;546970;552729;554901;92777.53611232036;95222;96058.51970740102;96758.5162074185;96931.51534242283;1136.1308598921833;1148.609472779259;1157.062779148892;1174.1546086817477;1174.4890972427022;17066.91466542709;17138.742918856475;17244.482665520056;17380.47858564245;17397.913010434866;38912.22175556416;39457.2108557833;40743.38884916788;41214.38178427266;41545.58454415538;54231;55264.17103743367;56303;59091;59715;12218.20581662189;12852.293123877902;12895.871041289467;12906.67733306675;12990.545330913372;9016.639334426549;11960.923516883522;13368.933155334162;13735.793963090362;13822.447102115802;11491.310521368745;11859;11968.940155299168;12490.875091249334;12508.812367814307;11748.412579371168;12069.517219311128;12084.335361555199;12118.818217726564;12196.817047744113;11392.886071139183;11928.284302941503;12100.576479823163;12270.631881043582;13362.732745345233;13012.804807928078;13218.933905330412;13261.535846245335;13402.396892139683;13430.798538021741;11287.379194144401;11410.258333208314;11430.48562814692;11471.139664525028;11586 09:06:09 INFO - PROCESS | 8410 | |3;mootools.html;1481.7703255995325;1563.7028964496742;1568.1688704986357;1801.945941621752;1942.1842826013074;7496;8278.048024477186;8439.704610338631;8440.873386899202;8451.408401411903;8087.878681819778;8260.380471464634;8262.91737082629;8264.049634292058;8266.049404318504;2411.0596867221752;2428.0651948999675;2430.3195105370523;2431.9392015199583;2432.9513409731794;2388.653645221442;2430.173740928084;2465.790407815338;2474.653548503211;2479.603263477844;2418.794402475783;2428.8421252618614;2429.501952099824;2449.987750061256;2451.4116612013077;2408.5303365843665;2418.1536462238164;2421.2615152378517;2423.8182136339756;2454.0306578901414;2395.4969456414;2400.759924007603;2401.7838394544574;2404.603240465321;2407.2537513370735;8201.425900186989;8361.996560412728;8390.454620449713;8406.117357677416;8407;5213.843584692465;5281.36623605166;5290.418054014055;5297.4437684043005;5316.149416093406;3259.8859039933727;3283.917902052468;3312.834358282076;3333.21669407689;3341.5823022122236;1129.570763110021;1130.5647325779553;1136.4147464056018;1136.732867776072;1144.204777679513;11873;12051.638450846489;12314.938425307906;12331.5067397304;12333.198342107824;4595.586397224266;4669.042846216517;4745.881352966135;4751.548602882721;4766.380370551806;9733.610655573839;9734.805303893883;9735.65925192629;9747.3664211826;9755.268354873271;5253.185756207794;5290.365156181206;5294.126469132627;5298.6290959633225;5302.125149350391;4178.331466965271;4284.464441944757;4729.408823897013;4772.427308722976;4916.213405855046;3950.822213000422;3956.485656864589;4021.7184797063924;4059.0664147245707;4063.065494936122;1235.6540168752763;1238.9442475088642;1239.1883316427575;1244.9190802597802;1252.4238850129043;981.8919918808925;988.930774845754;997.4912794474725;999.8420782502236;1011.6054738651932;5834.3290521589715;5891.96890544153;5907.497862681635;5971.850703732354;6048.697565121726;475.68367035921415;478.8946431785002;479.72655586316165;1077.4451157653814;1078.5955266774959;3961.3067713150085;3972.940405893914;3976.980115099406;4004.799760012046;4046.5548789633117;10285;10632.521536530874;10727.570897164182;10747.946260268649;10753.085987690978;10572.048515633629;10578.62974795894;10585.576576936835;10588.894111058791;10589.682309530726;8197.139300373494;8217;8521.488710677379;8552.144785521397;8569.143085691505;5770.422957704196;5864.384239654945;5875.588708790344;5950.791722289872;5991.310999235144;9380.343375963617;9604.51977401141;9614.18279446255;9816.018398160413;9818.901810982084;9686.321957463191;9716.271279654196;9928.751781205528;9950.203983681433;9954.950225248827;6615.636140012345;7040.331168538981;7243.420526357773;7326.816829579303;7415;8261.339092872677;8300.12848650883;8314.70898518573;8338.082810890919;8355.582220889053;7486.4759466836795;7600.733974310872;7611.771646850603;7650.158482567024;7752;7175.461840362098;7455.291747283999;7458.776236712907;7543.73596924105;7550.2072282411755;6952.165740111219;6955.095837541087;6996.475264355092;6999.440044796506;7000.61496617691;5085.92371114441;5111.309973153577;5198.246254293031;5267.9736601316745;5276.023935571931;5144.819931302386;5147.58819294448;5241.50205730455;5259.500347466985;5294.338207724035 09:06:09 INFO - PROCESS | 8410 | |4;prototype.html;356.25009355307077;365.57958347899927;368.9944650830237;370.1265014565625;373.4752672495145;6176.845578860531;6183.783567575136;6232.750689972401;6233.033879748635;6237.656928868911;6116.4800991915745;6199.225096862892;6204.379562043793;6207.8758424831585;6218.968905155468;4615.399998000255;4728.692634978733;4843.055604157191;4851.22380419133;4856.417229932413;4817;4843.709377437347;4845.588125009378;4854.199057155565;4855.053264613402;4606.470255920579;4827;4829.082474329866;4833.854984350475;4847.51524847516;4681.765911704419;4776.570108690217;4782.541324895906;4826.613870890355;4839.27410888366;4277.401163837066;4282.8715138545895;4287.078278170208;4290.506591741959;4293.441852559147;5972.581919265654;5978.790742323998;5985.042393217064;5986.491148252404;5995.7901473448655;5622.550195984311;5634.267545219136;5634.887302253973;5642.238297829782;5642.4357564243655;6339.873202535923;6571.178602674666;6574.76988305407;6579.539432239745;6589.538732288742;4528.569785870337;4542.227821270359;4568.383268258775;4588.701734387288;4594.402727645418;6819.215790184143;6886.414654754352;6896.172459304866;6898.793036208872;6899.724011039552;4750.667453278237;4751.762411879392;4755.500672429345;4757.452892917289;4759.762011899391;4811.446683631357;4812.374391329105;4812.470628230892;4814.975925120352;4816.54242846929;5537.003339398866;5545.445455454423;5547.805826796042;5552.7778888844805;5565.165225216169;6430.935690643128;6658.1011563438315;6658.4340331071435;6667.266600673922;6673.399394054559;1636.1819090454774;1680.3362671744592;1681.7729606502965;1685.6123091688735;1686.814450410454;1061.177587369779;1070.5022164693455;1081.588996181446;1105.4417519152776;1133.7675776465805;6310.936890631035;6380.968095159495;6387.105805187278;6389.584676995981;6398.072279519443;6771.830704232335;6779.322067793181;6782.253952065269;6784.219814721271;6787.694553745093;6359.618422894641;6361.01404282337;6371;6379.64911929839;6380.489560835122;3611.0972256935765;3643.3624115780162;3648.1791596891017;3649.4525821127045;3649.7445178837224;6910.827229319207;7070.257622949619;7073.646317684095;7076.115485564304;7083.335416177194;6900.551464154814;6900.930990690129;6906.965465172642;6917.9308206917285;6922.307769223138;7054.753083642048;7065.929340706527;7073.575585464889;7074.151101867808;7076.150861896605;6761.256261811099;6765.594064356154;6773.051772751917;6782.796516104525;6784.525083244125;6567.671616419256;6705.195376554844;6708.563943343667;6713.664316784044;6716.361945615159;7024.438044956493;7051.43588512928;7054.823629409306;7058.082449281561;7070.646467676698;4717.599004084691;4722.386089808303;4726.26742854858;4740.241561350167;4740.786664600032;6729.394354508117;6740.12378390806;6745.3591908768585;6745.426638735762;6754.797356079325;6412.903806442814;6507.219133703986;6544.083828264142;6550.279469258282;6563.212414510098;6487.734891696074;6533.052707357501;6533.542652014314;6543.640099794557;6612.70242839083;6425.45383642377;6445.16212892321;6446.742130314922;6447.838804029937;6450.967745161244;6569.638669873203;6576.473882089325;6580.078788969644;6580.736770529125;6589.868202635825;6284.402981716729;6431.196100487439;6436.066770318184;6440.323766004502;6451.387118223761 09:06:09 INFO - PROCESS | 8410 | |5;yui.html;809.4374409785202;827.635840230299;836.7155167243136;891.8795962545056;896.0725648953332;16991.320347186098;17227;17331.65336693267;17350.73973890391;17363.045032523205;15117.924410377933;15204;15221.771673424908;15235.847641523582;15264.771028434583;754.7018927523625;868.4832524647856;884.0408157149484;886.2201262888649;901.1214066285385;892.1479986612769;893.1961234888587;893.6157452295511;895.3061377432509;895.9372843900929;778.4473024152858;957.8563215517659;957.9377340472881;958.0132463562542;959.7648576098866;923.0999775219175;942.3026960049548;945.8581212818063;946.1437399153776;946.6639343033193;689.0387908867152;694.9930500694979;696.8815301398774;697.6267696782248;698.1935864077;15666;15705.214739263105;15769.211539422982;15781.36874525029;15845.12851793151;13629.25039122848;13640.658983525393;13938;13949.16305021702;14003.50987715425;11809.291442513477;12133.878661213363;12210.633680989496;12272.263664180178;12301.01591872648;3967.920641587152;3968.6626636735914;4033.69747268956;4080.1839632073406;4099.959000409987;56990.430095698925;57083.42916570823;57189.999999999585;57639.711801441146;57721.7113914432;10834.945825270823;11198.944005279922;11281.153913456523;11424.200305978668;11495.827562586568;20026.899865500578;20160.193592256146;20206.89896550508;20454.38636840897;20465.48836279075;8190.221928916862;8512.446690965067;8566.52884091381;8593.914060859312;8615.913840861636;4806.7836947337455;4842.685225460334;4918.163912134945;4946.975265123651;4979.850604481871;3458.342914846171;3698.3527882620433;3726.7763934164036;3731.645493678096;3733.439984002421;660.6234446365621;667.4593579200863;726.7964969808462;729.3836707981746;743.353282644103;799.9040115186099;802.358113509202;844.6199210355364;853.1724227499316;858.819647873941;9718.416894986323;10208.234382421348;10252.846207306897;10290.485475726184;10332.793344133075;768.3776141325544;783.8628240057967;797.1988151907296;807.3299161695778;826.0582935453588;4674.883127921829;4705.717656940595;4716.410448693913;4721.834735784231;4738.147133515931;61448.69275653593;63339.36660633427;63783.68108159523;63823.6808815953;63950.36049639444;55332;55884.720576397674;58334;58446.12330815041;64157.679211604576;49994.75002624963;53696.46303536915;54029.45970540244;55996.72001639966;56071.43928560744;9999.500024998575;10096.34373765703;10127.92384989851;10304.742381440525;10348;38125;38926.41610375903;39355.212895742494;39414.60585394224;40484.39273410842;47431.288530672755;49036.75481622569;49434.752826235635;49832.750836245585;50252;13018.15382000167;13257.933710331386;13303;13469.528566500125;13554.051216414757;13905.443782248596;14168.433262669378;14648.853511465175;14701.485448009269;14736.410543578137;11723;11795.705107372041;12042.75914481723;12062.819057714318;12375.009999199863;12951.805722913976;13199;13220.537281195113;13289.468421263042;13389.799153012518;13731.045490822107;13742.381592828147;13801.102928309629;13809.378577964217;13904.721905562035;10989.61536346224;11580.056846280184;11711.88288117108;11812.586559470377;11881.5841445549;11276.492557835081;11540.653780386601;11587.826182607436;11703.414829258674;11755.471003804678 09:06:09 INFO - PROCESS | 8410 | __end_tp_report 09:06:09 INFO - PROCESS | 8410 | __start_cc_report 09:06:09 INFO - PROCESS | 8410 | _x_x_mozilla_cycle_collect,850 09:06:09 INFO - PROCESS | 8410 | __end_cc_report 09:06:09 INFO - PROCESS | 8410 | __startTimestamp1467043569818__endTimestamp 09:06:09 INFO - PROCESS | 8410 | 09:06:09 INFO - PROCESS | 8410 | ------- Summary: start ------- 09:06:09 INFO - PROCESS | 8410 | Number of tests: 6 09:06:09 INFO - PROCESS | 8410 | 09:06:09 INFO - PROCESS | 8410 | [#0] dojo.html Cycles:165 Average:5636.58 Median:5845.59 stddev:634.66 (10.9%) stddev-sans-first:609.82 09:06:09 INFO - PROCESS | 8410 | Values: 3310.9 3353.5 3365.2 3377.3 3405.8 5578.0 5579.2 5591.5 5604.1 5611.9 5559.7 5576.5 5577.4 5596.9 5654.9 5057.5 5061.5 5138.2 5194.8 5221.8 5084.1 5105.9 5143.7 5145.5 5155.6 5075.4 5131.9 5154.1 5154.3 5191.4 5239.7 5257.8 5273.0 5273.1 5306.8 4985.1 5042.8 5067.4 5167.2 5171.4 5578.1 5607.9 5615.0 5616.5 5617.1 5942.1 5973.7 5983.2 5989.3 5998.8 5979.5 6016.1 6070.7 6086.1 6093.8 5680.6 5719.0 5733.0 5739.4 5745.5 6018.3 6252.1 6271.8 6273.0 6278.6 5795.1 5887.4 5895.1 5909.1 5909.9 6009.5 6010.5 6012.9 6016.0 6038.1 5938.9 6003.4 6009.5 6013.1 6013.4 6098.3 6099.0 6107.0 6111.0 6136.9 4633.1 4634.4 4636.8 4638.1 4669.9 4097.3 4122.3 4145.2 4164.3 4193.1 5788.2 5795.5 5795.7 5797.3 5801.2 6062.1 6084.1 6107.5 6121.6 6128.1 5700.2 5770.9 5788.4 5845.6 5848.8 5222.7 5237.9 5238.2 5239.4 5239.7 6333.2 6341.3 6346.1 6354.1 6357.3 6012.7 6069.1 6125.6 6141.2 6144.0 6320.8 6353.9 6364.1 6370.1 6378.9 5806.1 5990.8 5998.9 6004.4 6004.8 6028.7 6109.2 6110.2 6125.6 6141.0 5818.4 5832.2 5836.4 5842.6 5854.0 5806.6 5855.0 5859.9 5874.1 5892.4 5890.7 5895.6 5943.1 5945.8 5994.8 5997.3 6020.7 6052.5 6057.9 6059.1 5745.6 5830.9 5927.2 5941.1 5946.0 09:06:09 INFO - PROCESS | 8410 | 09:06:09 INFO - PROCESS | 8410 | [#1] ext.html Cycles:180 Average:57366.97 Median:35746.13 stddev:105364.00 (294.8%) stddev-sans-first:105573.56 09:06:09 INFO - PROCESS | 8410 | Values: 661.0 689.3 698.5 750.8 768.3 32463.4 39000.0 39167.6 39399.2 39413.0 40832.0 41364.4 41454.6 41651.8 41925.2 7961.8 8794.2 8869.9 8974.9 10408.6 10480.8 10641.9 10650.5 10650.8 10652.2 10654.8 10708.9 10725.9 10729.5 10733.5 10611.0 10687.6 10688.7 10689.5 10697.6 10822.2 10998.0 11009.3 11009.4 11013.1 43698.0 44170.0 44191.6 44219.6 44226.0 3697.7 3866.2 3995.9 4119.0 4257.9 33808.8 33866.0 33867.7 33892.8 34169.0 4597.2 4640.4 4683.0 4685.3 4716.3 336604.0 337699.0 338580.0 338718.0 339051.0 65622.3 65652.3 65696.0 66214.7 66215.0 69763.0 70011.3 70196.3 71473.0 71490.6 19750.4 19938.3 19958.0 19964.9 19965.5 13757.5 15359.1 15657.9 15716.9 15718.9 19690.1 19981.3 20184.5 20258.8 20296.3 7271.9 7525.5 7769.3 7805.1 7818.7 1036.4 1065.9 1141.4 1216.1 1229.6 33922.7 33948.8 34770.5 35342.1 35672.8 1119.2 1157.0 1165.0 1194.5 1207.8 16620.1 16845.2 16868.8 17070.7 17263.4 474038.0 478125.0 479834.0 480294.0 480994.0 61460.4 62521.7 62639.7 62872.4 63195.0 1415.9 1499.6 1513.0 1557.3 1624.8 32154.4 32840.3 33205.7 33845.7 34124.7 52618.0 53271.0 53329.7 53452.2 53465.0 360768.0 370416.0 370792.0 371610.0 371655.0 27949.2 28532.3 29406.3 30770.5 30949.5 43146.0 43609.3 43668.8 44257.6 44515.0 37039.8 37166.8 37245.4 37490.4 37500.6 38813.4 40357.8 40846.8 41080.0 41302.2 41457.2 42078.2 42188.6 42568.8 42588.8 33909.8 34804.1 35404.0 35475.3 35819.5 28261.6 28361.3 28423.9 28545.9 28682.0 09:06:09 INFO - PROCESS | 8410 | 09:06:09 INFO - PROCESS | 8410 | [#2] jquery.html Cycles:180 Average:30858.28 Median:19926.25 stddev:89567.10 (449.5%) stddev-sans-first:89789.20 09:06:09 INFO - PROCESS | 8410 | Values: 418.5 431.9 433.1 440.9 444.2 19073.7 19244.9 19252.0 19526.2 19711.1 19089.1 19298.8 20141.4 20144.1 20163.3 5383.8 5528.3 5759.9 5774.4 5778.2 4234.0 5716.1 5784.3 6109.4 6412.1 6369.8 6392.5 6397.3 6406.1 6407.6 5492.9 5770.7 5780.0 5784.9 6350.4 3897.7 5418.9 5631.8 5649.7 5680.4 14450.7 14653.1 14654.9 14689.3 22790.2 2306.1 2332.0 2359.9 2362.2 3059.2 10625.2 12695.6 13605.6 13828.0 13838.7 2027.5 2058.6 2091.2 2119.9 2194.1 75655.6 79723.0 80063.6 82154.6 83349.0 11383.6 11704.5 11706.4 11787.1 12036.2 16457.6 16620.4 16739.8 16749.0 16773.7 9174.4 9207.4 9283.5 9369.9 9381.7 9336.4 9362.1 9375.6 9421.8 9467.9 5111.2 5139.9 5182.5 5227.5 5238.4 1867.5 2083.4 2106.9 2110.8 2170.2 1023.6 1038.2 1045.7 1055.2 1120.7 18485.8 18898.4 19041.8 19233.5 19632.1 1012.0 1107.4 1115.6 1126.7 1134.9 10217.6 10649.2 10667.6 10672.3 10778.0 529339.0 541390.0 546970.0 552729.0 554901.0 92777.5 95222.0 96058.5 96758.5 96931.5 1136.1 1148.6 1157.1 1174.2 1174.5 17066.9 17138.7 17244.5 17380.5 17397.9 38912.2 39457.2 40743.4 41214.4 41545.6 54231.0 55264.2 56303.0 59091.0 59715.0 12218.2 12852.3 12895.9 12906.7 12990.5 9016.6 11960.9 13368.9 13735.8 13822.4 11491.3 11859.0 11968.9 12490.9 12508.8 11748.4 12069.5 12084.3 12118.8 12196.8 11392.9 11928.3 12100.6 12270.6 13362.7 13012.8 13218.9 13261.5 13402.4 13430.8 11287.4 11410.3 11430.5 11471.1 11586.0 09:06:09 INFO - PROCESS | 8410 | 09:06:09 INFO - PROCESS | 8410 | [#3] mootools.html Cycles:180 Average:5683.57 Median:5206.04 stddev:3154.92 (60.6%) stddev-sans-first:3147.97 09:06:09 INFO - PROCESS | 8410 | Values: 1481.8 1563.7 1568.2 1801.9 1942.2 7496.0 8278.0 8439.7 8440.9 8451.4 8087.9 8260.4 8262.9 8264.0 8266.0 2411.1 2428.1 2430.3 2431.9 2433.0 2388.7 2430.2 2465.8 2474.7 2479.6 2418.8 2428.8 2429.5 2450.0 2451.4 2408.5 2418.2 2421.3 2423.8 2454.0 2395.5 2400.8 2401.8 2404.6 2407.3 8201.4 8362.0 8390.5 8406.1 8407.0 5213.8 5281.4 5290.4 5297.4 5316.1 3259.9 3283.9 3312.8 3333.2 3341.6 1129.6 1130.6 1136.4 1136.7 1144.2 11873.0 12051.6 12314.9 12331.5 12333.2 4595.6 4669.0 4745.9 4751.5 4766.4 9733.6 9734.8 9735.7 9747.4 9755.3 5253.2 5290.4 5294.1 5298.6 5302.1 4178.3 4284.5 4729.4 4772.4 4916.2 3950.8 3956.5 4021.7 4059.1 4063.1 1235.7 1238.9 1239.2 1244.9 1252.4 981.9 988.9 997.5 999.8 1011.6 5834.3 5892.0 5907.5 5971.9 6048.7 475.7 478.9 479.7 1077.4 1078.6 3961.3 3972.9 3977.0 4004.8 4046.6 10285.0 10632.5 10727.6 10747.9 10753.1 10572.0 10578.6 10585.6 10588.9 10589.7 8197.1 8217.0 8521.5 8552.1 8569.1 5770.4 5864.4 5875.6 5950.8 5991.3 9380.3 9604.5 9614.2 9816.0 9818.9 9686.3 9716.3 9928.8 9950.2 9955.0 6615.6 7040.3 7243.4 7326.8 7415.0 8261.3 8300.1 8314.7 8338.1 8355.6 7486.5 7600.7 7611.8 7650.2 7752.0 7175.5 7455.3 7458.8 7543.7 7550.2 6952.2 6955.1 6996.5 6999.4 7000.6 5085.9 5111.3 5198.2 5268.0 5276.0 5144.8 5147.6 5241.5 5259.5 5294.3 09:06:09 INFO - PROCESS | 8410 | 09:06:09 INFO - PROCESS | 8410 | [#4] prototype.html Cycles:180 Average:5527.73 Median:6297.67 stddev:1648.43 (26.2%) stddev-sans-first:1606.70 09:06:09 INFO - PROCESS | 8410 | Values: 356.3 365.6 369.0 370.1 373.5 6176.8 6183.8 6232.8 6233.0 6237.7 6116.5 6199.2 6204.4 6207.9 6219.0 4615.4 4728.7 4843.1 4851.2 4856.4 4817.0 4843.7 4845.6 4854.2 4855.1 4606.5 4827.0 4829.1 4833.9 4847.5 4681.8 4776.6 4782.5 4826.6 4839.3 4277.4 4282.9 4287.1 4290.5 4293.4 5972.6 5978.8 5985.0 5986.5 5995.8 5622.6 5634.3 5634.9 5642.2 5642.4 6339.9 6571.2 6574.8 6579.5 6589.5 4528.6 4542.2 4568.4 4588.7 4594.4 6819.2 6886.4 6896.2 6898.8 6899.7 4750.7 4751.8 4755.5 4757.5 4759.8 4811.4 4812.4 4812.5 4815.0 4816.5 5537.0 5545.4 5547.8 5552.8 5565.2 6430.9 6658.1 6658.4 6667.3 6673.4 1636.2 1680.3 1681.8 1685.6 1686.8 1061.2 1070.5 1081.6 1105.4 1133.8 6310.9 6381.0 6387.1 6389.6 6398.1 6771.8 6779.3 6782.3 6784.2 6787.7 6359.6 6361.0 6371.0 6379.6 6380.5 3611.1 3643.4 3648.2 3649.5 3649.7 6910.8 7070.3 7073.6 7076.1 7083.3 6900.6 6900.9 6907.0 6917.9 6922.3 7054.8 7065.9 7073.6 7074.2 7076.2 6761.3 6765.6 6773.1 6782.8 6784.5 6567.7 6705.2 6708.6 6713.7 6716.4 7024.4 7051.4 7054.8 7058.1 7070.6 4717.6 4722.4 4726.3 4740.2 4740.8 6729.4 6740.1 6745.4 6745.4 6754.8 6412.9 6507.2 6544.1 6550.3 6563.2 6487.7 6533.1 6533.5 6543.6 6612.7 6425.5 6445.2 6446.7 6447.8 6451.0 6569.6 6576.5 6580.1 6580.7 6589.9 6284.4 6431.2 6436.1 6440.3 6451.4 09:06:09 INFO - PROCESS | 8410 | 09:06:09 INFO - PROCESS | 8410 | [#5] yui.html Cycles:180 Average:15853.10 Median:22282.29 stddev:18096.60 (81.2%) stddev-sans-first:18112.10 09:06:09 INFO - PROCESS | 8410 | Values: 809.4 827.6 836.7 891.9 896.1 16991.3 17227.0 17331.7 17350.7 17363.0 15117.9 15204.0 15221.8 15235.8 15264.8 754.7 868.5 884.0 886.2 901.1 892.1 893.2 893.6 895.3 895.9 778.4 957.9 957.9 958.0 959.8 923.1 942.3 945.9 946.1 946.7 689.0 695.0 696.9 697.6 698.2 15666.0 15705.2 15769.2 15781.4 15845.1 13629.3 13640.7 13938.0 13949.2 14003.5 11809.3 12133.9 12210.6 12272.3 12301.0 3967.9 3968.7 4033.7 4080.2 4100.0 56990.4 57083.4 57190.0 57639.7 57721.7 10834.9 11198.9 11281.2 11424.2 11495.8 20026.9 20160.2 20206.9 20454.4 20465.5 8190.2 8512.4 8566.5 8593.9 8615.9 4806.8 4842.7 4918.2 4947.0 4979.9 3458.3 3698.4 3726.8 3731.6 3733.4 660.6 667.5 726.8 729.4 743.4 799.9 802.4 844.6 853.2 858.8 9718.4 10208.2 10252.8 10290.5 10332.8 768.4 783.9 797.2 807.3 826.1 4674.9 4705.7 4716.4 4721.8 4738.1 61448.7 63339.4 63783.7 63823.7 63950.4 55332.0 55884.7 58334.0 58446.1 64157.7 49994.8 53696.5 54029.5 55996.7 56071.4 9999.5 10096.3 10127.9 10304.7 10348.0 38125.0 38926.4 39355.2 39414.6 40484.4 47431.3 49036.8 49434.8 49832.8 50252.0 13018.2 13257.9 13303.0 13469.5 13554.1 13905.4 14168.4 14648.9 14701.5 14736.4 11723.0 11795.7 12042.8 12062.8 12375.0 12951.8 13199.0 13220.5 13289.5 13389.8 13731.0 13742.4 13801.1 13809.4 13904.7 10989.6 11580.1 11711.9 11812.6 11881.6 11276.5 11540.7 11587.8 11703.4 11755.5 09:06:09 INFO - PROCESS | 8410 | -------- Summary: end -------- 09:06:09 INFO - PROCESS | 8410 | 09:06:10 INFO - TEST-INFO | 8410: exit 0 09:06:10 INFO - TEST-OK | dromaeo_css | took 1111157ms 09:06:10 INFO - TEST-START | kraken 09:06:10 INFO - operating with platform_type : linux_ 09:06:10 INFO - Initialising browser for kraken test... 09:06:10 INFO - TEST-INFO | started process 8602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphLhtH3/profile http://localhost:42423/getInfo.html) 09:06:14 INFO - PROCESS | 8602 | __metrics Screen width/height:1600/1200 09:06:14 INFO - PROCESS | 8602 | colorDepth:24 09:06:14 INFO - PROCESS | 8602 | Browser inner width/height: 1024/697 09:06:14 INFO - PROCESS | 8602 | __metrics 09:06:15 ERROR - PROCESS | 8602 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:06:16 INFO - TEST-INFO | 8602: exit 0 09:06:16 INFO - Browser initialized. 09:06:16 INFO - Running cycle 1/1 for kraken test... 09:06:16 INFO - TEST-INFO | started process 8690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphLhtH3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:27 INFO - PROCESS | 8690 | RSS: Main: 140460032 09:06:27 INFO - PROCESS | 8690 | 09:06:30 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42423/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:31 INFO - PROCESS | 8690 | RSS: Main: 197582848 09:06:31 INFO - PROCESS | 8690 | 09:06:33 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42423/tests/kraken/driver.html?testName=audio-dft) 09:06:34 INFO - PROCESS | 8690 | RSS: Main: 186040320 09:06:34 INFO - PROCESS | 8690 | 09:06:37 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42423/tests/kraken/driver.html?testName=audio-fft) 09:06:37 INFO - PROCESS | 8690 | RSS: Main: 274845696 09:06:37 INFO - PROCESS | 8690 | 09:06:39 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42423/tests/kraken/driver.html?testName=audio-oscillator) 09:06:40 INFO - PROCESS | 8690 | RSS: Main: 180973568 09:06:40 INFO - PROCESS | 8690 | 09:06:42 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42423/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:43 INFO - PROCESS | 8690 | RSS: Main: 178966528 09:06:43 INFO - PROCESS | 8690 | 09:06:46 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42423/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:46 INFO - PROCESS | 8690 | RSS: Main: 214036480 09:06:46 INFO - PROCESS | 8690 | 09:06:50 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42423/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:50 INFO - PROCESS | 8690 | RSS: Main: 213794816 09:06:50 INFO - PROCESS | 8690 | 09:06:53 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42423/tests/kraken/driver.html?testName=json-parse-financial) 09:06:54 INFO - PROCESS | 8690 | RSS: Main: 213475328 09:06:54 INFO - PROCESS | 8690 | 09:06:55 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42423/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:56 INFO - PROCESS | 8690 | RSS: Main: 192733184 09:06:56 INFO - PROCESS | 8690 | 09:06:57 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42423/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:58 INFO - PROCESS | 8690 | RSS: Main: 195252224 09:06:58 INFO - PROCESS | 8690 | 09:07:00 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42423/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:07:01 INFO - PROCESS | 8690 | RSS: Main: 208711680 09:07:01 INFO - PROCESS | 8690 | 09:07:03 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:07:03 INFO - PROCESS | 8690 | RSS: Main: 217702400 09:07:03 INFO - PROCESS | 8690 | 09:07:06 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:07 INFO - PROCESS | 8690 | RSS: Main: 212865024 09:07:07 INFO - PROCESS | 8690 | 09:07:08 INFO - PROCESS | 8690 | Cycle 1(1): loaded http://localhost:42423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42423/tests/kraken/driver.html?testName=ai-astar) 09:07:09 INFO - PROCESS | 8690 | RSS: Main: 273805312 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | __start_tp_report 09:07:09 INFO - PROCESS | 8690 | _x_x_mozilla_page_load 09:07:09 INFO - PROCESS | 8690 | _x_x_mozilla_page_load_details 09:07:09 INFO - PROCESS | 8690 | |i|pagename|runs| 09:07:09 INFO - PROCESS | 8690 | |0;ai-astar;110;109;109;111;109;110;104;110;110;109 09:07:09 INFO - PROCESS | 8690 | |1;audio-beat-detection;153;126;155;186;126;156;152;128;184;125 09:07:09 INFO - PROCESS | 8690 | |2;audio-dft;162;168;163;162;160;161;160;162;162;181 09:07:09 INFO - PROCESS | 8690 | |3;audio-fft;76;76;76;176;77;75;84;74;167;76 09:07:09 INFO - PROCESS | 8690 | |4;audio-oscillator;93;91;149;93;92;93;151;93;94;151 09:07:09 INFO - PROCESS | 8690 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;116;116 09:07:09 INFO - PROCESS | 8690 | |6;imaging-darkroom;146;145;146;145;145;145;145;145;145;144 09:07:09 INFO - PROCESS | 8690 | |7;imaging-desaturate;95;94;95;95;94;95;94;95;95;95 09:07:09 INFO - PROCESS | 8690 | |8;json-parse-financial;56;55;55;55;57;57;59;83;54;54 09:07:09 INFO - PROCESS | 8690 | |9;json-stringify-tinderbox;57;57;58;57;57;56;57;58;57;58 09:07:09 INFO - PROCESS | 8690 | |10;stanford-crypto-aes;72;71;72;72;82;73;81;73;73;74 09:07:09 INFO - PROCESS | 8690 | |11;stanford-crypto-ccm;112;116;109;112;113;114;112;115;127;128 09:07:09 INFO - PROCESS | 8690 | |12;stanford-crypto-pbkdf2;156;156;166;157;167;158;155;161;160;158 09:07:09 INFO - PROCESS | 8690 | |13;stanford-crypto-sha256-iterative;66;75;67;65;67;67;64;65;64;68 09:07:09 INFO - PROCESS | 8690 | __end_tp_report 09:07:09 INFO - PROCESS | 8690 | __start_cc_report 09:07:09 INFO - PROCESS | 8690 | _x_x_mozilla_cycle_collect,1563 09:07:09 INFO - PROCESS | 8690 | __end_cc_report 09:07:09 INFO - PROCESS | 8690 | __startTimestamp1467043629220__endTimestamp 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | ------- Summary: start ------- 09:07:09 INFO - PROCESS | 8690 | Number of tests: 14 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:1.91 (1.7%) stddev-sans-first:2.00 09:07:09 INFO - PROCESS | 8690 | Values: 110.0 109.0 109.0 111.0 109.0 110.0 104.0 110.0 110.0 109.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:154.00 stddev:23.04 (15.0%) stddev-sans-first:24.40 09:07:09 INFO - PROCESS | 8690 | Values: 153.0 126.0 155.0 186.0 126.0 156.0 152.0 128.0 184.0 125.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#2] audio-dft Cycles:10 Average:164.10 Median:162.00 stddev:6.35 (3.9%) stddev-sans-first:6.69 09:07:09 INFO - PROCESS | 8690 | Values: 162.0 168.0 163.0 162.0 160.0 161.0 160.0 162.0 162.0 181.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:40.10 (52.8%) stddev-sans-first:41.89 09:07:09 INFO - PROCESS | 8690 | Values: 76.0 76.0 76.0 176.0 77.0 75.0 84.0 74.0 167.0 76.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:93.00 stddev:27.85 (29.9%) stddev-sans-first:28.85 09:07:09 INFO - PROCESS | 8690 | Values: 93.0 91.0 149.0 93.0 92.0 93.0 151.0 93.0 94.0 151.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:07:09 INFO - PROCESS | 8690 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 09:07:09 INFO - PROCESS | 8690 | Values: 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 144.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:07:09 INFO - PROCESS | 8690 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:56.50 stddev:8.75 (15.5%) stddev-sans-first:9.23 09:07:09 INFO - PROCESS | 8690 | Values: 56.0 55.0 55.0 55.0 57.0 57.0 59.0 83.0 54.0 54.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 09:07:09 INFO - PROCESS | 8690 | Values: 57.0 57.0 58.0 57.0 57.0 56.0 57.0 58.0 57.0 58.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:73.00 stddev:3.89 (5.3%) stddev-sans-first:4.03 09:07:09 INFO - PROCESS | 8690 | Values: 72.0 71.0 72.0 72.0 82.0 73.0 81.0 73.0 73.0 74.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:114.50 stddev:6.46 (5.6%) stddev-sans-first:6.70 09:07:09 INFO - PROCESS | 8690 | Values: 112.0 116.0 109.0 112.0 113.0 114.0 112.0 115.0 127.0 128.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:159.00 stddev:4.17 (2.6%) stddev-sans-first:4.24 09:07:09 INFO - PROCESS | 8690 | Values: 156.0 156.0 166.0 157.0 167.0 158.0 155.0 161.0 160.0 158.0 09:07:09 INFO - PROCESS | 8690 | 09:07:09 INFO - PROCESS | 8690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:3.19 (4.8%) stddev-sans-first:3.37 09:07:09 INFO - PROCESS | 8690 | Values: 66.0 75.0 67.0 65.0 67.0 67.0 64.0 65.0 64.0 68.0 09:07:09 INFO - PROCESS | 8690 | -------- Summary: end -------- 09:07:09 INFO - PROCESS | 8690 | 09:07:10 INFO - TEST-INFO | 8690: exit 0 09:07:10 INFO - TEST-OK | kraken | took 59652ms 09:07:10 INFO - SUITE-END | took 1170s 09:07:10 INFO - Completed test suite (00:19:31) 09:07:10 INFO - javascript benchmark 09:07:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.8675652973875, 3353.463445848663, 3365.19235383508, 3377.324535092982, 3405.8126803025825, 5577.972110139449, 5579.246801681772, 5591.4688104630095, 5604.103343465046, 5611.9438805611935, 5559.722013899299, 5576.525995290395, 5577.414371490996, 5596.86007849804, 5654.858628534289, 5057.544820966113, 5061.519155680214, 5138.152204886189, 5194.844154675366, 5221.843344699665, 5084.0594490019275, 5105.897882042357, 5143.717095559743, 5145.459726728695, 5155.613329000321, 5075.441701412841, 5131.897362052757, 5154.149565321717, 5154.278401023859, 5191.351081114861, 5239.659422137568, 5257.815976440845, 5273.0, 5273.129933560957, 5306.814261500867, 4985.052839960396, 5042.773075211624, 5067.417247016603, 5167.22491626259, 5171.37943446785, 5578.079616863253, 5607.8878422431735, 5615.0, 5616.494515493584, 5617.129344951539, 5942.138389933435, 5973.671448070354, 5983.222181116471, 5989.281286245635, 5998.820035398901, 5979.521638268928, 6016.127661489103, 6070.725743932259, 6086.117512960596, 6093.817185484399, 5680.630759000652, 5719.02776527987, 5733.0, 5739.368669446358, 5745.482906538348, 6018.277806663141, 6252.062190671436, 6271.78048768291, 6273.027680709497, 6278.591891527036, 5795.1017592273265, 5887.35239123696, 5895.115732640053, 5909.084091965752, 5909.911351329733, 6009.549283803644, 6010.519158467312, 6012.909806352821, 6016.037434010537, 6038.064100064497, 5938.881222375615, 6003.369646187175, 6009.549283803644, 6013.067974463965, 6013.368596297413, 6098.32918378978, 6098.969505152446, 6107.0228763397645, 6110.953680641517, 6136.9079463808075, 4633.096546173464, 4634.420697412824, 4636.8145274188655, 4638.0955713636195, 4669.929951050737, 4097.303458412077, 4122.2786012447705, 4145.150244199932, 4164.250434921743, 4193.056562273464, 5788.160716696056, 5795.536357091422, 5795.710214489259, 5797.275340582427, 5801.158831969426, 6062.090686397076, 6084.056971169476, 6107.541934354852, 6121.632702037892, 6128.111423843607, 5700.201971723962, 5770.88458230833, 5788.392218817048, 5845.590808643439, 5848.795292164754, 5222.7127507987425, 5237.947620523746, 5238.214267859851, 5239.397469291081, 5239.659422137549, 6333.2400111985935, 6341.3341599132345, 6346.143270658495, 6354.110424540568, 6357.300696923335, 6012.699365031818, 6069.0592958091565, 6125.632272693401, 6141.240538582634, 6144.003198960445, 6320.778772742932, 6353.872922541431, 6364.109024736448, 6370.140031095742, 6378.87242255143, 5806.129080637938, 5990.820275391745, 5998.88002239944, 6004.42957918997, 6004.819855404345, 6028.728707208098, 6109.236345456818, 6110.1638887921135, 6125.601835880653, 6141.0, 5818.44724751148, 5832.154337621106, 5836.358000620014, 5842.591018628656, 5853.970730146322, 5806.622569532967, 5855.0, 5859.9121013183985, 5874.118882167538, 5892.440218179266, 5890.705464726832, 5895.557833162616, 5943.138244954544, 5945.762169513344, 5994.760209591742, 5997.250343707036, 6020.668863212565, 6052.455279024909, 6057.909131362945, 6059.121427392915, 5745.569082318926, 5830.883382332415, 5927.170196172453, 5941.1385349125, 5945.970270148621], "value": 5594.561444010972, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.9603423794573, 689.2693744630692, 698.4586945117536, 750.7935317787609, 768.258630421643, 32463.350732985327, 39000.0, 39167.60832391675, 39399.212015759666, 39413.0, 40832.0, 41364.379534306936, 41454.58545414545, 41651.79174104133, 41925.161496770044, 7961.761147165595, 8794.164554367357, 8869.866951995726, 8974.910250897505, 10408.583656653725, 10480.790384192349, 10641.893581064207, 10650.467476626138, 10650.78698426031, 10652.201084918623, 10654.840177397346, 10708.892911070907, 10725.892741072606, 10729.463526823627, 10733.51699173539, 10611.045005949463, 10687.572497100107, 10688.679339619785, 10689.518971646217, 10697.572097116106, 10822.24244302899, 10998.0, 11009.2843965142, 11009.449527523591, 11013.118950483942, 43698.0, 44170.0, 44191.55808441906, 44219.557804421864, 44226.0, 3697.7411581189326, 3866.168773713665, 3995.900102497461, 4119.011437255067, 4257.8509752158525, 33808.83095584531, 33866.0, 33867.661323386696, 33892.83053584716, 34169.0, 4597.172508948388, 4640.396748422683, 4682.953170468286, 4685.273782563708, 4716.29255611661, 336603.99999999756, 337699.0, 338580.0, 338718.0, 339050.99999999756, 65622.34377656163, 65652.34347656558, 65696.0, 66214.66892665505, 66215.0, 69763.0, 70011.2998870015, 70196.29803701898, 71473.0, 71490.64254678797, 19750.40748777539, 19938.302159424642, 19958.0, 19964.90017549932, 19965.500862478264, 13757.518486852912, 15359.078455292718, 15657.921710391374, 15716.92141539285, 15718.921405392899, 19690.113944872515, 19981.300654477312, 20184.49538761543, 20258.79741202569, 20296.289629862884, 7271.89092163618, 7525.510841795266, 7769.300762931251, 7805.141434442206, 7818.687252509836, 1036.3832421422455, 1065.893410658928, 1141.4121727310442, 1216.1304667163022, 1229.5819421396768, 33922.66077339245, 33948.75640544932, 34770.478442823376, 35342.11644708851, 35672.78944894972, 1119.1885882734953, 1156.9710757231137, 1164.9825252621217, 1194.5221911235576, 1207.8429804125408, 16620.085895275635, 16845.157742112846, 16868.831311686972, 17070.658586828442, 17263.3957811476, 474038.0, 478125.0, 479834.0, 480294.0, 480994.0, 61460.38539614636, 62521.68739156275, 62639.6868015657, 62872.37127628665, 63195.0, 1415.9221242831536, 1499.5576304990054, 1512.954611361661, 1557.268084000518, 1624.796900387428, 32154.35691286208, 32840.34319313552, 33205.66794332026, 33845.661543385235, 34124.65875341215, 52618.0, 53271.0, 53329.733351332994, 53452.19821702755, 53465.0, 360768.0, 370416.0, 370792.0, 371610.0, 371655.0, 27949.16152515428, 28532.286692832844, 29406.264843379086, 30770.538441923836, 30949.535756963214, 43146.0, 43609.34585981276, 43668.781656091516, 44257.55742442663, 44515.0, 37039.81480092582, 37166.814165929, 37245.4413183797, 37490.437643435915, 37500.62499374971, 38813.41779873248, 40357.798211008754, 40846.79576602098, 41080.0, 41302.1739565213, 41457.1708565833, 42078.15843683048, 42188.578114218464, 42568.78715606402, 42588.78705606576, 33909.830450847585, 34804.129896752784, 35404.0, 35475.290494190485, 35819.462708059924, 28261.597764190275, 28361.29096772515, 28423.85788071129, 28545.857270713514, 28682.0], "value": 21162.671853855467, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.5333353311059, 431.92051077572324, 433.053777496171, 440.92283850326197, 444.182703824962, 19073.71389429158, 19244.90377548114, 19252.0, 19526.21895124193, 19711.112999915003, 19089.14098865551, 19298.807011929875, 20141.39575812728, 20144.09351579179, 20163.294284700038, 5383.838484845451, 5528.336599608033, 5759.884802303952, 5774.422557744234, 5778.162166485878, 4234.0, 5716.114002329646, 5784.3058832940105, 6109.419605137505, 6412.102305677209, 6369.808905732835, 6392.4886009119155, 6397.296297407282, 6406.1351717518, 6407.551471397004, 5492.862678433031, 5770.711464426804, 5779.988502012131, 5784.942150578503, 6350.364963503635, 3897.7466464679987, 5418.9458105418835, 5631.8028868989795, 5649.745761440745, 5680.403557626472, 14450.71098578033, 14653.120812751162, 14654.926725366306, 14689.265536723227, 22790.202342917917, 2306.1467257114805, 2332.043862016565, 2359.905603775847, 2362.208660098869, 3059.174023013796, 10625.203109766799, 12695.619131426072, 13605.591832245049, 13828.0, 13838.723225535434, 2027.5336672565393, 2058.5574101568236, 2091.1948899673584, 2119.9364019079453, 2194.0565556810566, 75655.62172189158, 79723.0, 80063.59968200122, 82154.58922705348, 83349.0, 11383.601573944872, 11704.53693288339, 11706.35615041181, 11787.115966302561, 12036.157468977088, 16457.588560286087, 16620.418285359956, 16739.832601674072, 16749.0, 16773.664526709643, 9174.449533027906, 9207.40151890125, 9283.48940808262, 9369.90630093704, 9381.671641492652, 9336.439813611205, 9362.110599493037, 9375.578098985561, 9421.764455888657, 9467.857982130274, 5111.207762796773, 5139.948600514022, 5182.481751824787, 5227.503387178212, 5238.397584277857, 1867.4771064102074, 2083.3541602103396, 2106.9157233710785, 2110.767815540289, 2170.1536400803698, 1023.6212601337553, 1038.1975544459906, 1045.6706137566641, 1055.171690223171, 1120.7478317378525, 18485.81514184841, 18898.433047008613, 19041.809581904003, 19233.51916202106, 19632.11655475507, 1012.0436187802457, 1107.3577325151393, 1115.576081089181, 1126.6676330482528, 1134.8581427321585, 10217.642382516577, 10649.201309901788, 10667.626633067961, 10672.30630009047, 10778.0, 529339.0, 541390.0, 546970.0, 552729.0, 554901.0, 92777.53611232036, 95222.0, 96058.51970740102, 96758.5162074185, 96931.51534242283, 1136.1308598921833, 1148.609472779259, 1157.062779148892, 1174.1546086817477, 1174.4890972427022, 17066.91466542709, 17138.742918856475, 17244.482665520056, 17380.47858564245, 17397.913010434866, 38912.22175556416, 39457.2108557833, 40743.38884916788, 41214.38178427266, 41545.58454415538, 54231.0, 55264.17103743367, 56303.0, 59091.0, 59715.0, 12218.20581662189, 12852.293123877902, 12895.871041289467, 12906.67733306675, 12990.545330913372, 9016.639334426549, 11960.923516883522, 13368.933155334162, 13735.793963090362, 13822.447102115802, 11491.310521368745, 11859.0, 11968.940155299168, 12490.875091249334, 12508.812367814307, 11748.412579371168, 12069.517219311128, 12084.335361555199, 12118.818217726564, 12196.817047744113, 11392.886071139183, 11928.284302941503, 12100.576479823163, 12270.631881043582, 13362.732745345233, 13012.804807928078, 13218.933905330412, 13261.535846245335, 13402.396892139683, 13430.798538021741, 11287.379194144401, 11410.258333208314, 11430.48562814692, 11471.139664525028, 11586.0], "value": 9747.993067289553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.7703255995325, 1563.7028964496742, 1568.1688704986357, 1801.945941621752, 1942.1842826013074, 7496.0, 8278.048024477186, 8439.704610338631, 8440.873386899202, 8451.408401411903, 8087.878681819778, 8260.380471464634, 8262.91737082629, 8264.049634292058, 8266.049404318504, 2411.0596867221752, 2428.0651948999675, 2430.3195105370523, 2431.9392015199583, 2432.9513409731794, 2388.653645221442, 2430.173740928084, 2465.790407815338, 2474.653548503211, 2479.603263477844, 2418.794402475783, 2428.8421252618614, 2429.501952099824, 2449.987750061256, 2451.4116612013077, 2408.5303365843665, 2418.1536462238164, 2421.2615152378517, 2423.8182136339756, 2454.0306578901414, 2395.4969456414, 2400.759924007603, 2401.7838394544574, 2404.603240465321, 2407.2537513370735, 8201.425900186989, 8361.996560412728, 8390.454620449713, 8406.117357677416, 8407.0, 5213.843584692465, 5281.36623605166, 5290.418054014055, 5297.4437684043005, 5316.149416093406, 3259.8859039933727, 3283.917902052468, 3312.834358282076, 3333.21669407689, 3341.5823022122236, 1129.570763110021, 1130.5647325779553, 1136.4147464056018, 1136.732867776072, 1144.204777679513, 11873.0, 12051.638450846489, 12314.938425307906, 12331.5067397304, 12333.198342107824, 4595.586397224266, 4669.042846216517, 4745.881352966135, 4751.548602882721, 4766.380370551806, 9733.610655573839, 9734.805303893883, 9735.65925192629, 9747.3664211826, 9755.268354873271, 5253.185756207794, 5290.365156181206, 5294.126469132627, 5298.6290959633225, 5302.125149350391, 4178.331466965271, 4284.464441944757, 4729.408823897013, 4772.427308722976, 4916.213405855046, 3950.822213000422, 3956.485656864589, 4021.7184797063924, 4059.0664147245707, 4063.065494936122, 1235.6540168752763, 1238.9442475088642, 1239.1883316427575, 1244.9190802597802, 1252.4238850129043, 981.8919918808925, 988.930774845754, 997.4912794474725, 999.8420782502236, 1011.6054738651932, 5834.3290521589715, 5891.96890544153, 5907.497862681635, 5971.850703732354, 6048.697565121726, 475.68367035921415, 478.8946431785002, 479.72655586316165, 1077.4451157653814, 1078.5955266774959, 3961.3067713150085, 3972.940405893914, 3976.980115099406, 4004.799760012046, 4046.5548789633117, 10285.0, 10632.521536530874, 10727.570897164182, 10747.946260268649, 10753.085987690978, 10572.048515633629, 10578.62974795894, 10585.576576936835, 10588.894111058791, 10589.682309530726, 8197.139300373494, 8217.0, 8521.488710677379, 8552.144785521397, 8569.143085691505, 5770.422957704196, 5864.384239654945, 5875.588708790344, 5950.791722289872, 5991.310999235144, 9380.343375963617, 9604.51977401141, 9614.18279446255, 9816.018398160413, 9818.901810982084, 9686.321957463191, 9716.271279654196, 9928.751781205528, 9950.203983681433, 9954.950225248827, 6615.636140012345, 7040.331168538981, 7243.420526357773, 7326.816829579303, 7415.0, 8261.339092872677, 8300.12848650883, 8314.70898518573, 8338.082810890919, 8355.582220889053, 7486.4759466836795, 7600.733974310872, 7611.771646850603, 7650.158482567024, 7752.0, 7175.461840362098, 7455.291747283999, 7458.776236712907, 7543.73596924105, 7550.2072282411755, 6952.165740111219, 6955.095837541087, 6996.475264355092, 6999.440044796506, 7000.61496617691, 5085.92371114441, 5111.309973153577, 5198.246254293031, 5267.9736601316745, 5276.023935571931, 5144.819931302386, 5147.58819294448, 5241.50205730455, 5259.500347466985, 5294.338207724035], "value": 4577.481691109161, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.25009355307077, 365.57958347899927, 368.9944650830237, 370.1265014565625, 373.4752672495145, 6176.845578860531, 6183.783567575136, 6232.750689972401, 6233.033879748635, 6237.656928868911, 6116.4800991915745, 6199.225096862892, 6204.379562043793, 6207.8758424831585, 6218.968905155468, 4615.399998000255, 4728.692634978733, 4843.055604157191, 4851.22380419133, 4856.417229932413, 4817.0, 4843.709377437347, 4845.588125009378, 4854.199057155565, 4855.053264613402, 4606.470255920579, 4827.0, 4829.082474329866, 4833.854984350475, 4847.51524847516, 4681.765911704419, 4776.570108690217, 4782.541324895906, 4826.613870890355, 4839.27410888366, 4277.401163837066, 4282.8715138545895, 4287.078278170208, 4290.506591741959, 4293.441852559147, 5972.581919265654, 5978.790742323998, 5985.042393217064, 5986.491148252404, 5995.7901473448655, 5622.550195984311, 5634.267545219136, 5634.887302253973, 5642.238297829782, 5642.4357564243655, 6339.873202535923, 6571.178602674666, 6574.76988305407, 6579.539432239745, 6589.538732288742, 4528.569785870337, 4542.227821270359, 4568.383268258775, 4588.701734387288, 4594.402727645418, 6819.215790184143, 6886.414654754352, 6896.172459304866, 6898.793036208872, 6899.724011039552, 4750.667453278237, 4751.762411879392, 4755.500672429345, 4757.452892917289, 4759.762011899391, 4811.446683631357, 4812.374391329105, 4812.470628230892, 4814.975925120352, 4816.54242846929, 5537.003339398866, 5545.445455454423, 5547.805826796042, 5552.7778888844805, 5565.165225216169, 6430.935690643128, 6658.1011563438315, 6658.4340331071435, 6667.266600673922, 6673.399394054559, 1636.1819090454774, 1680.3362671744592, 1681.7729606502965, 1685.6123091688735, 1686.814450410454, 1061.177587369779, 1070.5022164693455, 1081.588996181446, 1105.4417519152776, 1133.7675776465805, 6310.936890631035, 6380.968095159495, 6387.105805187278, 6389.584676995981, 6398.072279519443, 6771.830704232335, 6779.322067793181, 6782.253952065269, 6784.219814721271, 6787.694553745093, 6359.618422894641, 6361.01404282337, 6371.0, 6379.64911929839, 6380.489560835122, 3611.0972256935765, 3643.3624115780162, 3648.1791596891017, 3649.4525821127045, 3649.7445178837224, 6910.827229319207, 7070.257622949619, 7073.646317684095, 7076.115485564304, 7083.335416177194, 6900.551464154814, 6900.930990690129, 6906.965465172642, 6917.9308206917285, 6922.307769223138, 7054.753083642048, 7065.929340706527, 7073.575585464889, 7074.151101867808, 7076.150861896605, 6761.256261811099, 6765.594064356154, 6773.051772751917, 6782.796516104525, 6784.525083244125, 6567.671616419256, 6705.195376554844, 6708.563943343667, 6713.664316784044, 6716.361945615159, 7024.438044956493, 7051.43588512928, 7054.823629409306, 7058.082449281561, 7070.646467676698, 4717.599004084691, 4722.386089808303, 4726.26742854858, 4740.241561350167, 4740.786664600032, 6729.394354508117, 6740.12378390806, 6745.3591908768585, 6745.426638735762, 6754.797356079325, 6412.903806442814, 6507.219133703986, 6544.083828264142, 6550.279469258282, 6563.212414510098, 6487.734891696074, 6533.052707357501, 6533.542652014314, 6543.640099794557, 6612.70242839083, 6425.45383642377, 6445.16212892321, 6446.742130314922, 6447.838804029937, 6450.967745161244, 6569.638669873203, 6576.473882089325, 6580.078788969644, 6580.736770529125, 6589.868202635825, 6284.402981716729, 6431.196100487439, 6436.066770318184, 6440.323766004502, 6451.387118223761], "value": 4993.248513082129, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.4374409785202, 827.635840230299, 836.7155167243136, 891.8795962545056, 896.0725648953332, 16991.320347186098, 17227.0, 17331.65336693267, 17350.73973890391, 17363.045032523205, 15117.924410377933, 15204.0, 15221.771673424908, 15235.847641523582, 15264.771028434583, 754.7018927523625, 868.4832524647856, 884.0408157149484, 886.2201262888649, 901.1214066285385, 892.1479986612769, 893.1961234888587, 893.6157452295511, 895.3061377432509, 895.9372843900929, 778.4473024152858, 957.8563215517659, 957.9377340472881, 958.0132463562542, 959.7648576098866, 923.0999775219175, 942.3026960049548, 945.8581212818063, 946.1437399153776, 946.6639343033193, 689.0387908867152, 694.9930500694979, 696.8815301398774, 697.6267696782248, 698.1935864077, 15666.0, 15705.214739263105, 15769.211539422982, 15781.36874525029, 15845.12851793151, 13629.25039122848, 13640.658983525393, 13938.0, 13949.16305021702, 14003.50987715425, 11809.291442513477, 12133.878661213363, 12210.633680989496, 12272.263664180178, 12301.01591872648, 3967.920641587152, 3968.6626636735914, 4033.69747268956, 4080.1839632073406, 4099.959000409987, 56990.430095698925, 57083.42916570823, 57189.999999999585, 57639.711801441146, 57721.7113914432, 10834.945825270823, 11198.944005279922, 11281.153913456523, 11424.200305978668, 11495.827562586568, 20026.899865500578, 20160.193592256146, 20206.89896550508, 20454.38636840897, 20465.48836279075, 8190.221928916862, 8512.446690965067, 8566.52884091381, 8593.914060859312, 8615.913840861636, 4806.7836947337455, 4842.685225460334, 4918.163912134945, 4946.975265123651, 4979.850604481871, 3458.342914846171, 3698.3527882620433, 3726.7763934164036, 3731.645493678096, 3733.439984002421, 660.6234446365621, 667.4593579200863, 726.7964969808462, 729.3836707981746, 743.353282644103, 799.9040115186099, 802.358113509202, 844.6199210355364, 853.1724227499316, 858.819647873941, 9718.416894986323, 10208.234382421348, 10252.846207306897, 10290.485475726184, 10332.793344133075, 768.3776141325544, 783.8628240057967, 797.1988151907296, 807.3299161695778, 826.0582935453588, 4674.883127921829, 4705.717656940595, 4716.410448693913, 4721.834735784231, 4738.147133515931, 61448.69275653593, 63339.36660633427, 63783.68108159523, 63823.6808815953, 63950.36049639444, 55332.0, 55884.720576397674, 58334.0, 58446.12330815041, 64157.679211604576, 49994.75002624963, 53696.46303536915, 54029.45970540244, 55996.72001639966, 56071.43928560744, 9999.500024998575, 10096.34373765703, 10127.92384989851, 10304.742381440525, 10348.0, 38125.0, 38926.41610375903, 39355.212895742494, 39414.60585394224, 40484.39273410842, 47431.288530672755, 49036.75481622569, 49434.752826235635, 49832.750836245585, 50252.0, 13018.15382000167, 13257.933710331386, 13303.0, 13469.528566500125, 13554.051216414757, 13905.443782248596, 14168.433262669378, 14648.853511465175, 14701.485448009269, 14736.410543578137, 11723.0, 11795.705107372041, 12042.75914481723, 12062.819057714318, 12375.009999199863, 12951.805722913976, 13199.0, 13220.537281195113, 13289.468421263042, 13389.799153012518, 13731.045490822107, 13742.381592828147, 13801.102928309629, 13809.378577964217, 13904.721905562035, 10989.61536346224, 11580.056846280184, 11711.88288117108, 11812.586559470377, 11881.5841445549, 11276.492557835081, 11540.653780386601, 11587.826182607436, 11703.414829258674, 11755.471003804678], "value": 7282.3351466144395, "unit": "score"}], "name": "dromaeo_css", "value": 7596.185474214555, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 109.0, 111.0, 109.0, 110.0, 104.0, 110.0, 110.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 155.0, 186.0, 126.0, 156.0, 152.0, 128.0, 184.0, 125.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 163.0, 162.0, 160.0, 161.0, 160.0, 162.0, 162.0, 181.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 176.0, 77.0, 75.0, 84.0, 74.0, 167.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 149.0, 93.0, 92.0, 93.0, 151.0, 93.0, 94.0, 151.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 57.0, 57.0, 59.0, 83.0, 54.0, 54.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 57.0, 56.0, 57.0, 58.0, 57.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 72.0, 82.0, 73.0, 81.0, 73.0, 73.0, 74.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 109.0, 112.0, 113.0, 114.0, 112.0, 115.0, 127.0, 128.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 166.0, 157.0, 167.0, 158.0, 155.0, 161.0, 160.0, 158.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 67.0, 65.0, 67.0, 67.0, 64.0, 65.0, 64.0, 68.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1516.5, "alertThreshold": 2.0}]} 09:07:10 INFO - Return code: 0 09:07:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:07:10 ERROR - # TBPL SUCCESS # 09:07:10 INFO - Running post-action listener: _resource_record_post_action 09:07:10 INFO - Running post-run listener: _resource_record_post_run 09:07:11 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 228515840; Read time: 16; Write time: 157444 09:07:11 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 13332480; Read time: 0; Write time: 1380 09:07:11 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 212975616; Read time: 16; Write time: 155876 09:07:11 INFO - Running post-run listener: _upload_blobber_files 09:07:11 INFO - Blob upload gear active. 09:07:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:07:11 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 09:07:11 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'] 09:07:11 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 09:07:12 INFO - (blobuploader) - INFO - Open directory for files ... 09:07:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:07:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:07:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:12 INFO - (blobuploader) - INFO - Done attempting. 09:07:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:07:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:07:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:13 INFO - (blobuploader) - INFO - Done attempting. 09:07:13 INFO - (blobuploader) - INFO - Iteration through files over. 09:07:13 INFO - Return code: 0 09:07:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:07:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:07:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5ff1e216f67d9f96971a30d2c181744696317f7680c6d5d213057e9234cbf1ce11d988af53cc56409fb47a97c1ccdd1ccfecc192324ca7c21bfc8342b95dcd1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89a5e7a14fd476e0dfd49fe34745e14f3a8f9401a37b9af4788ead41e8aeb04c56506b387cd3fc4cd49e8313a1cf7f41f04261378a1e1d7653f4755723eb3f39"} 09:07:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:07:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:07:13 INFO - Contents: 09:07:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5ff1e216f67d9f96971a30d2c181744696317f7680c6d5d213057e9234cbf1ce11d988af53cc56409fb47a97c1ccdd1ccfecc192324ca7c21bfc8342b95dcd1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89a5e7a14fd476e0dfd49fe34745e14f3a8f9401a37b9af4788ead41e8aeb04c56506b387cd3fc4cd49e8313a1cf7f41f04261378a1e1d7653f4755723eb3f39"} 09:07:13 INFO - Running post-run listener: copy_logs_to_upload_dir 09:07:13 INFO - Copying logs to upload dir... 09:07:13 INFO - mkdir: /builds/slave/test/build/upload/logs 09:07:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1325.781945 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2016-06-27 09:07:12.418177) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:07:12.421539) ========= 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=836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823 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/5ff1e216f67d9f96971a30d2c181744696317f7680c6d5d213057e9234cbf1ce11d988af53cc56409fb47a97c1ccdd1ccfecc192324ca7c21bfc8342b95dcd1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89a5e7a14fd476e0dfd49fe34745e14f3a8f9401a37b9af4788ead41e8aeb04c56506b387cd3fc4cd49e8313a1cf7f41f04261378a1e1d7653f4755723eb3f39"} build_url:https://queue.taskcluster.net/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/b376WTOURTqOYGowwm00-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5ff1e216f67d9f96971a30d2c181744696317f7680c6d5d213057e9234cbf1ce11d988af53cc56409fb47a97c1ccdd1ccfecc192324ca7c21bfc8342b95dcd1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89a5e7a14fd476e0dfd49fe34745e14f3a8f9401a37b9af4788ead41e8aeb04c56506b387cd3fc4cd49e8313a1cf7f41f04261378a1e1d7653f4755723eb3f39"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:07:12.448866) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:07:12.449556) ========= 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=836cfdc75598d54cb747368e000001a9-1467042264.273052-222763823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:07:12.533381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:07:12.533764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:07:12.534164) ========= ========= Total master_lag: 0.17 =========