builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1463599510.67 results: success (0) buildid: 20160518011743 builduid: 2ee73919dd5c44b5acf15250b7f87b6d revision: 45fd5912a58c6a3accd5a91e287eb90f615071cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:10.672861) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:10.673369) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:10.673682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:10.690289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:10.690741) ========= 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=52faae308a556c440401f8e5000001e8-1463599310.759914-412528591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 12:25:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.7M=0s 2016-05-18 12:25:11 (36.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114773 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:10.819082) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:10.819465) ========= 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=52faae308a556c440401f8e5000001e8-1463599310.759914-412528591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018805 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:10.869436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:10.869818) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 45fd5912a58c6a3accd5a91e287eb90f615071cc --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 45fd5912a58c6a3accd5a91e287eb90f615071cc --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=52faae308a556c440401f8e5000001e8-1463599310.759914-412528591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 12:25:11,581 truncating revision to first 12 chars 2016-05-18 12:25:11,582 Setting DEBUG logging. 2016-05-18 12:25:11,582 attempt 1/10 2016-05-18 12:25:11,582 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/45fd5912a58c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 12:25:11,999 unpacking tar archive at: mozilla-beta-45fd5912a58c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.721655 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:11.603840) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:11.604130) ========= script_repo_revision: 45fd5912a58c6a3accd5a91e287eb90f615071cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:11.604525) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:11.604801) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 12:25:11.648997) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-18 12:25:11.649407) ========= /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=52faae308a556c440401f8e5000001e8-1463599310.759914-412528591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:25:12 INFO - MultiFileLogger online at 20160518 12:25:12 in /builds/slave/test 12:25:12 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 12:25:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:25:12 INFO - {'append_to_log': False, 12:25:12 INFO - 'base_work_dir': '/builds/slave/test', 12:25:12 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:25:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:25:12 INFO - 'branch': 'Mozilla-Beta', 12:25:12 INFO - 'buildbot_json_path': 'buildprops.json', 12:25:12 INFO - 'config_files': ('talos/linux_config.py',), 12:25:12 INFO - 'default_actions': ('clobber', 12:25:12 INFO - 'read-buildbot-config', 12:25:12 INFO - 'download-and-extract', 12:25:12 INFO - 'populate-webroot', 12:25:12 INFO - 'create-virtualenv', 12:25:12 INFO - 'install', 12:25:12 INFO - 'run-tests'), 12:25:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:25:12 INFO - 'download_minidump_stackwalk': True, 12:25:12 INFO - 'download_symbols': 'ondemand', 12:25:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:25:12 INFO - 'tooltool.py': '/tools/tooltool.py', 12:25:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:25:12 INFO - '/tools/misc-python/virtualenv.py')}, 12:25:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:25:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:25:12 INFO - 'installer_path': 'installer.exe', 12:25:12 INFO - 'log_level': 'info', 12:25:12 INFO - 'log_name': 'talos', 12:25:12 INFO - 'log_to_console': True, 12:25:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:25:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:25:12 INFO - 'opt_config_files': (), 12:25:12 INFO - 'pip_index': False, 12:25:12 INFO - 'sps_profile': False, 12:25:12 INFO - 'sps_profile_interval': 0, 12:25:12 INFO - 'suite': 'dromaeojs', 12:25:12 INFO - 'system_bits': '32', 12:25:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:25:12 INFO - 'title': 'talos-linux64-ix-056', 12:25:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:25:12 INFO - 'use_talos_json': True, 12:25:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:25:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:25:12 INFO - 'work_dir': 'build'} 12:25:12 INFO - ##### 12:25:12 INFO - ##### Running clobber step. 12:25:12 INFO - ##### 12:25:12 INFO - Running pre-action listener: _resource_record_pre_action 12:25:12 INFO - Running main action method: clobber 12:25:12 INFO - rmtree: /builds/slave/test/build 12:25:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:25:12 INFO - Running post-action listener: _resource_record_post_action 12:25:12 INFO - ##### 12:25:12 INFO - ##### Running read-buildbot-config step. 12:25:12 INFO - ##### 12:25:12 INFO - Running pre-action listener: _resource_record_pre_action 12:25:12 INFO - Running main action method: read_buildbot_config 12:25:12 INFO - Using buildbot properties: 12:25:12 INFO - { 12:25:12 INFO - "project": "", 12:25:12 INFO - "product": "firefox", 12:25:12 INFO - "script_repo_revision": "production", 12:25:12 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:25:12 INFO - "repository": "", 12:25:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:25:12 INFO - "buildid": "20160518011743", 12:25:12 INFO - "pgo_build": "True", 12:25:12 INFO - "basedir": "/builds/slave/test", 12:25:12 INFO - "buildnumber": 15, 12:25:12 INFO - "slavename": "talos-linux64-ix-056", 12:25:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:25:12 INFO - "platform": "ubuntu64_hw", 12:25:12 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:25:12 INFO - "branch": "mozilla-beta", 12:25:12 INFO - "repo_path": "releases/mozilla-beta", 12:25:12 INFO - "revision": "45fd5912a58c6a3accd5a91e287eb90f615071cc", 12:25:12 INFO - "stage_platform": "linux64-pgo", 12:25:12 INFO - "builduid": "2ee73919dd5c44b5acf15250b7f87b6d", 12:25:12 INFO - "slavebuilddir": "test" 12:25:12 INFO - } 12:25:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 12:25:12 INFO - Running post-action listener: _resource_record_post_action 12:25:12 INFO - ##### 12:25:12 INFO - ##### Running download-and-extract step. 12:25:12 INFO - ##### 12:25:12 INFO - Running pre-action listener: _resource_record_pre_action 12:25:12 INFO - Running main action method: download_and_extract 12:25:12 INFO - mkdir: /builds/slave/test/build/tests 12:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:12 INFO - https://queue.taskcluster.net/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:25:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 12:25:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 12:25:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 12:25:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:25:16 INFO - Downloaded 1412 bytes. 12:25:16 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 12:25:16 INFO - Using the following test package requirements: 12:25:16 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 12:25:16 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:25:16 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:25:16 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:25:16 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 12:25:16 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:25:16 INFO - u'jsshell-linux-x86_64.zip'], 12:25:16 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:25:16 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:25:16 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 12:25:16 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:25:16 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 12:25:16 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:25:16 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 12:25:16 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:25:16 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:25:16 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 12:25:16 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:25:16 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:25:16 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:16 INFO - https://queue.taskcluster.net/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:25:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:25:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:25:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:25:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:25:18 INFO - Downloaded 23365582 bytes. 12:25:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:25:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:25:19 INFO - Return code: 0 12:25:19 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:19 INFO - https://queue.taskcluster.net/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:25:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:25:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:25:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:25:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:25:20 INFO - Downloaded 23365582 bytes. 12:25:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:25:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:25:22 INFO - Return code: 0 12:25:22 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')]} 12:25:22 INFO - https://queue.taskcluster.net/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:25:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 12:25:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 12:25:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 12:25:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:25:24 INFO - Downloaded 10845194 bytes. 12:25:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:25:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:25:24 INFO - Return code: 0 12:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:24 INFO - https://queue.taskcluster.net/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:25:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 12:25:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 12:25:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 12:25:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:25:28 INFO - Downloaded 53797272 bytes. 12:25:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 12:25:28 INFO - mkdir: /builds/slave/test/properties 12:25:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:25:28 INFO - Writing to file /builds/slave/test/properties/build_url 12:25:28 INFO - Contents: 12:25:28 INFO - build_url:https://queue.taskcluster.net/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 12:25:29 INFO - Running post-action listener: _resource_record_post_action 12:25:29 INFO - Running post-action listener: set_extra_try_arguments 12:25:29 INFO - ##### 12:25:29 INFO - ##### Running populate-webroot step. 12:25:29 INFO - ##### 12:25:29 INFO - Running pre-action listener: _resource_record_pre_action 12:25:29 INFO - Running main action method: populate_webroot 12:25:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:25:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:25:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:25:29 INFO - '--tppagecycles', 12:25:29 INFO - '7'], 12:25:29 INFO - 'tests': ['tsvgm']}}, 12:25:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:25:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:25:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:25:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:25:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:25:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:25:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:25:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:29 INFO - 'talos_options': ['--e10s'], 12:25:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:25:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:29 INFO - 'tests': ['damp', 'tps']}, 12:25:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:29 INFO - 'talos_options': ['--e10s'], 12:25:29 INFO - 'tests': ['damp', 'tps']}, 12:25:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:25:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:25:29 INFO - 'other': {'tests': ['a11yr', 12:25:29 INFO - 'ts_paint', 12:25:29 INFO - 'tpaint', 12:25:29 INFO - 'sessionrestore', 12:25:29 INFO - 'sessionrestore_no_auto_restore', 12:25:29 INFO - 'tabpaint']}, 12:25:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:25:29 INFO - 'tests': ['a11yr', 12:25:29 INFO - 'ts_paint', 12:25:29 INFO - 'tpaint', 12:25:29 INFO - 'sessionrestore', 12:25:29 INFO - 'sessionrestore_no_auto_restore', 12:25:29 INFO - 'tabpaint']}, 12:25:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:25:29 INFO - 'tests': ['a11yr', 12:25:29 INFO - 'ts_paint', 12:25:29 INFO - 'tpaint', 12:25:29 INFO - 'sessionrestore', 12:25:29 INFO - 'sessionrestore_no_auto_restore', 12:25:29 INFO - 'tabpaint']}, 12:25:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:25:29 INFO - 'tests': ['a11yr', 12:25:29 INFO - 'ts_paint', 12:25:29 INFO - 'tpaint', 12:25:29 INFO - 'sessionrestore', 12:25:29 INFO - 'sessionrestore_no_auto_restore', 12:25:29 INFO - 'tabpaint']}, 12:25:29 INFO - 'other_l64': {'tests': ['a11yr', 12:25:29 INFO - 'ts_paint', 12:25:29 INFO - 'tpaint', 12:25:29 INFO - 'sessionrestore', 12:25:29 INFO - 'sessionrestore_no_auto_restore', 12:25:29 INFO - 'tabpaint']}, 12:25:29 INFO - 'other_nol64': {'tests': ['a11yr', 12:25:29 INFO - 'ts_paint', 12:25:29 INFO - 'tpaint', 12:25:29 INFO - 'sessionrestore', 12:25:29 INFO - 'sessionrestore_no_auto_restore', 12:25:29 INFO - 'tabpaint']}, 12:25:29 INFO - 'svgr': {'tests': ['tsvgx', 12:25:29 INFO - 'tsvgr_opacity', 12:25:29 INFO - 'tart', 12:25:29 INFO - 'tscrollx', 12:25:29 INFO - 'cart']}, 12:25:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:25:29 INFO - 'tests': ['tsvgx', 12:25:29 INFO - 'tsvgr_opacity', 12:25:29 INFO - 'tart', 12:25:29 INFO - 'tscrollx', 12:25:29 INFO - 'cart']}, 12:25:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:29 INFO - 'tests': ['tp5o']}, 12:25:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:29 INFO - 'talos_options': ['--e10s'], 12:25:29 INFO - 'tests': ['tp5o']}, 12:25:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:29 INFO - 'talos_options': ['--xperf_path', 12:25:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:25:29 INFO - 'tests': ['tp5n']}, 12:25:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:29 INFO - 'talos_options': ['--e10s', 12:25:29 INFO - '--xperf_path', 12:25:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:25:29 INFO - 'tests': ['tp5n']}}, 12:25:29 INFO - 'talos.zip': {'path': '', 12:25:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:25:29 INFO - Running post-action listener: _resource_record_post_action 12:25:29 INFO - ##### 12:25:29 INFO - ##### Running create-virtualenv step. 12:25:29 INFO - ##### 12:25:29 INFO - Running pre-action listener: _resource_record_pre_action 12:25:29 INFO - Running main action method: create_virtualenv 12:25:29 INFO - Creating virtualenv /builds/slave/test/build/venv 12:25:29 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 12:25:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:25:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:25:29 INFO - Using real prefix '/usr' 12:25:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:25:30 INFO - Installing distribute.............................................................................................................................................................................................done. 12:25:31 INFO - Installing pip.................done. 12:25:31 INFO - Return code: 0 12:25:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:31 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 0x7f3ff5bc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9160>, '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 0xfea060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea4f0>, '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': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', '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 12:25:31 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 12:25:31 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 12:25:32 INFO - Using env: {'DISPLAY': ':0', 12:25:32 INFO - 'HOME': '/home/cltbld', 12:25:32 INFO - 'LANG': 'en_US.UTF-8', 12:25:32 INFO - 'LANGUAGE': 'en_US:en', 12:25:32 INFO - 'LOGNAME': 'cltbld', 12:25:32 INFO - 'MAIL': '/var/mail/cltbld', 12:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:32 INFO - 'MOZ_NO_REMOTE': '1', 12:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:32 INFO - 'NO_EM_RESTART': '1', 12:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:32 INFO - 'PWD': '/builds/slave/test', 12:25:32 INFO - 'SHELL': '/bin/bash', 12:25:32 INFO - 'SHLVL': '1', 12:25:32 INFO - 'TERM': 'linux', 12:25:32 INFO - 'TMOUT': '86400', 12:25:32 INFO - 'USER': 'cltbld', 12:25:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', 12:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:32 INFO - '_': '/tools/buildbot/bin/python'} 12:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:32 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 12:25:32 INFO - Cleaning up... 12:25:32 INFO - Return code: 0 12:25:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:32 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 0x7f3ff5bc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9160>, '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 0xfea060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea4f0>, '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': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', '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 12:25:32 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 12:25:32 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 12:25:32 INFO - Using env: {'DISPLAY': ':0', 12:25:32 INFO - 'HOME': '/home/cltbld', 12:25:32 INFO - 'LANG': 'en_US.UTF-8', 12:25:32 INFO - 'LANGUAGE': 'en_US:en', 12:25:32 INFO - 'LOGNAME': 'cltbld', 12:25:32 INFO - 'MAIL': '/var/mail/cltbld', 12:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:32 INFO - 'MOZ_NO_REMOTE': '1', 12:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:32 INFO - 'NO_EM_RESTART': '1', 12:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:32 INFO - 'PWD': '/builds/slave/test', 12:25:32 INFO - 'SHELL': '/bin/bash', 12:25:32 INFO - 'SHLVL': '1', 12:25:32 INFO - 'TERM': 'linux', 12:25:32 INFO - 'TMOUT': '86400', 12:25:32 INFO - 'USER': 'cltbld', 12:25:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', 12:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:32 INFO - '_': '/tools/buildbot/bin/python'} 12:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:32 INFO - Downloading/unpacking psutil>=0.7.1 12:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:25:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:25:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:25:34 INFO - Installing collected packages: psutil 12:25:34 INFO - Running setup.py install for psutil 12:25:34 INFO - building 'psutil._psutil_linux' extension 12:25:34 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 12:25:34 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 12:25:34 INFO - building 'psutil._psutil_posix' extension 12:25:34 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 12:25:34 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 12:25:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:25:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:25:34 INFO - Successfully installed psutil 12:25:34 INFO - Cleaning up... 12:25:34 INFO - Return code: 0 12:25:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ff5bc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9160>, '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 0xfea060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea4f0>, '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': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', '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 12:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:25:34 INFO - Using env: {'DISPLAY': ':0', 12:25:34 INFO - 'HOME': '/home/cltbld', 12:25:34 INFO - 'LANG': 'en_US.UTF-8', 12:25:34 INFO - 'LANGUAGE': 'en_US:en', 12:25:34 INFO - 'LOGNAME': 'cltbld', 12:25:34 INFO - 'MAIL': '/var/mail/cltbld', 12:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:34 INFO - 'MOZ_NO_REMOTE': '1', 12:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:34 INFO - 'NO_EM_RESTART': '1', 12:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:34 INFO - 'PWD': '/builds/slave/test', 12:25:34 INFO - 'SHELL': '/bin/bash', 12:25:34 INFO - 'SHLVL': '1', 12:25:34 INFO - 'TERM': 'linux', 12:25:34 INFO - 'TMOUT': '86400', 12:25:34 INFO - 'USER': 'cltbld', 12:25:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', 12:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:34 INFO - '_': '/tools/buildbot/bin/python'} 12:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:25:37 INFO - Installing collected packages: mozsystemmonitor 12:25:37 INFO - Running setup.py install for mozsystemmonitor 12:25:37 INFO - Successfully installed mozsystemmonitor 12:25:37 INFO - Cleaning up... 12:25:37 INFO - Return code: 0 12:25:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ff5bc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9160>, '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 0xfea060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea4f0>, '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': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', '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 12:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:25:37 INFO - Using env: {'DISPLAY': ':0', 12:25:37 INFO - 'HOME': '/home/cltbld', 12:25:37 INFO - 'LANG': 'en_US.UTF-8', 12:25:37 INFO - 'LANGUAGE': 'en_US:en', 12:25:37 INFO - 'LOGNAME': 'cltbld', 12:25:37 INFO - 'MAIL': '/var/mail/cltbld', 12:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:37 INFO - 'MOZ_NO_REMOTE': '1', 12:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:37 INFO - 'NO_EM_RESTART': '1', 12:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:37 INFO - 'PWD': '/builds/slave/test', 12:25:37 INFO - 'SHELL': '/bin/bash', 12:25:37 INFO - 'SHLVL': '1', 12:25:37 INFO - 'TERM': 'linux', 12:25:37 INFO - 'TMOUT': '86400', 12:25:37 INFO - 'USER': 'cltbld', 12:25:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', 12:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:37 INFO - '_': '/tools/buildbot/bin/python'} 12:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:37 INFO - Downloading/unpacking blobuploader==1.2.4 12:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:39 INFO - Downloading blobuploader-1.2.4.tar.gz 12:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:25:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:25:39 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 12:25:39 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 12:25:39 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 12:25:39 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 12:25:39 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 12:25:39 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 12:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:25:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:25:39 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 12:25:39 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 12:25:39 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 12:25:39 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 12:25:39 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 12:25:39 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 12:25:40 INFO - Downloading docopt-0.6.1.tar.gz 12:25:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:25:40 INFO - Installing collected packages: blobuploader, requests, docopt 12:25:40 INFO - Running setup.py install for blobuploader 12:25:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:25:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:25:40 INFO - Running setup.py install for requests 12:25:40 INFO - Running setup.py install for docopt 12:25:40 INFO - Successfully installed blobuploader requests docopt 12:25:40 INFO - Cleaning up... 12:25:40 INFO - Return code: 0 12:25:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:25:40 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')]} 12:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:40 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')]} 12:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:40 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 0x7f3ff5bc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9160>, '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 0xfea060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea4f0>, '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': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', '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 12:25:40 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 12:25:40 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 12:25:40 INFO - Using env: {'DISPLAY': ':0', 12:25:40 INFO - 'HOME': '/home/cltbld', 12:25:40 INFO - 'LANG': 'en_US.UTF-8', 12:25:40 INFO - 'LANGUAGE': 'en_US:en', 12:25:40 INFO - 'LOGNAME': 'cltbld', 12:25:40 INFO - 'MAIL': '/var/mail/cltbld', 12:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:40 INFO - 'MOZ_NO_REMOTE': '1', 12:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:40 INFO - 'NO_EM_RESTART': '1', 12:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:40 INFO - 'PWD': '/builds/slave/test', 12:25:40 INFO - 'SHELL': '/bin/bash', 12:25:40 INFO - 'SHLVL': '1', 12:25:40 INFO - 'TERM': 'linux', 12:25:40 INFO - 'TMOUT': '86400', 12:25:40 INFO - 'USER': 'cltbld', 12:25:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', 12:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:40 INFO - '_': '/tools/buildbot/bin/python'} 12:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:25:40 INFO - Running setup.py (path:/tmp/pip-FwvsWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:25:41 INFO - Running setup.py (path:/tmp/pip-3f_965-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:25:41 INFO - Running setup.py (path:/tmp/pip-4nsCyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:25:41 INFO - Running setup.py (path:/tmp/pip-bVQjPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:25:41 INFO - Running setup.py (path:/tmp/pip-b1YRtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:25:41 INFO - Running setup.py (path:/tmp/pip-h9yfnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:25:41 INFO - Running setup.py (path:/tmp/pip-sRR2KO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:25:41 INFO - Running setup.py (path:/tmp/pip-XicViV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:25:41 INFO - Running setup.py (path:/tmp/pip-zHrshT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:25:41 INFO - Running setup.py (path:/tmp/pip-HC3yx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:25:41 INFO - Running setup.py (path:/tmp/pip-Al1p7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:25:41 INFO - Running setup.py (path:/tmp/pip-Jcpzht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:25:41 INFO - Running setup.py (path:/tmp/pip-6HVWlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:25:41 INFO - Running setup.py (path:/tmp/pip-Gxh9r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:25:41 INFO - Running setup.py (path:/tmp/pip-ZszEwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:25:42 INFO - Running setup.py (path:/tmp/pip-fyWOKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:25:42 INFO - Running setup.py (path:/tmp/pip-SV2tLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:25:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:25:42 INFO - Running setup.py install for manifestparser 12:25:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:25:42 INFO - Running setup.py install for mozcrash 12:25:42 INFO - Running setup.py install for mozdebug 12:25:42 INFO - Running setup.py install for mozdevice 12:25:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:25:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:25:42 INFO - Running setup.py install for mozfile 12:25:42 INFO - Running setup.py install for mozhttpd 12:25:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:25:42 INFO - Running setup.py install for mozinfo 12:25:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:25:42 INFO - Running setup.py install for mozInstall 12:25:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:25:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:25:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:25:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:25:42 INFO - Running setup.py install for mozleak 12:25:43 INFO - Running setup.py install for mozlog 12:25:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:25:43 INFO - Running setup.py install for moznetwork 12:25:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:25:43 INFO - Running setup.py install for mozprocess 12:25:43 INFO - Running setup.py install for mozprofile 12:25:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:25:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:25:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:25:43 INFO - Running setup.py install for mozrunner 12:25:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:25:43 INFO - Running setup.py install for mozscreenshot 12:25:43 INFO - Running setup.py install for moztest 12:25:43 INFO - Running setup.py install for mozversion 12:25:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:25:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:25:43 INFO - Cleaning up... 12:25:43 INFO - Return code: 0 12:25:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:43 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 0x7f3ff5bc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9160>, '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 0xfea060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea4f0>, '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': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', '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 12:25:43 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 12:25:43 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 12:25:43 INFO - Using env: {'DISPLAY': ':0', 12:25:43 INFO - 'HOME': '/home/cltbld', 12:25:43 INFO - 'LANG': 'en_US.UTF-8', 12:25:43 INFO - 'LANGUAGE': 'en_US:en', 12:25:43 INFO - 'LOGNAME': 'cltbld', 12:25:43 INFO - 'MAIL': '/var/mail/cltbld', 12:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:43 INFO - 'MOZ_NO_REMOTE': '1', 12:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:43 INFO - 'NO_EM_RESTART': '1', 12:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:43 INFO - 'PWD': '/builds/slave/test', 12:25:43 INFO - 'SHELL': '/bin/bash', 12:25:43 INFO - 'SHLVL': '1', 12:25:43 INFO - 'TERM': 'linux', 12:25:43 INFO - 'TMOUT': '86400', 12:25:43 INFO - 'USER': 'cltbld', 12:25:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', 12:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:43 INFO - '_': '/tools/buildbot/bin/python'} 12:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:25:44 INFO - Running setup.py (path:/tmp/pip-4ckK4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:25:44 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)) 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:25:44 INFO - Running setup.py (path:/tmp/pip-QW60QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:25:44 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)) 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:25:44 INFO - Running setup.py (path:/tmp/pip-SAbfLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:25:44 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)) 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:25:44 INFO - Running setup.py (path:/tmp/pip-7N6K1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:25:44 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)) 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:25:44 INFO - Running setup.py (path:/tmp/pip-TGySwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:25:44 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)) 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:25:44 INFO - Running setup.py (path:/tmp/pip-ujtAib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:25:44 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)) 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:25:44 INFO - Running setup.py (path:/tmp/pip-xH5EKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:25:44 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)) 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:25:44 INFO - Running setup.py (path:/tmp/pip-B0ifzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:25:44 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)) 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:25:44 INFO - Running setup.py (path:/tmp/pip-CFXO99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:25:44 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)) 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:25:44 INFO - Running setup.py (path:/tmp/pip-VlxZZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:25:44 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)) 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:25:44 INFO - Running setup.py (path:/tmp/pip-rVR3jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:25:44 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)) 12:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:25:44 INFO - Running setup.py (path:/tmp/pip-1vEHGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:25:45 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)) 12:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:25:45 INFO - Running setup.py (path:/tmp/pip-_n4HB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:25:45 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)) 12:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:25:45 INFO - Running setup.py (path:/tmp/pip-K8YmUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:25:45 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)) 12:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:25:45 INFO - Running setup.py (path:/tmp/pip-mnzOod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:25:45 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)) 12:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:25:45 INFO - Running setup.py (path:/tmp/pip-zxGtED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:25:45 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)) 12:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:25:45 INFO - Running setup.py (path:/tmp/pip-LycPr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:25:45 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)) 12:25:45 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)) 12:25:45 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)) 12:25:45 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)) 12:25:45 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)) 12:25:45 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)) 12:25:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25:47 INFO - Downloading blessings-1.6.tar.gz 12:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:25:47 INFO - Installing collected packages: blessings 12:25:47 INFO - Running setup.py install for blessings 12:25:47 INFO - Successfully installed blessings 12:25:47 INFO - Cleaning up... 12:25:47 INFO - Return code: 0 12:25:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:25:47 INFO - Reading from file tmpfile_stdout 12:25:47 INFO - Current package versions: 12:25:47 INFO - argparse == 1.2.1 12:25:47 INFO - blessings == 1.6 12:25:47 INFO - blobuploader == 1.2.4 12:25:47 INFO - docopt == 0.6.1 12:25:47 INFO - manifestparser == 1.1 12:25:47 INFO - mozInstall == 1.12 12:25:47 INFO - mozcrash == 0.17 12:25:47 INFO - mozdebug == 0.1 12:25:47 INFO - mozdevice == 0.48 12:25:47 INFO - mozfile == 1.2 12:25:47 INFO - mozhttpd == 0.7 12:25:47 INFO - mozinfo == 0.9 12:25:47 INFO - mozleak == 0.1 12:25:47 INFO - mozlog == 3.1 12:25:47 INFO - moznetwork == 0.27 12:25:47 INFO - mozprocess == 0.22 12:25:47 INFO - mozprofile == 0.28 12:25:47 INFO - mozrunner == 6.11 12:25:47 INFO - mozscreenshot == 0.1 12:25:47 INFO - mozsystemmonitor == 0.0 12:25:47 INFO - moztest == 0.7 12:25:47 INFO - mozversion == 1.4 12:25:47 INFO - psutil == 3.1.1 12:25:47 INFO - requests == 1.2.3 12:25:47 INFO - wsgiref == 0.1.2 12:25:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:47 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 0x7f3ff5bc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9160>, '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 0xfea060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea4f0>, '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': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', '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 12:25:47 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 12:25:47 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 12:25:47 INFO - Using env: {'DISPLAY': ':0', 12:25:47 INFO - 'HOME': '/home/cltbld', 12:25:47 INFO - 'LANG': 'en_US.UTF-8', 12:25:47 INFO - 'LANGUAGE': 'en_US:en', 12:25:47 INFO - 'LOGNAME': 'cltbld', 12:25:47 INFO - 'MAIL': '/var/mail/cltbld', 12:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:47 INFO - 'MOZ_NO_REMOTE': '1', 12:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:47 INFO - 'NO_EM_RESTART': '1', 12:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:47 INFO - 'PWD': '/builds/slave/test', 12:25:47 INFO - 'SHELL': '/bin/bash', 12:25:47 INFO - 'SHLVL': '1', 12:25:47 INFO - 'TERM': 'linux', 12:25:47 INFO - 'TMOUT': '86400', 12:25:47 INFO - 'USER': 'cltbld', 12:25:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', 12:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:47 INFO - '_': '/tools/buildbot/bin/python'} 12:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:47 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)) 12:25:47 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)) 12:25:47 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)) 12:25:47 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)) 12:25:47 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)) 12:25:47 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)) 12:25:47 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)) 12:25:47 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)) 12:25:47 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)) 12:25:47 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)) 12:25:47 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)) 12:25:47 INFO - Cleaning up... 12:25:47 INFO - Return code: 0 12:25:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:47 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 0x7f3ff5bc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9160>, '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 0xfea060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea4f0>, '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': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', '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 12:25:47 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 12:25:47 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 12:25:47 INFO - Using env: {'DISPLAY': ':0', 12:25:47 INFO - 'HOME': '/home/cltbld', 12:25:47 INFO - 'LANG': 'en_US.UTF-8', 12:25:47 INFO - 'LANGUAGE': 'en_US:en', 12:25:47 INFO - 'LOGNAME': 'cltbld', 12:25:47 INFO - 'MAIL': '/var/mail/cltbld', 12:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:47 INFO - 'MOZ_NO_REMOTE': '1', 12:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:47 INFO - 'NO_EM_RESTART': '1', 12:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:47 INFO - 'PWD': '/builds/slave/test', 12:25:47 INFO - 'SHELL': '/bin/bash', 12:25:47 INFO - 'SHLVL': '1', 12:25:47 INFO - 'TERM': 'linux', 12:25:47 INFO - 'TMOUT': '86400', 12:25:47 INFO - 'USER': 'cltbld', 12:25:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', 12:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:47 INFO - '_': '/tools/buildbot/bin/python'} 12:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:48 INFO - Downloading/unpacking jsonschema 12:25:48 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 12:25:48 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 12:25:48 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 12:25:48 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 12:25:48 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 12:25:48 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 12:25:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:25:50 INFO - Downloading/unpacking functools32 (from jsonschema) 12:25:50 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 12:25:50 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 12:25:50 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 12:25:50 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 12:25:50 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 12:25:50 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 12:25:50 INFO - Downloading functools32-3.2.3-2.tar.gz 12:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:25:50 INFO - warning: no files found matching '*.txt' 12:25:50 INFO - no previously-included directories found matching 'build' 12:25:50 INFO - no previously-included directories found matching 'dist' 12:25:50 INFO - no previously-included directories found matching '.git*' 12:25:50 INFO - Installing collected packages: jsonschema, functools32 12:25:50 INFO - Running setup.py install for functools32 12:25:50 INFO - warning: no files found matching '*.txt' 12:25:50 INFO - no previously-included directories found matching 'build' 12:25:50 INFO - no previously-included directories found matching 'dist' 12:25:50 INFO - no previously-included directories found matching '.git*' 12:25:50 INFO - Successfully installed jsonschema functools32 12:25:50 INFO - Cleaning up... 12:25:50 INFO - Return code: 0 12:25:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:50 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 0x7f3ff5bc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9160>, '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 0xfea060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea4f0>, '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': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', '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 12:25:50 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 12:25:50 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 12:25:50 INFO - Using env: {'DISPLAY': ':0', 12:25:50 INFO - 'HOME': '/home/cltbld', 12:25:50 INFO - 'LANG': 'en_US.UTF-8', 12:25:50 INFO - 'LANGUAGE': 'en_US:en', 12:25:50 INFO - 'LOGNAME': 'cltbld', 12:25:50 INFO - 'MAIL': '/var/mail/cltbld', 12:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:50 INFO - 'MOZ_NO_REMOTE': '1', 12:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:50 INFO - 'NO_EM_RESTART': '1', 12:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:50 INFO - 'PWD': '/builds/slave/test', 12:25:50 INFO - 'SHELL': '/bin/bash', 12:25:50 INFO - 'SHLVL': '1', 12:25:50 INFO - 'TERM': 'linux', 12:25:50 INFO - 'TMOUT': '86400', 12:25:50 INFO - 'USER': 'cltbld', 12:25:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', 12:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:50 INFO - '_': '/tools/buildbot/bin/python'} 12:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:50 INFO - Downloading/unpacking flake8 12:25:50 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 12:25:50 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 12:25:50 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 12:25:50 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 12:25:50 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 12:25:50 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 12:25:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:25:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:25:52 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 12:25:52 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 12:25:52 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 12:25:52 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 12:25:52 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 12:25:52 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 12:25:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:25:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:25:52 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 12:25:52 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 12:25:52 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 12:25:52 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 12:25:52 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 12:25:52 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 12:25:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:25:53 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 12:25:53 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 12:25:53 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 12:25:53 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 12:25:53 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 12:25:53 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 12:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:25:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:25:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:25:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:25:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:25:53 INFO - no previously-included directories found matching 'docs/_build' 12:25:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:25:53 INFO - Running setup.py install for pep8 12:25:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:25:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:25:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:25:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:25:53 INFO - no previously-included directories found matching 'docs/_build' 12:25:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:25:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:25:53 INFO - Cleaning up... 12:25:53 INFO - Return code: 0 12:25:53 INFO - Running post-action listener: _resource_record_post_action 12:25:53 INFO - Running post-action listener: _start_resource_monitoring 12:25:53 INFO - Starting resource monitoring. 12:25:53 INFO - ##### 12:25:53 INFO - ##### Running install step. 12:25:53 INFO - ##### 12:25:53 INFO - Running pre-action listener: _resource_record_pre_action 12:25:53 INFO - Running main action method: install 12:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:25:53 INFO - Reading from file tmpfile_stdout 12:25:53 INFO - Detecting whether we're running mozinstall >=1.0... 12:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:25:54 INFO - Reading from file tmpfile_stdout 12:25:54 INFO - Output received: 12:25:54 INFO - Usage: mozinstall [options] installer 12:25:54 INFO - Options: 12:25:54 INFO - -h, --help show this help message and exit 12:25:54 INFO - -d DEST, --destination=DEST 12:25:54 INFO - Directory to install application into. [default: 12:25:54 INFO - "/builds/slave/test"] 12:25:54 INFO - --app=APP Application being installed. [default: firefox] 12:25:54 INFO - mkdir: /builds/slave/test/build/application 12:25:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:26:06 INFO - Reading from file tmpfile_stdout 12:26:06 INFO - Output received: 12:26:06 INFO - /builds/slave/test/build/application/firefox/firefox 12:26:06 INFO - Running post-action listener: _resource_record_post_action 12:26:06 INFO - ##### 12:26:06 INFO - ##### Running run-tests step. 12:26:06 INFO - ##### 12:26:06 INFO - Running pre-action listener: _resource_record_pre_action 12:26:06 INFO - Running main action method: run_tests 12:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:26:06 INFO - Python 2.7.3 12:26:06 INFO - Return code: 0 12:26:06 INFO - grabbing minidump binary from tooltool 12:26:06 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')]} 12:26:06 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 0xfe9160>, '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 0xfea060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:26:06 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 12:26:06 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 12:26:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:26:06 INFO - Return code: 0 12:26:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:26:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:26:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:26:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:26:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:26:07 INFO - Return code: 0 12:26:07 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/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 12:26:07 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/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 12:26:07 INFO - Using env: {'DISPLAY': ':0', 12:26:07 INFO - 'HOME': '/home/cltbld', 12:26:07 INFO - 'LANG': 'en_US.UTF-8', 12:26:07 INFO - 'LANGUAGE': 'en_US:en', 12:26:07 INFO - 'LOGNAME': 'cltbld', 12:26:07 INFO - 'MAIL': '/var/mail/cltbld', 12:26:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:26:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:07 INFO - 'MOZ_NO_REMOTE': '1', 12:26:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:07 INFO - 'NO_EM_RESTART': '1', 12:26:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:07 INFO - 'PWD': '/builds/slave/test', 12:26:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:26:07 INFO - 'SHELL': '/bin/bash', 12:26:07 INFO - 'SHLVL': '1', 12:26:07 INFO - 'TERM': 'linux', 12:26:07 INFO - 'TMOUT': '86400', 12:26:07 INFO - 'USER': 'cltbld', 12:26:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463599310.759914-412528591', 12:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:07 INFO - '_': '/tools/buildbot/bin/python'} 12:26:07 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/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 12:26:08 INFO - mozversion application_buildid: 20160518011743 12:26:08 INFO - mozversion application_changeset: 45fd5912a58c6a3accd5a91e287eb90f615071cc 12:26:08 INFO - mozversion application_display_name: Firefox 12:26:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:26:08 INFO - mozversion application_name: Firefox 12:26:08 INFO - mozversion application_remotingname: firefox 12:26:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:26:08 INFO - mozversion application_vendor: Mozilla 12:26:08 INFO - mozversion application_version: 47.0 12:26:08 INFO - mozversion platform_buildid: 20160518011743 12:26:08 INFO - mozversion platform_changeset: 45fd5912a58c6a3accd5a91e287eb90f615071cc 12:26:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:26:08 INFO - mozversion platform_version: 47.0 12:26:08 INFO - using testdate: 1463599568 12:26:08 INFO - actual date: 1463599568 12:26:08 INFO - starting webserver on 'localhost:45044' 12:26:08 INFO - SUITE-START | Running 2 tests 12:26:08 INFO - TEST-START | dromaeo_css 12:26:08 INFO - operating with platform_type : linux_ 12:26:08 INFO - Initialising browser for dromaeo_css test... 12:26:08 INFO - TEST-INFO | started process 16651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg7hNna/profile http://localhost:45044/getInfo.html) 12:26:12 INFO - PROCESS | 16651 | __metrics Screen width/height:1600/1200 12:26:12 INFO - PROCESS | 16651 | colorDepth:24 12:26:12 INFO - PROCESS | 16651 | Browser inner width/height: 1024/697 12:26:12 INFO - PROCESS | 16651 | __metrics 12:26:13 INFO - PROCESS | 16651 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:26:14 INFO - TEST-INFO | 16651: exit 0 12:26:14 INFO - Browser initialized. 12:26:14 INFO - Running cycle 1/1 for dromaeo_css test... 12:26:14 INFO - TEST-INFO | started process 16742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg7hNna/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:26:26 INFO - PROCESS | 16742 | RSS: Main: 138928128 12:26:26 INFO - PROCESS | 16742 | 12:27:17 INFO - PROCESS | 16742 | 1463599637342 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] 12:29:24 INFO - PROCESS | 16742 | Cycle 1(1): loaded http://localhost:45044/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45044/tests/dromaeo/cssquery-ext.html) 12:29:26 INFO - PROCESS | 16742 | RSS: Main: 258154496 12:29:26 INFO - PROCESS | 16742 | 12:32:28 INFO - PROCESS | 16742 | Cycle 1(1): loaded http://localhost:45044/tests/dromaeo/cssquery-ext.html (next: http://localhost:45044/tests/dromaeo/cssquery-jquery.html) 12:32:28 INFO - PROCESS | 16742 | RSS: Main: 221044736 12:32:28 INFO - PROCESS | 16742 | 12:35:30 INFO - PROCESS | 16742 | Cycle 1(1): loaded http://localhost:45044/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45044/tests/dromaeo/cssquery-mootools.html) 12:35:31 INFO - PROCESS | 16742 | RSS: Main: 226603008 12:35:31 INFO - PROCESS | 16742 | 12:38:32 INFO - PROCESS | 16742 | Cycle 1(1): loaded http://localhost:45044/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45044/tests/dromaeo/cssquery-prototype.html) 12:38:33 INFO - PROCESS | 16742 | RSS: Main: 210096128 12:38:33 INFO - PROCESS | 16742 | 12:41:35 INFO - PROCESS | 16742 | Cycle 1(1): loaded http://localhost:45044/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45044/tests/dromaeo/cssquery-yui.html) 12:41:36 INFO - PROCESS | 16742 | RSS: Main: 212959232 12:41:36 INFO - PROCESS | 16742 | 12:44:38 INFO - PROCESS | 16742 | Cycle 1(1): loaded http://localhost:45044/tests/dromaeo/cssquery-yui.html (next: http://localhost:45044/tests/dromaeo/cssquery-dojo.html) 12:44:38 INFO - PROCESS | 16742 | RSS: Main: 254717952 12:44:38 INFO - PROCESS | 16742 | 12:44:38 INFO - PROCESS | 16742 | __start_tp_report 12:44:38 INFO - PROCESS | 16742 | _x_x_mozilla_page_load 12:44:38 INFO - PROCESS | 16742 | _x_x_mozilla_page_load_details 12:44:38 INFO - PROCESS | 16742 | |i|pagename|runs| 12:44:38 INFO - PROCESS | 16742 | |0;dojo.html;3281.49136883783;3324.119108436263;3335.3662804067226;3343.799372037676;3358.311546133042;5345.705986170759;5359.5444387227135;5365.704886231256;5375.865603359913;5404.810831620894;5355.437679043693;5360.115580929152;5369.677819330833;5372.140457526796;5377.919331210035;4858.587020103278;4885.535874091974;4920.3111564381015;4920.60635149189;4967.279744437054;4888.828890988816;4968.254761785725;4982.252662100677;4984.352034235562;4987.675801072936;4970.353853998975;4977.776000079987;5031.823886163985;5033.320501732256;5037.093323201822;4944.011197760445;4973.4280557735965;4990.3013578098735;4993.800247990076;5026.472220416858;4779.283107533898;4880.975595122037;4898.926516102261;4918.8770280743265;4933.161362568372;5169;5178.896422071537;5198.480151984809;5226.843194704127;5253.395859476171;5694.4590263924865;5701.486866182022;5752;5766.423357664242;5770.596058275881;5758.856028599319;5802.709864506758;5826.417358264182;5841.912371314434;5853.414658534155;5429.185622156669;5432.70120143392;5439.3200849893365;5446.809361672323;5472.097103977799;5751.798687046017;5861.120831875252;5920.200772895604;5940.168376427304;5952.255968003999;5652.349979752299;5706.400827913092;5706.743196556082;5707.143928410772;5711.371749107595;5781.479666830005;5786.594938354359;5788.18965344852;5791.247137872049;5797.130430435384;5671.546276297886;5743.483086522233;5800.303963524404;5825.912611310834;5837.09525023622;5772.567057470623;5780.21967034445;5793.362730099686;5797.594168408255;5802.245708057925;4284.871453856389;4389.539098394686;4404.2512772828695;4406;4429.955700442954;3952.2490726761825;3997.3004724173734;4013.7993100344866;4014.397840323975;4044.009217741613;5485.780568777284;5504.394516603171;5506.587005974568;5511.779528818803;5512.448755124456;5680.517156041783;5816.41835816415;5822.446867547576;5828.912566311508;5842.678652674059;5512.6968016759465;5551.833444996657;5574.386817450078;5577;5611.354694210137;5012.172991456368;5042.243663450512;5042.394912610437;5046.21783623539;5069.467705890902;5896.882062358729;6003.489703375175;6055.909161362583;6084.4828189603495;6087.026075827846;5774.624649397776;5790.7973220937065;5793.188953546591;5794.594378393641;5796.8550786229;5980.102984552352;5980.282366116094;5983.970080149571;5984.13230081627;5986.311574169026;5575.498205161392;5689.715514224189;5694;5738.110592858114;5797.623154495113;5836.387179346108;5866.061430171323;5871.970640146772;5878.441548053099;5880.353161152184;5714.285714285715;5714.828555143353;5717.085266357363;5722.2561067061015;5722.341930677859;5592.412796656293;5652.689102099424;5718.1708652246025;5728.198052272602;5758.049921762862;5581.497665209989;5622.915656265078;5623.550115990629;5646.435356464321;5664.575156863334;5619.662820230799;5715;5742.569307302053;5782.739776710142;5787.39232380594;5537.6954267515675;5553.250311207935;5580.525655319181;5652.830415087554;5678.375378708256 12:44:38 INFO - PROCESS | 16742 | |1;ext.html;541.0504564489319;563.1749487001542;566.8696199874031;569.7265312649928;589.8201048680153;31686.207844803892;39073;40656.39015414764;40723.79638101805;40737.38893916594;42753.35869961953;42786.57213427865;42998;43253.35119973195;43391;8863.601137948792;9065.864012039792;9075.500847453388;9076.228520575725;9079.273658107368;9007.324450666194;9120.726378208632;9132.452052876815;9142.451452912814;9145;9113.043130471304;9177.311701622371;9182.173604375605;9193.448393096402;9210.723678289662;9012.098790121001;9095.909040909606;9096.77258068547;9111.407758495676;9113.362064655477;8964.14840590143;9124.954375228148;9133.315001374924;9133.45199288045;9137.269018478506;42620;43315.13369732619;43347.56652433499;43347.78326108381;43348.349774753406;3633;3644.362236608583;3650.6349365063547;3858.5369755629504;4129.69027322952;32779.83610081958;32960.505592416135;33118.17204569881;33323.16692082693;33822.98531044072;4195;4259.5740425957465;4268.125034367947;4309.82760689572;4375.409319741858;210407;210541;211928;212382.93808531013;212493;47183;47500.76249618799;63339;64300;64324.678376607815;44573.33140002903;45048.3242751359;45108.09783804371;45165.774171128935;45173.32240016403;16473.176341182894;16658.50024499267;16662.50012499627;16667.91666041662;16676.499705008628;13443.731125377437;13500.324983750774;13534.255615941218;13534.661633459045;13554.864451355557;15456.536303910902;16132.919335403249;16142.515724528283;16152.192390380435;16163.67672646564;5601.411851755507;5723.771049157987;5741.626794258444;5830.212921255661;5903.173555702205;986.6546708651914;1024.7335692719946;1076.1175835814556;1111.2665640677114;1155.4973586489737;29847.95532156364;30707.2323191922;30786.69213307838;30846.845765771475;30869;1101.564881871656;1108.972275693098;1138.93166410014;1199.2564609941892;1217.7442737025146;16047.919760401122;16122.435714749927;16204.594885127966;16209.756853647204;16230.594235144215;339102;343493;343701;343792;343906;58687.413125868195;59175.70412147912;59271.11093333604;59312.40687593155;59325;1246.8192112143688;1329.1626275446406;1411.8164638596916;1423.9999999999793;1440.27266230555;27850;27991.440171196868;29260.268493287836;30135.547966780076;30382;54116.72941635267;54793.452065478836;54822.72588637031;54867.17699234435;54981.72509137429;242482;244533;245304;245382;246092;35939.820300898326;46541.76729116333;50646;51635.741821290656;52766;47169.76415117903;47313.763431182626;47985.5201447981;48812.02375952532;48893.755531222116;39769;40090.599094008685;40266.798666006485;40294;40822.387664185655;37055.814720926224;37597.43603845999;38425.6157438422;38597;38767.41848872213;39463;39642.2071558573;40036.39945400763;40335.79832100821;40581;34259.828700856335;35199.296014080086;35772.4634130483;35862.28275434529;36263.81868090748;26892.865535672197;27018;27086.864565677046;27178.7766372173;27306 12:44:38 INFO - PROCESS | 16742 | |2;jquery.html;371.8828569000766;376.3789746917586;377.5695706894141;378.5476355754872;387.8487389917931;17862.642747145048;18010.09949502526;18863;18875.62248755024;18910.527236819085;17173.914130429363;17511.73732394015;17528.649427011453;17640.647187056253;17658.38195663152;5542.0855558832845;5770.307563092435;5778.6243894146955;5788.971055144719;5790.276215473066;4215.536291007987;5675.971620141893;5976.611520251192;6179.104029915659;6276.435120839124;6186.288576813657;6194.81415557534;6208.78269260576;6213.099100630406;6214.409631085062;5939.406059394069;6161.291451483092;6177.536684748662;6187.752489900398;6191.164192833978;3841.9231615367535;5225.843224703265;5350.27771250884;5354.625176237665;5429.701366424884;20826.895865520575;20930.79069209319;21034;21267.46831329214;21312.40156988232;2327.522857814144;2374.263978166774;2538.5811341128874;2556.590945448738;2556.731543187957;12910.67723306925;13102.08285420021;13256.801147982787;13582.796258056138;13603.727925441535;1852.370194134001;1873.175802646831;1885.3212843376373;1935.2533693257328;1938.5153711572107;62463;66787;66975.66512167409;67256;67639.66180169117;9634.855477167848;9657.551367294962;9882.308238423386;10073.29486935922;10097.24270679702;13345.266010369329;13354.265515396552;13439;13503.392347344394;13652.317384130754;8224.671013159526;8261.297789687824;8300.335973122135;8361;8462.02686691026;8196.508209507449;8236.039280032332;8247.257746802816;8316.750497485085;8348.582570871433;5998.130271110665;6009.939900601025;6082.787102451393;6088.786892458743;6134.38656134383;1634.2972521815495;1724.8874475963185;1775.6271183051704;1788.320438233463;1813.5556788586616;988.1403179233969;1005.2912696548915;1032.4682788363998;1093.0927330315978;1106.6790630717162;16041.919790400972;16276.10481423533;16531.752023719655;17770.111494425226;17859;997.2869398380193;1053.3995622495104;1058.4548957287004;1058.4866339825332;1085.6146068145852;10034.494825776192;10270.383776973405;10510.737231569272;10511.52698128586;10746.677599672023;461851;463432;468037;468866;486393;45035.08650723908;45718;61545.769084618056;70443.64778176077;71146.64426677937;1054.576053455761;1066.0778426660881;1071.276888100529;1116.20749268019;1128.9887101128884;15298.158601277037;15822.920885395499;15847.128407937675;16118.435854745028;16348.18259087017;35458.29083418369;36167;36180.27639447144;36257.63742362648;36798.63201368059;49132.508674912795;52695.47304527059;52735;52779.73610131925;54303;8108.148644392254;8137.064237612751;8145.79635509117;8337.833243334979;8364.289035432057;9268.304877134107;11626.360550169484;11829.467673954865;11834.881651183377;12617.49530018789;10031.949840251043;10258.487075646337;10310.536025878704;10404.323718958243;10509.37265683579;10849.186311026546;10978.396188209725;11157.609483668033;11296.152788541056;11539.942300288445;10809.729756756144;10918.78162436731;10937.617183398543;11039.889601103887;11302.717432064264;8289.792755181168;8498.74503764888;8516.787080322794;8716.956415217883;8746.256568191775;10988.395638239974;11303.208775385645;11690;11879.584214552795;11898 12:44:38 INFO - PROCESS | 16742 | |3;mootools.html;1376.1261598884719;1538.584582162816;1540.460838706453;1779.2616064333301;1903.1911437639;8135.2678258956685;8318.792030199247;8347.248747612713;8350.95824520878;8353.457025293352;8265.338772898169;8443.62003709833;8457.873131903027;8464.06895241523;8471.407001509897;2469.1111199967995;2493.563626365388;2495.5882279423963;2495.737947515503;2497.3382053755768;2460.434100156965;2554.297568168759;2569.9357516062155;2579.3035880312304;2585.547529182395;2501.3621526510715;2515.1448507507444;2516.6979962404444;2517.811164162686;2519.0805356045003;2456.091246238894;2468.4075821802726;2479.5412848622973;2521.873906304696;2522.230719630512;2515.157422263544;2537.023246050284;2543.885525151373;2559.5264875998;2559.7056338521124;8551.529665868375;8601.870971935426;8621.65513379464;8625.827483450295;8644.394892357537;5203.453637368098;5336.279602253685;5342.332208473941;5344.064788662007;5348.224507446398;3202.3115030268605;3225.8064516129107;3292.456744637132;3296.8021918684954;3349.2129349602824;1014.5282443663658;1039.2828948025838;1043.2801367056707;1047.528612124547;1058.8200005999;11959.820602690967;11968;11985.640430787003;11994.760104797942;12015.459304331238;4848.17581011229;4854.611631069506;4914.140025495524;4931.605471562267;4938.061768264019;10332.896671033193;10339.793204135874;10353.63762268332;10396.428196449267;10417.739556511147;5462.508374246337;5465.4261302563455;5471.671699698031;5483.314585676791;5485.232067510552;4233.767142807175;4594.241950078266;4679.625629949596;4682.438107427062;4960.727160006234;3961.8811435656976;3985.780782056957;4025.4364388985564;4040.212158629039;4071.3892916062237;1284.3000564692265;1299.123091912955;1303.6414985878769;1304.6477451088153;1313.7832257677567;1418.432626949208;1427.5931359562476;1432.1970639462552;1452.5932738832933;1464.816897887764;8258.958705206556;8305.792355191048;8307.916920830836;8332.250097491255;8345.374096942754;552.1276383314354;563.8449426407689;565.8839937812738;567.1577707104946;568.4656422962402;6218.409251121137;6443.581167224209;6445.774397896051;6447.3552644735155;6451.709673064724;9380.95309523448;9506.144446999802;9554.522273886418;10157.085862272432;10520.947395263127;9397.201237894718;9431.292653050912;9431.481268530297;9441.811163776823;9450.85823712645;7687.34657554103;7688.231176882379;7866.606669666494;7885.487443316166;7890.566018869017;7988.960055199686;8053.993250843644;8058.597070146587;8099.676012959416;8115.229053239933;8688.174623410765;8764.255038321815;8952.104789521256;9036.502992335485;9052.773680658036;9058.547072646474;9061.365704400629;9207.815843683224;9253.768655783659;9280.025597312186;6900.6204658744255;7284.635768211462;7381.483296169431;7432.962835185789;7510.812229694083;8113.878291825509;8126.715564955198;8141.51150930946;8146.837063258583;8159.83680326402;6951.27011663768;7029.26192749754;7043.436525078084;7124.964375178091;7207.099112610924;6974.407175389946;6996.825079373057;7051;7099.751508697377;7101.715931362688;7445.292697193758;7519.699212031457;7545.320921117126;7556;7563.508371955805;6800.251972282946;6850.588964662136;6852.965735171292;6878.55289406187;6888.655567221519;6904;6915.654217289216;6940.167179938439;6955.095837541087;6959.930400695928 12:44:38 INFO - PROCESS | 16742 | |4;prototype.html;354.39398628345526;358.6234453823488;361.8751530721902;364.7136997456996;368.0908156852575;5987.550933679975;6088.39116088391;6094.994325936226;6109.991851344523;6124.510039196864;6012.278526576806;6035.879282414349;6037.003894357425;6084.634921904689;6099.939000609993;4554.180247555439;4620.029793743318;4709;4753.096911586805;4760.90478190436;4707.811687532495;4713.717176969376;4742.952570474303;4743;4749.715017098968;4677.953220467786;4679.719216846983;4704.764761761915;4705.129551033053;4713.34013238147;4491.9775401123115;4581.541845815425;4702.412198475191;4706.788194531255;4723.929141062887;4190.329547272452;4193.811278492475;4200.348945913388;4203.558626344251;4207.705460617758;5685.061964775807;5698.202251684767;5706.686132262724;5708.029634962025;5710.600257981943;5403.918941215885;5425.104857698475;5472.124460086367;5474.178873169017;5476.2333273341765;6272.968635156795;6291.433770960635;6330.68346582669;6333.20834895638;6364.299927008025;4369.4319738434115;4489.416375871148;4502.2796352583755;4504.256797628387;4635.281531362644;6615.305392933721;6655.134832471747;6673.099131617267;6687.431568316651;6688.899666505006;4638.1883170445035;4641.3734145889875;4652;4652.1626107300335;4655.068986202773;4700.576948074689;4706.694064885772;4718.7168769873915;4719.504452032487;4720.740359280204;5365.141577347606;5366.409694933554;5369.24830523727;5374;5377.677339359651;6307.432331090224;6425.036244563259;6432.74269029243;6447.097406363113;6458.580192287486;1596.3056070609323;1601.4074792326915;1606.4618352851692;1609.0828227909979;1621.391978008247;1037.8495118207818;1055.3298655353906;1068.2095249515457;1091.8525998990194;1101.5098281264761;6093.421124993119;6102.572819902653;6112.327643959161;6119;6176.382361763877;6544.574602650812;6557.180352455943;6562.376574225441;6564.474842012628;6567.770128045496;6162.137300777895;6176.320604733476;6180.289266734293;6217.626942383381;6232.25212974446;3498.930021399558;3545.361834869697;3545.7340699447645;3548.2193917338145;3553.431450967833;6632.204135503771;6748.156480439945;6804.76183333581;6816.420604248595;6826.726930922807;6685.130932978682;6725.19297684281;6726.22648395431;6728.394444500019;6733.225679046875;6734.225564060196;6768.627725475048;6777.830554236183;6787.0498130262795;6791.796246112624;6543.672816359258;6544.116544266463;6562;6563.704633291418;6563.835904102436;6350.809475715736;6439.227292724903;6465.1595292611655;6636.7345306189145;6647.800565983028;6915.377616014583;6947.340002699735;6964.721411143498;6967.54710943787;6971.8257043572285;4594.816207351802;4638.582527572535;4661.417322834645;4666.533346665306;4667.62658987287;6682.465402767864;6688.933110668831;6689.565178263398;6703.363180497845;6704.128463299739;6350.7777227796805;6469.126667899962;6480.773172938924;6490.643014634052;6493;6460.4508616766225;6464.967675161594;6485;6493.837654058686;6497.902531462127;6316.684165791784;6351.777687780906;6353.82454245966;6358.523110766619;6366.649834258975;6514.9348506514325;6518.543701940818;6521.836954076186;6528.183977002875;6541.08424820516;6058.212432383762;6097.359777223328;6204.968975155276;6346.555741098079;6374.565722712353 12:44:38 INFO - PROCESS | 16742 | |5;yui.html;688.4182865478671;698.8567343694543;709.407644616745;735.9264073592639;772.6909236305477;14556.927215363921;14589.635259118528;14649.85350146501;14690.779638305434;14758.92620536897;13646.522371716992;13718.451261949534;13763.724725505484;13789.379477923492;13990.510332138378;765.1545042727803;920.1856357123927;941.3739862991137;943.3113826906363;944.8393773058563;926.7868390270241;939.0281059103829;944.773254418938;944.8441007233798;946.7633091727068;807.9596020198967;987.5950860147341;991.8710567626234;993.3096497933939;993.64228877604;945.2201933404934;966.9854952175723;971.3006635222664;971.4705485510343;971.4705485510414;715.0239922505795;717.0141056047934;719;719.7408932784193;720.9495335326529;14473.348699308557;14539.491117810932;14557.053791503518;14587.48943786973;14630.34163462636;13964.301784910715;14083.85916140846;14110.365033573515;14184;14294.642009009127;10769.515371808287;10891.292066015683;11067.833982490189;11071.501782419811;11225.214235003554;3743.794091324976;3773.0755964788527;3773.5094437723196;3775.9811200944096;3781.3382658035007;49209;49227.75386123082;51608.483915160745;51951;52137;11325.37710425918;11411.48648310828;11447.713807154887;11483.885161148448;11539.307641541534;19521.219151234076;19670;19702.70445943312;19712.310069147512;19727.704084438745;8069.273765361146;8199.958325478035;8299.95850020746;8429.367797415218;8623.223909848144;4352.564743525622;4369.300911854088;4480.4623445186135;4500.144972455289;4527.207738645724;3386.153461634591;3436.831477297731;3439.226174110805;3441.7590768645955;3459.4291941829315;564.0664699921637;582.7173820697043;583.4049269744921;587.2864469669372;589.2810770859544;621.6177051113533;729.5586170366958;747.5552046532413;752.3116348541024;752.3823778875352;8567.443116197428;8767.649294028295;8890.199882010651;9030.096990300917;9097;567.537456972566;649.1269242868428;649.571282953258;651.7686221391433;672.2672287206968;3912.374020156761;4088.550259471456;4092.529359123679;4147.19129769692;4308.9353659695125;58841.41158588445;59223.40776592265;60613.69693151506;60705.39294607086;64732;51508;51868.740656296475;51978.740106299985;53303.20045199325;53371.19943200855;50086;50422.49577504252;50935.98128037419;51427.74286128546;51933.22100168501;9269.629214831331;9331.86002209981;9371.109744574254;9405.858912116188;9529.332946693665;35482;36173.81913090418;36342.63657363393;36733;37140.44289335608;39089.022774430865;39498.21003579855;42974.785126074166;43921.12157756763;44948;11660.591879284184;11949.22330048544;12115.445923328174;12152.635420937386;12223.388830558259;10553.208509361675;11959.461824217757;12048.638540843789;12268.509259629514;12907.870921290667;11621.360825154698;11657.941710291394;11919.106067045179;12173.573924912585;12214.663190178162;11260.436978150896;11563.364014979257;11622.76754464889;11637.243579167665;11817.586384476503;10374.896251037393;11711.297322160357;11714.594248690211;11816.40917954116;11933.940330298294;8927.375083744075;8995.640174392951;9650.08324209199;9978.700638980843;10019.148372388428;9735.951320243354;10349;10358.482075896025;10361.4301213434;10371.792564148825 12:44:38 INFO - PROCESS | 16742 | __end_tp_report 12:44:38 INFO - PROCESS | 16742 | __start_cc_report 12:44:38 INFO - PROCESS | 16742 | _x_x_mozilla_cycle_collect,925 12:44:38 INFO - PROCESS | 16742 | __end_cc_report 12:44:38 INFO - PROCESS | 16742 | __startTimestamp1463600678801__endTimestamp 12:44:38 INFO - PROCESS | 16742 | 12:44:38 INFO - PROCESS | 16742 | ------- Summary: start ------- 12:44:38 INFO - PROCESS | 16742 | Number of tests: 6 12:44:38 INFO - PROCESS | 16742 | 12:44:38 INFO - PROCESS | 16742 | [#0] dojo.html Cycles:165 Average:5393.42 Median:5622.92 stddev:588.09 (10.5%) stddev-sans-first:566.07 12:44:38 INFO - PROCESS | 16742 | Values: 3281.5 3324.1 3335.4 3343.8 3358.3 5345.7 5359.5 5365.7 5375.9 5404.8 5355.4 5360.1 5369.7 5372.1 5377.9 4858.6 4885.5 4920.3 4920.6 4967.3 4888.8 4968.3 4982.3 4984.4 4987.7 4970.4 4977.8 5031.8 5033.3 5037.1 4944.0 4973.4 4990.3 4993.8 5026.5 4779.3 4881.0 4898.9 4918.9 4933.2 5169.0 5178.9 5198.5 5226.8 5253.4 5694.5 5701.5 5752.0 5766.4 5770.6 5758.9 5802.7 5826.4 5841.9 5853.4 5429.2 5432.7 5439.3 5446.8 5472.1 5751.8 5861.1 5920.2 5940.2 5952.3 5652.3 5706.4 5706.7 5707.1 5711.4 5781.5 5786.6 5788.2 5791.2 5797.1 5671.5 5743.5 5800.3 5825.9 5837.1 5772.6 5780.2 5793.4 5797.6 5802.2 4284.9 4389.5 4404.3 4406.0 4430.0 3952.2 3997.3 4013.8 4014.4 4044.0 5485.8 5504.4 5506.6 5511.8 5512.4 5680.5 5816.4 5822.4 5828.9 5842.7 5512.7 5551.8 5574.4 5577.0 5611.4 5012.2 5042.2 5042.4 5046.2 5069.5 5896.9 6003.5 6055.9 6084.5 6087.0 5774.6 5790.8 5793.2 5794.6 5796.9 5980.1 5980.3 5984.0 5984.1 5986.3 5575.5 5689.7 5694.0 5738.1 5797.6 5836.4 5866.1 5872.0 5878.4 5880.4 5714.3 5714.8 5717.1 5722.3 5722.3 5592.4 5652.7 5718.2 5728.2 5758.0 5581.5 5622.9 5623.6 5646.4 5664.6 5619.7 5715.0 5742.6 5782.7 5787.4 5537.7 5553.3 5580.5 5652.8 5678.4 12:44:38 INFO - PROCESS | 16742 | 12:44:38 INFO - PROCESS | 16742 | [#1] ext.html Cycles:180 Average:45425.68 Median:40178.70 stddev:71026.19 (176.8%) stddev-sans-first:71145.48 12:44:38 INFO - PROCESS | 16742 | Values: 541.1 563.2 566.9 569.7 589.8 31686.2 39073.0 40656.4 40723.8 40737.4 42753.4 42786.6 42998.0 43253.4 43391.0 8863.6 9065.9 9075.5 9076.2 9079.3 9007.3 9120.7 9132.5 9142.5 9145.0 9113.0 9177.3 9182.2 9193.4 9210.7 9012.1 9095.9 9096.8 9111.4 9113.4 8964.1 9125.0 9133.3 9133.5 9137.3 42620.0 43315.1 43347.6 43347.8 43348.3 3633.0 3644.4 3650.6 3858.5 4129.7 32779.8 32960.5 33118.2 33323.2 33823.0 4195.0 4259.6 4268.1 4309.8 4375.4 210407.0 210541.0 211928.0 212382.9 212493.0 47183.0 47500.8 63339.0 64300.0 64324.7 44573.3 45048.3 45108.1 45165.8 45173.3 16473.2 16658.5 16662.5 16667.9 16676.5 13443.7 13500.3 13534.3 13534.7 13554.9 15456.5 16132.9 16142.5 16152.2 16163.7 5601.4 5723.8 5741.6 5830.2 5903.2 986.7 1024.7 1076.1 1111.3 1155.5 29848.0 30707.2 30786.7 30846.8 30869.0 1101.6 1109.0 1138.9 1199.3 1217.7 16047.9 16122.4 16204.6 16209.8 16230.6 339102.0 343493.0 343701.0 343792.0 343906.0 58687.4 59175.7 59271.1 59312.4 59325.0 1246.8 1329.2 1411.8 1424.0 1440.3 27850.0 27991.4 29260.3 30135.5 30382.0 54116.7 54793.5 54822.7 54867.2 54981.7 242482.0 244533.0 245304.0 245382.0 246092.0 35939.8 46541.8 50646.0 51635.7 52766.0 47169.8 47313.8 47985.5 48812.0 48893.8 39769.0 40090.6 40266.8 40294.0 40822.4 37055.8 37597.4 38425.6 38597.0 38767.4 39463.0 39642.2 40036.4 40335.8 40581.0 34259.8 35199.3 35772.5 35862.3 36263.8 26892.9 27018.0 27086.9 27178.8 27306.0 12:44:38 INFO - PROCESS | 16742 | 12:44:38 INFO - PROCESS | 16742 | [#2] jquery.html Cycles:180 Average:26484.73 Median:2456.42 stddev:76734.12 (3123.8%) stddev-sans-first:76924.33 12:44:38 INFO - PROCESS | 16742 | Values: 371.9 376.4 377.6 378.5 387.8 17862.6 18010.1 18863.0 18875.6 18910.5 17173.9 17511.7 17528.6 17640.6 17658.4 5542.1 5770.3 5778.6 5789.0 5790.3 4215.5 5676.0 5976.6 6179.1 6276.4 6186.3 6194.8 6208.8 6213.1 6214.4 5939.4 6161.3 6177.5 6187.8 6191.2 3841.9 5225.8 5350.3 5354.6 5429.7 20826.9 20930.8 21034.0 21267.5 21312.4 2327.5 2374.3 2538.6 2556.6 2556.7 12910.7 13102.1 13256.8 13582.8 13603.7 1852.4 1873.2 1885.3 1935.3 1938.5 62463.0 66787.0 66975.7 67256.0 67639.7 9634.9 9657.6 9882.3 10073.3 10097.2 13345.3 13354.3 13439.0 13503.4 13652.3 8224.7 8261.3 8300.3 8361.0 8462.0 8196.5 8236.0 8247.3 8316.8 8348.6 5998.1 6009.9 6082.8 6088.8 6134.4 1634.3 1724.9 1775.6 1788.3 1813.6 988.1 1005.3 1032.5 1093.1 1106.7 16041.9 16276.1 16531.8 17770.1 17859.0 997.3 1053.4 1058.5 1058.5 1085.6 10034.5 10270.4 10510.7 10511.5 10746.7 461851.0 463432.0 468037.0 468866.0 486393.0 45035.1 45718.0 61545.8 70443.6 71146.6 1054.6 1066.1 1071.3 1116.2 1129.0 15298.2 15822.9 15847.1 16118.4 16348.2 35458.3 36167.0 36180.3 36257.6 36798.6 49132.5 52695.5 52735.0 52779.7 54303.0 8108.1 8137.1 8145.8 8337.8 8364.3 9268.3 11626.4 11829.5 11834.9 12617.5 10031.9 10258.5 10310.5 10404.3 10509.4 10849.2 10978.4 11157.6 11296.2 11539.9 10809.7 10918.8 10937.6 11039.9 11302.7 8289.8 8498.7 8516.8 8717.0 8746.3 10988.4 11303.2 11690.0 11879.6 11898.0 12:44:38 INFO - PROCESS | 16742 | 12:44:38 INFO - PROCESS | 16742 | [#3] mootools.html Cycles:180 Average:5906.21 Median:567.81 stddev:3060.24 (539.0%) stddev-sans-first:3049.88 12:44:38 INFO - PROCESS | 16742 | Values: 1376.1 1538.6 1540.5 1779.3 1903.2 8135.3 8318.8 8347.2 8351.0 8353.5 8265.3 8443.6 8457.9 8464.1 8471.4 2469.1 2493.6 2495.6 2495.7 2497.3 2460.4 2554.3 2569.9 2579.3 2585.5 2501.4 2515.1 2516.7 2517.8 2519.1 2456.1 2468.4 2479.5 2521.9 2522.2 2515.2 2537.0 2543.9 2559.5 2559.7 8551.5 8601.9 8621.7 8625.8 8644.4 5203.5 5336.3 5342.3 5344.1 5348.2 3202.3 3225.8 3292.5 3296.8 3349.2 1014.5 1039.3 1043.3 1047.5 1058.8 11959.8 11968.0 11985.6 11994.8 12015.5 4848.2 4854.6 4914.1 4931.6 4938.1 10332.9 10339.8 10353.6 10396.4 10417.7 5462.5 5465.4 5471.7 5483.3 5485.2 4233.8 4594.2 4679.6 4682.4 4960.7 3961.9 3985.8 4025.4 4040.2 4071.4 1284.3 1299.1 1303.6 1304.6 1313.8 1418.4 1427.6 1432.2 1452.6 1464.8 8259.0 8305.8 8307.9 8332.3 8345.4 552.1 563.8 565.9 567.2 568.5 6218.4 6443.6 6445.8 6447.4 6451.7 9381.0 9506.1 9554.5 10157.1 10520.9 9397.2 9431.3 9431.5 9441.8 9450.9 7687.3 7688.2 7866.6 7885.5 7890.6 7989.0 8054.0 8058.6 8099.7 8115.2 8688.2 8764.3 8952.1 9036.5 9052.8 9058.5 9061.4 9207.8 9253.8 9280.0 6900.6 7284.6 7381.5 7433.0 7510.8 8113.9 8126.7 8141.5 8146.8 8159.8 6951.3 7029.3 7043.4 7125.0 7207.1 6974.4 6996.8 7051.0 7099.8 7101.7 7445.3 7519.7 7545.3 7556.0 7563.5 6800.3 6850.6 6853.0 6878.6 6888.7 6904.0 6915.7 6940.2 6955.1 6959.9 12:44:38 INFO - PROCESS | 16742 | 12:44:38 INFO - PROCESS | 16742 | [#4] prototype.html Cycles:180 Average:5387.66 Median:6101.26 stddev:1604.37 (26.3%) stddev-sans-first:1563.76 12:44:38 INFO - PROCESS | 16742 | Values: 354.4 358.6 361.9 364.7 368.1 5987.6 6088.4 6095.0 6110.0 6124.5 6012.3 6035.9 6037.0 6084.6 6099.9 4554.2 4620.0 4709.0 4753.1 4760.9 4707.8 4713.7 4743.0 4743.0 4749.7 4678.0 4679.7 4704.8 4705.1 4713.3 4492.0 4581.5 4702.4 4706.8 4723.9 4190.3 4193.8 4200.3 4203.6 4207.7 5685.1 5698.2 5706.7 5708.0 5710.6 5403.9 5425.1 5472.1 5474.2 5476.2 6273.0 6291.4 6330.7 6333.2 6364.3 4369.4 4489.4 4502.3 4504.3 4635.3 6615.3 6655.1 6673.1 6687.4 6688.9 4638.2 4641.4 4652.0 4652.2 4655.1 4700.6 4706.7 4718.7 4719.5 4720.7 5365.1 5366.4 5369.2 5374.0 5377.7 6307.4 6425.0 6432.7 6447.1 6458.6 1596.3 1601.4 1606.5 1609.1 1621.4 1037.8 1055.3 1068.2 1091.9 1101.5 6093.4 6102.6 6112.3 6119.0 6176.4 6544.6 6557.2 6562.4 6564.5 6567.8 6162.1 6176.3 6180.3 6217.6 6232.3 3498.9 3545.4 3545.7 3548.2 3553.4 6632.2 6748.2 6804.8 6816.4 6826.7 6685.1 6725.2 6726.2 6728.4 6733.2 6734.2 6768.6 6777.8 6787.0 6791.8 6543.7 6544.1 6562.0 6563.7 6563.8 6350.8 6439.2 6465.2 6636.7 6647.8 6915.4 6947.3 6964.7 6967.5 6971.8 4594.8 4638.6 4661.4 4666.5 4667.6 6682.5 6688.9 6689.6 6703.4 6704.1 6350.8 6469.1 6480.8 6490.6 6493.0 6460.5 6465.0 6485.0 6493.8 6497.9 6316.7 6351.8 6353.8 6358.5 6366.6 6514.9 6518.5 6521.8 6528.2 6541.1 6058.2 6097.4 6205.0 6346.6 6374.6 12:44:38 INFO - PROCESS | 16742 | 12:44:38 INFO - PROCESS | 16742 | [#5] yui.html Cycles:180 Average:14469.71 Median:24200.79 stddev:16585.84 (68.5%) stddev-sans-first:16600.08 12:44:38 INFO - PROCESS | 16742 | Values: 688.4 698.9 709.4 735.9 772.7 14556.9 14589.6 14649.9 14690.8 14758.9 13646.5 13718.5 13763.7 13789.4 13990.5 765.2 920.2 941.4 943.3 944.8 926.8 939.0 944.8 944.8 946.8 808.0 987.6 991.9 993.3 993.6 945.2 967.0 971.3 971.5 971.5 715.0 717.0 719.0 719.7 720.9 14473.3 14539.5 14557.1 14587.5 14630.3 13964.3 14083.9 14110.4 14184.0 14294.6 10769.5 10891.3 11067.8 11071.5 11225.2 3743.8 3773.1 3773.5 3776.0 3781.3 49209.0 49227.8 51608.5 51951.0 52137.0 11325.4 11411.5 11447.7 11483.9 11539.3 19521.2 19670.0 19702.7 19712.3 19727.7 8069.3 8200.0 8300.0 8429.4 8623.2 4352.6 4369.3 4480.5 4500.1 4527.2 3386.2 3436.8 3439.2 3441.8 3459.4 564.1 582.7 583.4 587.3 589.3 621.6 729.6 747.6 752.3 752.4 8567.4 8767.6 8890.2 9030.1 9097.0 567.5 649.1 649.6 651.8 672.3 3912.4 4088.6 4092.5 4147.2 4308.9 58841.4 59223.4 60613.7 60705.4 64732.0 51508.0 51868.7 51978.7 53303.2 53371.2 50086.0 50422.5 50936.0 51427.7 51933.2 9269.6 9331.9 9371.1 9405.9 9529.3 35482.0 36173.8 36342.6 36733.0 37140.4 39089.0 39498.2 42974.8 43921.1 44948.0 11660.6 11949.2 12115.4 12152.6 12223.4 10553.2 11959.5 12048.6 12268.5 12907.9 11621.4 11657.9 11919.1 12173.6 12214.7 11260.4 11563.4 11622.8 11637.2 11817.6 10374.9 11711.3 11714.6 11816.4 11933.9 8927.4 8995.6 9650.1 9978.7 10019.1 9736.0 10349.0 10358.5 10361.4 10371.8 12:44:38 INFO - PROCESS | 16742 | -------- Summary: end -------- 12:44:38 INFO - PROCESS | 16742 | 12:44:39 INFO - TEST-INFO | 16742: exit 0 12:44:39 INFO - TEST-OK | dromaeo_css | took 1111441ms 12:44:39 INFO - TEST-START | kraken 12:44:39 INFO - operating with platform_type : linux_ 12:44:39 INFO - Initialising browser for kraken test... 12:44:39 INFO - TEST-INFO | started process 16934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuRGpxX/profile http://localhost:45044/getInfo.html) 12:44:43 INFO - PROCESS | 16934 | __metrics Screen width/height:1600/1200 12:44:43 INFO - PROCESS | 16934 | colorDepth:24 12:44:43 INFO - PROCESS | 16934 | Browser inner width/height: 1024/697 12:44:43 INFO - PROCESS | 16934 | __metrics 12:44:44 INFO - PROCESS | 16934 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:44:45 INFO - TEST-INFO | 16934: exit 0 12:44:45 INFO - Browser initialized. 12:44:45 INFO - Running cycle 1/1 for kraken test... 12:44:45 INFO - TEST-INFO | started process 17025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuRGpxX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:57 INFO - PROCESS | 17025 | RSS: Main: 139337728 12:44:57 INFO - PROCESS | 17025 | 12:44:59 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45044/tests/kraken/driver.html?testName=audio-beat-detection) 12:45:00 INFO - PROCESS | 17025 | RSS: Main: 173768704 12:45:00 INFO - PROCESS | 17025 | 12:45:03 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45044/tests/kraken/driver.html?testName=audio-dft) 12:45:03 INFO - PROCESS | 17025 | RSS: Main: 172363776 12:45:03 INFO - PROCESS | 17025 | 12:45:06 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45044/tests/kraken/driver.html?testName=audio-fft) 12:45:06 INFO - PROCESS | 17025 | RSS: Main: 169652224 12:45:06 INFO - PROCESS | 17025 | 12:45:09 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45044/tests/kraken/driver.html?testName=audio-oscillator) 12:45:09 INFO - PROCESS | 17025 | RSS: Main: 169877504 12:45:09 INFO - PROCESS | 17025 | 12:45:11 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45044/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:45:12 INFO - PROCESS | 17025 | RSS: Main: 167858176 12:45:12 INFO - PROCESS | 17025 | 12:45:15 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45044/tests/kraken/driver.html?testName=imaging-darkroom) 12:45:15 INFO - PROCESS | 17025 | RSS: Main: 167550976 12:45:15 INFO - PROCESS | 17025 | 12:45:19 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45044/tests/kraken/driver.html?testName=imaging-desaturate) 12:45:19 INFO - PROCESS | 17025 | RSS: Main: 168022016 12:45:19 INFO - PROCESS | 17025 | 12:45:22 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45044/tests/kraken/driver.html?testName=json-parse-financial) 12:45:23 INFO - PROCESS | 17025 | RSS: Main: 167673856 12:45:23 INFO - PROCESS | 17025 | 12:45:24 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45044/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:45:25 INFO - PROCESS | 17025 | RSS: Main: 173756416 12:45:25 INFO - PROCESS | 17025 | 12:45:27 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45044/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:45:27 INFO - PROCESS | 17025 | RSS: Main: 172040192 12:45:27 INFO - PROCESS | 17025 | 12:45:29 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45044/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:45:30 INFO - PROCESS | 17025 | RSS: Main: 178208768 12:45:30 INFO - PROCESS | 17025 | 12:45:32 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:45:33 INFO - PROCESS | 17025 | RSS: Main: 181432320 12:45:33 INFO - PROCESS | 17025 | 12:45:36 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:45:36 INFO - PROCESS | 17025 | RSS: Main: 180334592 12:45:36 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:45044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45044/tests/kraken/driver.html?testName=ai-astar) 12:45:38 INFO - PROCESS | 17025 | RSS: Main: 242622464 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | __start_tp_report 12:45:38 INFO - PROCESS | 17025 | _x_x_mozilla_page_load 12:45:38 INFO - PROCESS | 17025 | _x_x_mozilla_page_load_details 12:45:38 INFO - PROCESS | 17025 | |i|pagename|runs| 12:45:38 INFO - PROCESS | 17025 | |0;ai-astar;112;110;107;111;113;113;99;110;112;110 12:45:38 INFO - PROCESS | 17025 | |1;audio-beat-detection;155;126;152;176;127;157;155;144;176;128 12:45:38 INFO - PROCESS | 17025 | |2;audio-dft;164;163;164;162;162;163;163;165;161;162 12:45:38 INFO - PROCESS | 17025 | |3;audio-fft;77;78;76;159;75;78;76;75;179;76 12:45:38 INFO - PROCESS | 17025 | |4;audio-oscillator;95;95;143;94;93;93;135;94;94;143 12:45:38 INFO - PROCESS | 17025 | |5;imaging-gaussian-blur;117;117;118;117;117;116;116;117;117;116 12:45:38 INFO - PROCESS | 17025 | |6;imaging-darkroom;146;146;146;145;146;147;146;146;147;145 12:45:38 INFO - PROCESS | 17025 | |7;imaging-desaturate;96;95;95;95;96;96;96;95;96;95 12:45:38 INFO - PROCESS | 17025 | |8;json-parse-financial;58;59;58;58;60;57;58;57;56;55 12:45:38 INFO - PROCESS | 17025 | |9;json-stringify-tinderbox;77;77;77;77;77;78;79;77;77;77 12:45:38 INFO - PROCESS | 17025 | |10;stanford-crypto-aes;79;78;79;79;77;90;79;78;79;81 12:45:38 INFO - PROCESS | 17025 | |11;stanford-crypto-ccm;115;120;117;116;132;115;111;114;123;129 12:45:38 INFO - PROCESS | 17025 | |12;stanford-crypto-pbkdf2;142;143;154;158;156;142;148;154;152;156 12:45:38 INFO - PROCESS | 17025 | |13;stanford-crypto-sha256-iterative;70;72;73;69;74;69;69;72;69;70 12:45:38 INFO - PROCESS | 17025 | __end_tp_report 12:45:38 INFO - PROCESS | 17025 | __start_cc_report 12:45:38 INFO - PROCESS | 17025 | _x_x_mozilla_cycle_collect,1069 12:45:38 INFO - PROCESS | 17025 | __end_cc_report 12:45:38 INFO - PROCESS | 17025 | __startTimestamp1463600738619__endTimestamp 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | ------- Summary: start ------- 12:45:38 INFO - PROCESS | 17025 | Number of tests: 14 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#0] ai-astar Cycles:10 Average:109.70 Median:112.00 stddev:4.16 (3.7%) stddev-sans-first:4.33 12:45:38 INFO - PROCESS | 17025 | Values: 112.0 110.0 107.0 111.0 113.0 113.0 99.0 110.0 112.0 110.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:155.00 stddev:18.49 (11.9%) stddev-sans-first:19.51 12:45:38 INFO - PROCESS | 17025 | Values: 155.0 126.0 152.0 176.0 127.0 157.0 155.0 144.0 176.0 128.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 12:45:38 INFO - PROCESS | 17025 | Values: 164.0 163.0 164.0 162.0 162.0 163.0 163.0 165.0 161.0 162.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:39.35 (51.8%) stddev-sans-first:41.20 12:45:38 INFO - PROCESS | 17025 | Values: 77.0 78.0 76.0 159.0 75.0 78.0 76.0 75.0 179.0 76.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:94.00 stddev:22.50 (23.9%) stddev-sans-first:23.37 12:45:38 INFO - PROCESS | 17025 | Values: 95.0 95.0 143.0 94.0 93.0 93.0 135.0 94.0 94.0 143.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 12:45:38 INFO - PROCESS | 17025 | Values: 117.0 117.0 118.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 12:45:38 INFO - PROCESS | 17025 | Values: 146.0 146.0 146.0 145.0 146.0 147.0 146.0 146.0 147.0 145.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:45:38 INFO - PROCESS | 17025 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.43 (2.5%) stddev-sans-first:1.51 12:45:38 INFO - PROCESS | 17025 | Values: 58.0 59.0 58.0 58.0 60.0 57.0 58.0 57.0 56.0 55.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#9] json-stringify-tinderbox Cycles:10 Average:77.30 Median:77.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 12:45:38 INFO - PROCESS | 17025 | Values: 77.0 77.0 77.0 77.0 77.0 78.0 79.0 77.0 77.0 77.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:3.70 (4.7%) stddev-sans-first:3.91 12:45:38 INFO - PROCESS | 17025 | Values: 79.0 78.0 79.0 79.0 77.0 90.0 79.0 78.0 79.0 81.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:118.50 stddev:6.83 (5.8%) stddev-sans-first:7.07 12:45:38 INFO - PROCESS | 17025 | Values: 115.0 120.0 117.0 116.0 132.0 115.0 111.0 114.0 123.0 129.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:154.00 stddev:6.24 (4.1%) stddev-sans-first:5.81 12:45:38 INFO - PROCESS | 17025 | Values: 142.0 143.0 154.0 158.0 156.0 142.0 148.0 154.0 152.0 156.0 12:45:38 INFO - PROCESS | 17025 | 12:45:38 INFO - PROCESS | 17025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:1.89 (2.7%) stddev-sans-first:1.99 12:45:38 INFO - PROCESS | 17025 | Values: 70.0 72.0 73.0 69.0 74.0 69.0 69.0 72.0 69.0 70.0 12:45:38 INFO - PROCESS | 17025 | -------- Summary: end -------- 12:45:38 INFO - PROCESS | 17025 | 12:45:39 INFO - TEST-INFO | 17025: exit 0 12:45:39 INFO - TEST-OK | kraken | took 60120ms 12:45:39 INFO - SUITE-END | took 1171s 12:45:39 INFO - Completed test suite (00:19:31) 12:45:39 INFO - javascript benchmark 12:45:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3281.49136883783, 3324.119108436263, 3335.3662804067226, 3343.799372037676, 3358.311546133042, 5345.705986170759, 5359.5444387227135, 5365.704886231256, 5375.865603359913, 5404.810831620894, 5355.437679043693, 5360.115580929152, 5369.677819330833, 5372.140457526796, 5377.919331210035, 4858.587020103278, 4885.535874091974, 4920.3111564381015, 4920.60635149189, 4967.279744437054, 4888.828890988816, 4968.254761785725, 4982.252662100677, 4984.352034235562, 4987.675801072936, 4970.353853998975, 4977.776000079987, 5031.823886163985, 5033.320501732256, 5037.093323201822, 4944.011197760445, 4973.4280557735965, 4990.3013578098735, 4993.800247990076, 5026.472220416858, 4779.283107533898, 4880.975595122037, 4898.926516102261, 4918.8770280743265, 4933.161362568372, 5169.0, 5178.896422071537, 5198.480151984809, 5226.843194704127, 5253.395859476171, 5694.4590263924865, 5701.486866182022, 5752.0, 5766.423357664242, 5770.596058275881, 5758.856028599319, 5802.709864506758, 5826.417358264182, 5841.912371314434, 5853.414658534155, 5429.185622156669, 5432.70120143392, 5439.3200849893365, 5446.809361672323, 5472.097103977799, 5751.798687046017, 5861.120831875252, 5920.200772895604, 5940.168376427304, 5952.255968003999, 5652.349979752299, 5706.400827913092, 5706.743196556082, 5707.143928410772, 5711.371749107595, 5781.479666830005, 5786.594938354359, 5788.18965344852, 5791.247137872049, 5797.130430435384, 5671.546276297886, 5743.483086522233, 5800.303963524404, 5825.912611310834, 5837.09525023622, 5772.567057470623, 5780.21967034445, 5793.362730099686, 5797.594168408255, 5802.245708057925, 4284.871453856389, 4389.539098394686, 4404.2512772828695, 4406.0, 4429.955700442954, 3952.2490726761825, 3997.3004724173734, 4013.7993100344866, 4014.397840323975, 4044.009217741613, 5485.780568777284, 5504.394516603171, 5506.587005974568, 5511.779528818803, 5512.448755124456, 5680.517156041783, 5816.41835816415, 5822.446867547576, 5828.912566311508, 5842.678652674059, 5512.6968016759465, 5551.833444996657, 5574.386817450078, 5577.0, 5611.354694210137, 5012.172991456368, 5042.243663450512, 5042.394912610437, 5046.21783623539, 5069.467705890902, 5896.882062358729, 6003.489703375175, 6055.909161362583, 6084.4828189603495, 6087.026075827846, 5774.624649397776, 5790.7973220937065, 5793.188953546591, 5794.594378393641, 5796.8550786229, 5980.102984552352, 5980.282366116094, 5983.970080149571, 5984.13230081627, 5986.311574169026, 5575.498205161392, 5689.715514224189, 5694.0, 5738.110592858114, 5797.623154495113, 5836.387179346108, 5866.061430171323, 5871.970640146772, 5878.441548053099, 5880.353161152184, 5714.285714285715, 5714.828555143353, 5717.085266357363, 5722.2561067061015, 5722.341930677859, 5592.412796656293, 5652.689102099424, 5718.1708652246025, 5728.198052272602, 5758.049921762862, 5581.497665209989, 5622.915656265078, 5623.550115990629, 5646.435356464321, 5664.575156863334, 5619.662820230799, 5715.0, 5742.569307302053, 5782.739776710142, 5787.39232380594, 5537.6954267515675, 5553.250311207935, 5580.525655319181, 5652.830415087554, 5678.375378708256], "unit": "score", "name": "dojo.html", "value": 5356.1690962272305}, {"lowerIsBetter": false, "replicates": [541.0504564489319, 563.1749487001542, 566.8696199874031, 569.7265312649928, 589.8201048680153, 31686.207844803892, 39073.0, 40656.39015414764, 40723.79638101805, 40737.38893916594, 42753.35869961953, 42786.57213427865, 42998.0, 43253.35119973195, 43391.0, 8863.601137948792, 9065.864012039792, 9075.500847453388, 9076.228520575725, 9079.273658107368, 9007.324450666194, 9120.726378208632, 9132.452052876815, 9142.451452912814, 9145.0, 9113.043130471304, 9177.311701622371, 9182.173604375605, 9193.448393096402, 9210.723678289662, 9012.098790121001, 9095.909040909606, 9096.77258068547, 9111.407758495676, 9113.362064655477, 8964.14840590143, 9124.954375228148, 9133.315001374924, 9133.45199288045, 9137.269018478506, 42620.0, 43315.13369732619, 43347.56652433499, 43347.78326108381, 43348.349774753406, 3633.0, 3644.362236608583, 3650.6349365063547, 3858.5369755629504, 4129.69027322952, 32779.83610081958, 32960.505592416135, 33118.17204569881, 33323.16692082693, 33822.98531044072, 4195.0, 4259.5740425957465, 4268.125034367947, 4309.82760689572, 4375.409319741858, 210407.0, 210541.0, 211928.0, 212382.93808531013, 212493.0, 47183.0, 47500.76249618799, 63339.0, 64300.0, 64324.678376607815, 44573.33140002903, 45048.3242751359, 45108.09783804371, 45165.774171128935, 45173.32240016403, 16473.176341182894, 16658.50024499267, 16662.50012499627, 16667.91666041662, 16676.499705008628, 13443.731125377437, 13500.324983750774, 13534.255615941218, 13534.661633459045, 13554.864451355557, 15456.536303910902, 16132.919335403249, 16142.515724528283, 16152.192390380435, 16163.67672646564, 5601.411851755507, 5723.771049157987, 5741.626794258444, 5830.212921255661, 5903.173555702205, 986.6546708651914, 1024.7335692719946, 1076.1175835814556, 1111.2665640677114, 1155.4973586489737, 29847.95532156364, 30707.2323191922, 30786.69213307838, 30846.845765771475, 30869.0, 1101.564881871656, 1108.972275693098, 1138.93166410014, 1199.2564609941892, 1217.7442737025146, 16047.919760401122, 16122.435714749927, 16204.594885127966, 16209.756853647204, 16230.594235144215, 339102.0, 343493.0, 343701.0, 343792.0, 343906.0, 58687.413125868195, 59175.70412147912, 59271.11093333604, 59312.40687593155, 59325.0, 1246.8192112143688, 1329.1626275446406, 1411.8164638596916, 1423.9999999999793, 1440.27266230555, 27850.0, 27991.440171196868, 29260.268493287836, 30135.547966780076, 30382.0, 54116.72941635267, 54793.452065478836, 54822.72588637031, 54867.17699234435, 54981.72509137429, 242482.0, 244533.0, 245304.0, 245382.0, 246092.0, 35939.820300898326, 46541.76729116333, 50646.0, 51635.741821290656, 52766.0, 47169.76415117903, 47313.763431182626, 47985.5201447981, 48812.02375952532, 48893.755531222116, 39769.0, 40090.599094008685, 40266.798666006485, 40294.0, 40822.387664185655, 37055.814720926224, 37597.43603845999, 38425.6157438422, 38597.0, 38767.41848872213, 39463.0, 39642.2071558573, 40036.39945400763, 40335.79832100821, 40581.0, 34259.828700856335, 35199.296014080086, 35772.4634130483, 35862.28275434529, 36263.81868090748, 26892.865535672197, 27018.0, 27086.864565677046, 27178.7766372173, 27306.0], "unit": "score", "name": "ext.html", "value": 19127.496997963546}, {"lowerIsBetter": false, "replicates": [371.8828569000766, 376.3789746917586, 377.5695706894141, 378.5476355754872, 387.8487389917931, 17862.642747145048, 18010.09949502526, 18863.0, 18875.62248755024, 18910.527236819085, 17173.914130429363, 17511.73732394015, 17528.649427011453, 17640.647187056253, 17658.38195663152, 5542.0855558832845, 5770.307563092435, 5778.6243894146955, 5788.971055144719, 5790.276215473066, 4215.536291007987, 5675.971620141893, 5976.611520251192, 6179.104029915659, 6276.435120839124, 6186.288576813657, 6194.81415557534, 6208.78269260576, 6213.099100630406, 6214.409631085062, 5939.406059394069, 6161.291451483092, 6177.536684748662, 6187.752489900398, 6191.164192833978, 3841.9231615367535, 5225.843224703265, 5350.27771250884, 5354.625176237665, 5429.701366424884, 20826.895865520575, 20930.79069209319, 21034.0, 21267.46831329214, 21312.40156988232, 2327.522857814144, 2374.263978166774, 2538.5811341128874, 2556.590945448738, 2556.731543187957, 12910.67723306925, 13102.08285420021, 13256.801147982787, 13582.796258056138, 13603.727925441535, 1852.370194134001, 1873.175802646831, 1885.3212843376373, 1935.2533693257328, 1938.5153711572107, 62463.0, 66787.0, 66975.66512167409, 67256.0, 67639.66180169117, 9634.855477167848, 9657.551367294962, 9882.308238423386, 10073.29486935922, 10097.24270679702, 13345.266010369329, 13354.265515396552, 13439.0, 13503.392347344394, 13652.317384130754, 8224.671013159526, 8261.297789687824, 8300.335973122135, 8361.0, 8462.02686691026, 8196.508209507449, 8236.039280032332, 8247.257746802816, 8316.750497485085, 8348.582570871433, 5998.130271110665, 6009.939900601025, 6082.787102451393, 6088.786892458743, 6134.38656134383, 1634.2972521815495, 1724.8874475963185, 1775.6271183051704, 1788.320438233463, 1813.5556788586616, 988.1403179233969, 1005.2912696548915, 1032.4682788363998, 1093.0927330315978, 1106.6790630717162, 16041.919790400972, 16276.10481423533, 16531.752023719655, 17770.111494425226, 17859.0, 997.2869398380193, 1053.3995622495104, 1058.4548957287004, 1058.4866339825332, 1085.6146068145852, 10034.494825776192, 10270.383776973405, 10510.737231569272, 10511.52698128586, 10746.677599672023, 461851.0, 463432.0, 468037.0, 468866.0, 486393.0, 45035.08650723908, 45718.0, 61545.769084618056, 70443.64778176077, 71146.64426677937, 1054.576053455761, 1066.0778426660881, 1071.276888100529, 1116.20749268019, 1128.9887101128884, 15298.158601277037, 15822.920885395499, 15847.128407937675, 16118.435854745028, 16348.18259087017, 35458.29083418369, 36167.0, 36180.27639447144, 36257.63742362648, 36798.63201368059, 49132.508674912795, 52695.47304527059, 52735.0, 52779.73610131925, 54303.0, 8108.148644392254, 8137.064237612751, 8145.79635509117, 8337.833243334979, 8364.289035432057, 9268.304877134107, 11626.360550169484, 11829.467673954865, 11834.881651183377, 12617.49530018789, 10031.949840251043, 10258.487075646337, 10310.536025878704, 10404.323718958243, 10509.37265683579, 10849.186311026546, 10978.396188209725, 11157.609483668033, 11296.152788541056, 11539.942300288445, 10809.729756756144, 10918.78162436731, 10937.617183398543, 11039.889601103887, 11302.717432064264, 8289.792755181168, 8498.74503764888, 8516.787080322794, 8716.956415217883, 8746.256568191775, 10988.395638239974, 11303.208775385645, 11690.0, 11879.584214552795, 11898.0], "unit": "score", "name": "jquery.html", "value": 8868.219728425589}, {"lowerIsBetter": false, "replicates": [1376.1261598884719, 1538.584582162816, 1540.460838706453, 1779.2616064333301, 1903.1911437639, 8135.2678258956685, 8318.792030199247, 8347.248747612713, 8350.95824520878, 8353.457025293352, 8265.338772898169, 8443.62003709833, 8457.873131903027, 8464.06895241523, 8471.407001509897, 2469.1111199967995, 2493.563626365388, 2495.5882279423963, 2495.737947515503, 2497.3382053755768, 2460.434100156965, 2554.297568168759, 2569.9357516062155, 2579.3035880312304, 2585.547529182395, 2501.3621526510715, 2515.1448507507444, 2516.6979962404444, 2517.811164162686, 2519.0805356045003, 2456.091246238894, 2468.4075821802726, 2479.5412848622973, 2521.873906304696, 2522.230719630512, 2515.157422263544, 2537.023246050284, 2543.885525151373, 2559.5264875998, 2559.7056338521124, 8551.529665868375, 8601.870971935426, 8621.65513379464, 8625.827483450295, 8644.394892357537, 5203.453637368098, 5336.279602253685, 5342.332208473941, 5344.064788662007, 5348.224507446398, 3202.3115030268605, 3225.8064516129107, 3292.456744637132, 3296.8021918684954, 3349.2129349602824, 1014.5282443663658, 1039.2828948025838, 1043.2801367056707, 1047.528612124547, 1058.8200005999, 11959.820602690967, 11968.0, 11985.640430787003, 11994.760104797942, 12015.459304331238, 4848.17581011229, 4854.611631069506, 4914.140025495524, 4931.605471562267, 4938.061768264019, 10332.896671033193, 10339.793204135874, 10353.63762268332, 10396.428196449267, 10417.739556511147, 5462.508374246337, 5465.4261302563455, 5471.671699698031, 5483.314585676791, 5485.232067510552, 4233.767142807175, 4594.241950078266, 4679.625629949596, 4682.438107427062, 4960.727160006234, 3961.8811435656976, 3985.780782056957, 4025.4364388985564, 4040.212158629039, 4071.3892916062237, 1284.3000564692265, 1299.123091912955, 1303.6414985878769, 1304.6477451088153, 1313.7832257677567, 1418.432626949208, 1427.5931359562476, 1432.1970639462552, 1452.5932738832933, 1464.816897887764, 8258.958705206556, 8305.792355191048, 8307.916920830836, 8332.250097491255, 8345.374096942754, 552.1276383314354, 563.8449426407689, 565.8839937812738, 567.1577707104946, 568.4656422962402, 6218.409251121137, 6443.581167224209, 6445.774397896051, 6447.3552644735155, 6451.709673064724, 9380.95309523448, 9506.144446999802, 9554.522273886418, 10157.085862272432, 10520.947395263127, 9397.201237894718, 9431.292653050912, 9431.481268530297, 9441.811163776823, 9450.85823712645, 7687.34657554103, 7688.231176882379, 7866.606669666494, 7885.487443316166, 7890.566018869017, 7988.960055199686, 8053.993250843644, 8058.597070146587, 8099.676012959416, 8115.229053239933, 8688.174623410765, 8764.255038321815, 8952.104789521256, 9036.502992335485, 9052.773680658036, 9058.547072646474, 9061.365704400629, 9207.815843683224, 9253.768655783659, 9280.025597312186, 6900.6204658744255, 7284.635768211462, 7381.483296169431, 7432.962835185789, 7510.812229694083, 8113.878291825509, 8126.715564955198, 8141.51150930946, 8146.837063258583, 8159.83680326402, 6951.27011663768, 7029.26192749754, 7043.436525078084, 7124.964375178091, 7207.099112610924, 6974.407175389946, 6996.825079373057, 7051.0, 7099.751508697377, 7101.715931362688, 7445.292697193758, 7519.699212031457, 7545.320921117126, 7556.0, 7563.508371955805, 6800.251972282946, 6850.588964662136, 6852.965735171292, 6878.55289406187, 6888.655567221519, 6904.0, 6915.654217289216, 6940.167179938439, 6955.095837541087, 6959.930400695928], "unit": "score", "name": "mootools.html", "value": 4791.898417524781}, {"lowerIsBetter": false, "replicates": [354.39398628345526, 358.6234453823488, 361.8751530721902, 364.7136997456996, 368.0908156852575, 5987.550933679975, 6088.39116088391, 6094.994325936226, 6109.991851344523, 6124.510039196864, 6012.278526576806, 6035.879282414349, 6037.003894357425, 6084.634921904689, 6099.939000609993, 4554.180247555439, 4620.029793743318, 4709.0, 4753.096911586805, 4760.90478190436, 4707.811687532495, 4713.717176969376, 4742.952570474303, 4743.0, 4749.715017098968, 4677.953220467786, 4679.719216846983, 4704.764761761915, 4705.129551033053, 4713.34013238147, 4491.9775401123115, 4581.541845815425, 4702.412198475191, 4706.788194531255, 4723.929141062887, 4190.329547272452, 4193.811278492475, 4200.348945913388, 4203.558626344251, 4207.705460617758, 5685.061964775807, 5698.202251684767, 5706.686132262724, 5708.029634962025, 5710.600257981943, 5403.918941215885, 5425.104857698475, 5472.124460086367, 5474.178873169017, 5476.2333273341765, 6272.968635156795, 6291.433770960635, 6330.68346582669, 6333.20834895638, 6364.299927008025, 4369.4319738434115, 4489.416375871148, 4502.2796352583755, 4504.256797628387, 4635.281531362644, 6615.305392933721, 6655.134832471747, 6673.099131617267, 6687.431568316651, 6688.899666505006, 4638.1883170445035, 4641.3734145889875, 4652.0, 4652.1626107300335, 4655.068986202773, 4700.576948074689, 4706.694064885772, 4718.7168769873915, 4719.504452032487, 4720.740359280204, 5365.141577347606, 5366.409694933554, 5369.24830523727, 5374.0, 5377.677339359651, 6307.432331090224, 6425.036244563259, 6432.74269029243, 6447.097406363113, 6458.580192287486, 1596.3056070609323, 1601.4074792326915, 1606.4618352851692, 1609.0828227909979, 1621.391978008247, 1037.8495118207818, 1055.3298655353906, 1068.2095249515457, 1091.8525998990194, 1101.5098281264761, 6093.421124993119, 6102.572819902653, 6112.327643959161, 6119.0, 6176.382361763877, 6544.574602650812, 6557.180352455943, 6562.376574225441, 6564.474842012628, 6567.770128045496, 6162.137300777895, 6176.320604733476, 6180.289266734293, 6217.626942383381, 6232.25212974446, 3498.930021399558, 3545.361834869697, 3545.7340699447645, 3548.2193917338145, 3553.431450967833, 6632.204135503771, 6748.156480439945, 6804.76183333581, 6816.420604248595, 6826.726930922807, 6685.130932978682, 6725.19297684281, 6726.22648395431, 6728.394444500019, 6733.225679046875, 6734.225564060196, 6768.627725475048, 6777.830554236183, 6787.0498130262795, 6791.796246112624, 6543.672816359258, 6544.116544266463, 6562.0, 6563.704633291418, 6563.835904102436, 6350.809475715736, 6439.227292724903, 6465.1595292611655, 6636.7345306189145, 6647.800565983028, 6915.377616014583, 6947.340002699735, 6964.721411143498, 6967.54710943787, 6971.8257043572285, 4594.816207351802, 4638.582527572535, 4661.417322834645, 4666.533346665306, 4667.62658987287, 6682.465402767864, 6688.933110668831, 6689.565178263398, 6703.363180497845, 6704.128463299739, 6350.7777227796805, 6469.126667899962, 6480.773172938924, 6490.643014634052, 6493.0, 6460.4508616766225, 6464.967675161594, 6485.0, 6493.837654058686, 6497.902531462127, 6316.684165791784, 6351.777687780906, 6353.82454245966, 6358.523110766619, 6366.649834258975, 6514.9348506514325, 6518.543701940818, 6521.836954076186, 6528.183977002875, 6541.08424820516, 6058.212432383762, 6097.359777223328, 6204.968975155276, 6346.555741098079, 6374.565722712353], "unit": "score", "name": "prototype.html", "value": 4868.377896457246}, {"lowerIsBetter": false, "replicates": [688.4182865478671, 698.8567343694543, 709.407644616745, 735.9264073592639, 772.6909236305477, 14556.927215363921, 14589.635259118528, 14649.85350146501, 14690.779638305434, 14758.92620536897, 13646.522371716992, 13718.451261949534, 13763.724725505484, 13789.379477923492, 13990.510332138378, 765.1545042727803, 920.1856357123927, 941.3739862991137, 943.3113826906363, 944.8393773058563, 926.7868390270241, 939.0281059103829, 944.773254418938, 944.8441007233798, 946.7633091727068, 807.9596020198967, 987.5950860147341, 991.8710567626234, 993.3096497933939, 993.64228877604, 945.2201933404934, 966.9854952175723, 971.3006635222664, 971.4705485510343, 971.4705485510414, 715.0239922505795, 717.0141056047934, 719.0, 719.7408932784193, 720.9495335326529, 14473.348699308557, 14539.491117810932, 14557.053791503518, 14587.48943786973, 14630.34163462636, 13964.301784910715, 14083.85916140846, 14110.365033573515, 14184.0, 14294.642009009127, 10769.515371808287, 10891.292066015683, 11067.833982490189, 11071.501782419811, 11225.214235003554, 3743.794091324976, 3773.0755964788527, 3773.5094437723196, 3775.9811200944096, 3781.3382658035007, 49209.0, 49227.75386123082, 51608.483915160745, 51951.0, 52137.0, 11325.37710425918, 11411.48648310828, 11447.713807154887, 11483.885161148448, 11539.307641541534, 19521.219151234076, 19670.0, 19702.70445943312, 19712.310069147512, 19727.704084438745, 8069.273765361146, 8199.958325478035, 8299.95850020746, 8429.367797415218, 8623.223909848144, 4352.564743525622, 4369.300911854088, 4480.4623445186135, 4500.144972455289, 4527.207738645724, 3386.153461634591, 3436.831477297731, 3439.226174110805, 3441.7590768645955, 3459.4291941829315, 564.0664699921637, 582.7173820697043, 583.4049269744921, 587.2864469669372, 589.2810770859544, 621.6177051113533, 729.5586170366958, 747.5552046532413, 752.3116348541024, 752.3823778875352, 8567.443116197428, 8767.649294028295, 8890.199882010651, 9030.096990300917, 9097.0, 567.537456972566, 649.1269242868428, 649.571282953258, 651.7686221391433, 672.2672287206968, 3912.374020156761, 4088.550259471456, 4092.529359123679, 4147.19129769692, 4308.9353659695125, 58841.41158588445, 59223.40776592265, 60613.69693151506, 60705.39294607086, 64732.0, 51508.0, 51868.740656296475, 51978.740106299985, 53303.20045199325, 53371.19943200855, 50086.0, 50422.49577504252, 50935.98128037419, 51427.74286128546, 51933.22100168501, 9269.629214831331, 9331.86002209981, 9371.109744574254, 9405.858912116188, 9529.332946693665, 35482.0, 36173.81913090418, 36342.63657363393, 36733.0, 37140.44289335608, 39089.022774430865, 39498.21003579855, 42974.785126074166, 43921.12157756763, 44948.0, 11660.591879284184, 11949.22330048544, 12115.445923328174, 12152.635420937386, 12223.388830558259, 10553.208509361675, 11959.461824217757, 12048.638540843789, 12268.509259629514, 12907.870921290667, 11621.360825154698, 11657.941710291394, 11919.106067045179, 12173.573924912585, 12214.663190178162, 11260.436978150896, 11563.364014979257, 11622.76754464889, 11637.243579167665, 11817.586384476503, 10374.896251037393, 11711.297322160357, 11714.594248690211, 11816.40917954116, 11933.940330298294, 8927.375083744075, 8995.640174392951, 9650.08324209199, 9978.700638980843, 10019.148372388428, 9735.951320243354, 10349.0, 10358.482075896025, 10361.4301213434, 10371.792564148825], "unit": "score", "name": "yui.html", "value": 6689.245100234472}], "name": "dromaeo_css", "value": 7221.195244007527}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 107.0, 111.0, 113.0, 113.0, 99.0, 110.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 152.0, 176.0, 127.0, 157.0, 155.0, 144.0, 176.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 164.0, 162.0, 162.0, 163.0, 163.0, 165.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 76.0, 159.0, 75.0, 78.0, 76.0, 75.0, 179.0, 76.0], "unit": "score", "name": "audio-fft", "value": 94.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 143.0, 94.0, 93.0, 93.0, 135.0, 94.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 58.0, 58.0, 60.0, 57.0, 58.0, 57.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 77.0, 77.0, 77.0, 78.0, 79.0, 77.0, 77.0, 77.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.3}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 79.0, 79.0, 77.0, 90.0, 79.0, 78.0, 79.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [115.0, 120.0, 117.0, 116.0, 132.0, 115.0, 111.0, 114.0, 123.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [142.0, 143.0, 154.0, 158.0, 156.0, 142.0, 148.0, 154.0, 152.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.5}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 73.0, 69.0, 74.0, 69.0, 69.0, 72.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1538.5}]} 12:45:39 INFO - Return code: 0 12:45:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:45:39 INFO - # TBPL SUCCESS # 12:45:39 INFO - Running post-action listener: _resource_record_post_action 12:45:39 INFO - Running post-run listener: _resource_record_post_run 12:45:40 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 16384; Write bytes: 396185600; Read time: 36; Write time: 314808 12:45:40 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 174817280; Read time: 0; Write time: 199192 12:45:41 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 16384; Write bytes: 221368320; Read time: 36; Write time: 115616 12:45:41 INFO - Running post-run listener: _upload_blobber_files 12:45:41 INFO - Blob upload gear active. 12:45:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:45:41 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 12:45:41 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'] 12:45:41 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 12:45:41 INFO - (blobuploader) - INFO - Open directory for files ... 12:45:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:45:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:45:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:45:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:42 INFO - (blobuploader) - INFO - Done attempting. 12:45:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:45:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:45:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:45:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:43 INFO - (blobuploader) - INFO - Done attempting. 12:45:43 INFO - (blobuploader) - INFO - Iteration through files over. 12:45:43 INFO - Return code: 0 12:45:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:45:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:45:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51819b657a468459357fe2ce7a586b3ee5327d22e67ef76d6d219913034b00b40fe48c92213928c8157c3703e85a8b8f422d4adbf530597fe9f8a7d85685567a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e331395aae8b6282292ef8a72bb6a2ebf482e4fff577fb1cea369a1825574656608cf9a6510700920792b9b7c5d8caa3ce55aa82e4414321e7b1f081842f682"} 12:45:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:45:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:45:43 INFO - Contents: 12:45:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51819b657a468459357fe2ce7a586b3ee5327d22e67ef76d6d219913034b00b40fe48c92213928c8157c3703e85a8b8f422d4adbf530597fe9f8a7d85685567a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e331395aae8b6282292ef8a72bb6a2ebf482e4fff577fb1cea369a1825574656608cf9a6510700920792b9b7c5d8caa3ce55aa82e4414321e7b1f081842f682"} 12:45:43 INFO - Running post-run listener: copy_logs_to_upload_dir 12:45:43 INFO - Copying logs to upload dir... 12:45:43 INFO - mkdir: /builds/slave/test/build/upload/logs 12:45:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.854780 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-18 12:45:42.487287) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 12:45:42.491122) ========= 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=52faae308a556c440401f8e5000001e8-1463599310.759914-412528591 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/51819b657a468459357fe2ce7a586b3ee5327d22e67ef76d6d219913034b00b40fe48c92213928c8157c3703e85a8b8f422d4adbf530597fe9f8a7d85685567a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e331395aae8b6282292ef8a72bb6a2ebf482e4fff577fb1cea369a1825574656608cf9a6510700920792b9b7c5d8caa3ce55aa82e4414321e7b1f081842f682"} build_url:https://queue.taskcluster.net/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/c0MxSyLvQYis9sjvq0UYWg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51819b657a468459357fe2ce7a586b3ee5327d22e67ef76d6d219913034b00b40fe48c92213928c8157c3703e85a8b8f422d4adbf530597fe9f8a7d85685567a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e331395aae8b6282292ef8a72bb6a2ebf482e4fff577fb1cea369a1825574656608cf9a6510700920792b9b7c5d8caa3ce55aa82e4414321e7b1f081842f682"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 12:45:42.516329) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:45:42.516733) ========= 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=52faae308a556c440401f8e5000001e8-1463599310.759914-412528591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:45:42.600553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 12:45:42.600923) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 12:45:42.601226) ========= ========= Total master_lag: 0.13 =========