builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1467650784.15 results: success (0) buildid: 20160704065143 builduid: 77f35740e5f448a98c1c8a8c40608da9 revision: 3e04c4853a8bc95b6b485c42fb7e1e2d7500316b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:24.153603) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:24.154116) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:24.154469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:24.169813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:24.170164) ========= 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=5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 09:46:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-07-04 09:46:24 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087996 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:24.273433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:24.273799) ========= 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=5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018455 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:24.323423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:24.323812) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3e04c4853a8bc95b6b485c42fb7e1e2d7500316b --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 3e04c4853a8bc95b6b485c42fb7e1e2d7500316b --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=5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 09:46:24,561 truncating revision to first 12 chars 2016-07-04 09:46:24,561 Setting DEBUG logging. 2016-07-04 09:46:24,561 attempt 1/10 2016-07-04 09:46:24,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3e04c4853a8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 09:46:24,971 unpacking tar archive at: mozilla-beta-3e04c4853a8b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.779916 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:25.120834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:25.121332) ========= script_repo_revision: 3e04c4853a8bc95b6b485c42fb7e1e2d7500316b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:25.121882) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:25.122205) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 09:46:25.133867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-07-04 09:46:25.134181) ========= /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=5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:46:25 INFO - MultiFileLogger online at 20160704 09:46:25 in /builds/slave/test 09:46:25 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 09:46:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:46:25 INFO - {'append_to_log': False, 09:46:25 INFO - 'base_work_dir': '/builds/slave/test', 09:46:25 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:46:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:46:25 INFO - 'branch': 'Mozilla-Beta', 09:46:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:46:25 INFO - 'config_files': ('talos/linux_config.py',), 09:46:25 INFO - 'default_actions': ('clobber', 09:46:25 INFO - 'read-buildbot-config', 09:46:25 INFO - 'download-and-extract', 09:46:25 INFO - 'populate-webroot', 09:46:25 INFO - 'create-virtualenv', 09:46:25 INFO - 'install', 09:46:25 INFO - 'run-tests'), 09:46:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:46:25 INFO - 'download_minidump_stackwalk': True, 09:46:25 INFO - 'download_symbols': 'ondemand', 09:46:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:46:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:46:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:46:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:46:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:46:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:46:25 INFO - 'installer_path': 'installer.exe', 09:46:25 INFO - 'log_level': 'info', 09:46:25 INFO - 'log_name': 'talos', 09:46:25 INFO - 'log_to_console': True, 09:46:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:46:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:46:25 INFO - 'opt_config_files': (), 09:46:25 INFO - 'pip_index': False, 09:46:25 INFO - 'sps_profile': False, 09:46:25 INFO - 'sps_profile_interval': 0, 09:46:25 INFO - 'suite': 'dromaeojs', 09:46:25 INFO - 'system_bits': '32', 09:46:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:46:25 INFO - 'title': 'talos-linux64-ix-011', 09:46:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:46:25 INFO - 'use_talos_json': True, 09:46:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:46:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:46:25 INFO - 'work_dir': 'build'} 09:46:25 INFO - ##### 09:46:25 INFO - ##### Running clobber step. 09:46:25 INFO - ##### 09:46:25 INFO - Running pre-action listener: _resource_record_pre_action 09:46:25 INFO - Running main action method: clobber 09:46:25 INFO - rmtree: /builds/slave/test/build 09:46:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:46:26 INFO - Running post-action listener: _resource_record_post_action 09:46:26 INFO - ##### 09:46:26 INFO - ##### Running read-buildbot-config step. 09:46:26 INFO - ##### 09:46:26 INFO - Running pre-action listener: _resource_record_pre_action 09:46:26 INFO - Running main action method: read_buildbot_config 09:46:26 INFO - Using buildbot properties: 09:46:26 INFO - { 09:46:26 INFO - "project": "", 09:46:26 INFO - "product": "firefox", 09:46:26 INFO - "script_repo_revision": "production", 09:46:26 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:46:26 INFO - "repository": "", 09:46:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:46:26 INFO - "buildid": "20160704065143", 09:46:26 INFO - "pgo_build": "True", 09:46:26 INFO - "basedir": "/builds/slave/test", 09:46:26 INFO - "buildnumber": 151, 09:46:26 INFO - "slavename": "talos-linux64-ix-011", 09:46:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:46:26 INFO - "platform": "ubuntu64_hw", 09:46:26 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:46:26 INFO - "branch": "mozilla-beta", 09:46:26 INFO - "repo_path": "releases/mozilla-beta", 09:46:26 INFO - "revision": "3e04c4853a8bc95b6b485c42fb7e1e2d7500316b", 09:46:26 INFO - "stage_platform": "linux64-pgo", 09:46:26 INFO - "builduid": "77f35740e5f448a98c1c8a8c40608da9", 09:46:26 INFO - "slavebuilddir": "test" 09:46:26 INFO - } 09:46:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 09:46:26 INFO - Running post-action listener: _resource_record_post_action 09:46:26 INFO - ##### 09:46:26 INFO - ##### Running download-and-extract step. 09:46:26 INFO - ##### 09:46:26 INFO - Running pre-action listener: _resource_record_pre_action 09:46:26 INFO - Running main action method: download_and_extract 09:46:26 INFO - mkdir: /builds/slave/test/build/tests 09:46:26 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')]} 09:46:26 INFO - https://queue.taskcluster.net/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:46:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:46:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:46:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/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 09:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/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 09:46:27 INFO - Downloaded 1327 bytes. 09:46:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:46:27 INFO - Using the following test package requirements: 09:46:27 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:46:27 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:46:27 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:46:27 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:46:27 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 09:46:27 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:46:27 INFO - u'jsshell-linux-x86_64.zip'], 09:46:27 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:46:27 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:46:27 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:46:27 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:46:27 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 09:46:27 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:46:27 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 09:46:27 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:46:27 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:46:27 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:46:27 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:46:27 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:27 INFO - https://queue.taskcluster.net/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:46:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:46:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:46:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/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 09:46:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/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 09:46:28 INFO - Downloaded 24236684 bytes. 09:46:28 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'] 09:46:28 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 09:46:29 INFO - Return code: 0 09:46:29 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 09:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:29 INFO - https://queue.taskcluster.net/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/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 09:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/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 09:46:30 INFO - Downloaded 24236684 bytes. 09:46:30 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'] 09:46:30 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 09:46:32 INFO - Return code: 0 09:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:32 INFO - https://queue.taskcluster.net/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:46:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:46:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:46:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/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 09:46:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/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 09:46:33 INFO - Downloaded 10840145 bytes. 09:46:33 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'] 09:46:33 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 09:46:33 INFO - Return code: 0 09:46:33 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')]} 09:46:33 INFO - https://queue.taskcluster.net/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:46:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:46:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:46:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/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 09:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/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 09:46:34 INFO - Downloaded 56017902 bytes. 09:46:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:46:34 INFO - mkdir: /builds/slave/test/properties 09:46:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:46:34 INFO - Writing to file /builds/slave/test/properties/build_url 09:46:34 INFO - Contents: 09:46:34 INFO - build_url:https://queue.taskcluster.net/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:46:35 INFO - Running post-action listener: _resource_record_post_action 09:46:35 INFO - Running post-action listener: set_extra_try_arguments 09:46:35 INFO - ##### 09:46:35 INFO - ##### Running populate-webroot step. 09:46:35 INFO - ##### 09:46:35 INFO - Running pre-action listener: _resource_record_pre_action 09:46:35 INFO - Running main action method: populate_webroot 09:46:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:46:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:46:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:46:35 INFO - '--tppagecycles', 09:46:35 INFO - '7'], 09:46:35 INFO - 'tests': ['tsvgm']}}, 09:46:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:46:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:46:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:46:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:46:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:46:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:46:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:35 INFO - 'talos_options': ['--disable-e10s'], 09:46:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:35 INFO - 'talos_options': ['--disable-e10s'], 09:46:35 INFO - 'tests': ['damp', 'tps']}, 09:46:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:35 INFO - 'tests': ['damp', 'tps']}, 09:46:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:46:35 INFO - 'tests': ['dromaeo_dom']}, 09:46:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:46:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:46:35 INFO - 'tests': ['a11yr', 09:46:35 INFO - 'ts_paint', 09:46:35 INFO - 'tpaint', 09:46:35 INFO - 'sessionrestore', 09:46:35 INFO - 'sessionrestore_no_auto_restore', 09:46:35 INFO - 'tabpaint']}, 09:46:35 INFO - 'other-e10s': {'tests': ['a11yr', 09:46:35 INFO - 'ts_paint', 09:46:35 INFO - 'tpaint', 09:46:35 INFO - 'sessionrestore', 09:46:35 INFO - 'sessionrestore_no_auto_restore', 09:46:35 INFO - 'tabpaint']}, 09:46:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:46:35 INFO - 'ts_paint', 09:46:35 INFO - 'tpaint', 09:46:35 INFO - 'sessionrestore', 09:46:35 INFO - 'sessionrestore_no_auto_restore', 09:46:35 INFO - 'tabpaint']}, 09:46:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:46:35 INFO - 'ts_paint', 09:46:35 INFO - 'tpaint', 09:46:35 INFO - 'sessionrestore', 09:46:35 INFO - 'sessionrestore_no_auto_restore', 09:46:35 INFO - 'tabpaint']}, 09:46:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:46:35 INFO - 'tests': ['a11yr', 09:46:35 INFO - 'ts_paint', 09:46:35 INFO - 'tpaint', 09:46:35 INFO - 'sessionrestore', 09:46:35 INFO - 'sessionrestore_no_auto_restore', 09:46:35 INFO - 'tabpaint']}, 09:46:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:46:35 INFO - 'tests': ['a11yr', 09:46:35 INFO - 'ts_paint', 09:46:35 INFO - 'tpaint', 09:46:35 INFO - 'sessionrestore', 09:46:35 INFO - 'sessionrestore_no_auto_restore', 09:46:35 INFO - 'tabpaint']}, 09:46:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:46:35 INFO - 'tests': ['tsvgx', 09:46:35 INFO - 'tsvgr_opacity', 09:46:35 INFO - 'tart', 09:46:35 INFO - 'tscrollx', 09:46:35 INFO - 'cart']}, 09:46:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:46:35 INFO - 'tsvgr_opacity', 09:46:35 INFO - 'tart', 09:46:35 INFO - 'tscrollx', 09:46:35 INFO - 'cart']}, 09:46:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:35 INFO - 'talos_options': ['--disable-e10s'], 09:46:35 INFO - 'tests': ['tp5o']}, 09:46:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:35 INFO - 'tests': ['tp5o']}, 09:46:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:35 INFO - 'talos_options': ['--disable-e10s', 09:46:35 INFO - '--xperf_path', 09:46:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:35 INFO - 'tests': ['tp5n']}, 09:46:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:35 INFO - 'talos_options': ['--xperf_path', 09:46:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:35 INFO - 'tests': ['tp5n']}}, 09:46:35 INFO - 'talos.zip': {'path': '', 09:46:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:46:35 INFO - Running post-action listener: _resource_record_post_action 09:46:35 INFO - ##### 09:46:35 INFO - ##### Running create-virtualenv step. 09:46:35 INFO - ##### 09:46:35 INFO - Running pre-action listener: _resource_record_pre_action 09:46:35 INFO - Running main action method: create_virtualenv 09:46:35 INFO - Creating virtualenv /builds/slave/test/build/venv 09:46:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:46:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:46:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:46:35 INFO - Using real prefix '/usr' 09:46:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:46:36 INFO - Installing distribute.............................................................................................................................................................................................done. 09:46:38 INFO - Installing pip.................done. 09:46:38 INFO - Return code: 0 09:46:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:46: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')]} 09:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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')]} 09:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f420595af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17905a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f410>, '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 0x1820310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18207a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', '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 09:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:46:38 INFO - Using env: {'DISPLAY': ':0', 09:46:38 INFO - 'HOME': '/home/cltbld', 09:46:38 INFO - 'LANG': 'en_US.UTF-8', 09:46:38 INFO - 'LANGUAGE': 'en_US:en', 09:46:38 INFO - 'LOGNAME': 'cltbld', 09:46:38 INFO - 'MAIL': '/var/mail/cltbld', 09:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:38 INFO - 'MOZ_NO_REMOTE': '1', 09:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:38 INFO - 'NO_EM_RESTART': '1', 09:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:38 INFO - 'PWD': '/builds/slave/test', 09:46:38 INFO - 'SHELL': '/bin/bash', 09:46:38 INFO - 'SHLVL': '1', 09:46:38 INFO - 'TERM': 'linux', 09:46:38 INFO - 'TMOUT': '86400', 09:46:38 INFO - 'USER': 'cltbld', 09:46:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', 09:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:38 INFO - '_': '/tools/buildbot/bin/python'} 09:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:46:38 INFO - Cleaning up... 09:46:38 INFO - Return code: 0 09:46:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:46: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')]} 09:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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')]} 09:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f420595af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17905a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f410>, '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 0x1820310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18207a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', '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 09:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:46:38 INFO - Using env: {'DISPLAY': ':0', 09:46:38 INFO - 'HOME': '/home/cltbld', 09:46:38 INFO - 'LANG': 'en_US.UTF-8', 09:46:38 INFO - 'LANGUAGE': 'en_US:en', 09:46:38 INFO - 'LOGNAME': 'cltbld', 09:46:38 INFO - 'MAIL': '/var/mail/cltbld', 09:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:38 INFO - 'MOZ_NO_REMOTE': '1', 09:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:38 INFO - 'NO_EM_RESTART': '1', 09:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:38 INFO - 'PWD': '/builds/slave/test', 09:46:38 INFO - 'SHELL': '/bin/bash', 09:46:38 INFO - 'SHLVL': '1', 09:46:38 INFO - 'TERM': 'linux', 09:46:38 INFO - 'TMOUT': '86400', 09:46:38 INFO - 'USER': 'cltbld', 09:46:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', 09:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:38 INFO - '_': '/tools/buildbot/bin/python'} 09:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:38 INFO - Downloading/unpacking psutil>=0.7.1 09:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:46:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:40 INFO - Installing collected packages: psutil 09:46:40 INFO - Running setup.py install for psutil 09:46:40 INFO - building 'psutil._psutil_linux' extension 09:46:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:46:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:46:40 INFO - building 'psutil._psutil_posix' extension 09:46:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:46:41 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 09:46:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:41 INFO - Successfully installed psutil 09:46:41 INFO - Cleaning up... 09:46:41 INFO - Return code: 0 09:46:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f420595af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17905a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f410>, '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 0x1820310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18207a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', '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 09:46:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:46:41 INFO - Using env: {'DISPLAY': ':0', 09:46:41 INFO - 'HOME': '/home/cltbld', 09:46:41 INFO - 'LANG': 'en_US.UTF-8', 09:46:41 INFO - 'LANGUAGE': 'en_US:en', 09:46:41 INFO - 'LOGNAME': 'cltbld', 09:46:41 INFO - 'MAIL': '/var/mail/cltbld', 09:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:41 INFO - 'MOZ_NO_REMOTE': '1', 09:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:41 INFO - 'NO_EM_RESTART': '1', 09:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:41 INFO - 'PWD': '/builds/slave/test', 09:46:41 INFO - 'SHELL': '/bin/bash', 09:46:41 INFO - 'SHLVL': '1', 09:46:41 INFO - 'TERM': 'linux', 09:46:41 INFO - 'TMOUT': '86400', 09:46:41 INFO - 'USER': 'cltbld', 09:46:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', 09:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:41 INFO - '_': '/tools/buildbot/bin/python'} 09:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:46:43 INFO - Installing collected packages: mozsystemmonitor 09:46:43 INFO - Running setup.py install for mozsystemmonitor 09:46:43 INFO - Successfully installed mozsystemmonitor 09:46:43 INFO - Cleaning up... 09:46:43 INFO - Return code: 0 09:46:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f420595af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17905a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f410>, '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 0x1820310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18207a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', '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 09:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:46:43 INFO - Using env: {'DISPLAY': ':0', 09:46:43 INFO - 'HOME': '/home/cltbld', 09:46:43 INFO - 'LANG': 'en_US.UTF-8', 09:46:43 INFO - 'LANGUAGE': 'en_US:en', 09:46:43 INFO - 'LOGNAME': 'cltbld', 09:46:43 INFO - 'MAIL': '/var/mail/cltbld', 09:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:43 INFO - 'MOZ_NO_REMOTE': '1', 09:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:43 INFO - 'NO_EM_RESTART': '1', 09:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:43 INFO - 'PWD': '/builds/slave/test', 09:46:43 INFO - 'SHELL': '/bin/bash', 09:46:43 INFO - 'SHLVL': '1', 09:46:43 INFO - 'TERM': 'linux', 09:46:43 INFO - 'TMOUT': '86400', 09:46:43 INFO - 'USER': 'cltbld', 09:46:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', 09:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:43 INFO - '_': '/tools/buildbot/bin/python'} 09:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:43 INFO - Downloading/unpacking blobuploader==1.2.4 09:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:45 INFO - Downloading blobuploader-1.2.4.tar.gz 09:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:46:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:46:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:46:46 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 09:46:46 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 09:46:46 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 09:46:46 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 09:46:46 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 09:46:46 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 09:46:46 INFO - Downloading docopt-0.6.1.tar.gz 09:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:46:46 INFO - Installing collected packages: blobuploader, requests, docopt 09:46:46 INFO - Running setup.py install for blobuploader 09:46:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:46:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:46:46 INFO - Running setup.py install for requests 09:46:46 INFO - Running setup.py install for docopt 09:46:46 INFO - Successfully installed blobuploader requests docopt 09:46:46 INFO - Cleaning up... 09:46:47 INFO - Return code: 0 09:46:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:47 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')]} 09:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:47 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')]} 09:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:47 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 0x7f420595af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17905a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f410>, '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 0x1820310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18207a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', '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 09:46:47 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 09:46:47 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 09:46:47 INFO - Using env: {'DISPLAY': ':0', 09:46:47 INFO - 'HOME': '/home/cltbld', 09:46:47 INFO - 'LANG': 'en_US.UTF-8', 09:46:47 INFO - 'LANGUAGE': 'en_US:en', 09:46:47 INFO - 'LOGNAME': 'cltbld', 09:46:47 INFO - 'MAIL': '/var/mail/cltbld', 09:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:47 INFO - 'MOZ_NO_REMOTE': '1', 09:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:47 INFO - 'NO_EM_RESTART': '1', 09:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:47 INFO - 'PWD': '/builds/slave/test', 09:46:47 INFO - 'SHELL': '/bin/bash', 09:46:47 INFO - 'SHLVL': '1', 09:46:47 INFO - 'TERM': 'linux', 09:46:47 INFO - 'TMOUT': '86400', 09:46:47 INFO - 'USER': 'cltbld', 09:46:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', 09:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:47 INFO - '_': '/tools/buildbot/bin/python'} 09:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:47 INFO - Running setup.py (path:/tmp/pip-xkosUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:47 INFO - Running setup.py (path:/tmp/pip-jzLh0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:47 INFO - Running setup.py (path:/tmp/pip-egR9uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:47 INFO - Running setup.py (path:/tmp/pip-qSt4o1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:47 INFO - Running setup.py (path:/tmp/pip-6pyKPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:47 INFO - Running setup.py (path:/tmp/pip-CaG_30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:47 INFO - Running setup.py (path:/tmp/pip-oHMY8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:47 INFO - Running setup.py (path:/tmp/pip-MpSdyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:47 INFO - Running setup.py (path:/tmp/pip-P1vWg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:47 INFO - Running setup.py (path:/tmp/pip-nowx7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:47 INFO - Running setup.py (path:/tmp/pip-NjjIRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:48 INFO - Running setup.py (path:/tmp/pip-jkH0Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:48 INFO - Running setup.py (path:/tmp/pip-cGhkTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:48 INFO - Running setup.py (path:/tmp/pip-gx4d4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:48 INFO - Running setup.py (path:/tmp/pip-GT0GPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:48 INFO - Running setup.py (path:/tmp/pip-Wx3Dgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:48 INFO - Running setup.py (path:/tmp/pip-iN58zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:46:48 INFO - Running setup.py install for manifestparser 09:46:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:46:48 INFO - Running setup.py install for mozcrash 09:46:48 INFO - Running setup.py install for mozdebug 09:46:48 INFO - Running setup.py install for mozdevice 09:46:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:46:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:46:48 INFO - Running setup.py install for mozfile 09:46:49 INFO - Running setup.py install for mozhttpd 09:46:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Running setup.py install for mozinfo 09:46:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Running setup.py install for mozInstall 09:46:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Running setup.py install for mozleak 09:46:49 INFO - Running setup.py install for mozlog 09:46:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Running setup.py install for moznetwork 09:46:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Running setup.py install for mozprocess 09:46:49 INFO - Running setup.py install for mozprofile 09:46:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Running setup.py install for mozrunner 09:46:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:46:49 INFO - Running setup.py install for mozscreenshot 09:46:50 INFO - Running setup.py install for moztest 09:46:50 INFO - Running setup.py install for mozversion 09:46:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:46:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:46:50 INFO - Cleaning up... 09:46:50 INFO - Return code: 0 09:46:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:50 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 0x7f420595af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17905a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f410>, '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 0x1820310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18207a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', '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 09:46:50 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 09:46:50 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 09:46:50 INFO - Using env: {'DISPLAY': ':0', 09:46:50 INFO - 'HOME': '/home/cltbld', 09:46:50 INFO - 'LANG': 'en_US.UTF-8', 09:46:50 INFO - 'LANGUAGE': 'en_US:en', 09:46:50 INFO - 'LOGNAME': 'cltbld', 09:46:50 INFO - 'MAIL': '/var/mail/cltbld', 09:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:50 INFO - 'MOZ_NO_REMOTE': '1', 09:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:50 INFO - 'NO_EM_RESTART': '1', 09:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:50 INFO - 'PWD': '/builds/slave/test', 09:46:50 INFO - 'SHELL': '/bin/bash', 09:46:50 INFO - 'SHLVL': '1', 09:46:50 INFO - 'TERM': 'linux', 09:46:50 INFO - 'TMOUT': '86400', 09:46:50 INFO - 'USER': 'cltbld', 09:46:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', 09:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:50 INFO - '_': '/tools/buildbot/bin/python'} 09:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:50 INFO - Running setup.py (path:/tmp/pip-N6GdkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:50 INFO - Running setup.py (path:/tmp/pip-2B0NIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:50 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)) 09:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:50 INFO - Running setup.py (path:/tmp/pip-NZ6oub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:50 INFO - Running setup.py (path:/tmp/pip-NeFNGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:50 INFO - Running setup.py (path:/tmp/pip-B_w40j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:50 INFO - Running setup.py (path:/tmp/pip-PLF_eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:50 INFO - Running setup.py (path:/tmp/pip-ft8ZqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:51 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)) 09:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:51 INFO - Running setup.py (path:/tmp/pip-7nxIUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:51 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)) 09:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:51 INFO - Running setup.py (path:/tmp/pip-4dO8tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:51 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)) 09:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:51 INFO - Running setup.py (path:/tmp/pip-rJuVxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:51 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)) 09:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:51 INFO - Running setup.py (path:/tmp/pip-S7Y3ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:51 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)) 09:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:51 INFO - Running setup.py (path:/tmp/pip-n_WIxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:51 INFO - Running setup.py (path:/tmp/pip-p995Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:51 INFO - Running setup.py (path:/tmp/pip-2vtcMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:51 INFO - Running setup.py (path:/tmp/pip-NYvCMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:51 INFO - Running setup.py (path:/tmp/pip-TR_9Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:51 INFO - Running setup.py (path:/tmp/pip-2SROoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:53 INFO - Downloading blessings-1.6.tar.gz 09:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:46:53 INFO - Installing collected packages: blessings 09:46:53 INFO - Running setup.py install for blessings 09:46:53 INFO - Successfully installed blessings 09:46:53 INFO - Cleaning up... 09:46:53 INFO - Return code: 0 09:46:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:46:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:54 INFO - Reading from file tmpfile_stdout 09:46:54 INFO - Current package versions: 09:46:54 INFO - argparse == 1.2.1 09:46:54 INFO - blessings == 1.6 09:46:54 INFO - blobuploader == 1.2.4 09:46:54 INFO - docopt == 0.6.1 09:46:54 INFO - manifestparser == 1.1 09:46:54 INFO - mozInstall == 1.12 09:46:54 INFO - mozcrash == 0.17 09:46:54 INFO - mozdebug == 0.1 09:46:54 INFO - mozdevice == 0.48 09:46:54 INFO - mozfile == 1.2 09:46:54 INFO - mozhttpd == 0.7 09:46:54 INFO - mozinfo == 0.9 09:46:54 INFO - mozleak == 0.1 09:46:54 INFO - mozlog == 3.1 09:46:54 INFO - moznetwork == 0.27 09:46:54 INFO - mozprocess == 0.22 09:46:54 INFO - mozprofile == 0.28 09:46:54 INFO - mozrunner == 6.11 09:46:54 INFO - mozscreenshot == 0.1 09:46:54 INFO - mozsystemmonitor == 0.0 09:46:54 INFO - moztest == 0.7 09:46:54 INFO - mozversion == 1.4 09:46:54 INFO - psutil == 3.1.1 09:46:54 INFO - requests == 1.2.3 09:46:54 INFO - wsgiref == 0.1.2 09:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 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 0x7f420595af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17905a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f410>, '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 0x1820310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18207a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', '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 09:46:54 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 09:46:54 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 09:46:54 INFO - Using env: {'DISPLAY': ':0', 09:46:54 INFO - 'HOME': '/home/cltbld', 09:46:54 INFO - 'LANG': 'en_US.UTF-8', 09:46:54 INFO - 'LANGUAGE': 'en_US:en', 09:46:54 INFO - 'LOGNAME': 'cltbld', 09:46:54 INFO - 'MAIL': '/var/mail/cltbld', 09:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:54 INFO - 'MOZ_NO_REMOTE': '1', 09:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:54 INFO - 'NO_EM_RESTART': '1', 09:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:54 INFO - 'PWD': '/builds/slave/test', 09:46:54 INFO - 'SHELL': '/bin/bash', 09:46:54 INFO - 'SHLVL': '1', 09:46:54 INFO - 'TERM': 'linux', 09:46:54 INFO - 'TMOUT': '86400', 09:46:54 INFO - 'USER': 'cltbld', 09:46:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', 09:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:54 INFO - '_': '/tools/buildbot/bin/python'} 09:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:54 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)) 09:46:54 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)) 09:46:54 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)) 09:46:54 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)) 09:46:54 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)) 09:46:54 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)) 09:46:54 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)) 09:46:54 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)) 09:46:54 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)) 09:46:54 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)) 09:46:54 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)) 09:46:54 INFO - Cleaning up... 09:46:54 INFO - Return code: 0 09:46:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f420595af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17905a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f410>, '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 0x1820310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18207a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', '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 09:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:46:54 INFO - Using env: {'DISPLAY': ':0', 09:46:54 INFO - 'HOME': '/home/cltbld', 09:46:54 INFO - 'LANG': 'en_US.UTF-8', 09:46:54 INFO - 'LANGUAGE': 'en_US:en', 09:46:54 INFO - 'LOGNAME': 'cltbld', 09:46:54 INFO - 'MAIL': '/var/mail/cltbld', 09:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:54 INFO - 'MOZ_NO_REMOTE': '1', 09:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:54 INFO - 'NO_EM_RESTART': '1', 09:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:54 INFO - 'PWD': '/builds/slave/test', 09:46:54 INFO - 'SHELL': '/bin/bash', 09:46:54 INFO - 'SHLVL': '1', 09:46:54 INFO - 'TERM': 'linux', 09:46:54 INFO - 'TMOUT': '86400', 09:46:54 INFO - 'USER': 'cltbld', 09:46:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', 09:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:54 INFO - '_': '/tools/buildbot/bin/python'} 09:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:54 INFO - Downloading/unpacking jsonschema 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:46:56 INFO - Downloading/unpacking functools32 (from jsonschema) 09:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:46:56 INFO - warning: no files found matching '*.txt' 09:46:56 INFO - no previously-included directories found matching 'build' 09:46:56 INFO - no previously-included directories found matching 'dist' 09:46:56 INFO - no previously-included directories found matching '.git*' 09:46:56 INFO - Installing collected packages: jsonschema, functools32 09:46:56 INFO - Running setup.py install for functools32 09:46:56 INFO - warning: no files found matching '*.txt' 09:46:56 INFO - no previously-included directories found matching 'build' 09:46:56 INFO - no previously-included directories found matching 'dist' 09:46:56 INFO - no previously-included directories found matching '.git*' 09:46:56 INFO - Successfully installed jsonschema functools32 09:46:56 INFO - Cleaning up... 09:46:56 INFO - Return code: 0 09:46:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f420595af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17905a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f410>, '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 0x1820310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18207a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', '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 09:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:46:56 INFO - Using env: {'DISPLAY': ':0', 09:46:56 INFO - 'HOME': '/home/cltbld', 09:46:56 INFO - 'LANG': 'en_US.UTF-8', 09:46:56 INFO - 'LANGUAGE': 'en_US:en', 09:46:56 INFO - 'LOGNAME': 'cltbld', 09:46:56 INFO - 'MAIL': '/var/mail/cltbld', 09:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:56 INFO - 'MOZ_NO_REMOTE': '1', 09:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:56 INFO - 'NO_EM_RESTART': '1', 09:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:56 INFO - 'PWD': '/builds/slave/test', 09:46:56 INFO - 'SHELL': '/bin/bash', 09:46:56 INFO - 'SHLVL': '1', 09:46:56 INFO - 'TERM': 'linux', 09:46:56 INFO - 'TMOUT': '86400', 09:46:56 INFO - 'USER': 'cltbld', 09:46:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', 09:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:56 INFO - '_': '/tools/buildbot/bin/python'} 09:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:57 INFO - Downloading/unpacking flake8 09:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:46:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:46:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:46:59 INFO - no previously-included directories found matching 'docs/_build' 09:46:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:46:59 INFO - Running setup.py install for pep8 09:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:46:59 INFO - no previously-included directories found matching 'docs/_build' 09:46:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:46:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:46:59 INFO - Cleaning up... 09:46:59 INFO - Return code: 0 09:46:59 INFO - Running post-action listener: _resource_record_post_action 09:46:59 INFO - Running post-action listener: _start_resource_monitoring 09:46:59 INFO - Starting resource monitoring. 09:46:59 INFO - ##### 09:46:59 INFO - ##### Running install step. 09:46:59 INFO - ##### 09:46:59 INFO - Running pre-action listener: _resource_record_pre_action 09:46:59 INFO - Running main action method: install 09:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:00 INFO - Reading from file tmpfile_stdout 09:47:00 INFO - Detecting whether we're running mozinstall >=1.0... 09:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:47:00 INFO - Reading from file tmpfile_stdout 09:47:00 INFO - Output received: 09:47:00 INFO - Usage: mozinstall [options] installer 09:47:00 INFO - Options: 09:47:00 INFO - -h, --help show this help message and exit 09:47:00 INFO - -d DEST, --destination=DEST 09:47:00 INFO - Directory to install application into. [default: 09:47:00 INFO - "/builds/slave/test"] 09:47:00 INFO - --app=APP Application being installed. [default: firefox] 09:47:00 INFO - mkdir: /builds/slave/test/build/application 09:47:00 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'] 09:47:00 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 09:47:13 INFO - Reading from file tmpfile_stdout 09:47:13 INFO - Output received: 09:47:13 INFO - /builds/slave/test/build/application/firefox/firefox 09:47:13 INFO - Running post-action listener: _resource_record_post_action 09:47:13 INFO - ##### 09:47:13 INFO - ##### Running run-tests step. 09:47:13 INFO - ##### 09:47:13 INFO - Running pre-action listener: _resource_record_pre_action 09:47:13 INFO - Running main action method: run_tests 09:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:47:13 INFO - Python 2.7.3 09:47:13 INFO - Return code: 0 09:47:13 INFO - grabbing minidump binary from tooltool 09:47:13 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')]} 09:47:13 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 0x181f410>, '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 0x1820310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18207a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:47:13 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 09:47:13 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 09:47:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:47:13 INFO - Return code: 0 09:47:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:47:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:47:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:47:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:47:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:47:14 INFO - Return code: 0 09:47:14 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/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 09:47:14 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/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 09:47:14 INFO - Using env: {'DISPLAY': ':0', 09:47:14 INFO - 'HOME': '/home/cltbld', 09:47:14 INFO - 'LANG': 'en_US.UTF-8', 09:47:14 INFO - 'LANGUAGE': 'en_US:en', 09:47:14 INFO - 'LOGNAME': 'cltbld', 09:47:14 INFO - 'MAIL': '/var/mail/cltbld', 09:47:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:47:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:14 INFO - 'MOZ_NO_REMOTE': '1', 09:47:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:14 INFO - 'NO_EM_RESTART': '1', 09:47:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:14 INFO - 'PWD': '/builds/slave/test', 09:47:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:47:14 INFO - 'SHELL': '/bin/bash', 09:47:14 INFO - 'SHLVL': '1', 09:47:14 INFO - 'TERM': 'linux', 09:47:14 INFO - 'TMOUT': '86400', 09:47:14 INFO - 'USER': 'cltbld', 09:47:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059', 09:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:14 INFO - '_': '/tools/buildbot/bin/python'} 09:47:14 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/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 09:47:14 INFO - mozversion application_buildid: 20160704065143 09:47:14 INFO - mozversion application_changeset: 3e04c4853a8bc95b6b485c42fb7e1e2d7500316b 09:47:14 INFO - mozversion application_display_name: Firefox 09:47:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:47:14 INFO - mozversion application_name: Firefox 09:47:14 INFO - mozversion application_remotingname: firefox 09:47:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:47:14 INFO - mozversion application_vendor: Mozilla 09:47:14 INFO - mozversion application_version: 48.0 09:47:14 INFO - mozversion platform_buildid: 20160704065143 09:47:14 INFO - mozversion platform_changeset: 3e04c4853a8bc95b6b485c42fb7e1e2d7500316b 09:47:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:47:14 INFO - mozversion platform_version: 48.0 09:47:14 INFO - using testdate: 1467650834 09:47:14 INFO - actual date: 1467650834 09:47:14 INFO - starting webserver on 'localhost:39271' 09:47:14 INFO - SUITE-START | Running 2 tests 09:47:14 INFO - TEST-START | dromaeo_css 09:47:14 INFO - operating with platform_type : linux_ 09:47:14 INFO - Initialising browser for dromaeo_css test... 09:47:14 INFO - TEST-INFO | started process 32095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB78VDf/profile http://localhost:39271/getInfo.html) 09:47:19 INFO - PROCESS | 32095 | __metrics Screen width/height:1600/1200 09:47:19 INFO - PROCESS | 32095 | colorDepth:24 09:47:19 INFO - PROCESS | 32095 | Browser inner width/height: 1024/697 09:47:19 INFO - PROCESS | 32095 | __metrics 09:47:21 ERROR - PROCESS | 32095 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:47:21 INFO - TEST-INFO | 32095: exit 0 09:47:21 INFO - Browser initialized. 09:47:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:47:22 INFO - TEST-INFO | started process 32190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB78VDf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:47:33 INFO - PROCESS | 32190 | RSS: Main: 139862016 09:47:33 INFO - PROCESS | 32190 | 09:48:24 INFO - PROCESS | 32190 | 1467650904639 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] 09:50:32 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:39271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39271/tests/dromaeo/cssquery-ext.html) 09:50:33 INFO - PROCESS | 32190 | RSS: Main: 249618432 09:50:33 INFO - PROCESS | 32190 | 09:53:35 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:39271/tests/dromaeo/cssquery-ext.html (next: http://localhost:39271/tests/dromaeo/cssquery-jquery.html) 09:53:36 INFO - PROCESS | 32190 | RSS: Main: 223784960 09:53:36 INFO - PROCESS | 32190 | 09:56:38 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:39271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39271/tests/dromaeo/cssquery-mootools.html) 09:56:38 INFO - PROCESS | 32190 | RSS: Main: 223469568 09:56:38 INFO - PROCESS | 32190 | 09:59:40 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:39271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39271/tests/dromaeo/cssquery-prototype.html) 09:59:40 INFO - PROCESS | 32190 | RSS: Main: 217571328 09:59:40 INFO - PROCESS | 32190 | 10:02:43 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:39271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39271/tests/dromaeo/cssquery-yui.html) 10:02:44 INFO - PROCESS | 32190 | RSS: Main: 213508096 10:02:44 INFO - PROCESS | 32190 | 10:05:46 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:39271/tests/dromaeo/cssquery-yui.html (next: http://localhost:39271/tests/dromaeo/cssquery-dojo.html) 10:05:46 INFO - PROCESS | 32190 | RSS: Main: 256520192 10:05:46 INFO - PROCESS | 32190 | 10:05:46 INFO - PROCESS | 32190 | __start_tp_report 10:05:46 INFO - PROCESS | 32190 | _x_x_mozilla_page_load 10:05:46 INFO - PROCESS | 32190 | _x_x_mozilla_page_load_details 10:05:46 INFO - PROCESS | 32190 | |i|pagename|runs| 10:05:46 INFO - PROCESS | 32190 | |0;dojo.html;3261.478163493841;3302.0754188827136;3317.1375442384974;3329.3008468221674;3347.6484969078247;5477.616566840323;5486.506214440699;5496.367917689467;5508.55931525478;5516.0898451755465;5454.7272636368225;5490.450954904518;5498.230247765306;5499.972500137494;5522.337319521653;4940.382452193467;4949.901001979958;5039.924401133986;5086.287919691228;5109.029284435946;4911.214205727084;4980.626453016021;5018.924716129261;5025.296458495795;5025.974870125644;5024.196128619422;5070.340855688773;5078.365204349457;5101.336826212587;5118.309028281172;5044.621653376012;5068.771905264253;5072.036313100499;5073.061483625541;5087.49125087492;4851.417829860439;4945.332380128672;4963.404391473046;4980.452150263468;5026.798928042874;5424.701641409721;5455.208994695747;5465.426130256305;5466.781328746845;5487.341519017744;5883.676397798119;5903.586748927577;5905.350411454737;5905.881882362329;5908.084246941731;5897.14491398749;5938.732757025944;5966.67183304918;6004.969975150097;6020.157177995085;5568.777248910039;5578.916316255219;5582.330120385539;5599.972000140055;5601.3558440779425;5960.433758792908;6096.329403765582;6116.143739876421;6116.35778243278;6117.265928088569;5839.328477225088;5880.588358814927;5887.941120588825;5901.881962360729;5913.793017244376;5862.12068189775;5862.14998825168;5863.120531920246;5863.912041319383;5864.70676466175;5800.4489573490455;5839.416058394127;5846.210761547221;5847.327557330961;5878.706064696834;5927.851803704855;5932.2584676915385;5932.584719069624;5958.940410595926;5963.701814909237;4545.636349092131;4548.636109111263;4549;4551.112533056023;4573.6569757268335;3993.201359728066;4001.3597824347967;4045;4085.325921222965;4120.505539335299;5590.636608620427;5607.915881261784;5612.35457922336;5615.578831587647;5641.492265696107;5916.349201587822;5919.911201331984;5923.585349025527;5925.318588362307;5925.525957923442;5380.112281473591;5605.467480589419;5607.551395888319;5681.914771278434;5696.686682232434;5059.747012649353;5070.2141168119;5076.238564215398;5078.517540833689;5080.923786143211;6151.84620384494;6152.046432802923;6156.168917196211;6156.353582873823;6157.291911430243;5814.854628634318;5893.970530147321;5949.91075133882;5980.790672326448;5985.281766188085;6199.876619370823;6222.533310001859;6234.064890266496;6234.781782637586;6238.875222495434;5657.038303488334;5842.620229685057;5846.590738648424;5846.94153058464;5875.383084776037;5980.880382392241;6044.848878778066;6049.516038716804;6050.092486127116;6074.696265186812;5823.5923485355615;5828.242328497268;5855.180274761622;5857.26784151981;5864.091065884794;5679.829605111853;5748.051571490657;5802.361740208489;5846.824595262149;5858.5898987070495;5682.943170568242;5730.369659337553;5733.684647344436;5734.512566431733;5766.769329226784;5819.5635327351465;5844.561657875762;5844.649321040752;5849.268841394825;5851.707414629166;5630.239917611234;5709.257796486596;5737.540996720169;5745.3105627324985;5834.416558344132 10:05:46 INFO - PROCESS | 32190 | |1;ext.html;655.2791928878231;668.1247565688948;679.4190966723452;679.7552880962854;682;32982.50526242108;33281.66718332816;33614.49578256328;33635.65457381702;40394.59605403945;44326.113477730425;45013.54986450134;45056.54943450564;45220;45244.77377613107;8592.18374254448;8784.38509304349;8799.95600021999;8800.207981281683;8800.383973121883;8184.140665230155;8642.30861531079;8746.562671866413;10279.537420816045;10388.844167337496;10574.629887953923;10620.46897655118;10652.840207396895;10653.147748180127;10661.946690266537;10417.531211095518;10517.474126293731;10521.684349469528;10525.421101839396;10527.84208236877;10471.47642617866;10576.52405641748;10580.629677961311;10585.788284234271;10594.841077383846;40178.39732404016;40482;45044.324335134996;45075.32387014165;45178.54821451776;3755.455458958436;3756;3820.3123437781187;4057.2088442753675;4497.055618320157;34373.82813085918;34401.827990859885;34670.653293466996;35373.646263537295;36124.63875361266;4533.34131808248;4627.051454451829;4630.421197350332;4632.397788287535;4693.225617773063;314735.4263228692;314911;315972;316425;316512;41257.38113928294;42075.57924420778;42151;68007.3199268001;68164;39094.41358379627;39250.803745981655;39383.80308098499;39561.80219098886;39567.80216098901;17572.12139393025;17761.200745966464;17765.555861103316;17787.46637600874;17801.198946047458;14076.577702668936;14168.574942751733;14181.85818141826;14205.644858878612;14218.075825071337;9109.954450227706;9507.904920950701;9685.9031409685;9690.612375505041;9795;3672.878053654426;3708.870189543353;3717.9314708798593;3749.4750734897134;3791.279656865187;1104.8839871813504;1121.1087185687397;1194.3908606610692;1197.700574856286;1259.6221133659865;34240.315193696486;34392.82803585966;34454.310913781585;34713.13217169591;35449.29101417957;1291.4511332683571;1292.4377895615437;1293.379177994568;1306.6994591244068;1344.4017412251649;17757.556061098316;17903.28386864537;17993.492731560273;18025.54936126581;18118.728219076726;462549;775703;789204;790008;797800;63431.36568634255;63741.36258637354;64081;64138;64198.35801641924;1394.532831501438;1468.1044562816674;1547.156799544251;1553.3398305720025;1566.702326557973;31196.220094497818;31924;32134.19664508406;32431.513527296636;32446.188845279055;49507.7524612389;49916.75041624768;50333.74833125811;50343.49656503388;50441;358820;361509;362117;362285;367544;28130.71869281363;31646.525302120946;48582.75708621434;48598.27102593535;49303.753481232365;48620.756896216706;48691.756541217066;49450.50549494459;49611;49692;39655.80172099121;40030.39954400628;40350;40512.59487405206;41069;38933.610663894135;39442.605573943896;40070;40364.3945340826;41370.58629413788;45209;45441.318380224984;45773.31340029969;46317.53682463132;46403;36831.263374732895;38737.80631096826;38968.80515597404;39006.219875602896;39653.2069358617;29738.702612973593;30083.3983320328;30222;30400.84799575988;30463.543046854757 10:05:46 INFO - PROCESS | 32190 | |2;jquery.html;422.2188950441682;425.51278785790254;432.1810169728367;435.830026289747;438.7148353570179;12430.875691243085;12975.675608109803;18806.62386752266;19474.123664435097;19475.123619437123;20734.688979665316;21142.57714845702;21328.57342853142;22581.54836903261;22607.095716171334;6612.702428390734;6617.272100069001;6793.184817821868;6821.761238356658;6830.692618832164;4700.670953033272;6702.832429189285;6765.2219994700745;7118.537295075804;7522.059742532184;7495;7513.323800857922;7518.69925202994;7535.246475352448;7535.849283014337;7101.609411482366;7420.257974202536;7467.8506429871095;7483.289087536703;7487.10154781427;4437.844675436344;7046.894296585555;7211.531250468703;7262.164851042145;7405.592692401916;24693.62959555608;25666.74333256662;25828.49979604635;26120.216393508224;26128.73871261282;2743.245607457945;2822.1674605991284;2845.3171238902514;3275.3121844412462;3405.8467368968454;16201.756973645404;16661.91669041659;16678.082705451194;16807.411740589145;16987.66024679512;2179.6512557990645;2311.9768802312096;2318.8840557972203;2322.198841399714;2343.5195784864063;82362.58818705929;84026.57986710088;88981;90341.54829225877;96804.51597741967;17768.378106766202;17931.820681793015;18113.28300754871;18568.164432600566;18736.15687294075;34325.65674343224;34555.827220863735;35068.64931350654;35279.823600881835;35331.64668353335;8652.913470865211;8987.146221108984;8987.820243595092;9034.909650903539;9126.543672816333;9154.67958621445;9180.540972951325;9240.491772952417;9300.069993000781;9327.393719408217;5134.922976155361;5160.716160611202;5201;5207;5208.661437006658;1835.3922989209652;2014.3841803961923;2027.7059826325394;2032.6747720364967;2061.5258490547258;1058.3173852865013;1066;1071.9517621707041;1086.462201210406;1124.3928278729559;19096.427107186806;19147.61704765897;19198.232070717295;19344.41966741;20042.699359509617;1092.2190633696946;1093.830456279278;1103.2167161315556;1123.3765260280622;1146.9713257168637;11347.659570212907;11351;11361.659150225507;11441.427928603536;11479.655610331703;501782;503228;505993;509241;516260;92537.07462925419;93427;94789;97028.51485742527;97064.51467742617;1085.3216739537788;1099.1371773158191;1106.1758989552995;1143.7941170589208;1154.717094311899;12943.805842912176;17221.483355499357;17721.822781772018;18102.275908963493;18348.266069357076;40750;42171;42210.36684449797;42279.154416912104;42450.575494245895;54954;55131;55158;55160.72419637876;55233.44766552283;9369.203617692572;9429;9470.715878523655;9563.091506307168;9641.855372169563;9039.774005649648;11229.831552526883;13663.18020918748;13800.37898294559;14033;11736.119791015537;11831.881681183422;12054.75890482203;12136;12576.685582860136;10487.63660724101;11352.262102963281;11686.94156529212;11908.106891983309;11930.582429614922;11609.30344179352;12394.504219831106;12415.510138783404;12438.875611244133;12748.553800616934;9266.11971862672;9395.671151509665;9425.811483770149;9453.385529940531;9486.573104210189;9844.261680374144;11245.100391968459;11274.267172633752;11275;11286.435678215892 10:05:46 INFO - PROCESS | 32190 | |3;mootools.html;1418.7659036259017;1582.6834633073386;1590.506942847717;1808.1772793379014;1907.9046047697602;7597.278258565434;8340.457870238437;8500.702475413362;8503.78740531487;8510.10643882392;8305.50166989981;8452.112528184529;8461.703840365588;8504.914950850489;8508.91491085089;2375.3111597636666;2395.9041638334447;2396.341006223285;2400.759924007603;2402.315340128064;2306.734725506563;2325.093213646671;2350.576896158699;2357.26924653358;2376.5603363377745;2364.4207169243473;2374.2402431222017;2383.3922349800864;2411.4815314707334;2416.5770990076667;2397.2688330059327;2415.0339864054345;2419.5281920025514;2421.6125419932814;2447.5716749568933;2333.7432882382923;2391.2826152154457;2393.916212932539;2396.9041238350446;2399.8200134989947;7313.926860731431;7480.625968701597;8610.87083693745;8630.956845215735;8647.697330593399;4797.2564252540915;5122.359705036871;5341.759620817073;5342.439043900374;5345.919811202835;3381.323735252959;3394.3381040697072;3430.811305378203;3447.9655203447896;3474.3919814032442;1139.3904261220207;1152.734870979671;1178.2753606532008;1179.0803173524664;1202.6091520255952;11768.293902365886;11827.526898924032;11852;11867.169298149047;12327.50689972409;4723.5984941279685;4760.428748550196;4816.301636262722;4840.080384726891;4855.5387238212315;10531.894681053245;10582.523786429629;10582.629607963685;10595.099416549525;10601.098906593026;5493.038718224295;5525.861853453695;5537.8061767837935;5540.196671482612;5544.91682624761;5010.599152067826;5068.949310506848;5077.517635824591;5079.822206222764;5083.034223497523;3983.3626619740703;4044.8786536403954;4105.91788164235;4112.856050038235;4119.237940980928;1253.1729058821315;1260.489501751792;1261.9305938173304;1275.2985857778185;1290.2581015915887;845.4082142500274;922.8338898998245;936.5691781780321;949.6771097826634;975.4595437590935;5429.158480435539;5499.1476321170285;5517.779288828482;5519.061759500814;5644.491995720405;948.5778828421286;959.9760005999906;973.7662960889477;1022.4529876516028;1024.7694268789462;3763.962360376361;3767.811609419518;3772.358699021173;3795.6204379561823;3829.272438236726;10552.788944221225;10659.573617055232;10994.175436842268;10994.230403871652;10994.780104397867;10771.03060724523;10783.13734901206;10863.076638485818;10918.1811364148;10921.344719316867;8229.917700822914;8295.502269863828;8396.916030839735;8418.074011858691;8483.066862645104;5525.475079867406;5571.554275657856;5608.551315894637;5630.211770352236;5676.631018983753;9674;9862.753431164278;9887.703368898945;9944.950275248577;9945.900540994788;9166.266698664223;9303.209227215762;9469.857952130862;10037.849432258668;10059.044390782863;7744.380449564134;7860.764177074697;7876.369890408868;7880.3301719354495;7912.643931023233;7991.3606911448105;8020.197980201933;8023.438359314792;8033.959830201045;8045.517268963881;7405.888911666221;7656.502327348704;7672;7696.076470823537;7769.223077692185;7431.739889103856;7455.9627201865815;7595.696172153273;7691.615419228904;7726.111497177896;6646;6652.966735166293;6665.166854143232;6704.195496540447;6710;4244.915101697887;4670.859874203779;4720.929186062143;4752.453467851241;4805.519448055166;4733.171694953438;4882.95117048825;4911.4106307243355;4914.385701787277;4951.851444456672 10:05:46 INFO - PROCESS | 32190 | |4;prototype.html;344.5090745687395;345.4438354249656;351.043406716697;355.1618181092621;355.9893203203904;6198.318184999652;6217.129601855738;6221.284552276489;6233.968830155854;6241.188645476093;6194.659293738842;6264.906026409608;6284.811455656338;6289.0566415037765;6304.369563043693;4490.9550904491025;4572.885677858064;4615.123126605951;4630.629549636038;4640.721556706609;4737.289406589005;4751.382320298374;4768.094062128184;4775.92836107457;4782.187028205196;4680.274557443602;4706.3411122442885;4711.057788442308;4719.221328480797;4735.90528189436;4457.531959144292;4592.724436533818;4684.812607495696;4719.5752382285755;4725.527447255281;4159.480064991876;4170.16596680665;4175.102352994121;4177.4569305990335;4186.016286172747;5984.880302393928;5991.850203744898;5994.760209591611;6004.12940123684;6009.609375390585;5530.170474428827;5533.612647114704;5538.0031594313;5540.2243685884005;5550.084236101079;6552.672366381662;6553.606783593;6562.015697645344;6563.048357988065;6566.1135746674545;4419.690621656486;4576.427946506687;4580.083983203373;4601.746903920283;4659.184642687516;6809.38715515606;6854.246032936423;6878.58728476293;6879.174499060095;6896.27589103147;4595.931061034087;4609.985803123374;4611.492735799059;4621.214393553104;4625.1443482955765;4672.789724462407;4675.883102922386;4680.08738296029;4687.460941991714;4687.7656117194;5432.185172224119;5437.238786569884;5438.15708565173;5438.265834112344;5442.91835622466;6448.193975753031;6592.912169492076;6617.04052912325;6639.236487803868;6653.2681405045405;1632.6816270827312;1640.7374820028738;1641.0973964319576;1641.499342700464;1644.112179423098;1008.2841182760322;1072.3190773858655;1094.0591091661165;1111.5776005118003;1117.9888201118047;6293.370662933761;6384.648844313514;6407.070974708641;6460.709268082854;6495.512836537278;6817.488688348394;6823.727050918007;6828.385445309946;6835.555688880207;6850.794476165723;6460.321666224979;6470.4823614110755;6471.708773105222;6482.870342593122;6484.221893372825;3644.4715516250526;3659.3596120678776;3674.0998455378603;3679.9264014719556;3684.115812205105;6927.376536111774;7138.321859423347;7182.784516464514;7230.060092187982;7237.601931893796;6997;7012.544184627983;7018.157821061505;7023.613701246379;7031.015657807911;7239.565626062453;7247.23903990084;7248.9999999998945;7252.129744430702;7254.8911766323545;6859.828504287433;6868.656567171722;6873.553219040747;6875.931240687529;6880.105586273752;6505.154329937078;6682.264950855305;6698;6729.865402692017;6779.762708305186;7198.6400679964745;7214.2785721427435;7216.89174662391;7227.819304517218;7233.095863017123;4715.457722361973;4752.976235118802;4761.357216775691;4761.6904901181315;4765.356676848581;6850.691718872563;6856.382925536725;6865.073215115895;6868.416184624363;6870.3473170048765;6400.967995159995;6591.307912669101;6659.500537459613;6664.66676666155;6686.264510903894;6633.2371777246235;6668;6678.866422671616;6681.699323530355;6681.799546013627;6559.836004099936;6562.212534495891;6572.4084832363405;6576.506761992965;6584.901226481702;6703.262641109376;6714.563553369016;6732.427743641845;6738.561993470409;6742.359475849787;6436;6568.967155164385;6575.80272591823;6591.472682185317;6595.835104122435 10:05:46 INFO - PROCESS | 32190 | |5;yui.html;822.8518866604009;891.3270480787008;920.9114154438129;935.868978343032;960.0591420408005;14916.328765205564;15325.310361033738;15438.073715577058;15694.686106277868;15851.682966340666;14497.637559061002;14566.271686415663;14640.707185856276;14641.92679036606;14669.413223471074;723.1611330856208;740.2116745665876;741.6699568691935;870.495112834556;887.2635712358726;736.3851184261148;852.3011130872687;884.1423818895661;887.8313120507115;887.9112088791134;914.963401463944;916.0656130746635;916.6012784438757;917.7980844214262;918;753.1978442958232;907.0294784580501;910.2808781062952;912.083356226991;912.9041450647653;659.5053709717712;673.7473447457204;674.1202730436778;674.2953613473932;674.4604316546792;14729.116253024853;14791.260436978107;14795.260236988108;14818.333175007043;14823;14103.78844317336;14663.853361466356;14712.852871471363;14768.113913165245;14998;10730;11097.500612472459;11193.66419007431;11240.044596209333;11252.493637786238;4110.5591796836;4110.630043296118;4119.382092686091;4159.9376009359585;4258.169656916903;56778.43221567773;57036.42963570353;57085.71457142729;57357.71321143409;58174.41825581775;11118.499667514981;11128.05411540012;11492.42537873103;11674.241174323643;11815.940920295343;21680.457988550097;21685.67471487929;21702.565948680938;21707.457313567287;21746.56506869854;8444.493330400073;8477.703280385156;8534.914650853412;8569.271611912933;8574;5048.1418158913075;5058.064258112261;5088.516590923857;5118.795248190031;5135;3623.673869351771;3670.4494325851338;3671.9816400917825;3673.4673472346362;3676.5955744868043;653.2520264297448;655.4723447624613;658.8616390558036;670.0719503487704;688.1913751342153;695.6591270277629;720.3876704800878;728.9139182617968;755.9130699969464;819.6803246733779;9703.902960970441;9830;9857.309988300893;10211.846822297672;10212.285140040274;695.8156088636515;746.294751459876;763.9847203055908;789.5617932047654;810.6716779704229;4495.977520112378;4574.839880604163;4587.747673877969;4605.286180642006;4669.509701481364;61583.38416615777;62103;62656;62835;62881.37118628847;53576;55144.691318520214;55321.1701824473;57163;57644.423555763904;49171.262431063566;49270;49612.75193624081;52289.47710522846;52642.21036684453;9830.213582913493;10132.493375331056;10189.643362482277;10301.124404425707;10450.790984180427;38072;38813.611863881;39127.41308880312;39674;40621;44374.55625443704;50083;50588;50720;50947.745261273456;12786.168899021533;12848.486060557847;12927.5475358362;13020.94235618975;13167;14170.858291417366;14258.500952466615;14297.499587514387;14350.784738229144;14389.7841532375;12995.675108122372;13298.601041968757;13353.465861365825;13383.063185576917;13464;12344.3827808611;12559.937200314305;12682.112252142262;13016.414261358072;13462.528811491551;12048.096392770402;12075.396230188631;12476.875231247572;12845.100842940905;12854.228746275254;11150.442477875911;11465.656030319104;11633.709157271136;11795.291607749814;11855.466504007512;10154.949225254122;10856.077233434931;11021.614243501439;11044.889551104707;11049.613263535737 10:05:46 INFO - PROCESS | 32190 | __end_tp_report 10:05:46 INFO - PROCESS | 32190 | __start_cc_report 10:05:46 INFO - PROCESS | 32190 | _x_x_mozilla_cycle_collect,872 10:05:46 INFO - PROCESS | 32190 | __end_cc_report 10:05:46 INFO - PROCESS | 32190 | __startTimestamp1467651946656__endTimestamp 10:05:46 INFO - PROCESS | 32190 | 10:05:46 INFO - PROCESS | 32190 | ------- Summary: start ------- 10:05:46 INFO - PROCESS | 32190 | Number of tests: 6 10:05:46 INFO - PROCESS | 32190 | 10:05:46 INFO - PROCESS | 32190 | [#0] dojo.html Cycles:165 Average:5510.58 Median:5734.51 stddev:620.81 (10.8%) stddev-sans-first:597.12 10:05:46 INFO - PROCESS | 32190 | Values: 3261.5 3302.1 3317.1 3329.3 3347.6 5477.6 5486.5 5496.4 5508.6 5516.1 5454.7 5490.5 5498.2 5500.0 5522.3 4940.4 4949.9 5039.9 5086.3 5109.0 4911.2 4980.6 5018.9 5025.3 5026.0 5024.2 5070.3 5078.4 5101.3 5118.3 5044.6 5068.8 5072.0 5073.1 5087.5 4851.4 4945.3 4963.4 4980.5 5026.8 5424.7 5455.2 5465.4 5466.8 5487.3 5883.7 5903.6 5905.4 5905.9 5908.1 5897.1 5938.7 5966.7 6005.0 6020.2 5568.8 5578.9 5582.3 5600.0 5601.4 5960.4 6096.3 6116.1 6116.4 6117.3 5839.3 5880.6 5887.9 5901.9 5913.8 5862.1 5862.1 5863.1 5863.9 5864.7 5800.4 5839.4 5846.2 5847.3 5878.7 5927.9 5932.3 5932.6 5958.9 5963.7 4545.6 4548.6 4549.0 4551.1 4573.7 3993.2 4001.4 4045.0 4085.3 4120.5 5590.6 5607.9 5612.4 5615.6 5641.5 5916.3 5919.9 5923.6 5925.3 5925.5 5380.1 5605.5 5607.6 5681.9 5696.7 5059.7 5070.2 5076.2 5078.5 5080.9 6151.8 6152.0 6156.2 6156.4 6157.3 5814.9 5894.0 5949.9 5980.8 5985.3 6199.9 6222.5 6234.1 6234.8 6238.9 5657.0 5842.6 5846.6 5846.9 5875.4 5980.9 6044.8 6049.5 6050.1 6074.7 5823.6 5828.2 5855.2 5857.3 5864.1 5679.8 5748.1 5802.4 5846.8 5858.6 5682.9 5730.4 5733.7 5734.5 5766.8 5819.6 5844.6 5844.6 5849.3 5851.7 5630.2 5709.3 5737.5 5745.3 5834.4 10:05:46 INFO - PROCESS | 32190 | 10:05:46 INFO - PROCESS | 32190 | [#1] ext.html Cycles:180 Average:62309.69 Median:3805.80 stddev:136204.71 (3578.9%) stddev-sans-first:136508.13 10:05:46 INFO - PROCESS | 32190 | Values: 655.3 668.1 679.4 679.8 682.0 32982.5 33281.7 33614.5 33635.7 40394.6 44326.1 45013.5 45056.5 45220.0 45244.8 8592.2 8784.4 8800.0 8800.2 8800.4 8184.1 8642.3 8746.6 10279.5 10388.8 10574.6 10620.5 10652.8 10653.1 10661.9 10417.5 10517.5 10521.7 10525.4 10527.8 10471.5 10576.5 10580.6 10585.8 10594.8 40178.4 40482.0 45044.3 45075.3 45178.5 3755.5 3756.0 3820.3 4057.2 4497.1 34373.8 34401.8 34670.7 35373.6 36124.6 4533.3 4627.1 4630.4 4632.4 4693.2 314735.4 314911.0 315972.0 316425.0 316512.0 41257.4 42075.6 42151.0 68007.3 68164.0 39094.4 39250.8 39383.8 39561.8 39567.8 17572.1 17761.2 17765.6 17787.5 17801.2 14076.6 14168.6 14181.9 14205.6 14218.1 9110.0 9507.9 9685.9 9690.6 9795.0 3672.9 3708.9 3717.9 3749.5 3791.3 1104.9 1121.1 1194.4 1197.7 1259.6 34240.3 34392.8 34454.3 34713.1 35449.3 1291.5 1292.4 1293.4 1306.7 1344.4 17757.6 17903.3 17993.5 18025.5 18118.7 462549.0 775703.0 789204.0 790008.0 797800.0 63431.4 63741.4 64081.0 64138.0 64198.4 1394.5 1468.1 1547.2 1553.3 1566.7 31196.2 31924.0 32134.2 32431.5 32446.2 49507.8 49916.8 50333.7 50343.5 50441.0 358820.0 361509.0 362117.0 362285.0 367544.0 28130.7 31646.5 48582.8 48598.3 49303.8 48620.8 48691.8 49450.5 49611.0 49692.0 39655.8 40030.4 40350.0 40512.6 41069.0 38933.6 39442.6 40070.0 40364.4 41370.6 45209.0 45441.3 45773.3 46317.5 46403.0 36831.3 38737.8 38968.8 39006.2 39653.2 29738.7 30083.4 30222.0 30400.8 30463.5 10:05:46 INFO - PROCESS | 32190 | 10:05:46 INFO - PROCESS | 32190 | [#2] jquery.html Cycles:180 Average:31019.93 Median:3060.31 stddev:83534.00 (2729.6%) stddev-sans-first:83736.74 10:05:46 INFO - PROCESS | 32190 | Values: 422.2 425.5 432.2 435.8 438.7 12430.9 12975.7 18806.6 19474.1 19475.1 20734.7 21142.6 21328.6 22581.5 22607.1 6612.7 6617.3 6793.2 6821.8 6830.7 4700.7 6702.8 6765.2 7118.5 7522.1 7495.0 7513.3 7518.7 7535.2 7535.8 7101.6 7420.3 7467.9 7483.3 7487.1 4437.8 7046.9 7211.5 7262.2 7405.6 24693.6 25666.7 25828.5 26120.2 26128.7 2743.2 2822.2 2845.3 3275.3 3405.8 16201.8 16661.9 16678.1 16807.4 16987.7 2179.7 2312.0 2318.9 2322.2 2343.5 82362.6 84026.6 88981.0 90341.5 96804.5 17768.4 17931.8 18113.3 18568.2 18736.2 34325.7 34555.8 35068.6 35279.8 35331.6 8652.9 8987.1 8987.8 9034.9 9126.5 9154.7 9180.5 9240.5 9300.1 9327.4 5134.9 5160.7 5201.0 5207.0 5208.7 1835.4 2014.4 2027.7 2032.7 2061.5 1058.3 1066.0 1072.0 1086.5 1124.4 19096.4 19147.6 19198.2 19344.4 20042.7 1092.2 1093.8 1103.2 1123.4 1147.0 11347.7 11351.0 11361.7 11441.4 11479.7 501782.0 503228.0 505993.0 509241.0 516260.0 92537.1 93427.0 94789.0 97028.5 97064.5 1085.3 1099.1 1106.2 1143.8 1154.7 12943.8 17221.5 17721.8 18102.3 18348.3 40750.0 42171.0 42210.4 42279.2 42450.6 54954.0 55131.0 55158.0 55160.7 55233.4 9369.2 9429.0 9470.7 9563.1 9641.9 9039.8 11229.8 13663.2 13800.4 14033.0 11736.1 11831.9 12054.8 12136.0 12576.7 10487.6 11352.3 11686.9 11908.1 11930.6 11609.3 12394.5 12415.5 12438.9 12748.6 9266.1 9395.7 9425.8 9453.4 9486.6 9844.3 11245.1 11274.3 11275.0 11286.4 10:05:46 INFO - PROCESS | 32190 | 10:05:46 INFO - PROCESS | 32190 | [#3] mootools.html Cycles:180 Average:5698.10 Median:4869.24 stddev:3196.80 (65.7%) stddev-sans-first:3189.59 10:05:46 INFO - PROCESS | 32190 | Values: 1418.8 1582.7 1590.5 1808.2 1907.9 7597.3 8340.5 8500.7 8503.8 8510.1 8305.5 8452.1 8461.7 8504.9 8508.9 2375.3 2395.9 2396.3 2400.8 2402.3 2306.7 2325.1 2350.6 2357.3 2376.6 2364.4 2374.2 2383.4 2411.5 2416.6 2397.3 2415.0 2419.5 2421.6 2447.6 2333.7 2391.3 2393.9 2396.9 2399.8 7313.9 7480.6 8610.9 8631.0 8647.7 4797.3 5122.4 5341.8 5342.4 5345.9 3381.3 3394.3 3430.8 3448.0 3474.4 1139.4 1152.7 1178.3 1179.1 1202.6 11768.3 11827.5 11852.0 11867.2 12327.5 4723.6 4760.4 4816.3 4840.1 4855.5 10531.9 10582.5 10582.6 10595.1 10601.1 5493.0 5525.9 5537.8 5540.2 5544.9 5010.6 5068.9 5077.5 5079.8 5083.0 3983.4 4044.9 4105.9 4112.9 4119.2 1253.2 1260.5 1261.9 1275.3 1290.3 845.4 922.8 936.6 949.7 975.5 5429.2 5499.1 5517.8 5519.1 5644.5 948.6 960.0 973.8 1022.5 1024.8 3764.0 3767.8 3772.4 3795.6 3829.3 10552.8 10659.6 10994.2 10994.2 10994.8 10771.0 10783.1 10863.1 10918.2 10921.3 8229.9 8295.5 8396.9 8418.1 8483.1 5525.5 5571.6 5608.6 5630.2 5676.6 9674.0 9862.8 9887.7 9945.0 9945.9 9166.3 9303.2 9469.9 10037.8 10059.0 7744.4 7860.8 7876.4 7880.3 7912.6 7991.4 8020.2 8023.4 8034.0 8045.5 7405.9 7656.5 7672.0 7696.1 7769.2 7431.7 7456.0 7595.7 7691.6 7726.1 6646.0 6653.0 6665.2 6704.2 6710.0 4244.9 4670.9 4720.9 4752.5 4805.5 4733.2 4883.0 4911.4 4914.4 4951.9 10:05:46 INFO - PROCESS | 32190 | 10:05:46 INFO - PROCESS | 32190 | [#4] prototype.html Cycles:180 Average:5543.74 Median:6344.51 stddev:1698.24 (26.8%) stddev-sans-first:1657.56 10:05:46 INFO - PROCESS | 32190 | Values: 344.5 345.4 351.0 355.2 356.0 6198.3 6217.1 6221.3 6234.0 6241.2 6194.7 6264.9 6284.8 6289.1 6304.4 4491.0 4572.9 4615.1 4630.6 4640.7 4737.3 4751.4 4768.1 4775.9 4782.2 4680.3 4706.3 4711.1 4719.2 4735.9 4457.5 4592.7 4684.8 4719.6 4725.5 4159.5 4170.2 4175.1 4177.5 4186.0 5984.9 5991.9 5994.8 6004.1 6009.6 5530.2 5533.6 5538.0 5540.2 5550.1 6552.7 6553.6 6562.0 6563.0 6566.1 4419.7 4576.4 4580.1 4601.7 4659.2 6809.4 6854.2 6878.6 6879.2 6896.3 4595.9 4610.0 4611.5 4621.2 4625.1 4672.8 4675.9 4680.1 4687.5 4687.8 5432.2 5437.2 5438.2 5438.3 5442.9 6448.2 6592.9 6617.0 6639.2 6653.3 1632.7 1640.7 1641.1 1641.5 1644.1 1008.3 1072.3 1094.1 1111.6 1118.0 6293.4 6384.6 6407.1 6460.7 6495.5 6817.5 6823.7 6828.4 6835.6 6850.8 6460.3 6470.5 6471.7 6482.9 6484.2 3644.5 3659.4 3674.1 3679.9 3684.1 6927.4 7138.3 7182.8 7230.1 7237.6 6997.0 7012.5 7018.2 7023.6 7031.0 7239.6 7247.2 7249.0 7252.1 7254.9 6859.8 6868.7 6873.6 6875.9 6880.1 6505.2 6682.3 6698.0 6729.9 6779.8 7198.6 7214.3 7216.9 7227.8 7233.1 4715.5 4753.0 4761.4 4761.7 4765.4 6850.7 6856.4 6865.1 6868.4 6870.3 6401.0 6591.3 6659.5 6664.7 6686.3 6633.2 6668.0 6678.9 6681.7 6681.8 6559.8 6562.2 6572.4 6576.5 6584.9 6703.3 6714.6 6732.4 6738.6 6742.4 6436.0 6569.0 6575.8 6591.5 6595.8 10:05:46 INFO - PROCESS | 32190 | 10:05:46 INFO - PROCESS | 32190 | [#5] yui.html Cycles:180 Average:15554.84 Median:24316.36 stddev:17699.52 (72.8%) stddev-sans-first:17714.60 10:05:46 INFO - PROCESS | 32190 | Values: 822.9 891.3 920.9 935.9 960.1 14916.3 15325.3 15438.1 15694.7 15851.7 14497.6 14566.3 14640.7 14641.9 14669.4 723.2 740.2 741.7 870.5 887.3 736.4 852.3 884.1 887.8 887.9 915.0 916.1 916.6 917.8 918.0 753.2 907.0 910.3 912.1 912.9 659.5 673.7 674.1 674.3 674.5 14729.1 14791.3 14795.3 14818.3 14823.0 14103.8 14663.9 14712.9 14768.1 14998.0 10730.0 11097.5 11193.7 11240.0 11252.5 4110.6 4110.6 4119.4 4159.9 4258.2 56778.4 57036.4 57085.7 57357.7 58174.4 11118.5 11128.1 11492.4 11674.2 11815.9 21680.5 21685.7 21702.6 21707.5 21746.6 8444.5 8477.7 8534.9 8569.3 8574.0 5048.1 5058.1 5088.5 5118.8 5135.0 3623.7 3670.4 3672.0 3673.5 3676.6 653.3 655.5 658.9 670.1 688.2 695.7 720.4 728.9 755.9 819.7 9703.9 9830.0 9857.3 10211.8 10212.3 695.8 746.3 764.0 789.6 810.7 4496.0 4574.8 4587.7 4605.3 4669.5 61583.4 62103.0 62656.0 62835.0 62881.4 53576.0 55144.7 55321.2 57163.0 57644.4 49171.3 49270.0 49612.8 52289.5 52642.2 9830.2 10132.5 10189.6 10301.1 10450.8 38072.0 38813.6 39127.4 39674.0 40621.0 44374.6 50083.0 50588.0 50720.0 50947.7 12786.2 12848.5 12927.5 13020.9 13167.0 14170.9 14258.5 14297.5 14350.8 14389.8 12995.7 13298.6 13353.5 13383.1 13464.0 12344.4 12559.9 12682.1 13016.4 13462.5 12048.1 12075.4 12476.9 12845.1 12854.2 11150.4 11465.7 11633.7 11795.3 11855.5 10154.9 10856.1 11021.6 11044.9 11049.6 10:05:46 INFO - PROCESS | 32190 | -------- Summary: end -------- 10:05:46 INFO - PROCESS | 32190 | 10:05:47 INFO - TEST-INFO | 32190: exit 0 10:05:47 INFO - TEST-OK | dromaeo_css | took 1112763ms 10:05:47 INFO - TEST-START | kraken 10:05:47 INFO - operating with platform_type : linux_ 10:05:47 INFO - Initialising browser for kraken test... 10:05:47 INFO - TEST-INFO | started process 32378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOfDPqn/profile http://localhost:39271/getInfo.html) 10:05:52 INFO - PROCESS | 32378 | __metrics Screen width/height:1600/1200 10:05:52 INFO - PROCESS | 32378 | colorDepth:24 10:05:52 INFO - PROCESS | 32378 | Browser inner width/height: 1024/697 10:05:52 INFO - PROCESS | 32378 | __metrics 10:05:53 ERROR - PROCESS | 32378 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:05:54 INFO - TEST-INFO | 32378: exit 0 10:05:54 INFO - Browser initialized. 10:05:54 INFO - Running cycle 1/1 for kraken test... 10:05:54 INFO - TEST-INFO | started process 32470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOfDPqn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:06 INFO - PROCESS | 32470 | RSS: Main: 139497472 10:06:06 INFO - PROCESS | 32470 | 10:06:08 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39271/tests/kraken/driver.html?testName=audio-beat-detection) 10:06:09 INFO - PROCESS | 32470 | RSS: Main: 197545984 10:06:09 INFO - PROCESS | 32470 | 10:06:12 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39271/tests/kraken/driver.html?testName=audio-dft) 10:06:12 INFO - PROCESS | 32470 | RSS: Main: 185901056 10:06:12 INFO - PROCESS | 32470 | 10:06:15 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39271/tests/kraken/driver.html?testName=audio-fft) 10:06:16 INFO - PROCESS | 32470 | RSS: Main: 274497536 10:06:16 INFO - PROCESS | 32470 | 10:06:18 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39271/tests/kraken/driver.html?testName=audio-oscillator) 10:06:18 INFO - PROCESS | 32470 | RSS: Main: 181043200 10:06:18 INFO - PROCESS | 32470 | 10:06:20 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:06:21 INFO - PROCESS | 32470 | RSS: Main: 178909184 10:06:21 INFO - PROCESS | 32470 | 10:06:24 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39271/tests/kraken/driver.html?testName=imaging-darkroom) 10:06:25 INFO - PROCESS | 32470 | RSS: Main: 214179840 10:06:25 INFO - PROCESS | 32470 | 10:06:28 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39271/tests/kraken/driver.html?testName=imaging-desaturate) 10:06:29 INFO - PROCESS | 32470 | RSS: Main: 213979136 10:06:29 INFO - PROCESS | 32470 | 10:06:31 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39271/tests/kraken/driver.html?testName=json-parse-financial) 10:06:32 INFO - PROCESS | 32470 | RSS: Main: 213549056 10:06:32 INFO - PROCESS | 32470 | 10:06:33 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:06:34 INFO - PROCESS | 32470 | RSS: Main: 194461696 10:06:34 INFO - PROCESS | 32470 | 10:06:36 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39271/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:06:36 INFO - PROCESS | 32470 | RSS: Main: 196550656 10:06:36 INFO - PROCESS | 32470 | 10:06:38 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:06:39 INFO - PROCESS | 32470 | RSS: Main: 210841600 10:06:39 INFO - PROCESS | 32470 | 10:06:41 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:06:42 INFO - PROCESS | 32470 | RSS: Main: 218025984 10:06:42 INFO - PROCESS | 32470 | 10:06:45 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:06:45 INFO - PROCESS | 32470 | RSS: Main: 213983232 10:06:45 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | Cycle 1(1): loaded http://localhost:39271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39271/tests/kraken/driver.html?testName=ai-astar) 10:06:47 INFO - PROCESS | 32470 | RSS: Main: 275722240 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | __start_tp_report 10:06:47 INFO - PROCESS | 32470 | _x_x_mozilla_page_load 10:06:47 INFO - PROCESS | 32470 | _x_x_mozilla_page_load_details 10:06:47 INFO - PROCESS | 32470 | |i|pagename|runs| 10:06:47 INFO - PROCESS | 32470 | |0;ai-astar;109;111;110;110;110;110;105;109;109;108 10:06:47 INFO - PROCESS | 32470 | |1;audio-beat-detection;153;126;162;179;132;152;147;127;178;124 10:06:47 INFO - PROCESS | 32470 | |2;audio-dft;160;162;160;162;161;159;160;160;160;160 10:06:47 INFO - PROCESS | 32470 | |3;audio-fft;77;75;76;176;76;76;75;75;175;77 10:06:47 INFO - PROCESS | 32470 | |4;audio-oscillator;93;92;148;92;92;91;146;91;93;147 10:06:47 INFO - PROCESS | 32470 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;117;116;116 10:06:47 INFO - PROCESS | 32470 | |6;imaging-darkroom;145;144;145;146;145;145;145;145;145;145 10:06:47 INFO - PROCESS | 32470 | |7;imaging-desaturate;95;95;95;95;94;94;94;94;94;94 10:06:47 INFO - PROCESS | 32470 | |8;json-parse-financial;53;53;55;53;54;53;64;72;51;51 10:06:47 INFO - PROCESS | 32470 | |9;json-stringify-tinderbox;58;58;57;57;58;58;57;58;58;58 10:06:47 INFO - PROCESS | 32470 | |10;stanford-crypto-aes;73;72;72;73;72;73;82;74;79;74 10:06:47 INFO - PROCESS | 32470 | |11;stanford-crypto-ccm;118;116;113;113;119;121;112;121;128;126 10:06:47 INFO - PROCESS | 32470 | |12;stanford-crypto-pbkdf2;157;158;159;161;157;156;155;156;157;155 10:06:47 INFO - PROCESS | 32470 | |13;stanford-crypto-sha256-iterative;66;67;70;68;65;67;63;67;64;63 10:06:47 INFO - PROCESS | 32470 | __end_tp_report 10:06:47 INFO - PROCESS | 32470 | __start_cc_report 10:06:47 INFO - PROCESS | 32470 | _x_x_mozilla_cycle_collect,1587 10:06:47 INFO - PROCESS | 32470 | __end_cc_report 10:06:47 INFO - PROCESS | 32470 | __startTimestamp1467652007564__endTimestamp 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | ------- Summary: start ------- 10:06:47 INFO - PROCESS | 32470 | Number of tests: 14 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:1.66 (1.5%) stddev-sans-first:1.76 10:06:47 INFO - PROCESS | 32470 | Values: 109.0 111.0 110.0 110.0 110.0 110.0 105.0 109.0 109.0 108.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:152.50 stddev:20.70 (13.6%) stddev-sans-first:21.88 10:06:47 INFO - PROCESS | 32470 | Values: 153.0 126.0 162.0 179.0 132.0 152.0 147.0 127.0 178.0 124.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 10:06:47 INFO - PROCESS | 32470 | Values: 160.0 162.0 160.0 162.0 161.0 159.0 160.0 160.0 160.0 160.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#3] audio-fft Cycles:10 Average:95.80 Median:76.00 stddev:42.01 (55.3%) stddev-sans-first:44.01 10:06:47 INFO - PROCESS | 32470 | Values: 77.0 75.0 76.0 176.0 76.0 76.0 75.0 75.0 175.0 77.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:92.00 stddev:26.58 (28.9%) stddev-sans-first:27.59 10:06:47 INFO - PROCESS | 32470 | Values: 93.0 92.0 148.0 92.0 92.0 91.0 146.0 91.0 93.0 147.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:06:47 INFO - PROCESS | 32470 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 10:06:47 INFO - PROCESS | 32470 | Values: 145.0 144.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:06:47 INFO - PROCESS | 32470 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:53.50 stddev:6.76 (12.6%) stddev-sans-first:7.08 10:06:47 INFO - PROCESS | 32470 | Values: 53.0 53.0 55.0 53.0 54.0 53.0 64.0 72.0 51.0 51.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 10:06:47 INFO - PROCESS | 32470 | Values: 58.0 58.0 57.0 57.0 58.0 58.0 57.0 58.0 58.0 58.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:73.50 stddev:3.37 (4.6%) stddev-sans-first:3.54 10:06:47 INFO - PROCESS | 32470 | Values: 73.0 72.0 72.0 73.0 72.0 73.0 82.0 74.0 79.0 74.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:120.00 stddev:5.46 (4.5%) stddev-sans-first:5.78 10:06:47 INFO - PROCESS | 32470 | Values: 118.0 116.0 113.0 113.0 119.0 121.0 112.0 121.0 128.0 126.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:157.00 stddev:1.85 (1.2%) stddev-sans-first:1.96 10:06:47 INFO - PROCESS | 32470 | Values: 157.0 158.0 159.0 161.0 157.0 156.0 155.0 156.0 157.0 155.0 10:06:47 INFO - PROCESS | 32470 | 10:06:47 INFO - PROCESS | 32470 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:67.00 stddev:2.26 (3.4%) stddev-sans-first:2.40 10:06:47 INFO - PROCESS | 32470 | Values: 66.0 67.0 70.0 68.0 65.0 67.0 63.0 67.0 64.0 63.0 10:06:47 INFO - PROCESS | 32470 | -------- Summary: end -------- 10:06:47 INFO - PROCESS | 32470 | 10:06:48 INFO - TEST-INFO | 32470: exit 0 10:06:48 INFO - TEST-OK | kraken | took 61088ms 10:06:48 INFO - SUITE-END | took 1173s 10:06:48 INFO - Completed test suite (00:19:34) 10:06:48 INFO - javascript benchmark 10:06:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3261.478163493841, 3302.0754188827136, 3317.1375442384974, 3329.3008468221674, 3347.6484969078247, 5477.616566840323, 5486.506214440699, 5496.367917689467, 5508.55931525478, 5516.0898451755465, 5454.7272636368225, 5490.450954904518, 5498.230247765306, 5499.972500137494, 5522.337319521653, 4940.382452193467, 4949.901001979958, 5039.924401133986, 5086.287919691228, 5109.029284435946, 4911.214205727084, 4980.626453016021, 5018.924716129261, 5025.296458495795, 5025.974870125644, 5024.196128619422, 5070.340855688773, 5078.365204349457, 5101.336826212587, 5118.309028281172, 5044.621653376012, 5068.771905264253, 5072.036313100499, 5073.061483625541, 5087.49125087492, 4851.417829860439, 4945.332380128672, 4963.404391473046, 4980.452150263468, 5026.798928042874, 5424.701641409721, 5455.208994695747, 5465.426130256305, 5466.781328746845, 5487.341519017744, 5883.676397798119, 5903.586748927577, 5905.350411454737, 5905.881882362329, 5908.084246941731, 5897.14491398749, 5938.732757025944, 5966.67183304918, 6004.969975150097, 6020.157177995085, 5568.777248910039, 5578.916316255219, 5582.330120385539, 5599.972000140055, 5601.3558440779425, 5960.433758792908, 6096.329403765582, 6116.143739876421, 6116.35778243278, 6117.265928088569, 5839.328477225088, 5880.588358814927, 5887.941120588825, 5901.881962360729, 5913.793017244376, 5862.12068189775, 5862.14998825168, 5863.120531920246, 5863.912041319383, 5864.70676466175, 5800.4489573490455, 5839.416058394127, 5846.210761547221, 5847.327557330961, 5878.706064696834, 5927.851803704855, 5932.2584676915385, 5932.584719069624, 5958.940410595926, 5963.701814909237, 4545.636349092131, 4548.636109111263, 4549.0, 4551.112533056023, 4573.6569757268335, 3993.201359728066, 4001.3597824347967, 4045.0, 4085.325921222965, 4120.505539335299, 5590.636608620427, 5607.915881261784, 5612.35457922336, 5615.578831587647, 5641.492265696107, 5916.349201587822, 5919.911201331984, 5923.585349025527, 5925.318588362307, 5925.525957923442, 5380.112281473591, 5605.467480589419, 5607.551395888319, 5681.914771278434, 5696.686682232434, 5059.747012649353, 5070.2141168119, 5076.238564215398, 5078.517540833689, 5080.923786143211, 6151.84620384494, 6152.046432802923, 6156.168917196211, 6156.353582873823, 6157.291911430243, 5814.854628634318, 5893.970530147321, 5949.91075133882, 5980.790672326448, 5985.281766188085, 6199.876619370823, 6222.533310001859, 6234.064890266496, 6234.781782637586, 6238.875222495434, 5657.038303488334, 5842.620229685057, 5846.590738648424, 5846.94153058464, 5875.383084776037, 5980.880382392241, 6044.848878778066, 6049.516038716804, 6050.092486127116, 6074.696265186812, 5823.5923485355615, 5828.242328497268, 5855.180274761622, 5857.26784151981, 5864.091065884794, 5679.829605111853, 5748.051571490657, 5802.361740208489, 5846.824595262149, 5858.5898987070495, 5682.943170568242, 5730.369659337553, 5733.684647344436, 5734.512566431733, 5766.769329226784, 5819.5635327351465, 5844.561657875762, 5844.649321040752, 5849.268841394825, 5851.707414629166, 5630.239917611234, 5709.257796486596, 5737.540996720169, 5745.3105627324985, 5834.416558344132], "value": 5469.664320399441, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.2791928878231, 668.1247565688948, 679.4190966723452, 679.7552880962854, 682.0, 32982.50526242108, 33281.66718332816, 33614.49578256328, 33635.65457381702, 40394.59605403945, 44326.113477730425, 45013.54986450134, 45056.54943450564, 45220.0, 45244.77377613107, 8592.18374254448, 8784.38509304349, 8799.95600021999, 8800.207981281683, 8800.383973121883, 8184.140665230155, 8642.30861531079, 8746.562671866413, 10279.537420816045, 10388.844167337496, 10574.629887953923, 10620.46897655118, 10652.840207396895, 10653.147748180127, 10661.946690266537, 10417.531211095518, 10517.474126293731, 10521.684349469528, 10525.421101839396, 10527.84208236877, 10471.47642617866, 10576.52405641748, 10580.629677961311, 10585.788284234271, 10594.841077383846, 40178.39732404016, 40482.0, 45044.324335134996, 45075.32387014165, 45178.54821451776, 3755.455458958436, 3756.0, 3820.3123437781187, 4057.2088442753675, 4497.055618320157, 34373.82813085918, 34401.827990859885, 34670.653293466996, 35373.646263537295, 36124.63875361266, 4533.34131808248, 4627.051454451829, 4630.421197350332, 4632.397788287535, 4693.225617773063, 314735.4263228692, 314911.0, 315972.0, 316425.0, 316512.0, 41257.38113928294, 42075.57924420778, 42151.0, 68007.3199268001, 68164.0, 39094.41358379627, 39250.803745981655, 39383.80308098499, 39561.80219098886, 39567.80216098901, 17572.12139393025, 17761.200745966464, 17765.555861103316, 17787.46637600874, 17801.198946047458, 14076.577702668936, 14168.574942751733, 14181.85818141826, 14205.644858878612, 14218.075825071337, 9109.954450227706, 9507.904920950701, 9685.9031409685, 9690.612375505041, 9795.0, 3672.878053654426, 3708.870189543353, 3717.9314708798593, 3749.4750734897134, 3791.279656865187, 1104.8839871813504, 1121.1087185687397, 1194.3908606610692, 1197.700574856286, 1259.6221133659865, 34240.315193696486, 34392.82803585966, 34454.310913781585, 34713.13217169591, 35449.29101417957, 1291.4511332683571, 1292.4377895615437, 1293.379177994568, 1306.6994591244068, 1344.4017412251649, 17757.556061098316, 17903.28386864537, 17993.492731560273, 18025.54936126581, 18118.728219076726, 462549.0, 775703.0, 789204.0, 790008.0, 797800.0, 63431.36568634255, 63741.36258637354, 64081.0, 64138.0, 64198.35801641924, 1394.532831501438, 1468.1044562816674, 1547.156799544251, 1553.3398305720025, 1566.702326557973, 31196.220094497818, 31924.0, 32134.19664508406, 32431.513527296636, 32446.188845279055, 49507.7524612389, 49916.75041624768, 50333.74833125811, 50343.49656503388, 50441.0, 358820.0, 361509.0, 362117.0, 362285.0, 367544.0, 28130.71869281363, 31646.525302120946, 48582.75708621434, 48598.27102593535, 49303.753481232365, 48620.756896216706, 48691.756541217066, 49450.50549494459, 49611.0, 49692.0, 39655.80172099121, 40030.39954400628, 40350.0, 40512.59487405206, 41069.0, 38933.610663894135, 39442.605573943896, 40070.0, 40364.3945340826, 41370.58629413788, 45209.0, 45441.318380224984, 45773.31340029969, 46317.53682463132, 46403.0, 36831.263374732895, 38737.80631096826, 38968.80515597404, 39006.219875602896, 39653.2069358617, 29738.702612973593, 30083.3983320328, 30222.0, 30400.84799575988, 30463.543046854757], "value": 20266.430708122778, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.2188950441682, 425.51278785790254, 432.1810169728367, 435.830026289747, 438.7148353570179, 12430.875691243085, 12975.675608109803, 18806.62386752266, 19474.123664435097, 19475.123619437123, 20734.688979665316, 21142.57714845702, 21328.57342853142, 22581.54836903261, 22607.095716171334, 6612.702428390734, 6617.272100069001, 6793.184817821868, 6821.761238356658, 6830.692618832164, 4700.670953033272, 6702.832429189285, 6765.2219994700745, 7118.537295075804, 7522.059742532184, 7495.0, 7513.323800857922, 7518.69925202994, 7535.246475352448, 7535.849283014337, 7101.609411482366, 7420.257974202536, 7467.8506429871095, 7483.289087536703, 7487.10154781427, 4437.844675436344, 7046.894296585555, 7211.531250468703, 7262.164851042145, 7405.592692401916, 24693.62959555608, 25666.74333256662, 25828.49979604635, 26120.216393508224, 26128.73871261282, 2743.245607457945, 2822.1674605991284, 2845.3171238902514, 3275.3121844412462, 3405.8467368968454, 16201.756973645404, 16661.91669041659, 16678.082705451194, 16807.411740589145, 16987.66024679512, 2179.6512557990645, 2311.9768802312096, 2318.8840557972203, 2322.198841399714, 2343.5195784864063, 82362.58818705929, 84026.57986710088, 88981.0, 90341.54829225877, 96804.51597741967, 17768.378106766202, 17931.820681793015, 18113.28300754871, 18568.164432600566, 18736.15687294075, 34325.65674343224, 34555.827220863735, 35068.64931350654, 35279.823600881835, 35331.64668353335, 8652.913470865211, 8987.146221108984, 8987.820243595092, 9034.909650903539, 9126.543672816333, 9154.67958621445, 9180.540972951325, 9240.491772952417, 9300.069993000781, 9327.393719408217, 5134.922976155361, 5160.716160611202, 5201.0, 5207.0, 5208.661437006658, 1835.3922989209652, 2014.3841803961923, 2027.7059826325394, 2032.6747720364967, 2061.5258490547258, 1058.3173852865013, 1066.0, 1071.9517621707041, 1086.462201210406, 1124.3928278729559, 19096.427107186806, 19147.61704765897, 19198.232070717295, 19344.41966741, 20042.699359509617, 1092.2190633696946, 1093.830456279278, 1103.2167161315556, 1123.3765260280622, 1146.9713257168637, 11347.659570212907, 11351.0, 11361.659150225507, 11441.427928603536, 11479.655610331703, 501782.0, 503228.0, 505993.0, 509241.0, 516260.0, 92537.07462925419, 93427.0, 94789.0, 97028.51485742527, 97064.51467742617, 1085.3216739537788, 1099.1371773158191, 1106.1758989552995, 1143.7941170589208, 1154.717094311899, 12943.805842912176, 17221.483355499357, 17721.822781772018, 18102.275908963493, 18348.266069357076, 40750.0, 42171.0, 42210.36684449797, 42279.154416912104, 42450.575494245895, 54954.0, 55131.0, 55158.0, 55160.72419637876, 55233.44766552283, 9369.203617692572, 9429.0, 9470.715878523655, 9563.091506307168, 9641.855372169563, 9039.774005649648, 11229.831552526883, 13663.18020918748, 13800.37898294559, 14033.0, 11736.119791015537, 11831.881681183422, 12054.75890482203, 12136.0, 12576.685582860136, 10487.63660724101, 11352.262102963281, 11686.94156529212, 11908.106891983309, 11930.582429614922, 11609.30344179352, 12394.504219831106, 12415.510138783404, 12438.875611244133, 12748.553800616934, 9266.11971862672, 9395.671151509665, 9425.811483770149, 9453.385529940531, 9486.573104210189, 9844.261680374144, 11245.100391968459, 11274.267172633752, 11275.0, 11286.435678215892], "value": 10407.929965154683, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.7659036259017, 1582.6834633073386, 1590.506942847717, 1808.1772793379014, 1907.9046047697602, 7597.278258565434, 8340.457870238437, 8500.702475413362, 8503.78740531487, 8510.10643882392, 8305.50166989981, 8452.112528184529, 8461.703840365588, 8504.914950850489, 8508.91491085089, 2375.3111597636666, 2395.9041638334447, 2396.341006223285, 2400.759924007603, 2402.315340128064, 2306.734725506563, 2325.093213646671, 2350.576896158699, 2357.26924653358, 2376.5603363377745, 2364.4207169243473, 2374.2402431222017, 2383.3922349800864, 2411.4815314707334, 2416.5770990076667, 2397.2688330059327, 2415.0339864054345, 2419.5281920025514, 2421.6125419932814, 2447.5716749568933, 2333.7432882382923, 2391.2826152154457, 2393.916212932539, 2396.9041238350446, 2399.8200134989947, 7313.926860731431, 7480.625968701597, 8610.87083693745, 8630.956845215735, 8647.697330593399, 4797.2564252540915, 5122.359705036871, 5341.759620817073, 5342.439043900374, 5345.919811202835, 3381.323735252959, 3394.3381040697072, 3430.811305378203, 3447.9655203447896, 3474.3919814032442, 1139.3904261220207, 1152.734870979671, 1178.2753606532008, 1179.0803173524664, 1202.6091520255952, 11768.293902365886, 11827.526898924032, 11852.0, 11867.169298149047, 12327.50689972409, 4723.5984941279685, 4760.428748550196, 4816.301636262722, 4840.080384726891, 4855.5387238212315, 10531.894681053245, 10582.523786429629, 10582.629607963685, 10595.099416549525, 10601.098906593026, 5493.038718224295, 5525.861853453695, 5537.8061767837935, 5540.196671482612, 5544.91682624761, 5010.599152067826, 5068.949310506848, 5077.517635824591, 5079.822206222764, 5083.034223497523, 3983.3626619740703, 4044.8786536403954, 4105.91788164235, 4112.856050038235, 4119.237940980928, 1253.1729058821315, 1260.489501751792, 1261.9305938173304, 1275.2985857778185, 1290.2581015915887, 845.4082142500274, 922.8338898998245, 936.5691781780321, 949.6771097826634, 975.4595437590935, 5429.158480435539, 5499.1476321170285, 5517.779288828482, 5519.061759500814, 5644.491995720405, 948.5778828421286, 959.9760005999906, 973.7662960889477, 1022.4529876516028, 1024.7694268789462, 3763.962360376361, 3767.811609419518, 3772.358699021173, 3795.6204379561823, 3829.272438236726, 10552.788944221225, 10659.573617055232, 10994.175436842268, 10994.230403871652, 10994.780104397867, 10771.03060724523, 10783.13734901206, 10863.076638485818, 10918.1811364148, 10921.344719316867, 8229.917700822914, 8295.502269863828, 8396.916030839735, 8418.074011858691, 8483.066862645104, 5525.475079867406, 5571.554275657856, 5608.551315894637, 5630.211770352236, 5676.631018983753, 9674.0, 9862.753431164278, 9887.703368898945, 9944.950275248577, 9945.900540994788, 9166.266698664223, 9303.209227215762, 9469.857952130862, 10037.849432258668, 10059.044390782863, 7744.380449564134, 7860.764177074697, 7876.369890408868, 7880.3301719354495, 7912.643931023233, 7991.3606911448105, 8020.197980201933, 8023.438359314792, 8033.959830201045, 8045.517268963881, 7405.888911666221, 7656.502327348704, 7672.0, 7696.076470823537, 7769.223077692185, 7431.739889103856, 7455.9627201865815, 7595.696172153273, 7691.615419228904, 7726.111497177896, 6646.0, 6652.966735166293, 6665.166854143232, 6704.195496540447, 6710.0, 4244.915101697887, 4670.859874203779, 4720.929186062143, 4752.453467851241, 4805.519448055166, 4733.171694953438, 4882.95117048825, 4911.4106307243355, 4914.385701787277, 4951.851444456672], "value": 4602.132640411382, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.5090745687395, 345.4438354249656, 351.043406716697, 355.1618181092621, 355.9893203203904, 6198.318184999652, 6217.129601855738, 6221.284552276489, 6233.968830155854, 6241.188645476093, 6194.659293738842, 6264.906026409608, 6284.811455656338, 6289.0566415037765, 6304.369563043693, 4490.9550904491025, 4572.885677858064, 4615.123126605951, 4630.629549636038, 4640.721556706609, 4737.289406589005, 4751.382320298374, 4768.094062128184, 4775.92836107457, 4782.187028205196, 4680.274557443602, 4706.3411122442885, 4711.057788442308, 4719.221328480797, 4735.90528189436, 4457.531959144292, 4592.724436533818, 4684.812607495696, 4719.5752382285755, 4725.527447255281, 4159.480064991876, 4170.16596680665, 4175.102352994121, 4177.4569305990335, 4186.016286172747, 5984.880302393928, 5991.850203744898, 5994.760209591611, 6004.12940123684, 6009.609375390585, 5530.170474428827, 5533.612647114704, 5538.0031594313, 5540.2243685884005, 5550.084236101079, 6552.672366381662, 6553.606783593, 6562.015697645344, 6563.048357988065, 6566.1135746674545, 4419.690621656486, 4576.427946506687, 4580.083983203373, 4601.746903920283, 4659.184642687516, 6809.38715515606, 6854.246032936423, 6878.58728476293, 6879.174499060095, 6896.27589103147, 4595.931061034087, 4609.985803123374, 4611.492735799059, 4621.214393553104, 4625.1443482955765, 4672.789724462407, 4675.883102922386, 4680.08738296029, 4687.460941991714, 4687.7656117194, 5432.185172224119, 5437.238786569884, 5438.15708565173, 5438.265834112344, 5442.91835622466, 6448.193975753031, 6592.912169492076, 6617.04052912325, 6639.236487803868, 6653.2681405045405, 1632.6816270827312, 1640.7374820028738, 1641.0973964319576, 1641.499342700464, 1644.112179423098, 1008.2841182760322, 1072.3190773858655, 1094.0591091661165, 1111.5776005118003, 1117.9888201118047, 6293.370662933761, 6384.648844313514, 6407.070974708641, 6460.709268082854, 6495.512836537278, 6817.488688348394, 6823.727050918007, 6828.385445309946, 6835.555688880207, 6850.794476165723, 6460.321666224979, 6470.4823614110755, 6471.708773105222, 6482.870342593122, 6484.221893372825, 3644.4715516250526, 3659.3596120678776, 3674.0998455378603, 3679.9264014719556, 3684.115812205105, 6927.376536111774, 7138.321859423347, 7182.784516464514, 7230.060092187982, 7237.601931893796, 6997.0, 7012.544184627983, 7018.157821061505, 7023.613701246379, 7031.015657807911, 7239.565626062453, 7247.23903990084, 7248.9999999998945, 7252.129744430702, 7254.8911766323545, 6859.828504287433, 6868.656567171722, 6873.553219040747, 6875.931240687529, 6880.105586273752, 6505.154329937078, 6682.264950855305, 6698.0, 6729.865402692017, 6779.762708305186, 7198.6400679964745, 7214.2785721427435, 7216.89174662391, 7227.819304517218, 7233.095863017123, 4715.457722361973, 4752.976235118802, 4761.357216775691, 4761.6904901181315, 4765.356676848581, 6850.691718872563, 6856.382925536725, 6865.073215115895, 6868.416184624363, 6870.3473170048765, 6400.967995159995, 6591.307912669101, 6659.500537459613, 6664.66676666155, 6686.264510903894, 6633.2371777246235, 6668.0, 6678.866422671616, 6681.699323530355, 6681.799546013627, 6559.836004099936, 6562.212534495891, 6572.4084832363405, 6576.506761992965, 6584.901226481702, 6703.262641109376, 6714.563553369016, 6732.427743641845, 6738.561993470409, 6742.359475849787, 6436.0, 6568.967155164385, 6575.80272591823, 6591.472682185317, 6595.835104122435], "value": 4987.604105926729, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.8518866604009, 891.3270480787008, 920.9114154438129, 935.868978343032, 960.0591420408005, 14916.328765205564, 15325.310361033738, 15438.073715577058, 15694.686106277868, 15851.682966340666, 14497.637559061002, 14566.271686415663, 14640.707185856276, 14641.92679036606, 14669.413223471074, 723.1611330856208, 740.2116745665876, 741.6699568691935, 870.495112834556, 887.2635712358726, 736.3851184261148, 852.3011130872687, 884.1423818895661, 887.8313120507115, 887.9112088791134, 914.963401463944, 916.0656130746635, 916.6012784438757, 917.7980844214262, 918.0, 753.1978442958232, 907.0294784580501, 910.2808781062952, 912.083356226991, 912.9041450647653, 659.5053709717712, 673.7473447457204, 674.1202730436778, 674.2953613473932, 674.4604316546792, 14729.116253024853, 14791.260436978107, 14795.260236988108, 14818.333175007043, 14823.0, 14103.78844317336, 14663.853361466356, 14712.852871471363, 14768.113913165245, 14998.0, 10730.0, 11097.500612472459, 11193.66419007431, 11240.044596209333, 11252.493637786238, 4110.5591796836, 4110.630043296118, 4119.382092686091, 4159.9376009359585, 4258.169656916903, 56778.43221567773, 57036.42963570353, 57085.71457142729, 57357.71321143409, 58174.41825581775, 11118.499667514981, 11128.05411540012, 11492.42537873103, 11674.241174323643, 11815.940920295343, 21680.457988550097, 21685.67471487929, 21702.565948680938, 21707.457313567287, 21746.56506869854, 8444.493330400073, 8477.703280385156, 8534.914650853412, 8569.271611912933, 8574.0, 5048.1418158913075, 5058.064258112261, 5088.516590923857, 5118.795248190031, 5135.0, 3623.673869351771, 3670.4494325851338, 3671.9816400917825, 3673.4673472346362, 3676.5955744868043, 653.2520264297448, 655.4723447624613, 658.8616390558036, 670.0719503487704, 688.1913751342153, 695.6591270277629, 720.3876704800878, 728.9139182617968, 755.9130699969464, 819.6803246733779, 9703.902960970441, 9830.0, 9857.309988300893, 10211.846822297672, 10212.285140040274, 695.8156088636515, 746.294751459876, 763.9847203055908, 789.5617932047654, 810.6716779704229, 4495.977520112378, 4574.839880604163, 4587.747673877969, 4605.286180642006, 4669.509701481364, 61583.38416615777, 62103.0, 62656.0, 62835.0, 62881.37118628847, 53576.0, 55144.691318520214, 55321.1701824473, 57163.0, 57644.423555763904, 49171.262431063566, 49270.0, 49612.75193624081, 52289.47710522846, 52642.21036684453, 9830.213582913493, 10132.493375331056, 10189.643362482277, 10301.124404425707, 10450.790984180427, 38072.0, 38813.611863881, 39127.41308880312, 39674.0, 40621.0, 44374.55625443704, 50083.0, 50588.0, 50720.0, 50947.745261273456, 12786.168899021533, 12848.486060557847, 12927.5475358362, 13020.94235618975, 13167.0, 14170.858291417366, 14258.500952466615, 14297.499587514387, 14350.784738229144, 14389.7841532375, 12995.675108122372, 13298.601041968757, 13353.465861365825, 13383.063185576917, 13464.0, 12344.3827808611, 12559.937200314305, 12682.112252142262, 13016.414261358072, 13462.528811491551, 12048.096392770402, 12075.396230188631, 12476.875231247572, 12845.100842940905, 12854.228746275254, 11150.442477875911, 11465.656030319104, 11633.709157271136, 11795.291607749814, 11855.466504007512, 10154.949225254122, 10856.077233434931, 11021.614243501439, 11044.889551104707, 11049.613263535737], "value": 7124.321253121136, "unit": "score"}], "name": "dromaeo_css", "value": 7573.377943832108, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 110.0, 110.0, 110.0, 110.0, 105.0, 109.0, 109.0, 108.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 162.0, 179.0, 132.0, 152.0, 147.0, 127.0, 178.0, 124.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 162.0, 161.0, 159.0, 160.0, 160.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 176.0, 76.0, 76.0, 75.0, 75.0, 175.0, 77.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 148.0, 92.0, 92.0, 91.0, 146.0, 91.0, 93.0, 147.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 53.0, 54.0, 53.0, 64.0, 72.0, 51.0, 51.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 73.0, 72.0, 73.0, 82.0, 74.0, 79.0, 74.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 113.0, 113.0, 119.0, 121.0, 112.0, 121.0, 128.0, 126.0], "value": 118.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 159.0, 161.0, 157.0, 156.0, 155.0, 156.0, 157.0, 155.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 70.0, 68.0, 65.0, 67.0, 63.0, 67.0, 64.0, 63.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1507.5, "alertThreshold": 2.0}]} 10:06:48 INFO - Return code: 0 10:06:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:06:48 ERROR - # TBPL SUCCESS # 10:06:48 INFO - Running post-action listener: _resource_record_post_action 10:06:48 INFO - Running post-run listener: _resource_record_post_run 10:06:49 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 459902976; Read time: 16; Write time: 816348 10:06:49 INFO - install - Wall time: 14s; CPU: 17.0%; Read bytes: 0; Write bytes: 242749440; Read time: 0; Write time: 589656 10:06:49 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 217153536; Read time: 16; Write time: 226692 10:06:49 INFO - Running post-run listener: _upload_blobber_files 10:06:49 INFO - Blob upload gear active. 10:06:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:06:49 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 10:06:49 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'] 10:06:49 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 10:06:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:06:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:06:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:06:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:51 INFO - (blobuploader) - INFO - Done attempting. 10:06:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:06:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:06:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:51 INFO - (blobuploader) - INFO - Done attempting. 10:06:51 INFO - (blobuploader) - INFO - Iteration through files over. 10:06:51 INFO - Return code: 0 10:06:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:06:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:06:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8200fea8b91d5fde926686ef2c65de88383294f1511d27e12ed5f04725371870f946fdecf821cbfc05826ff48f72d36a86ebc7a218b2e6f4b2aa190e7c22c0d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e63afade41c52b4f5c09d8ace336d53ee865a798bc969571d583de187de8335f5f5ad6718cb262a3c95f6a6536d4b93ba510a1c162249fd1661ac4a060253703"} 10:06:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:06:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:06:51 INFO - Contents: 10:06:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8200fea8b91d5fde926686ef2c65de88383294f1511d27e12ed5f04725371870f946fdecf821cbfc05826ff48f72d36a86ebc7a218b2e6f4b2aa190e7c22c0d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e63afade41c52b4f5c09d8ace336d53ee865a798bc969571d583de187de8335f5f5ad6718cb262a3c95f6a6536d4b93ba510a1c162249fd1661ac4a060253703"} 10:06:51 INFO - Running post-run listener: copy_logs_to_upload_dir 10:06:51 INFO - Copying logs to upload dir... 10:06:51 INFO - mkdir: /builds/slave/test/build/upload/logs 10:06:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.610377 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-07-04 10:06:51.765620) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 10:06:51.768737) ========= 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=5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059 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/8200fea8b91d5fde926686ef2c65de88383294f1511d27e12ed5f04725371870f946fdecf821cbfc05826ff48f72d36a86ebc7a218b2e6f4b2aa190e7c22c0d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e63afade41c52b4f5c09d8ace336d53ee865a798bc969571d583de187de8335f5f5ad6718cb262a3c95f6a6536d4b93ba510a1c162249fd1661ac4a060253703"} build_url:https://queue.taskcluster.net/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/QI9IkKj4Q3adM1Y5Zqs3DQ/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/8200fea8b91d5fde926686ef2c65de88383294f1511d27e12ed5f04725371870f946fdecf821cbfc05826ff48f72d36a86ebc7a218b2e6f4b2aa190e7c22c0d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e63afade41c52b4f5c09d8ace336d53ee865a798bc969571d583de187de8335f5f5ad6718cb262a3c95f6a6536d4b93ba510a1c162249fd1661ac4a060253703"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 10:06:51.794412) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 10:06:51.794760) ========= 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=5cf47e208febbcd81da23b2e0000026f-1467650783.586828-653230059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 10:06:51.877510) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 10:06:51.877860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 10:06:51.878169) ========= ========= Total master_lag: 0.18 =========