builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1468376820.48 results: success (0) buildid: 20160712164026 builduid: fe52684c386341788feef6a4a2ece107 revision: 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:00.483150) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:00.483726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:00.484169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:00.507042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:00.507343) ========= 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=d2a8c569965ab8367867b893000001a1-1468375849.755809-657731516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 19:27:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 106K=0.1s 2016-07-12 19:27:01 (106 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.280268 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:00.803552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:00.804132) ========= 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=d2a8c569965ab8367867b893000001a1-1468375849.755809-657731516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022241 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:00.854914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:00.855588) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 --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 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 --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=d2a8c569965ab8367867b893000001a1-1468375849.755809-657731516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 19:27:01,168 truncating revision to first 12 chars 2016-07-12 19:27:01,168 Setting DEBUG logging. 2016-07-12 19:27:01,168 attempt 1/10 2016-07-12 19:27:01,168 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/01aead8192bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 19:27:01,472 unpacking tar archive at: mozilla-beta-01aead8192bd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630809 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:01.504491) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:01.505200) ========= script_repo_revision: 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:01.505643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:01.505957) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:01.516478) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-12 19:27:01.517114) ========= /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=d2a8c569965ab8367867b893000001a1-1468375849.755809-657731516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:27:01 INFO - MultiFileLogger online at 20160712 19:27:01 in /builds/slave/test 19:27:01 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 19:27:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:27:01 INFO - {'append_to_log': False, 19:27:01 INFO - 'base_work_dir': '/builds/slave/test', 19:27:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:27:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:27:01 INFO - 'branch': 'Mozilla-Beta', 19:27:01 INFO - 'buildbot_json_path': 'buildprops.json', 19:27:01 INFO - 'config_files': ('talos/linux_config.py',), 19:27:01 INFO - 'default_actions': ('clobber', 19:27:01 INFO - 'read-buildbot-config', 19:27:01 INFO - 'download-and-extract', 19:27:01 INFO - 'populate-webroot', 19:27:01 INFO - 'create-virtualenv', 19:27:01 INFO - 'install', 19:27:01 INFO - 'run-tests'), 19:27:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:27:01 INFO - 'download_minidump_stackwalk': True, 19:27:01 INFO - 'download_symbols': 'ondemand', 19:27:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:27:01 INFO - 'tooltool.py': '/tools/tooltool.py', 19:27:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:27:01 INFO - '/tools/misc-python/virtualenv.py')}, 19:27:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:27:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:27:01 INFO - 'installer_path': 'installer.exe', 19:27:01 INFO - 'log_level': 'info', 19:27:01 INFO - 'log_name': 'talos', 19:27:01 INFO - 'log_to_console': True, 19:27:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:27:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:27:01 INFO - 'opt_config_files': (), 19:27:01 INFO - 'pip_index': False, 19:27:01 INFO - 'sps_profile': False, 19:27:01 INFO - 'sps_profile_interval': 0, 19:27:01 INFO - 'suite': 'dromaeojs', 19:27:01 INFO - 'system_bits': '32', 19:27:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:27:01 INFO - 'title': 'talos-linux64-ix-043', 19:27:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:27:01 INFO - 'use_talos_json': True, 19:27:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:27:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:27:01 INFO - 'work_dir': 'build'} 19:27:01 INFO - ##### 19:27:01 INFO - ##### Running clobber step. 19:27:01 INFO - ##### 19:27:01 INFO - Running pre-action listener: _resource_record_pre_action 19:27:01 INFO - Running main action method: clobber 19:27:01 INFO - rmtree: /builds/slave/test/build 19:27:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:27:02 INFO - Running post-action listener: _resource_record_post_action 19:27:02 INFO - ##### 19:27:02 INFO - ##### Running read-buildbot-config step. 19:27:02 INFO - ##### 19:27:02 INFO - Running pre-action listener: _resource_record_pre_action 19:27:02 INFO - Running main action method: read_buildbot_config 19:27:02 INFO - Using buildbot properties: 19:27:02 INFO - { 19:27:02 INFO - "project": "", 19:27:02 INFO - "product": "firefox", 19:27:02 INFO - "script_repo_revision": "production", 19:27:02 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 19:27:02 INFO - "repository": "", 19:27:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 19:27:02 INFO - "buildid": "20160712164026", 19:27:02 INFO - "pgo_build": "True", 19:27:02 INFO - "basedir": "/builds/slave/test", 19:27:02 INFO - "buildnumber": 101, 19:27:02 INFO - "slavename": "talos-linux64-ix-043", 19:27:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:27:02 INFO - "platform": "ubuntu64_hw", 19:27:02 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 19:27:02 INFO - "branch": "mozilla-beta", 19:27:02 INFO - "repo_path": "releases/mozilla-beta", 19:27:02 INFO - "revision": "01aead8192bd5dca6f1dbef7424da9f0a70bc4a9", 19:27:02 INFO - "stage_platform": "linux64-pgo", 19:27:02 INFO - "builduid": "fe52684c386341788feef6a4a2ece107", 19:27:02 INFO - "slavebuilddir": "test" 19:27:02 INFO - } 19:27:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 19:27:02 INFO - Running post-action listener: _resource_record_post_action 19:27:02 INFO - ##### 19:27:02 INFO - ##### Running download-and-extract step. 19:27:02 INFO - ##### 19:27:02 INFO - Running pre-action listener: _resource_record_pre_action 19:27:02 INFO - Running main action method: download_and_extract 19:27:02 INFO - mkdir: /builds/slave/test/build/tests 19:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:02 INFO - https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:27:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:27:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:27:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:27:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:27:08 INFO - Downloaded 1327 bytes. 19:27:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:27:08 INFO - Using the following test package requirements: 19:27:08 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 19:27:08 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:08 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 19:27:08 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:08 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 19:27:08 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:08 INFO - u'jsshell-linux-x86_64.zip'], 19:27:08 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:08 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 19:27:08 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 19:27:08 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:08 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 19:27:08 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:08 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 19:27:08 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:08 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 19:27:08 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:08 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 19:27:08 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:08 INFO - https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:27:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:27:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:27:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:27:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:27:13 INFO - Downloaded 24236550 bytes. 19:27:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:27:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:27:14 INFO - Return code: 0 19:27:14 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:14 INFO - https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:27:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:27:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:27:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:27:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:27:19 INFO - Downloaded 24236550 bytes. 19:27:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:27:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:27:21 INFO - Return code: 0 19:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:21 INFO - https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:27:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 19:27:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 19:27:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 19:27:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:27:22 INFO - Downloaded 10840145 bytes. 19:27:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:27:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:27:22 INFO - Return code: 0 19:27: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')]} 19:27:22 INFO - https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:27:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:27:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:27:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:27:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:27:24 INFO - Downloaded 56026149 bytes. 19:27:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:27:24 INFO - mkdir: /builds/slave/test/properties 19:27:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:27:24 INFO - Writing to file /builds/slave/test/properties/build_url 19:27:24 INFO - Contents: 19:27:24 INFO - build_url:https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:27:24 INFO - Running post-action listener: _resource_record_post_action 19:27:24 INFO - Running post-action listener: set_extra_try_arguments 19:27:24 INFO - ##### 19:27:24 INFO - ##### Running populate-webroot step. 19:27:24 INFO - ##### 19:27:24 INFO - Running pre-action listener: _resource_record_pre_action 19:27:24 INFO - Running main action method: populate_webroot 19:27:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:27:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:27:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:27:24 INFO - '--tppagecycles', 19:27:24 INFO - '7'], 19:27:24 INFO - 'tests': ['tsvgm']}}, 19:27:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:27:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:27:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:27:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:27:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:27:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:27:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:24 INFO - 'talos_options': ['--disable-e10s'], 19:27:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:24 INFO - 'talos_options': ['--disable-e10s'], 19:27:24 INFO - 'tests': ['damp', 'tps']}, 19:27:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:24 INFO - 'tests': ['damp', 'tps']}, 19:27:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:27:24 INFO - 'tests': ['dromaeo_dom']}, 19:27:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:27:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:27:24 INFO - 'tests': ['a11yr', 19:27:24 INFO - 'ts_paint', 19:27:24 INFO - 'tpaint', 19:27:24 INFO - 'sessionrestore', 19:27:24 INFO - 'sessionrestore_no_auto_restore', 19:27:24 INFO - 'tabpaint']}, 19:27:24 INFO - 'other-e10s': {'tests': ['a11yr', 19:27:24 INFO - 'ts_paint', 19:27:24 INFO - 'tpaint', 19:27:24 INFO - 'sessionrestore', 19:27:24 INFO - 'sessionrestore_no_auto_restore', 19:27:24 INFO - 'tabpaint']}, 19:27:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:27:24 INFO - 'ts_paint', 19:27:24 INFO - 'tpaint', 19:27:24 INFO - 'sessionrestore', 19:27:24 INFO - 'sessionrestore_no_auto_restore', 19:27:24 INFO - 'tabpaint']}, 19:27:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:27:24 INFO - 'ts_paint', 19:27:24 INFO - 'tpaint', 19:27:24 INFO - 'sessionrestore', 19:27:24 INFO - 'sessionrestore_no_auto_restore', 19:27:24 INFO - 'tabpaint']}, 19:27:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:27:24 INFO - 'tests': ['a11yr', 19:27:24 INFO - 'ts_paint', 19:27:24 INFO - 'tpaint', 19:27:24 INFO - 'sessionrestore', 19:27:24 INFO - 'sessionrestore_no_auto_restore', 19:27:24 INFO - 'tabpaint']}, 19:27:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:27:24 INFO - 'tests': ['a11yr', 19:27:24 INFO - 'ts_paint', 19:27:24 INFO - 'tpaint', 19:27:24 INFO - 'sessionrestore', 19:27:24 INFO - 'sessionrestore_no_auto_restore', 19:27:24 INFO - 'tabpaint']}, 19:27:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:27:24 INFO - 'tests': ['tsvgx', 19:27:24 INFO - 'tsvgr_opacity', 19:27:24 INFO - 'tart', 19:27:24 INFO - 'tscrollx', 19:27:24 INFO - 'cart']}, 19:27:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:27:24 INFO - 'tsvgr_opacity', 19:27:24 INFO - 'tart', 19:27:24 INFO - 'tscrollx', 19:27:24 INFO - 'cart']}, 19:27:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:24 INFO - 'talos_options': ['--disable-e10s'], 19:27:24 INFO - 'tests': ['tp5o']}, 19:27:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:24 INFO - 'tests': ['tp5o']}, 19:27:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:24 INFO - 'talos_options': ['--disable-e10s', 19:27:24 INFO - '--xperf_path', 19:27:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:24 INFO - 'tests': ['tp5n']}, 19:27:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:24 INFO - 'talos_options': ['--xperf_path', 19:27:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:24 INFO - 'tests': ['tp5n']}}, 19:27:24 INFO - 'talos.zip': {'path': '', 19:27:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:27:24 INFO - Running post-action listener: _resource_record_post_action 19:27:24 INFO - ##### 19:27:25 INFO - ##### Running create-virtualenv step. 19:27:25 INFO - ##### 19:27:25 INFO - Running pre-action listener: _resource_record_pre_action 19:27:25 INFO - Running main action method: create_virtualenv 19:27:25 INFO - Creating virtualenv /builds/slave/test/build/venv 19:27:25 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 19:27:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:27:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:27:25 INFO - Using real prefix '/usr' 19:27:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:27:25 INFO - Installing distribute.............................................................................................................................................................................................done. 19:27:27 INFO - Installing pip.................done. 19:27:27 INFO - Return code: 0 19:27:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:27 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 0x7f3b12d3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb410>, '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 0x10bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', '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 19:27:27 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 19:27:27 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 19:27:27 INFO - Using env: {'DISPLAY': ':0', 19:27:27 INFO - 'HOME': '/home/cltbld', 19:27:27 INFO - 'LANG': 'en_US.UTF-8', 19:27:27 INFO - 'LANGUAGE': 'en_US:en', 19:27:27 INFO - 'LOGNAME': 'cltbld', 19:27:27 INFO - 'MAIL': '/var/mail/cltbld', 19:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:27 INFO - 'MOZ_NO_REMOTE': '1', 19:27:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:27 INFO - 'NO_EM_RESTART': '1', 19:27:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:27 INFO - 'PWD': '/builds/slave/test', 19:27:27 INFO - 'SHELL': '/bin/bash', 19:27:27 INFO - 'SHLVL': '1', 19:27:27 INFO - 'TERM': 'linux', 19:27:27 INFO - 'TMOUT': '86400', 19:27:27 INFO - 'USER': 'cltbld', 19:27:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', 19:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:27 INFO - '_': '/tools/buildbot/bin/python'} 19:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:27 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 19:27:27 INFO - Cleaning up... 19:27:27 INFO - Return code: 0 19:27:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:27 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 0x7f3b12d3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb410>, '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 0x10bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', '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 19:27:27 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 19:27:27 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 19:27:27 INFO - Using env: {'DISPLAY': ':0', 19:27:27 INFO - 'HOME': '/home/cltbld', 19:27:27 INFO - 'LANG': 'en_US.UTF-8', 19:27:27 INFO - 'LANGUAGE': 'en_US:en', 19:27:27 INFO - 'LOGNAME': 'cltbld', 19:27:27 INFO - 'MAIL': '/var/mail/cltbld', 19:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:27 INFO - 'MOZ_NO_REMOTE': '1', 19:27:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:27 INFO - 'NO_EM_RESTART': '1', 19:27:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:27 INFO - 'PWD': '/builds/slave/test', 19:27:27 INFO - 'SHELL': '/bin/bash', 19:27:27 INFO - 'SHLVL': '1', 19:27:27 INFO - 'TERM': 'linux', 19:27:27 INFO - 'TMOUT': '86400', 19:27:27 INFO - 'USER': 'cltbld', 19:27:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', 19:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:27 INFO - '_': '/tools/buildbot/bin/python'} 19:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:28 INFO - Downloading/unpacking psutil>=0.7.1 19:27:28 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 19:27:28 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 19:27:28 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 19:27:28 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 19:27:28 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 19:27:28 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 19:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:27:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:30 INFO - Installing collected packages: psutil 19:27:30 INFO - Running setup.py install for psutil 19:27:30 INFO - building 'psutil._psutil_linux' extension 19:27:30 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 19:27:30 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 19:27:30 INFO - building 'psutil._psutil_posix' extension 19:27:30 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 19:27:30 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 19:27:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:30 INFO - Successfully installed psutil 19:27:30 INFO - Cleaning up... 19:27:30 INFO - Return code: 0 19:27:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:30 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 0x7f3b12d3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb410>, '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 0x10bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', '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 19:27:30 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 19:27:30 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 19:27:30 INFO - Using env: {'DISPLAY': ':0', 19:27:30 INFO - 'HOME': '/home/cltbld', 19:27:30 INFO - 'LANG': 'en_US.UTF-8', 19:27:30 INFO - 'LANGUAGE': 'en_US:en', 19:27:30 INFO - 'LOGNAME': 'cltbld', 19:27:30 INFO - 'MAIL': '/var/mail/cltbld', 19:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:30 INFO - 'MOZ_NO_REMOTE': '1', 19:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:30 INFO - 'NO_EM_RESTART': '1', 19:27:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:30 INFO - 'PWD': '/builds/slave/test', 19:27:30 INFO - 'SHELL': '/bin/bash', 19:27:30 INFO - 'SHLVL': '1', 19:27:30 INFO - 'TERM': 'linux', 19:27:30 INFO - 'TMOUT': '86400', 19:27:30 INFO - 'USER': 'cltbld', 19:27:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', 19:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:30 INFO - '_': '/tools/buildbot/bin/python'} 19:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:27:32 INFO - Installing collected packages: mozsystemmonitor 19:27:32 INFO - Running setup.py install for mozsystemmonitor 19:27:32 INFO - Successfully installed mozsystemmonitor 19:27:32 INFO - Cleaning up... 19:27:32 INFO - Return code: 0 19:27:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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', '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 0x7f3b12d3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb410>, '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 0x10bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', '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 19:27: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:27: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 blobuploader==1.2.4 19:27:32 INFO - Using env: {'DISPLAY': ':0', 19:27:32 INFO - 'HOME': '/home/cltbld', 19:27:32 INFO - 'LANG': 'en_US.UTF-8', 19:27:32 INFO - 'LANGUAGE': 'en_US:en', 19:27:32 INFO - 'LOGNAME': 'cltbld', 19:27:32 INFO - 'MAIL': '/var/mail/cltbld', 19:27:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:32 INFO - 'MOZ_NO_REMOTE': '1', 19:27:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:32 INFO - 'NO_EM_RESTART': '1', 19:27:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:32 INFO - 'PWD': '/builds/slave/test', 19:27:32 INFO - 'SHELL': '/bin/bash', 19:27:32 INFO - 'SHLVL': '1', 19:27:32 INFO - 'TERM': 'linux', 19:27:32 INFO - 'TMOUT': '86400', 19:27:32 INFO - 'USER': 'cltbld', 19:27:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', 19:27:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:32 INFO - '_': '/tools/buildbot/bin/python'} 19:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:33 INFO - Downloading/unpacking blobuploader==1.2.4 19:27:33 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 19:27:33 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 19:27:33 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 19:27:33 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 19:27:33 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 19:27:33 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 19:27:34 INFO - Downloading blobuploader-1.2.4.tar.gz 19:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:27:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:27:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:35 INFO - Downloading docopt-0.6.1.tar.gz 19:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:27:35 INFO - Installing collected packages: blobuploader, requests, docopt 19:27:35 INFO - Running setup.py install for blobuploader 19:27:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:27:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:27:35 INFO - Running setup.py install for requests 19:27:36 INFO - Running setup.py install for docopt 19:27:36 INFO - Successfully installed blobuploader requests docopt 19:27:36 INFO - Cleaning up... 19:27:36 INFO - Return code: 0 19:27:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:36 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')]} 19:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:36 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')]} 19:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:36 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 0x7f3b12d3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb410>, '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 0x10bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', '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 19:27:36 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 19:27:36 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 19:27:36 INFO - Using env: {'DISPLAY': ':0', 19:27:36 INFO - 'HOME': '/home/cltbld', 19:27:36 INFO - 'LANG': 'en_US.UTF-8', 19:27:36 INFO - 'LANGUAGE': 'en_US:en', 19:27:36 INFO - 'LOGNAME': 'cltbld', 19:27:36 INFO - 'MAIL': '/var/mail/cltbld', 19:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:36 INFO - 'MOZ_NO_REMOTE': '1', 19:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:36 INFO - 'NO_EM_RESTART': '1', 19:27:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:36 INFO - 'PWD': '/builds/slave/test', 19:27:36 INFO - 'SHELL': '/bin/bash', 19:27:36 INFO - 'SHLVL': '1', 19:27:36 INFO - 'TERM': 'linux', 19:27:36 INFO - 'TMOUT': '86400', 19:27:36 INFO - 'USER': 'cltbld', 19:27:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', 19:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:36 INFO - '_': '/tools/buildbot/bin/python'} 19:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:36 INFO - Running setup.py (path:/tmp/pip-By_Zhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:36 INFO - Running setup.py (path:/tmp/pip-Ws22S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:36 INFO - Running setup.py (path:/tmp/pip-vUcpjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:36 INFO - Running setup.py (path:/tmp/pip-yP3uej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:36 INFO - Running setup.py (path:/tmp/pip-F9Ycdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:36 INFO - Running setup.py (path:/tmp/pip-ywV5_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:37 INFO - Running setup.py (path:/tmp/pip-F_htdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:37 INFO - Running setup.py (path:/tmp/pip-dIA__e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:37 INFO - Running setup.py (path:/tmp/pip-NVkTno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:37 INFO - Running setup.py (path:/tmp/pip-NdWJ20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:37 INFO - Running setup.py (path:/tmp/pip-_6oEw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:37 INFO - Running setup.py (path:/tmp/pip-2lHUga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:37 INFO - Running setup.py (path:/tmp/pip-i9f436-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:37 INFO - Running setup.py (path:/tmp/pip-3CVK1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:37 INFO - Running setup.py (path:/tmp/pip-3dTmSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:37 INFO - Running setup.py (path:/tmp/pip-SICHNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:37 INFO - Running setup.py (path:/tmp/pip-87a30l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:27:37 INFO - Running setup.py install for manifestparser 19:27:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:27:37 INFO - Running setup.py install for mozcrash 19:27:38 INFO - Running setup.py install for mozdebug 19:27:38 INFO - Running setup.py install for mozdevice 19:27:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:27:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:27:38 INFO - Running setup.py install for mozfile 19:27:38 INFO - Running setup.py install for mozhttpd 19:27:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:27:38 INFO - Running setup.py install for mozinfo 19:27:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:27:38 INFO - Running setup.py install for mozInstall 19:27:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:27:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:27:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:27:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:27:38 INFO - Running setup.py install for mozleak 19:27:38 INFO - Running setup.py install for mozlog 19:27:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:27:38 INFO - Running setup.py install for moznetwork 19:27:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:27:38 INFO - Running setup.py install for mozprocess 19:27:39 INFO - Running setup.py install for mozprofile 19:27:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:27:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:27:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:27:39 INFO - Running setup.py install for mozrunner 19:27:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:27:39 INFO - Running setup.py install for mozscreenshot 19:27:39 INFO - Running setup.py install for moztest 19:27:39 INFO - Running setup.py install for mozversion 19:27:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:27:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:27:39 INFO - Cleaning up... 19:27:39 INFO - Return code: 0 19:27:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:39 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')]} 19:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:39 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')]} 19:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:39 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 0x7f3b12d3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb410>, '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 0x10bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', '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 19:27:39 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 19:27:39 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 19:27:39 INFO - Using env: {'DISPLAY': ':0', 19:27:39 INFO - 'HOME': '/home/cltbld', 19:27:39 INFO - 'LANG': 'en_US.UTF-8', 19:27:39 INFO - 'LANGUAGE': 'en_US:en', 19:27:39 INFO - 'LOGNAME': 'cltbld', 19:27:39 INFO - 'MAIL': '/var/mail/cltbld', 19:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:39 INFO - 'MOZ_NO_REMOTE': '1', 19:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:39 INFO - 'NO_EM_RESTART': '1', 19:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:39 INFO - 'PWD': '/builds/slave/test', 19:27:39 INFO - 'SHELL': '/bin/bash', 19:27:39 INFO - 'SHLVL': '1', 19:27:39 INFO - 'TERM': 'linux', 19:27:39 INFO - 'TMOUT': '86400', 19:27:39 INFO - 'USER': 'cltbld', 19:27:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', 19:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:39 INFO - '_': '/tools/buildbot/bin/python'} 19:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:39 INFO - Running setup.py (path:/tmp/pip-AlO32v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:39 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)) 19:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:39 INFO - Running setup.py (path:/tmp/pip-tuLguK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:39 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)) 19:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:39 INFO - Running setup.py (path:/tmp/pip-urJLFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:40 INFO - Running setup.py (path:/tmp/pip-HSiFa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:40 INFO - Running setup.py (path:/tmp/pip-uPp3rV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:40 INFO - Running setup.py (path:/tmp/pip-Xnegfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:40 INFO - Running setup.py (path:/tmp/pip-uXVc1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:40 INFO - Running setup.py (path:/tmp/pip-GopGK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:40 INFO - Running setup.py (path:/tmp/pip-EbDX74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:40 INFO - Running setup.py (path:/tmp/pip-y4VR64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:40 INFO - Running setup.py (path:/tmp/pip-e_VkOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:40 INFO - Running setup.py (path:/tmp/pip-Mbrbn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:40 INFO - Running setup.py (path:/tmp/pip-h8OaWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:40 INFO - Running setup.py (path:/tmp/pip-m_0rrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:40 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)) 19:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:40 INFO - Running setup.py (path:/tmp/pip-Y6jxvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:41 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)) 19:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:41 INFO - Running setup.py (path:/tmp/pip-4VdOAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:41 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)) 19:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:41 INFO - Running setup.py (path:/tmp/pip-Ow1k63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:43 INFO - Downloading blessings-1.6.tar.gz 19:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:27:43 INFO - Installing collected packages: blessings 19:27:43 INFO - Running setup.py install for blessings 19:27:43 INFO - Successfully installed blessings 19:27:43 INFO - Cleaning up... 19:27:43 INFO - Return code: 0 19:27:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:27:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:43 INFO - Reading from file tmpfile_stdout 19:27:43 INFO - Current package versions: 19:27:43 INFO - argparse == 1.2.1 19:27:43 INFO - blessings == 1.6 19:27:43 INFO - blobuploader == 1.2.4 19:27:43 INFO - docopt == 0.6.1 19:27:43 INFO - manifestparser == 1.1 19:27:43 INFO - mozInstall == 1.12 19:27:43 INFO - mozcrash == 0.17 19:27:43 INFO - mozdebug == 0.1 19:27:43 INFO - mozdevice == 0.48 19:27:43 INFO - mozfile == 1.2 19:27:43 INFO - mozhttpd == 0.7 19:27:43 INFO - mozinfo == 0.9 19:27:43 INFO - mozleak == 0.1 19:27:43 INFO - mozlog == 3.1 19:27:43 INFO - moznetwork == 0.27 19:27:43 INFO - mozprocess == 0.22 19:27:43 INFO - mozprofile == 0.28 19:27:43 INFO - mozrunner == 6.11 19:27:43 INFO - mozscreenshot == 0.1 19:27:43 INFO - mozsystemmonitor == 0.0 19:27:43 INFO - moztest == 0.7 19:27:43 INFO - mozversion == 1.4 19:27:43 INFO - psutil == 3.1.1 19:27:43 INFO - requests == 1.2.3 19:27:43 INFO - wsgiref == 0.1.2 19:27:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 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 0x7f3b12d3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb410>, '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 0x10bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', '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 19:27:43 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 19:27:43 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 19:27:43 INFO - Using env: {'DISPLAY': ':0', 19:27:43 INFO - 'HOME': '/home/cltbld', 19:27:43 INFO - 'LANG': 'en_US.UTF-8', 19:27:43 INFO - 'LANGUAGE': 'en_US:en', 19:27:43 INFO - 'LOGNAME': 'cltbld', 19:27:43 INFO - 'MAIL': '/var/mail/cltbld', 19:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:43 INFO - 'MOZ_NO_REMOTE': '1', 19:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:43 INFO - 'NO_EM_RESTART': '1', 19:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:43 INFO - 'PWD': '/builds/slave/test', 19:27:43 INFO - 'SHELL': '/bin/bash', 19:27:43 INFO - 'SHLVL': '1', 19:27:43 INFO - 'TERM': 'linux', 19:27:43 INFO - 'TMOUT': '86400', 19:27:43 INFO - 'USER': 'cltbld', 19:27:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', 19:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:43 INFO - '_': '/tools/buildbot/bin/python'} 19:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:43 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)) 19:27:43 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)) 19:27:43 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)) 19:27:43 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)) 19:27:43 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)) 19:27:43 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)) 19:27:43 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)) 19:27:43 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)) 19:27:43 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)) 19:27:43 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)) 19:27:43 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)) 19:27:43 INFO - Cleaning up... 19:27:43 INFO - Return code: 0 19:27:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b12d3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb410>, '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 0x10bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', '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 19:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:27:43 INFO - Using env: {'DISPLAY': ':0', 19:27:43 INFO - 'HOME': '/home/cltbld', 19:27:43 INFO - 'LANG': 'en_US.UTF-8', 19:27:43 INFO - 'LANGUAGE': 'en_US:en', 19:27:43 INFO - 'LOGNAME': 'cltbld', 19:27:43 INFO - 'MAIL': '/var/mail/cltbld', 19:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:43 INFO - 'MOZ_NO_REMOTE': '1', 19:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:43 INFO - 'NO_EM_RESTART': '1', 19:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:43 INFO - 'PWD': '/builds/slave/test', 19:27:43 INFO - 'SHELL': '/bin/bash', 19:27:43 INFO - 'SHLVL': '1', 19:27:43 INFO - 'TERM': 'linux', 19:27:43 INFO - 'TMOUT': '86400', 19:27:43 INFO - 'USER': 'cltbld', 19:27:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', 19:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:43 INFO - '_': '/tools/buildbot/bin/python'} 19:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:43 INFO - Downloading/unpacking jsonschema 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:27:45 INFO - Downloading/unpacking functools32 (from jsonschema) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:46 INFO - Downloading functools32-3.2.3-2.tar.gz 19:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:27:46 INFO - warning: no files found matching '*.txt' 19:27:46 INFO - no previously-included directories found matching 'build' 19:27:46 INFO - no previously-included directories found matching 'dist' 19:27:46 INFO - no previously-included directories found matching '.git*' 19:27:46 INFO - Installing collected packages: jsonschema, functools32 19:27:46 INFO - Running setup.py install for functools32 19:27:46 INFO - warning: no files found matching '*.txt' 19:27:46 INFO - no previously-included directories found matching 'build' 19:27:46 INFO - no previously-included directories found matching 'dist' 19:27:46 INFO - no previously-included directories found matching '.git*' 19:27:46 INFO - Successfully installed jsonschema functools32 19:27:46 INFO - Cleaning up... 19:27:46 INFO - Return code: 0 19:27:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:46 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 0x7f3b12d3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb410>, '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 0x10bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', '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 19:27:46 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 19:27:46 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 19:27:46 INFO - Using env: {'DISPLAY': ':0', 19:27:46 INFO - 'HOME': '/home/cltbld', 19:27:46 INFO - 'LANG': 'en_US.UTF-8', 19:27:46 INFO - 'LANGUAGE': 'en_US:en', 19:27:46 INFO - 'LOGNAME': 'cltbld', 19:27:46 INFO - 'MAIL': '/var/mail/cltbld', 19:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:46 INFO - 'MOZ_NO_REMOTE': '1', 19:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:46 INFO - 'NO_EM_RESTART': '1', 19:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:46 INFO - 'PWD': '/builds/slave/test', 19:27:46 INFO - 'SHELL': '/bin/bash', 19:27:46 INFO - 'SHLVL': '1', 19:27:46 INFO - 'TERM': 'linux', 19:27:46 INFO - 'TMOUT': '86400', 19:27:46 INFO - 'USER': 'cltbld', 19:27:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', 19:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:46 INFO - '_': '/tools/buildbot/bin/python'} 19:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:46 INFO - Downloading/unpacking flake8 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:27:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:27:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:27:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:27:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:27:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:27:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:27:50 INFO - no previously-included directories found matching 'docs/_build' 19:27:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:27:50 INFO - Running setup.py install for pep8 19:27:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:27:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:27:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:27:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:27:50 INFO - no previously-included directories found matching 'docs/_build' 19:27:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:27:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:27:50 INFO - Cleaning up... 19:27:50 INFO - Return code: 0 19:27:50 INFO - Running post-action listener: _resource_record_post_action 19:27:50 INFO - Running post-action listener: _start_resource_monitoring 19:27:50 INFO - Starting resource monitoring. 19:27:50 INFO - ##### 19:27:50 INFO - ##### Running install step. 19:27:50 INFO - ##### 19:27:50 INFO - Running pre-action listener: _resource_record_pre_action 19:27:50 INFO - Running main action method: install 19:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:50 INFO - Reading from file tmpfile_stdout 19:27:50 INFO - Detecting whether we're running mozinstall >=1.0... 19:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:27:50 INFO - Reading from file tmpfile_stdout 19:27:50 INFO - Output received: 19:27:50 INFO - Usage: mozinstall [options] installer 19:27:50 INFO - Options: 19:27:50 INFO - -h, --help show this help message and exit 19:27:50 INFO - -d DEST, --destination=DEST 19:27:50 INFO - Directory to install application into. [default: 19:27:50 INFO - "/builds/slave/test"] 19:27:50 INFO - --app=APP Application being installed. [default: firefox] 19:27:50 INFO - mkdir: /builds/slave/test/build/application 19:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:28:03 INFO - Reading from file tmpfile_stdout 19:28:03 INFO - Output received: 19:28:03 INFO - /builds/slave/test/build/application/firefox/firefox 19:28:03 INFO - Running post-action listener: _resource_record_post_action 19:28:03 INFO - ##### 19:28:03 INFO - ##### Running run-tests step. 19:28:03 INFO - ##### 19:28:03 INFO - Running pre-action listener: _resource_record_pre_action 19:28:03 INFO - Running main action method: run_tests 19:28:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:28:03 INFO - Python 2.7.3 19:28:03 INFO - Return code: 0 19:28:03 INFO - grabbing minidump binary from tooltool 19:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:03 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 0x10bb410>, '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 0x10bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:28:03 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 19:28:03 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 19:28:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:28:04 INFO - Return code: 0 19:28:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:28:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:28:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:28:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:28:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:28:04 INFO - Return code: 0 19:28:04 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/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 19:28:04 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/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 19:28:04 INFO - Using env: {'DISPLAY': ':0', 19:28:04 INFO - 'HOME': '/home/cltbld', 19:28:04 INFO - 'LANG': 'en_US.UTF-8', 19:28:04 INFO - 'LANGUAGE': 'en_US:en', 19:28:04 INFO - 'LOGNAME': 'cltbld', 19:28:04 INFO - 'MAIL': '/var/mail/cltbld', 19:28:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:28:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:04 INFO - 'MOZ_NO_REMOTE': '1', 19:28:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:04 INFO - 'NO_EM_RESTART': '1', 19:28:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:04 INFO - 'PWD': '/builds/slave/test', 19:28:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:28:04 INFO - 'SHELL': '/bin/bash', 19:28:04 INFO - 'SHLVL': '1', 19:28:04 INFO - 'TERM': 'linux', 19:28:04 INFO - 'TMOUT': '86400', 19:28:04 INFO - 'USER': 'cltbld', 19:28:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468375849.755809-657731516', 19:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:04 INFO - '_': '/tools/buildbot/bin/python'} 19:28:04 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/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 19:28:05 INFO - mozversion application_buildid: 20160712164026 19:28:05 INFO - mozversion application_changeset: 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 19:28:05 INFO - mozversion application_display_name: Firefox 19:28:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:28:05 INFO - mozversion application_name: Firefox 19:28:05 INFO - mozversion application_remotingname: firefox 19:28:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:28:05 INFO - mozversion application_vendor: Mozilla 19:28:05 INFO - mozversion application_version: 48.0 19:28:05 INFO - mozversion platform_buildid: 20160712164026 19:28:05 INFO - mozversion platform_changeset: 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 19:28:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:28:05 INFO - mozversion platform_version: 48.0 19:28:05 INFO - using testdate: 1468376885 19:28:05 INFO - actual date: 1468376885 19:28:05 INFO - starting webserver on 'localhost:38525' 19:28:05 INFO - SUITE-START | Running 2 tests 19:28:05 INFO - TEST-START | dromaeo_css 19:28:05 INFO - operating with platform_type : linux_ 19:28:05 INFO - Initialising browser for dromaeo_css test... 19:28:05 INFO - TEST-INFO | started process 19099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY76mFU/profile http://localhost:38525/getInfo.html) 19:28:09 INFO - PROCESS | 19099 | __metrics Screen width/height:1600/1200 19:28:09 INFO - PROCESS | 19099 | colorDepth:24 19:28:09 INFO - PROCESS | 19099 | Browser inner width/height: 1024/697 19:28:09 INFO - PROCESS | 19099 | __metrics 19:28:10 ERROR - PROCESS | 19099 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:28:11 INFO - TEST-INFO | 19099: exit 0 19:28:11 INFO - Browser initialized. 19:28:11 INFO - Running cycle 1/1 for dromaeo_css test... 19:28:11 INFO - TEST-INFO | started process 19187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY76mFU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:22 INFO - PROCESS | 19187 | RSS: Main: 139313152 19:28:22 INFO - PROCESS | 19187 | 19:29:14 INFO - PROCESS | 19187 | 1468376954397 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] 19:31:21 INFO - PROCESS | 19187 | Cycle 1(1): loaded http://localhost:38525/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38525/tests/dromaeo/cssquery-ext.html) 19:31:22 INFO - PROCESS | 19187 | RSS: Main: 247439360 19:31:22 INFO - PROCESS | 19187 | 19:34:24 INFO - PROCESS | 19187 | Cycle 1(1): loaded http://localhost:38525/tests/dromaeo/cssquery-ext.html (next: http://localhost:38525/tests/dromaeo/cssquery-jquery.html) 19:34:25 INFO - PROCESS | 19187 | RSS: Main: 223686656 19:34:25 INFO - PROCESS | 19187 | 19:37:26 INFO - PROCESS | 19187 | Cycle 1(1): loaded http://localhost:38525/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38525/tests/dromaeo/cssquery-mootools.html) 19:37:27 INFO - PROCESS | 19187 | RSS: Main: 219439104 19:37:27 INFO - PROCESS | 19187 | 19:40:29 INFO - PROCESS | 19187 | Cycle 1(1): loaded http://localhost:38525/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38525/tests/dromaeo/cssquery-prototype.html) 19:40:29 INFO - PROCESS | 19187 | RSS: Main: 215310336 19:40:29 INFO - PROCESS | 19187 | 19:43:32 INFO - PROCESS | 19187 | Cycle 1(1): loaded http://localhost:38525/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38525/tests/dromaeo/cssquery-yui.html) 19:43:33 INFO - PROCESS | 19187 | RSS: Main: 208887808 19:43:33 INFO - PROCESS | 19187 | 19:46:35 INFO - PROCESS | 19187 | Cycle 1(1): loaded http://localhost:38525/tests/dromaeo/cssquery-yui.html (next: http://localhost:38525/tests/dromaeo/cssquery-dojo.html) 19:46:35 INFO - PROCESS | 19187 | RSS: Main: 249491456 19:46:35 INFO - PROCESS | 19187 | 19:46:35 INFO - PROCESS | 19187 | __start_tp_report 19:46:35 INFO - PROCESS | 19187 | _x_x_mozilla_page_load 19:46:35 INFO - PROCESS | 19187 | _x_x_mozilla_page_load_details 19:46:35 INFO - PROCESS | 19187 | |i|pagename|runs| 19:46:35 INFO - PROCESS | 19187 | |0;dojo.html;3313.701766840984;3352.832358382082;3384.137045053511;3410.9488357674622;3415.914602134948;5568.443155684429;5573.024720673881;5577.749001294941;5586.385497595261;5596.748146333414;5552.361478429972;5576.553875689945;5584.52531534819;5593.161025846125;5630.2117703521435;5014.774335154918;5031.84904452867;5050.974745126287;5089.592832573404;5154.046501397253;4964.751762411883;5001.799928002875;5073.797048118089;5073.898522029557;5083.135866902617;5064.215046667772;5103.795848166069;5113.923291150636;5127.128388174019;5138.254953031808;5144.0740666679985;5192.58459323257;5200.115980283361;5205.453427390145;5223.660462069991;4962.0324036812835;5010.699358038493;5077.593792496591;5102.36220472441;5105.438401775802;5401.648892821993;5414.242006119146;5444.8094316698725;5454.91817622736;5464.617476776627;5931.851703707399;5953.761849526014;5979.820605381846;5991.610545314541;6000.75996960121;5835.883282334329;5964.791232306892;6013.278406591237;6050.909236361458;6097.756089756404;5619.831405057855;5632.831015069554;5657.886842263173;5661.60368774186;5670.404607516151;6186.19579454677;6201.410865967816;6206.875862482815;6208.317085120633;6210.9068363974575;5733.942660573341;5807.767689292381;5879.559033072536;5915.556333275022;5922.1412895130825;6005.39946005396;6037.154798328237;6045.8488537786025;6054.303755068224;6055.455009049207;5745.13822926556;6002.6698531580305;6004.42957918997;6021.217241758631;6024.457798798129;5888.793892213752;5910.822675319661;5915.645061296336;5959.255093113361;5960.940390596125;4525.208088584484;4528.071745292207;4542.205114105019;4543.341215523797;4575.885602859955;4006.6794656427414;4026.275270451288;4060.147369052473;4066.4103704962613;4101.036256479725;5742.253507044057;5777.6133727905;5778.479936805707;5782.074868021096;5827.562932780059;6021.42796434338;6027.698615069229;6032.698365081728;6033.336333003366;6033.366496517802;5653.971730141405;5670.461306175906;5727.513161381329;5771.105478650816;5831.037878750044;5104.18333066715;5111.437741848394;5111.948880511147;5117.104506711311;5119.436861945183;6281.811545653638;6311.589746666452;6313;6317.147185129948;6323.30443651198;5753.3958934311295;5877.4122587740885;5938.079597662369;5952.940470595412;6002.459778619857;6313.11870061635;6334.049892516159;6336.936630633634;6367.840803979938;6372.36276372359;5934.080217566284;5956.970215148896;5958.046712525975;5960.791372302122;5989.52083833301;5835.503982161564;5922.496587789914;5960.552958528215;5970.223870896929;6004.099385092271;5769.048107062287;5777.537796976316;5778;5784.421557844182;5794.507466865363;5651.180578816131;5707.800226992035;5764.106563482499;5779.335376431764;5781.277340332458;5633.4084921082695;5701.40135285789;5768.192453056491;5775.220345253337;5795.565332599987;5794.62334948227;5811.53507719373;5819.592628515963;5833.445822646841;5834.03738383162;5567.47109024642;5579.414161512983;5737.684427356368;5746.913796293143;5790.9420905792085 19:46:35 INFO - PROCESS | 19187 | |1;ext.html;666.1639642248978;672.7309076369448;673.8551211489532;680.3094858718401;748.3564134844037;32304.353912921757;41489;42052.36921446173;42203.57796422035;42206.7889660552;43535.34696979548;44041.339379909245;44196;44241.55758442415;44320;7732.226777322251;8727.51998640073;8913.242374398184;8913.28693704502;10262.692119236397;10365.844512332322;10510.894891051068;10518.053375196268;10525.526351314209;10527.578896844117;10498.107660848837;10575.894241057567;10581.36511809294;10583.3649981001;10585.153187744962;10440.895591044105;10508.842367364496;10512.947435262775;10522.579096836118;10525.263231573794;10368.637097701545;10818;10829.945850270777;10832.566697332097;10847.891521084766;43476;43838;43882.341764873556;43981.34027989551;43982.56017439817;3730.198007428389;3775.528058992626;3781.0499040785476;3786.0345611869075;3862.864799732024;30410.84794576035;30502.237444063852;30626.38747225043;30807.229819254473;31378.52932205996;4166.895827604304;4178.456800615901;4243.087736136746;4292.248856450109;4403.207422663919;294476;300799;301107.9999999978;301646;302853;34162.82918585391;34658.82670586631;34728;34736.47895281573;65678.34321656817;32962.50556241658;33047.17382065419;33105.83447082749;33178.3364332712;33186;15924.840751592335;16092.195390230441;16097.356105755638;16103.677926441405;16118.677626447405;13093.738125237442;14116.50592229267;14325.64185895361;14355.56933292003;14382.568522944328;7661.118971318369;7661.808454788564;7663.961680191564;7702.306792388712;7747.92252077472;3056.7401770849283;3224.2584205632834;3252.804831710105;3261.3314270574474;3269.493228549579;1142.3716955674347;1174.8120300751839;1180.3685028509879;1180.722530205401;1209.848768903887;33332.1666958328;34169.65830341714;34438.48342274868;34732.65267347294;35131.64868351335;1192.9656848101;1228.0789407944042;1240.022164647386;1263.993680031594;1304.5368894042667;17930.5517362067;17937.192826322847;17978.460646180636;18307.993060381807;18327.816721832878;535516;538629;543494;544257;545063;64336.35663643304;64497.35502645007;64830;64948.67525662341;65103;1390.464671101613;1497.573191640399;1520.2702702702766;1567.7569976653638;1672.406295764986;32349.676503234667;34522.65477345194;34773.73970691897;34878.302433950674;34932.650673493954;55343.72328138333;55880;56279.718601406734;56336;56373;430720;439992;440350;440688;441969;36709.63290367169;46707;47998.280025798944;48373.27440088331;53935.19097213623;52201;53416;53427.46572534225;53907.73046134744;54253;42275;43425.3486197701;43765;44061;44841.77579112084;43197.78401107974;43273.3508997359;43415.56584434115;44135.117297654506;44730.3290450637;45488;45683.77158114188;45969.77015114903;46019.539804602864;46445.76777116093;37598.8120059398;39230.215395692496;39311.14075450757;39807;39827.40258896177;29745.788545242463;30196;30205.244868878453;30227.848860755556;30629 19:46:35 INFO - PROCESS | 19187 | |2;jquery.html;404.6519992806187;404.68232437536534;421.79964516854477;422.3812115251158;425.77264336330614;13821.219249631173;18295.26818927243;18574.81425185748;18798.812011879876;18827.05864706766;15601.687966240668;18503.537411564717;19291.228350865982;19605.313814016514;19893.20427182911;5707.743151558169;5870.471657550841;5880.029795083806;5886.6173698709445;5913.674747888865;5740.311162660487;5819.156222347757;5820.592558520905;5824.126381042835;5826.242588463515;5576.832695019156;5739.426057394269;5885.970570147165;5895.204147440105;5897.262842144732;5661.377248502661;5686.317641882959;5691.402402747714;5706.572007099463;5712.600117991742;5017.37282839645;5030.2957585938;5038.622103342264;5075.213341932006;5227.451117632631;23171.420714482105;23751.76248237513;23958.880205599035;24057.518849623084;24117.638235426482;2525.330787341356;2644.457886133338;2719.265798234466;2820.19624407043;2859.8646377288796;13754.93122534381;14808.703825923529;14829.629259268497;15069;15144.54566363011;1960.1767257751778;2024.170090262985;2046.6009128220003;2089.613421517009;2156.91372345106;77886;78133.60933195298;80116;80581.19418805854;81076.59461702712;10104.141148002502;10395.128876802248;10657.360558366368;10738.302010369302;11102.222844400976;14907.70184596302;14989.775153372708;14995.250237488082;15024;15031.323590438456;8751.56242187888;8881.42270752412;8883.73348799537;8930.68742594019;8995.77510562228;8916.242119419792;8953.149450802164;8961.283097352327;9052.185303322733;9059.36584439083;6012.729427175787;6728.293529179464;6792.354726300993;6839.726410943606;6869.210040845367;1814.2978086668772;1866.7759868815558;1917.4822797844784;1917.7986311437378;1953.1601411393237;1011.4083261292227;1054.5570860238718;1103.5254840418536;1106.446776611694;1111.5109351885305;18061.367852125113;18334.358297459527;19532.92568908695;19658.051292306267;20078.196872125245;1043.2488608202082;1063.5320458998017;1110.7500812317164;1122.7586068995206;1153.2734377342222;10962.506687199095;11350.148738844455;11517;11535.250208736574;11545.307281563133;314412;319369;320406;320443;588480;97173.5141324303;98407.50796245973;99868;101601;101817;1105.4638500327335;1142.7543078238218;1152.0438036429744;1160.8200728887036;1168.7311918258847;17450.73823892668;17724.645507089528;17865.821341786937;17965.820341796414;17975.370862019765;39534.40698389584;39681.80159099186;40540.594594053684;41576.79211603923;41882.58117418909;59551;60412.697936510034;61197.388026119166;61236;61337.386626134954;8429.199226073513;8579.65681372738;8644.91355086441;8693.087225841196;9100.22648074921;12235.632931011727;13808;13918.930405347908;14161.858381416054;14236.928815356272;12427.254364738144;12447.875521245034;12453.128281020605;12555.74888502243;12566.120371573903;12019.519219231133;12182.208156469802;12202.511899523919;12316.876831231573;12707;12199.878001219875;12659;12796.808047879103;12857;12863.163894347212;8485.363597730318;8837.690680826141;8855.91144088551;8980.685676001309;9379.155875971195;8975.461472311683;12170.57402990891;12336.136470447342;12863.678408039874;13123.934380328037 19:46:35 INFO - PROCESS | 19187 | |3;mootools.html;1430.3491911180413;1543.8533339332762;1624.7644091606714;1849.6763066463366;1949.1521188283098;8368.874466882993;8592.785180370494;8617.95691021544;8621.741347759562;8636.30909527238;8450.746477605666;8591.711243313506;8598.871016934736;8635.568221588926;8652.783680407993;2411.6864807575034;2431.173401043645;2437.756224377557;2439.3047981325326;2445.1319781477587;2422.9636555451593;2452.4849781545895;2464.100603279799;2466.075221791828;2480.875956202192;2368.538135063663;2402.8678422686744;2421.406755344934;2426.7694569015916;2430.2830664953794;2437.5368679950843;2444.5721998650165;2456.6069428891383;2457.594496908008;2492.5762620354403;2483.2177863972793;2525.4696513732138;2547.7961763059097;2549.349915771485;2554.348641096527;8648.65405383784;8778.780530486725;8788.560571971377;8818.338624603117;8891.555422228863;5381.246625472398;5481.095619222823;5483.232347471358;5491.478309560585;5493.835184944458;3388.762786604939;3440.449528075521;3461.7749846260162;3578.248567800765;3579.158897659048;1088.3089238333714;1096.1285777806663;1114.6433141394757;1126.9154813388946;1127.1264769803468;12615.747685046339;12728.745425091447;12738.426770795337;12748.298843563693;12748.362581870962;4632.2819962905805;4666.696664716783;4707.552782485658;4809.495003024702;4835.323054772335;10043.548040338203;10045.246606504541;10067.446290454096;10093;10104.797904041878;5415.323084614423;5442.591805614595;5471.124620060771;5479.917801232905;5486.067368547357;4412.205802955435;4439.178751930903;4907.3620429343955;5015.122353588107;5052.292679024939;4026.174634199982;4043.231785960717;4130.359794231899;4138.110306284103;4158.313878210122;1199.400299850075;1208.9516419343304;1211.1764000479582;1218.780619488483;1232.3222227774688;975.8682577852042;976.6239997600833;1059.4755595980039;1061.1828891753307;1076.1928553584812;6210.4410603045035;6232.750689972441;6240.7503699852405;6304.810855674337;6421.133147025185;466.82027419443756;468.5197672385832;477.41755058828176;480.7764389558872;490.2474701333436;4245.12974840157;4313.6980411370905;4359.760213188241;4363.323684828793;4363.956360436418;10886.183536234814;11238.325700457835;11249;11256.15578831591;11282.830757538644;10970.890291097146;10973.341599504056;11063.280886742335;11094;11108.333499990027;8488;8493.447925884797;8585.742427727178;8597.226249637688;8602.827943441096;6031.517478601613;6032.638041717511;6142.324344322032;6210.347913469021;6229.781957631642;9861.063198996084;10001.449920254456;10010.349327293703;10035.444506101567;10142.695719128438;9539.47532885698;9645.37305075168;9801.509924503604;9823.115919567274;9853.06395892389;6832.760853370109;7553.773386798405;7735.7679269622;7914.6834126636595;8053.114157442794;8319.625616847377;8363.372747043873;8412;8450.535220562682;8476.025257095267;7499.2500749924575;7510.399168066432;7513.436492262993;7785.182555831782;7800.882986755089;7534.0582427196605;7559;7568.8486230276185;7652.273034061755;7683.308502234826;7107.395871350786;7128.28717128283;7176.390006849476;7187.353138217585;7192.748253811092;4967.478414766398;4997.775100120576;5096.541311282002;5143.974280128576;5156.278121062979;5277.577793776411;5351.705656188947;5357.24998500218;5431.402545719889;5587.106063029895 19:46:35 INFO - PROCESS | 19187 | |4;prototype.html;345.2370261721595;345.3317829998952;346.229639053107;348.83779042745124;350.94735789631557;6058.5456090793205;6105.969470152643;6112.266528016638;6113.5414843886665;6139.9386006139985;6008.489278411329;6050.455459008688;6082.908756368658;6114.55417832866;6115.663638499881;4429.800658970354;4532.637389008888;4594.425696787902;4677.345171675968;4711.057788442308;4606.838760643378;4687.507811679776;4702.200625893606;4707.811687532495;4712.175369310374;4624.421947256593;4626.236670949289;4630.467496237925;4636.814527418916;4650.627949764028;4417.293233082707;4464;4564.155631208204;4583;4588.01357708091;3984.362501999666;3986.262541429845;3988.2422339755353;3990.20195960809;3996.320625493644;5850.707464626794;5862.560307976876;5869.354371019184;5874.265716785402;5874.3244526879525;5327.706976116312;5329.813456529003;5329.893402131975;5334.1732031535175;5339.65292256006;6401;6405.455536279422;6408.519361047894;6409.070684750732;6412.61524308543;4250.341197114452;4343.804528796211;4389.978050109729;4392.802323895432;4445.444319460067;6598.5051121165625;6668.599884006975;6694.732210711566;6697.430718388894;6705.765298214588;4353.194658988034;4398.56014398564;4401.405810215644;4403.8458653946955;4453.265211240174;4458.308962110878;4465.553444655508;4465.709728867613;4502.549745025472;4503.909921801545;5290.1800220965815;5290.1800220965815;5294.179402192666;5297.231901374356;5298.178782288752;6436.066770318372;6442.291347951722;6445;6448;6452.838679033061;1587.7538981457892;1602.9519114426587;1604.791377120967;1605.9357625695075;1606.8232494425604;1001.0340021878922;1013.8935411781657;1034.4155552113182;1058.6453538064682;1084.5986984815668;6140.6929653517145;6172.351903050205;6178.443940045418;6214.4407003369915;6243.188385509946;6573.638449885207;6578.111954886125;6582.901256481156;6584.341565843473;6593;6225.128482012522;6232.75068997235;6235.719392627343;6240.375962403814;6255.311915689271;3511.5786105667485;3552.786832790041;3554.9466757998653;3561.1097225693575;3563.0914116900026;6816.727330906808;6956.686949087303;7042.295770422917;7083.362497375261;7103.786886393416;6814.761483348158;6829.897551536731;6839.726410943506;6844.384005439534;6845.794626161123;7050.753223637251;7062.470314726416;7067.151941766918;7069.575825450489;7070.399016083587;6688.799336019927;6702.765403210864;6711.865762684816;6716;6718.529702920749;6475.902861456988;6624.536282460374;6624.90062649051;6628.5028622852515;6636.2700102987665;7005.334493223136;7038.683259253244;7040.436765058681;7049.9647501762165;7050.894236586353;4480.551944805494;4514.90970180588;4518.390017347616;4530.886727831698;4536.228841097088;6665.433438157811;6673.733050677918;6683.8997415039785;6685.76599819004;6686.796376652249;6248.094026366242;6422.100905873275;6481.805545833632;6482.416582507597;6495.577787443801;6440.033994900802;6457.3865482779065;6462.709178086903;6463.935360646521;6470.38531339522;6352.269489008823;6355.777547785805;6367.458766004941;6371.681415929278;6373.808785736435;6517.608943463218;6521.902171467526;6522.021696745526;6522.412982831568;6536.215654121535;6010.398960103955;6104.694765261808;6315.242170939517;6381.329960354282;6388.169537960035 19:46:35 INFO - PROCESS | 19187 | |5;yui.html;911.6945823149244;921.7419122645658;928.9631044835373;936.9765755856102;937.1706040154461;14108;14261.286935653216;14265.71468570628;15914.442994495195;16098.83901160988;14390.712185756278;14452.5664230073;14468.348924298405;14500.782488262685;14502.782458263107;764.1861417590277;924.5377311344328;930.4882314726907;932.580338847518;932.5943214701592;925.9166674999249;943.306669597845;943.9433633981948;946.2855544064222;948.1892981500821;971.3928794503436;986.2603047714215;988.5798535622367;989.2531138990053;990.425553179158;785.5954183595453;954.9140577348003;971.9951400242988;973.634886917406;975.7024107647164;711.9928800711979;715.8532500837316;717.4583189691801;718.2314923032305;718.7735863203075;14102.083364581373;14135.646608834759;14154.575362739135;14161.079529830631;14163.22102284374;14324.785128223086;14899.851001489955;14910.70178596433;14991.925040374837;15040.774388384183;11486.942565287203;11573.18987670855;11799.056075513938;11904.047676185884;12226;4026.7583944963394;4045.9190816183805;4095.1195492968855;4183.91632167355;4191.832326706928;58554.41445585532;59485;60202.39797602012;60719.39280607182;60900;10772.461376931122;10848.566057357775;10858.511366988505;10950.780984380268;11166.218364714392;20277.797222027886;20328.593428131353;20418.285360012327;20456.0794764233;20486.078126484343;8661.870071948926;8695.956520217485;8786.073022959275;8796.736097916944;9209.677661281823;5105.9489405106215;5157.896842063138;5199.194124910645;5225.843224703265;5278.049951008778;3682.852685892588;3753.399456087013;3754.3992961126087;3754.4931434256573;3759.981200094037;699.3111784891878;703.6868593475854;712.2770388056127;713.4553691258471;722.584513904507;646.7865604350553;720.0387482710536;736.5433431272538;740.2782287269869;771.6411868481183;9965.455354420077;10215.7446063849;10383.688489345332;10536.947315263375;10695.411752353539;772.4322622872185;809.7044578728721;819.6557844564541;856.8115014696757;878.1043335797451;4415.205263052617;4498.280275155959;4709.105269998689;4740.336352910595;4741.834035808799;64754.67622661951;65361;65361.346386536476;65363.673181633785;65384;53158.46841531535;54409.45590544044;55073.44926550683;55245;55377.723111384184;50912;51831.740841295556;51980.740096299276;52293.215601766;52511;9949.154321882721;10110.89889101129;10274.691759247235;10483.423411712123;10884.346939183675;40172.598274016884;40440.1911961765;40583.1883362337;41006.17987640171;41527.792361038;50183;50643.49356506388;51134.23298650449;51901;53761;13064.21614703121;13191.208527488381;13418.127821691558;13445.46218151263;13520.661983450493;13210.27343496117;13619.79570306466;14491.92754036223;14920.179390133648;14966.700665986837;12697.8281209563;12893.033022523161;12969.221846689228;13143.53997610079;13445.394957226752;12589.24464532131;12854.100212985002;13033.608991730263;13531.661708457368;13574.524891628746;13440.529581464602;13487.460501579826;13549.59351219465;13883.652908677364;14308.928455358073;11310.151738619472;11415.828762568402;11416.200865939305;11568.537258509565;11783.882161178279;11431.542738290374;11769.52921883115;11954.222975506564;12071.336076515876;12083.75832483363 19:46:35 INFO - PROCESS | 19187 | __end_tp_report 19:46:35 INFO - PROCESS | 19187 | __start_cc_report 19:46:35 INFO - PROCESS | 19187 | _x_x_mozilla_cycle_collect,832 19:46:35 INFO - PROCESS | 19187 | __end_cc_report 19:46:35 INFO - PROCESS | 19187 | __startTimestamp1468377995787__endTimestamp 19:46:35 INFO - PROCESS | 19187 | 19:46:35 INFO - PROCESS | 19187 | ------- Summary: start ------- 19:46:35 INFO - PROCESS | 19187 | Number of tests: 6 19:46:35 INFO - PROCESS | 19187 | 19:46:35 INFO - PROCESS | 19187 | [#0] dojo.html Cycles:165 Average:5560.54 Median:5769.05 stddev:628.49 (10.9%) stddev-sans-first:605.20 19:46:35 INFO - PROCESS | 19187 | Values: 3313.7 3352.8 3384.1 3410.9 3415.9 5568.4 5573.0 5577.7 5586.4 5596.7 5552.4 5576.6 5584.5 5593.2 5630.2 5014.8 5031.8 5051.0 5089.6 5154.0 4964.8 5001.8 5073.8 5073.9 5083.1 5064.2 5103.8 5113.9 5127.1 5138.3 5144.1 5192.6 5200.1 5205.5 5223.7 4962.0 5010.7 5077.6 5102.4 5105.4 5401.6 5414.2 5444.8 5454.9 5464.6 5931.9 5953.8 5979.8 5991.6 6000.8 5835.9 5964.8 6013.3 6050.9 6097.8 5619.8 5632.8 5657.9 5661.6 5670.4 6186.2 6201.4 6206.9 6208.3 6210.9 5733.9 5807.8 5879.6 5915.6 5922.1 6005.4 6037.2 6045.8 6054.3 6055.5 5745.1 6002.7 6004.4 6021.2 6024.5 5888.8 5910.8 5915.6 5959.3 5960.9 4525.2 4528.1 4542.2 4543.3 4575.9 4006.7 4026.3 4060.1 4066.4 4101.0 5742.3 5777.6 5778.5 5782.1 5827.6 6021.4 6027.7 6032.7 6033.3 6033.4 5654.0 5670.5 5727.5 5771.1 5831.0 5104.2 5111.4 5111.9 5117.1 5119.4 6281.8 6311.6 6313.0 6317.1 6323.3 5753.4 5877.4 5938.1 5952.9 6002.5 6313.1 6334.0 6336.9 6367.8 6372.4 5934.1 5957.0 5958.0 5960.8 5989.5 5835.5 5922.5 5960.6 5970.2 6004.1 5769.0 5777.5 5778.0 5784.4 5794.5 5651.2 5707.8 5764.1 5779.3 5781.3 5633.4 5701.4 5768.2 5775.2 5795.6 5794.6 5811.5 5819.6 5833.4 5834.0 5567.5 5579.4 5737.7 5746.9 5790.9 19:46:35 INFO - PROCESS | 19187 | 19:46:35 INFO - PROCESS | 19187 | [#1] ext.html Cycles:180 Average:59117.52 Median:35920.64 stddev:116253.36 (323.6%) stddev-sans-first:116496.65 19:46:35 INFO - PROCESS | 19187 | Values: 666.2 672.7 673.9 680.3 748.4 32304.4 41489.0 42052.4 42203.6 42206.8 43535.3 44041.3 44196.0 44241.6 44320.0 7732.2 8727.5 8913.2 8913.3 10262.7 10365.8 10510.9 10518.1 10525.5 10527.6 10498.1 10575.9 10581.4 10583.4 10585.2 10440.9 10508.8 10512.9 10522.6 10525.3 10368.6 10818.0 10829.9 10832.6 10847.9 43476.0 43838.0 43882.3 43981.3 43982.6 3730.2 3775.5 3781.0 3786.0 3862.9 30410.8 30502.2 30626.4 30807.2 31378.5 4166.9 4178.5 4243.1 4292.2 4403.2 294476.0 300799.0 301108.0 301646.0 302853.0 34162.8 34658.8 34728.0 34736.5 65678.3 32962.5 33047.2 33105.8 33178.3 33186.0 15924.8 16092.2 16097.4 16103.7 16118.7 13093.7 14116.5 14325.6 14355.6 14382.6 7661.1 7661.8 7664.0 7702.3 7747.9 3056.7 3224.3 3252.8 3261.3 3269.5 1142.4 1174.8 1180.4 1180.7 1209.8 33332.2 34169.7 34438.5 34732.7 35131.6 1193.0 1228.1 1240.0 1264.0 1304.5 17930.6 17937.2 17978.5 18308.0 18327.8 535516.0 538629.0 543494.0 544257.0 545063.0 64336.4 64497.4 64830.0 64948.7 65103.0 1390.5 1497.6 1520.3 1567.8 1672.4 32349.7 34522.7 34773.7 34878.3 34932.7 55343.7 55880.0 56279.7 56336.0 56373.0 430720.0 439992.0 440350.0 440688.0 441969.0 36709.6 46707.0 47998.3 48373.3 53935.2 52201.0 53416.0 53427.5 53907.7 54253.0 42275.0 43425.3 43765.0 44061.0 44841.8 43197.8 43273.4 43415.6 44135.1 44730.3 45488.0 45683.8 45969.8 46019.5 46445.8 37598.8 39230.2 39311.1 39807.0 39827.4 29745.8 30196.0 30205.2 30227.8 30629.0 19:46:35 INFO - PROCESS | 19187 | 19:46:35 INFO - PROCESS | 19187 | [#2] jquery.html Cycles:180 Average:26271.87 Median:12664.17 stddev:64992.55 (513.2%) stddev-sans-first:65145.85 19:46:35 INFO - PROCESS | 19187 | Values: 404.7 404.7 421.8 422.4 425.8 13821.2 18295.3 18574.8 18798.8 18827.1 15601.7 18503.5 19291.2 19605.3 19893.2 5707.7 5870.5 5880.0 5886.6 5913.7 5740.3 5819.2 5820.6 5824.1 5826.2 5576.8 5739.4 5886.0 5895.2 5897.3 5661.4 5686.3 5691.4 5706.6 5712.6 5017.4 5030.3 5038.6 5075.2 5227.5 23171.4 23751.8 23958.9 24057.5 24117.6 2525.3 2644.5 2719.3 2820.2 2859.9 13754.9 14808.7 14829.6 15069.0 15144.5 1960.2 2024.2 2046.6 2089.6 2156.9 77886.0 78133.6 80116.0 80581.2 81076.6 10104.1 10395.1 10657.4 10738.3 11102.2 14907.7 14989.8 14995.3 15024.0 15031.3 8751.6 8881.4 8883.7 8930.7 8995.8 8916.2 8953.1 8961.3 9052.2 9059.4 6012.7 6728.3 6792.4 6839.7 6869.2 1814.3 1866.8 1917.5 1917.8 1953.2 1011.4 1054.6 1103.5 1106.4 1111.5 18061.4 18334.4 19532.9 19658.1 20078.2 1043.2 1063.5 1110.8 1122.8 1153.3 10962.5 11350.1 11517.0 11535.3 11545.3 314412.0 319369.0 320406.0 320443.0 588480.0 97173.5 98407.5 99868.0 101601.0 101817.0 1105.5 1142.8 1152.0 1160.8 1168.7 17450.7 17724.6 17865.8 17965.8 17975.4 39534.4 39681.8 40540.6 41576.8 41882.6 59551.0 60412.7 61197.4 61236.0 61337.4 8429.2 8579.7 8644.9 8693.1 9100.2 12235.6 13808.0 13918.9 14161.9 14236.9 12427.3 12447.9 12453.1 12555.7 12566.1 12019.5 12182.2 12202.5 12316.9 12707.0 12199.9 12659.0 12796.8 12857.0 12863.2 8485.4 8837.7 8855.9 8980.7 9379.2 8975.5 12170.6 12336.1 12863.7 13123.9 19:46:35 INFO - PROCESS | 19187 | 19:46:35 INFO - PROCESS | 19187 | [#3] mootools.html Cycles:180 Average:5852.02 Median:2645.14 stddev:3289.05 (124.3%) stddev-sans-first:3281.49 19:46:35 INFO - PROCESS | 19187 | Values: 1430.3 1543.9 1624.8 1849.7 1949.2 8368.9 8592.8 8618.0 8621.7 8636.3 8450.7 8591.7 8598.9 8635.6 8652.8 2411.7 2431.2 2437.8 2439.3 2445.1 2423.0 2452.5 2464.1 2466.1 2480.9 2368.5 2402.9 2421.4 2426.8 2430.3 2437.5 2444.6 2456.6 2457.6 2492.6 2483.2 2525.5 2547.8 2549.3 2554.3 8648.7 8778.8 8788.6 8818.3 8891.6 5381.2 5481.1 5483.2 5491.5 5493.8 3388.8 3440.4 3461.8 3578.2 3579.2 1088.3 1096.1 1114.6 1126.9 1127.1 12615.7 12728.7 12738.4 12748.3 12748.4 4632.3 4666.7 4707.6 4809.5 4835.3 10043.5 10045.2 10067.4 10093.0 10104.8 5415.3 5442.6 5471.1 5479.9 5486.1 4412.2 4439.2 4907.4 5015.1 5052.3 4026.2 4043.2 4130.4 4138.1 4158.3 1199.4 1209.0 1211.2 1218.8 1232.3 975.9 976.6 1059.5 1061.2 1076.2 6210.4 6232.8 6240.8 6304.8 6421.1 466.8 468.5 477.4 480.8 490.2 4245.1 4313.7 4359.8 4363.3 4364.0 10886.2 11238.3 11249.0 11256.2 11282.8 10970.9 10973.3 11063.3 11094.0 11108.3 8488.0 8493.4 8585.7 8597.2 8602.8 6031.5 6032.6 6142.3 6210.3 6229.8 9861.1 10001.4 10010.3 10035.4 10142.7 9539.5 9645.4 9801.5 9823.1 9853.1 6832.8 7553.8 7735.8 7914.7 8053.1 8319.6 8363.4 8412.0 8450.5 8476.0 7499.3 7510.4 7513.4 7785.2 7800.9 7534.1 7559.0 7568.8 7652.3 7683.3 7107.4 7128.3 7176.4 7187.4 7192.7 4967.5 4997.8 5096.5 5144.0 5156.3 5277.6 5351.7 5357.2 5431.4 5587.1 19:46:35 INFO - PROCESS | 19187 | 19:46:35 INFO - PROCESS | 19187 | [#4] prototype.html Cycles:180 Average:5384.98 Median:6127.80 stddev:1656.65 (27.0%) stddev-sans-first:1617.53 19:46:35 INFO - PROCESS | 19187 | Values: 345.2 345.3 346.2 348.8 350.9 6058.5 6106.0 6112.3 6113.5 6139.9 6008.5 6050.5 6082.9 6114.6 6115.7 4429.8 4532.6 4594.4 4677.3 4711.1 4606.8 4687.5 4702.2 4707.8 4712.2 4624.4 4626.2 4630.5 4636.8 4650.6 4417.3 4464.0 4564.2 4583.0 4588.0 3984.4 3986.3 3988.2 3990.2 3996.3 5850.7 5862.6 5869.4 5874.3 5874.3 5327.7 5329.8 5329.9 5334.2 5339.7 6401.0 6405.5 6408.5 6409.1 6412.6 4250.3 4343.8 4390.0 4392.8 4445.4 6598.5 6668.6 6694.7 6697.4 6705.8 4353.2 4398.6 4401.4 4403.8 4453.3 4458.3 4465.6 4465.7 4502.5 4503.9 5290.2 5290.2 5294.2 5297.2 5298.2 6436.1 6442.3 6445.0 6448.0 6452.8 1587.8 1603.0 1604.8 1605.9 1606.8 1001.0 1013.9 1034.4 1058.6 1084.6 6140.7 6172.4 6178.4 6214.4 6243.2 6573.6 6578.1 6582.9 6584.3 6593.0 6225.1 6232.8 6235.7 6240.4 6255.3 3511.6 3552.8 3554.9 3561.1 3563.1 6816.7 6956.7 7042.3 7083.4 7103.8 6814.8 6829.9 6839.7 6844.4 6845.8 7050.8 7062.5 7067.2 7069.6 7070.4 6688.8 6702.8 6711.9 6716.0 6718.5 6475.9 6624.5 6624.9 6628.5 6636.3 7005.3 7038.7 7040.4 7050.0 7050.9 4480.6 4514.9 4518.4 4530.9 4536.2 6665.4 6673.7 6683.9 6685.8 6686.8 6248.1 6422.1 6481.8 6482.4 6495.6 6440.0 6457.4 6462.7 6463.9 6470.4 6352.3 6355.8 6367.5 6371.7 6373.8 6517.6 6521.9 6522.0 6522.4 6536.2 6010.4 6104.7 6315.2 6381.3 6388.2 19:46:35 INFO - PROCESS | 19187 | 19:46:35 INFO - PROCESS | 19187 | [#5] yui.html Cycles:180 Average:15866.45 Median:22855.85 stddev:18217.31 (79.7%) stddev-sans-first:18233.80 19:46:35 INFO - PROCESS | 19187 | Values: 911.7 921.7 929.0 937.0 937.2 14108.0 14261.3 14265.7 15914.4 16098.8 14390.7 14452.6 14468.3 14500.8 14502.8 764.2 924.5 930.5 932.6 932.6 925.9 943.3 943.9 946.3 948.2 971.4 986.3 988.6 989.3 990.4 785.6 954.9 972.0 973.6 975.7 712.0 715.9 717.5 718.2 718.8 14102.1 14135.6 14154.6 14161.1 14163.2 14324.8 14899.9 14910.7 14991.9 15040.8 11486.9 11573.2 11799.1 11904.0 12226.0 4026.8 4045.9 4095.1 4183.9 4191.8 58554.4 59485.0 60202.4 60719.4 60900.0 10772.5 10848.6 10858.5 10950.8 11166.2 20277.8 20328.6 20418.3 20456.1 20486.1 8661.9 8696.0 8786.1 8796.7 9209.7 5105.9 5157.9 5199.2 5225.8 5278.0 3682.9 3753.4 3754.4 3754.5 3760.0 699.3 703.7 712.3 713.5 722.6 646.8 720.0 736.5 740.3 771.6 9965.5 10215.7 10383.7 10536.9 10695.4 772.4 809.7 819.7 856.8 878.1 4415.2 4498.3 4709.1 4740.3 4741.8 64754.7 65361.0 65361.3 65363.7 65384.0 53158.5 54409.5 55073.4 55245.0 55377.7 50912.0 51831.7 51980.7 52293.2 52511.0 9949.2 10110.9 10274.7 10483.4 10884.3 40172.6 40440.2 40583.2 41006.2 41527.8 50183.0 50643.5 51134.2 51901.0 53761.0 13064.2 13191.2 13418.1 13445.5 13520.7 13210.3 13619.8 14491.9 14920.2 14966.7 12697.8 12893.0 12969.2 13143.5 13445.4 12589.2 12854.1 13033.6 13531.7 13574.5 13440.5 13487.5 13549.6 13883.7 14308.9 11310.2 11415.8 11416.2 11568.5 11783.9 11431.5 11769.5 11954.2 12071.3 12083.8 19:46:35 INFO - PROCESS | 19187 | -------- Summary: end -------- 19:46:35 INFO - PROCESS | 19187 | 19:46:36 INFO - TEST-INFO | 19187: exit 0 19:46:36 INFO - TEST-OK | dromaeo_css | took 1111265ms 19:46:36 INFO - TEST-START | kraken 19:46:36 INFO - operating with platform_type : linux_ 19:46:36 INFO - Initialising browser for kraken test... 19:46:36 INFO - TEST-INFO | started process 19380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6n9NY/profile http://localhost:38525/getInfo.html) 19:46:40 INFO - PROCESS | 19380 | __metrics Screen width/height:1600/1200 19:46:40 INFO - PROCESS | 19380 | colorDepth:24 19:46:40 INFO - PROCESS | 19380 | Browser inner width/height: 1024/697 19:46:40 INFO - PROCESS | 19380 | __metrics 19:46:41 ERROR - PROCESS | 19380 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:46:42 INFO - TEST-INFO | 19380: exit 0 19:46:42 INFO - Browser initialized. 19:46:42 INFO - Running cycle 1/1 for kraken test... 19:46:42 INFO - TEST-INFO | started process 19471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6n9NY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:46:54 INFO - PROCESS | 19471 | RSS: Main: 139558912 19:46:54 INFO - PROCESS | 19471 | 19:46:56 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38525/tests/kraken/driver.html?testName=audio-beat-detection) 19:46:57 INFO - PROCESS | 19471 | RSS: Main: 197316608 19:46:57 INFO - PROCESS | 19471 | 19:47:00 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38525/tests/kraken/driver.html?testName=audio-dft) 19:47:00 INFO - PROCESS | 19471 | RSS: Main: 183771136 19:47:00 INFO - PROCESS | 19471 | 19:47:03 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38525/tests/kraken/driver.html?testName=audio-fft) 19:47:04 INFO - PROCESS | 19471 | RSS: Main: 273162240 19:47:04 INFO - PROCESS | 19471 | 19:47:06 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38525/tests/kraken/driver.html?testName=audio-oscillator) 19:47:06 INFO - PROCESS | 19471 | RSS: Main: 179351552 19:47:06 INFO - PROCESS | 19471 | 19:47:08 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38525/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:47:09 INFO - PROCESS | 19471 | RSS: Main: 177487872 19:47:09 INFO - PROCESS | 19471 | 19:47:12 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38525/tests/kraken/driver.html?testName=imaging-darkroom) 19:47:13 INFO - PROCESS | 19471 | RSS: Main: 213721088 19:47:13 INFO - PROCESS | 19471 | 19:47:16 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38525/tests/kraken/driver.html?testName=imaging-desaturate) 19:47:16 INFO - PROCESS | 19471 | RSS: Main: 212930560 19:47:16 INFO - PROCESS | 19471 | 19:47:19 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38525/tests/kraken/driver.html?testName=json-parse-financial) 19:47:20 INFO - PROCESS | 19471 | RSS: Main: 212156416 19:47:20 INFO - PROCESS | 19471 | 19:47:21 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38525/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:47:22 INFO - PROCESS | 19471 | RSS: Main: 197038080 19:47:22 INFO - PROCESS | 19471 | 19:47:24 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38525/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:47:24 INFO - PROCESS | 19471 | RSS: Main: 198701056 19:47:24 INFO - PROCESS | 19471 | 19:47:26 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38525/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:47:27 INFO - PROCESS | 19471 | RSS: Main: 210276352 19:47:27 INFO - PROCESS | 19471 | 19:47:29 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:47:30 INFO - PROCESS | 19471 | RSS: Main: 216367104 19:47:30 INFO - PROCESS | 19471 | 19:47:32 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:47:33 INFO - PROCESS | 19471 | RSS: Main: 213458944 19:47:33 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:38525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38525/tests/kraken/driver.html?testName=ai-astar) 19:47:35 INFO - PROCESS | 19471 | RSS: Main: 273727488 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | __start_tp_report 19:47:35 INFO - PROCESS | 19471 | _x_x_mozilla_page_load 19:47:35 INFO - PROCESS | 19471 | _x_x_mozilla_page_load_details 19:47:35 INFO - PROCESS | 19471 | |i|pagename|runs| 19:47:35 INFO - PROCESS | 19471 | |0;ai-astar;114;111;111;113;112;111;105;109;109;108 19:47:35 INFO - PROCESS | 19471 | |1;audio-beat-detection;164;126;153;183;126;161;154;126;176;127 19:47:35 INFO - PROCESS | 19471 | |2;audio-dft;162;160;162;164;159;160;160;161;159;161 19:47:35 INFO - PROCESS | 19471 | |3;audio-fft;77;77;75;173;77;77;72;76;160;77 19:47:35 INFO - PROCESS | 19471 | |4;audio-oscillator;92;91;152;91;91;91;146;92;92;147 19:47:35 INFO - PROCESS | 19471 | |5;imaging-gaussian-blur;118;118;117;118;117;118;117;117;116;117 19:47:35 INFO - PROCESS | 19471 | |6;imaging-darkroom;145;146;145;145;145;145;146;145;146;144 19:47:35 INFO - PROCESS | 19471 | |7;imaging-desaturate;94;95;95;94;94;94;95;94;94;95 19:47:35 INFO - PROCESS | 19471 | |8;json-parse-financial;54;56;54;54;55;55;55;75;53;54 19:47:35 INFO - PROCESS | 19471 | |9;json-stringify-tinderbox;57;60;56;57;57;57;58;58;57;58 19:47:35 INFO - PROCESS | 19471 | |10;stanford-crypto-aes;73;73;73;73;73;73;74;72;73;73 19:47:35 INFO - PROCESS | 19471 | |11;stanford-crypto-ccm;113;117;112;112;118;121;114;113;126;124 19:47:35 INFO - PROCESS | 19471 | |12;stanford-crypto-pbkdf2;158;157;158;159;157;158;156;156;156;156 19:47:35 INFO - PROCESS | 19471 | |13;stanford-crypto-sha256-iterative;69;65;66;66;66;63;65;64;65;68 19:47:35 INFO - PROCESS | 19471 | __end_tp_report 19:47:35 INFO - PROCESS | 19471 | __start_cc_report 19:47:35 INFO - PROCESS | 19471 | _x_x_mozilla_cycle_collect,1571 19:47:35 INFO - PROCESS | 19471 | __end_cc_report 19:47:35 INFO - PROCESS | 19471 | __startTimestamp1468378055352__endTimestamp 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | ------- Summary: start ------- 19:47:35 INFO - PROCESS | 19471 | Number of tests: 14 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.63 (2.4%) stddev-sans-first:2.42 19:47:35 INFO - PROCESS | 19471 | Values: 114.0 111.0 111.0 113.0 112.0 111.0 105.0 109.0 109.0 108.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:157.50 stddev:22.02 (14.0%) stddev-sans-first:22.73 19:47:35 INFO - PROCESS | 19471 | Values: 164.0 126.0 153.0 183.0 126.0 161.0 154.0 126.0 176.0 127.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.55 (1.0%) stddev-sans-first:1.58 19:47:35 INFO - PROCESS | 19471 | Values: 162.0 160.0 162.0 164.0 159.0 160.0 160.0 161.0 159.0 161.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#3] audio-fft Cycles:10 Average:94.10 Median:77.00 stddev:38.31 (49.8%) stddev-sans-first:40.13 19:47:35 INFO - PROCESS | 19471 | Values: 77.0 77.0 75.0 173.0 77.0 77.0 72.0 76.0 160.0 77.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:91.00 stddev:27.53 (30.3%) stddev-sans-first:28.55 19:47:35 INFO - PROCESS | 19471 | Values: 92.0 91.0 152.0 91.0 91.0 91.0 146.0 92.0 92.0 147.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 19:47:35 INFO - PROCESS | 19471 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 116.0 117.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 19:47:35 INFO - PROCESS | 19471 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 144.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:47:35 INFO - PROCESS | 19471 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:55.00 stddev:6.55 (11.9%) stddev-sans-first:6.89 19:47:35 INFO - PROCESS | 19471 | Values: 54.0 56.0 54.0 54.0 55.0 55.0 55.0 75.0 53.0 54.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:57.50 stddev:1.08 (1.9%) stddev-sans-first:1.13 19:47:35 INFO - PROCESS | 19471 | Values: 57.0 60.0 56.0 57.0 57.0 57.0 58.0 58.0 57.0 58.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:0.47 (0.6%) stddev-sans-first:0.50 19:47:35 INFO - PROCESS | 19471 | Values: 73.0 73.0 73.0 73.0 73.0 73.0 74.0 72.0 73.0 73.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:117.50 stddev:5.14 (4.4%) stddev-sans-first:5.25 19:47:35 INFO - PROCESS | 19471 | Values: 113.0 117.0 112.0 112.0 118.0 121.0 114.0 113.0 126.0 124.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:157.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 19:47:35 INFO - PROCESS | 19471 | Values: 158.0 157.0 158.0 159.0 157.0 158.0 156.0 156.0 156.0 156.0 19:47:35 INFO - PROCESS | 19471 | 19:47:35 INFO - PROCESS | 19471 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.77 (2.7%) stddev-sans-first:1.41 19:47:35 INFO - PROCESS | 19471 | Values: 69.0 65.0 66.0 66.0 66.0 63.0 65.0 64.0 65.0 68.0 19:47:35 INFO - PROCESS | 19471 | -------- Summary: end -------- 19:47:35 INFO - PROCESS | 19471 | 19:47:36 INFO - TEST-INFO | 19471: exit 0 19:47:36 INFO - TEST-OK | kraken | took 59927ms 19:47:36 INFO - SUITE-END | took 1171s 19:47:36 INFO - Completed test suite (00:19:31) 19:47:36 INFO - javascript benchmark 19:47:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.701766840984, 3352.832358382082, 3384.137045053511, 3410.9488357674622, 3415.914602134948, 5568.443155684429, 5573.024720673881, 5577.749001294941, 5586.385497595261, 5596.748146333414, 5552.361478429972, 5576.553875689945, 5584.52531534819, 5593.161025846125, 5630.2117703521435, 5014.774335154918, 5031.84904452867, 5050.974745126287, 5089.592832573404, 5154.046501397253, 4964.751762411883, 5001.799928002875, 5073.797048118089, 5073.898522029557, 5083.135866902617, 5064.215046667772, 5103.795848166069, 5113.923291150636, 5127.128388174019, 5138.254953031808, 5144.0740666679985, 5192.58459323257, 5200.115980283361, 5205.453427390145, 5223.660462069991, 4962.0324036812835, 5010.699358038493, 5077.593792496591, 5102.36220472441, 5105.438401775802, 5401.648892821993, 5414.242006119146, 5444.8094316698725, 5454.91817622736, 5464.617476776627, 5931.851703707399, 5953.761849526014, 5979.820605381846, 5991.610545314541, 6000.75996960121, 5835.883282334329, 5964.791232306892, 6013.278406591237, 6050.909236361458, 6097.756089756404, 5619.831405057855, 5632.831015069554, 5657.886842263173, 5661.60368774186, 5670.404607516151, 6186.19579454677, 6201.410865967816, 6206.875862482815, 6208.317085120633, 6210.9068363974575, 5733.942660573341, 5807.767689292381, 5879.559033072536, 5915.556333275022, 5922.1412895130825, 6005.39946005396, 6037.154798328237, 6045.8488537786025, 6054.303755068224, 6055.455009049207, 5745.13822926556, 6002.6698531580305, 6004.42957918997, 6021.217241758631, 6024.457798798129, 5888.793892213752, 5910.822675319661, 5915.645061296336, 5959.255093113361, 5960.940390596125, 4525.208088584484, 4528.071745292207, 4542.205114105019, 4543.341215523797, 4575.885602859955, 4006.6794656427414, 4026.275270451288, 4060.147369052473, 4066.4103704962613, 4101.036256479725, 5742.253507044057, 5777.6133727905, 5778.479936805707, 5782.074868021096, 5827.562932780059, 6021.42796434338, 6027.698615069229, 6032.698365081728, 6033.336333003366, 6033.366496517802, 5653.971730141405, 5670.461306175906, 5727.513161381329, 5771.105478650816, 5831.037878750044, 5104.18333066715, 5111.437741848394, 5111.948880511147, 5117.104506711311, 5119.436861945183, 6281.811545653638, 6311.589746666452, 6313.0, 6317.147185129948, 6323.30443651198, 5753.3958934311295, 5877.4122587740885, 5938.079597662369, 5952.940470595412, 6002.459778619857, 6313.11870061635, 6334.049892516159, 6336.936630633634, 6367.840803979938, 6372.36276372359, 5934.080217566284, 5956.970215148896, 5958.046712525975, 5960.791372302122, 5989.52083833301, 5835.503982161564, 5922.496587789914, 5960.552958528215, 5970.223870896929, 6004.099385092271, 5769.048107062287, 5777.537796976316, 5778.0, 5784.421557844182, 5794.507466865363, 5651.180578816131, 5707.800226992035, 5764.106563482499, 5779.335376431764, 5781.277340332458, 5633.4084921082695, 5701.40135285789, 5768.192453056491, 5775.220345253337, 5795.565332599987, 5794.62334948227, 5811.53507719373, 5819.592628515963, 5833.445822646841, 5834.03738383162, 5567.47109024642, 5579.414161512983, 5737.684427356368, 5746.913796293143, 5790.9420905792085], "value": 5519.245129515331, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.1639642248978, 672.7309076369448, 673.8551211489532, 680.3094858718401, 748.3564134844037, 32304.353912921757, 41489.0, 42052.36921446173, 42203.57796422035, 42206.7889660552, 43535.34696979548, 44041.339379909245, 44196.0, 44241.55758442415, 44320.0, 7732.226777322251, 8727.51998640073, 8913.242374398184, 8913.28693704502, 10262.692119236397, 10365.844512332322, 10510.894891051068, 10518.053375196268, 10525.526351314209, 10527.578896844117, 10498.107660848837, 10575.894241057567, 10581.36511809294, 10583.3649981001, 10585.153187744962, 10440.895591044105, 10508.842367364496, 10512.947435262775, 10522.579096836118, 10525.263231573794, 10368.637097701545, 10818.0, 10829.945850270777, 10832.566697332097, 10847.891521084766, 43476.0, 43838.0, 43882.341764873556, 43981.34027989551, 43982.56017439817, 3730.198007428389, 3775.528058992626, 3781.0499040785476, 3786.0345611869075, 3862.864799732024, 30410.84794576035, 30502.237444063852, 30626.38747225043, 30807.229819254473, 31378.52932205996, 4166.895827604304, 4178.456800615901, 4243.087736136746, 4292.248856450109, 4403.207422663919, 294476.0, 300799.0, 301107.9999999978, 301646.0, 302853.0, 34162.82918585391, 34658.82670586631, 34728.0, 34736.47895281573, 65678.34321656817, 32962.50556241658, 33047.17382065419, 33105.83447082749, 33178.3364332712, 33186.0, 15924.840751592335, 16092.195390230441, 16097.356105755638, 16103.677926441405, 16118.677626447405, 13093.738125237442, 14116.50592229267, 14325.64185895361, 14355.56933292003, 14382.568522944328, 7661.118971318369, 7661.808454788564, 7663.961680191564, 7702.306792388712, 7747.92252077472, 3056.7401770849283, 3224.2584205632834, 3252.804831710105, 3261.3314270574474, 3269.493228549579, 1142.3716955674347, 1174.8120300751839, 1180.3685028509879, 1180.722530205401, 1209.848768903887, 33332.1666958328, 34169.65830341714, 34438.48342274868, 34732.65267347294, 35131.64868351335, 1192.9656848101, 1228.0789407944042, 1240.022164647386, 1263.993680031594, 1304.5368894042667, 17930.5517362067, 17937.192826322847, 17978.460646180636, 18307.993060381807, 18327.816721832878, 535516.0, 538629.0, 543494.0, 544257.0, 545063.0, 64336.35663643304, 64497.35502645007, 64830.0, 64948.67525662341, 65103.0, 1390.464671101613, 1497.573191640399, 1520.2702702702766, 1567.7569976653638, 1672.406295764986, 32349.676503234667, 34522.65477345194, 34773.73970691897, 34878.302433950674, 34932.650673493954, 55343.72328138333, 55880.0, 56279.718601406734, 56336.0, 56373.0, 430720.0, 439992.0, 440350.0, 440688.0, 441969.0, 36709.63290367169, 46707.0, 47998.280025798944, 48373.27440088331, 53935.19097213623, 52201.0, 53416.0, 53427.46572534225, 53907.73046134744, 54253.0, 42275.0, 43425.3486197701, 43765.0, 44061.0, 44841.77579112084, 43197.78401107974, 43273.3508997359, 43415.56584434115, 44135.117297654506, 44730.3290450637, 45488.0, 45683.77158114188, 45969.77015114903, 46019.539804602864, 46445.76777116093, 37598.8120059398, 39230.215395692496, 39311.14075450757, 39807.0, 39827.40258896177, 29745.788545242463, 30196.0, 30205.244868878453, 30227.848860755556, 30629.0], "value": 20020.536833221147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.6519992806187, 404.68232437536534, 421.79964516854477, 422.3812115251158, 425.77264336330614, 13821.219249631173, 18295.26818927243, 18574.81425185748, 18798.812011879876, 18827.05864706766, 15601.687966240668, 18503.537411564717, 19291.228350865982, 19605.313814016514, 19893.20427182911, 5707.743151558169, 5870.471657550841, 5880.029795083806, 5886.6173698709445, 5913.674747888865, 5740.311162660487, 5819.156222347757, 5820.592558520905, 5824.126381042835, 5826.242588463515, 5576.832695019156, 5739.426057394269, 5885.970570147165, 5895.204147440105, 5897.262842144732, 5661.377248502661, 5686.317641882959, 5691.402402747714, 5706.572007099463, 5712.600117991742, 5017.37282839645, 5030.2957585938, 5038.622103342264, 5075.213341932006, 5227.451117632631, 23171.420714482105, 23751.76248237513, 23958.880205599035, 24057.518849623084, 24117.638235426482, 2525.330787341356, 2644.457886133338, 2719.265798234466, 2820.19624407043, 2859.8646377288796, 13754.93122534381, 14808.703825923529, 14829.629259268497, 15069.0, 15144.54566363011, 1960.1767257751778, 2024.170090262985, 2046.6009128220003, 2089.613421517009, 2156.91372345106, 77886.0, 78133.60933195298, 80116.0, 80581.19418805854, 81076.59461702712, 10104.141148002502, 10395.128876802248, 10657.360558366368, 10738.302010369302, 11102.222844400976, 14907.70184596302, 14989.775153372708, 14995.250237488082, 15024.0, 15031.323590438456, 8751.56242187888, 8881.42270752412, 8883.73348799537, 8930.68742594019, 8995.77510562228, 8916.242119419792, 8953.149450802164, 8961.283097352327, 9052.185303322733, 9059.36584439083, 6012.729427175787, 6728.293529179464, 6792.354726300993, 6839.726410943606, 6869.210040845367, 1814.2978086668772, 1866.7759868815558, 1917.4822797844784, 1917.7986311437378, 1953.1601411393237, 1011.4083261292227, 1054.5570860238718, 1103.5254840418536, 1106.446776611694, 1111.5109351885305, 18061.367852125113, 18334.358297459527, 19532.92568908695, 19658.051292306267, 20078.196872125245, 1043.2488608202082, 1063.5320458998017, 1110.7500812317164, 1122.7586068995206, 1153.2734377342222, 10962.506687199095, 11350.148738844455, 11517.0, 11535.250208736574, 11545.307281563133, 314412.0, 319369.0, 320406.0, 320443.0, 588480.0, 97173.5141324303, 98407.50796245973, 99868.0, 101601.0, 101817.0, 1105.4638500327335, 1142.7543078238218, 1152.0438036429744, 1160.8200728887036, 1168.7311918258847, 17450.73823892668, 17724.645507089528, 17865.821341786937, 17965.820341796414, 17975.370862019765, 39534.40698389584, 39681.80159099186, 40540.594594053684, 41576.79211603923, 41882.58117418909, 59551.0, 60412.697936510034, 61197.388026119166, 61236.0, 61337.386626134954, 8429.199226073513, 8579.65681372738, 8644.91355086441, 8693.087225841196, 9100.22648074921, 12235.632931011727, 13808.0, 13918.930405347908, 14161.858381416054, 14236.928815356272, 12427.254364738144, 12447.875521245034, 12453.128281020605, 12555.74888502243, 12566.120371573903, 12019.519219231133, 12182.208156469802, 12202.511899523919, 12316.876831231573, 12707.0, 12199.878001219875, 12659.0, 12796.808047879103, 12857.0, 12863.163894347212, 8485.363597730318, 8837.690680826141, 8855.91144088551, 8980.685676001309, 9379.155875971195, 8975.461472311683, 12170.57402990891, 12336.136470447342, 12863.678408039874, 13123.934380328037], "value": 9599.403234567788, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.3491911180413, 1543.8533339332762, 1624.7644091606714, 1849.6763066463366, 1949.1521188283098, 8368.874466882993, 8592.785180370494, 8617.95691021544, 8621.741347759562, 8636.30909527238, 8450.746477605666, 8591.711243313506, 8598.871016934736, 8635.568221588926, 8652.783680407993, 2411.6864807575034, 2431.173401043645, 2437.756224377557, 2439.3047981325326, 2445.1319781477587, 2422.9636555451593, 2452.4849781545895, 2464.100603279799, 2466.075221791828, 2480.875956202192, 2368.538135063663, 2402.8678422686744, 2421.406755344934, 2426.7694569015916, 2430.2830664953794, 2437.5368679950843, 2444.5721998650165, 2456.6069428891383, 2457.594496908008, 2492.5762620354403, 2483.2177863972793, 2525.4696513732138, 2547.7961763059097, 2549.349915771485, 2554.348641096527, 8648.65405383784, 8778.780530486725, 8788.560571971377, 8818.338624603117, 8891.555422228863, 5381.246625472398, 5481.095619222823, 5483.232347471358, 5491.478309560585, 5493.835184944458, 3388.762786604939, 3440.449528075521, 3461.7749846260162, 3578.248567800765, 3579.158897659048, 1088.3089238333714, 1096.1285777806663, 1114.6433141394757, 1126.9154813388946, 1127.1264769803468, 12615.747685046339, 12728.745425091447, 12738.426770795337, 12748.298843563693, 12748.362581870962, 4632.2819962905805, 4666.696664716783, 4707.552782485658, 4809.495003024702, 4835.323054772335, 10043.548040338203, 10045.246606504541, 10067.446290454096, 10093.0, 10104.797904041878, 5415.323084614423, 5442.591805614595, 5471.124620060771, 5479.917801232905, 5486.067368547357, 4412.205802955435, 4439.178751930903, 4907.3620429343955, 5015.122353588107, 5052.292679024939, 4026.174634199982, 4043.231785960717, 4130.359794231899, 4138.110306284103, 4158.313878210122, 1199.400299850075, 1208.9516419343304, 1211.1764000479582, 1218.780619488483, 1232.3222227774688, 975.8682577852042, 976.6239997600833, 1059.4755595980039, 1061.1828891753307, 1076.1928553584812, 6210.4410603045035, 6232.750689972441, 6240.7503699852405, 6304.810855674337, 6421.133147025185, 466.82027419443756, 468.5197672385832, 477.41755058828176, 480.7764389558872, 490.2474701333436, 4245.12974840157, 4313.6980411370905, 4359.760213188241, 4363.323684828793, 4363.956360436418, 10886.183536234814, 11238.325700457835, 11249.0, 11256.15578831591, 11282.830757538644, 10970.890291097146, 10973.341599504056, 11063.280886742335, 11094.0, 11108.333499990027, 8488.0, 8493.447925884797, 8585.742427727178, 8597.226249637688, 8602.827943441096, 6031.517478601613, 6032.638041717511, 6142.324344322032, 6210.347913469021, 6229.781957631642, 9861.063198996084, 10001.449920254456, 10010.349327293703, 10035.444506101567, 10142.695719128438, 9539.47532885698, 9645.37305075168, 9801.509924503604, 9823.115919567274, 9853.06395892389, 6832.760853370109, 7553.773386798405, 7735.7679269622, 7914.6834126636595, 8053.114157442794, 8319.625616847377, 8363.372747043873, 8412.0, 8450.535220562682, 8476.025257095267, 7499.2500749924575, 7510.399168066432, 7513.436492262993, 7785.182555831782, 7800.882986755089, 7534.0582427196605, 7559.0, 7568.8486230276185, 7652.273034061755, 7683.308502234826, 7107.395871350786, 7128.28717128283, 7176.390006849476, 7187.353138217585, 7192.748253811092, 4967.478414766398, 4997.775100120576, 5096.541311282002, 5143.974280128576, 5156.278121062979, 5277.577793776411, 5351.705656188947, 5357.24998500218, 5431.402545719889, 5587.106063029895], "value": 4640.804339420364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.2370261721595, 345.3317829998952, 346.229639053107, 348.83779042745124, 350.94735789631557, 6058.5456090793205, 6105.969470152643, 6112.266528016638, 6113.5414843886665, 6139.9386006139985, 6008.489278411329, 6050.455459008688, 6082.908756368658, 6114.55417832866, 6115.663638499881, 4429.800658970354, 4532.637389008888, 4594.425696787902, 4677.345171675968, 4711.057788442308, 4606.838760643378, 4687.507811679776, 4702.200625893606, 4707.811687532495, 4712.175369310374, 4624.421947256593, 4626.236670949289, 4630.467496237925, 4636.814527418916, 4650.627949764028, 4417.293233082707, 4464.0, 4564.155631208204, 4583.0, 4588.01357708091, 3984.362501999666, 3986.262541429845, 3988.2422339755353, 3990.20195960809, 3996.320625493644, 5850.707464626794, 5862.560307976876, 5869.354371019184, 5874.265716785402, 5874.3244526879525, 5327.706976116312, 5329.813456529003, 5329.893402131975, 5334.1732031535175, 5339.65292256006, 6401.0, 6405.455536279422, 6408.519361047894, 6409.070684750732, 6412.61524308543, 4250.341197114452, 4343.804528796211, 4389.978050109729, 4392.802323895432, 4445.444319460067, 6598.5051121165625, 6668.599884006975, 6694.732210711566, 6697.430718388894, 6705.765298214588, 4353.194658988034, 4398.56014398564, 4401.405810215644, 4403.8458653946955, 4453.265211240174, 4458.308962110878, 4465.553444655508, 4465.709728867613, 4502.549745025472, 4503.909921801545, 5290.1800220965815, 5290.1800220965815, 5294.179402192666, 5297.231901374356, 5298.178782288752, 6436.066770318372, 6442.291347951722, 6445.0, 6448.0, 6452.838679033061, 1587.7538981457892, 1602.9519114426587, 1604.791377120967, 1605.9357625695075, 1606.8232494425604, 1001.0340021878922, 1013.8935411781657, 1034.4155552113182, 1058.6453538064682, 1084.5986984815668, 6140.6929653517145, 6172.351903050205, 6178.443940045418, 6214.4407003369915, 6243.188385509946, 6573.638449885207, 6578.111954886125, 6582.901256481156, 6584.341565843473, 6593.0, 6225.128482012522, 6232.75068997235, 6235.719392627343, 6240.375962403814, 6255.311915689271, 3511.5786105667485, 3552.786832790041, 3554.9466757998653, 3561.1097225693575, 3563.0914116900026, 6816.727330906808, 6956.686949087303, 7042.295770422917, 7083.362497375261, 7103.786886393416, 6814.761483348158, 6829.897551536731, 6839.726410943506, 6844.384005439534, 6845.794626161123, 7050.753223637251, 7062.470314726416, 7067.151941766918, 7069.575825450489, 7070.399016083587, 6688.799336019927, 6702.765403210864, 6711.865762684816, 6716.0, 6718.529702920749, 6475.902861456988, 6624.536282460374, 6624.90062649051, 6628.5028622852515, 6636.2700102987665, 7005.334493223136, 7038.683259253244, 7040.436765058681, 7049.9647501762165, 7050.894236586353, 4480.551944805494, 4514.90970180588, 4518.390017347616, 4530.886727831698, 4536.228841097088, 6665.433438157811, 6673.733050677918, 6683.8997415039785, 6685.76599819004, 6686.796376652249, 6248.094026366242, 6422.100905873275, 6481.805545833632, 6482.416582507597, 6495.577787443801, 6440.033994900802, 6457.3865482779065, 6462.709178086903, 6463.935360646521, 6470.38531339522, 6352.269489008823, 6355.777547785805, 6367.458766004941, 6371.681415929278, 6373.808785736435, 6517.608943463218, 6521.902171467526, 6522.021696745526, 6522.412982831568, 6536.215654121535, 6010.398960103955, 6104.694765261808, 6315.242170939517, 6381.329960354282, 6388.169537960035], "value": 4844.614130747921, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.6945823149244, 921.7419122645658, 928.9631044835373, 936.9765755856102, 937.1706040154461, 14108.0, 14261.286935653216, 14265.71468570628, 15914.442994495195, 16098.83901160988, 14390.712185756278, 14452.5664230073, 14468.348924298405, 14500.782488262685, 14502.782458263107, 764.1861417590277, 924.5377311344328, 930.4882314726907, 932.580338847518, 932.5943214701592, 925.9166674999249, 943.306669597845, 943.9433633981948, 946.2855544064222, 948.1892981500821, 971.3928794503436, 986.2603047714215, 988.5798535622367, 989.2531138990053, 990.425553179158, 785.5954183595453, 954.9140577348003, 971.9951400242988, 973.634886917406, 975.7024107647164, 711.9928800711979, 715.8532500837316, 717.4583189691801, 718.2314923032305, 718.7735863203075, 14102.083364581373, 14135.646608834759, 14154.575362739135, 14161.079529830631, 14163.22102284374, 14324.785128223086, 14899.851001489955, 14910.70178596433, 14991.925040374837, 15040.774388384183, 11486.942565287203, 11573.18987670855, 11799.056075513938, 11904.047676185884, 12226.0, 4026.7583944963394, 4045.9190816183805, 4095.1195492968855, 4183.91632167355, 4191.832326706928, 58554.41445585532, 59485.0, 60202.39797602012, 60719.39280607182, 60900.0, 10772.461376931122, 10848.566057357775, 10858.511366988505, 10950.780984380268, 11166.218364714392, 20277.797222027886, 20328.593428131353, 20418.285360012327, 20456.0794764233, 20486.078126484343, 8661.870071948926, 8695.956520217485, 8786.073022959275, 8796.736097916944, 9209.677661281823, 5105.9489405106215, 5157.896842063138, 5199.194124910645, 5225.843224703265, 5278.049951008778, 3682.852685892588, 3753.399456087013, 3754.3992961126087, 3754.4931434256573, 3759.981200094037, 699.3111784891878, 703.6868593475854, 712.2770388056127, 713.4553691258471, 722.584513904507, 646.7865604350553, 720.0387482710536, 736.5433431272538, 740.2782287269869, 771.6411868481183, 9965.455354420077, 10215.7446063849, 10383.688489345332, 10536.947315263375, 10695.411752353539, 772.4322622872185, 809.7044578728721, 819.6557844564541, 856.8115014696757, 878.1043335797451, 4415.205263052617, 4498.280275155959, 4709.105269998689, 4740.336352910595, 4741.834035808799, 64754.67622661951, 65361.0, 65361.346386536476, 65363.673181633785, 65384.0, 53158.46841531535, 54409.45590544044, 55073.44926550683, 55245.0, 55377.723111384184, 50912.0, 51831.740841295556, 51980.740096299276, 52293.215601766, 52511.0, 9949.154321882721, 10110.89889101129, 10274.691759247235, 10483.423411712123, 10884.346939183675, 40172.598274016884, 40440.1911961765, 40583.1883362337, 41006.17987640171, 41527.792361038, 50183.0, 50643.49356506388, 51134.23298650449, 51901.0, 53761.0, 13064.21614703121, 13191.208527488381, 13418.127821691558, 13445.46218151263, 13520.661983450493, 13210.27343496117, 13619.79570306466, 14491.92754036223, 14920.179390133648, 14966.700665986837, 12697.8281209563, 12893.033022523161, 12969.221846689228, 13143.53997610079, 13445.394957226752, 12589.24464532131, 12854.100212985002, 13033.608991730263, 13531.661708457368, 13574.524891628746, 13440.529581464602, 13487.460501579826, 13549.59351219465, 13883.652908677364, 14308.928455358073, 11310.151738619472, 11415.828762568402, 11416.200865939305, 11568.537258509565, 11783.882161178279, 11431.542738290374, 11769.52921883115, 11954.222975506564, 12071.336076515876, 12083.75832483363], "value": 7315.771686839861, "unit": "score"}], "name": "dromaeo_css", "value": 7475.242874743361, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 111.0, 113.0, 112.0, 111.0, 105.0, 109.0, 109.0, 108.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 126.0, 153.0, 183.0, 126.0, 161.0, 154.0, 126.0, 176.0, 127.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 164.0, 159.0, 160.0, 160.0, 161.0, 159.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 173.0, 77.0, 77.0, 72.0, 76.0, 160.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 152.0, 91.0, 91.0, 91.0, 146.0, 92.0, 92.0, 147.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 144.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 54.0, 55.0, 55.0, 55.0, 75.0, 53.0, 54.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 56.0, 57.0, 57.0, 57.0, 58.0, 58.0, 57.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 73.0, 73.0, 74.0, 72.0, 73.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 112.0, 112.0, 118.0, 121.0, 114.0, 113.0, 126.0, 124.0], "value": 117.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 158.0, 159.0, 157.0, 158.0, 156.0, 156.0, 156.0, 156.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 66.0, 66.0, 63.0, 65.0, 64.0, 65.0, 68.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1506.9999999999998, "alertThreshold": 2.0}]} 19:47:36 INFO - Return code: 0 19:47:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:47:36 ERROR - # TBPL SUCCESS # 19:47:36 INFO - Running post-action listener: _resource_record_post_action 19:47:36 INFO - Running post-run listener: _resource_record_post_run 19:47:37 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 24576; Write bytes: 462647296; Read time: 12; Write time: 430300 19:47:37 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 175173632; Read time: 0; Write time: 260104 19:47:37 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 219901952; Read time: 0; Write time: 125916 19:47:37 INFO - Running post-run listener: _upload_blobber_files 19:47:37 INFO - Blob upload gear active. 19:47:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:47:37 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 19:47:37 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'] 19:47:37 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 19:47:38 INFO - (blobuploader) - INFO - Open directory for files ... 19:47:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:47:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:47:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:38 INFO - (blobuploader) - INFO - Done attempting. 19:47:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:47:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:47:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:39 INFO - (blobuploader) - INFO - Done attempting. 19:47:39 INFO - (blobuploader) - INFO - Iteration through files over. 19:47:39 INFO - Return code: 0 19:47:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:47:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:47:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b68c0af6333d7c9ac32d0baed1cd2ba253857f526b388d1682e7637d13749931f66d57fd86da221c9d234f8ca50d6a8f5ca82365b458628dbe6463579d1602df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5fc91c2538ae8d05282ce5f4a74ad8938fa3231a38ae86e174ce5b0aaa451fd2c56120a406698d1a7bedf9f29f6630466b7aad3445888e61fbbc3a14c7fdf17"} 19:47:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:47:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:47:39 INFO - Contents: 19:47:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b68c0af6333d7c9ac32d0baed1cd2ba253857f526b388d1682e7637d13749931f66d57fd86da221c9d234f8ca50d6a8f5ca82365b458628dbe6463579d1602df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5fc91c2538ae8d05282ce5f4a74ad8938fa3231a38ae86e174ce5b0aaa451fd2c56120a406698d1a7bedf9f29f6630466b7aad3445888e61fbbc3a14c7fdf17"} 19:47:39 INFO - Running post-run listener: copy_logs_to_upload_dir 19:47:39 INFO - Copying logs to upload dir... 19:47:39 INFO - mkdir: /builds/slave/test/build/upload/logs 19:47:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.877505 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-12 19:47:39.405608) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:47:39.408954) ========= 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=d2a8c569965ab8367867b893000001a1-1468375849.755809-657731516 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/b68c0af6333d7c9ac32d0baed1cd2ba253857f526b388d1682e7637d13749931f66d57fd86da221c9d234f8ca50d6a8f5ca82365b458628dbe6463579d1602df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5fc91c2538ae8d05282ce5f4a74ad8938fa3231a38ae86e174ce5b0aaa451fd2c56120a406698d1a7bedf9f29f6630466b7aad3445888e61fbbc3a14c7fdf17"} build_url:https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b68c0af6333d7c9ac32d0baed1cd2ba253857f526b388d1682e7637d13749931f66d57fd86da221c9d234f8ca50d6a8f5ca82365b458628dbe6463579d1602df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5fc91c2538ae8d05282ce5f4a74ad8938fa3231a38ae86e174ce5b0aaa451fd2c56120a406698d1a7bedf9f29f6630466b7aad3445888e61fbbc3a14c7fdf17"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:47:39.434219) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:47:39.434559) ========= 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=d2a8c569965ab8367867b893000001a1-1468375849.755809-657731516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:47:39.520406) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:47:39.520742) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:47:39.521096) ========= ========= Total master_lag: 0.17 =========