builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1463507504.08 results: success (0) buildid: 20160517004009 builduid: ef91a013044b49f4abd91345e579e6b6 revision: 17724486e1591858eea09dc327475a25883854a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.080881) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.081307) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.081617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.116723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.117005) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 10:51:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.8M=0s 2016-05-17 10:51:44 (34.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081568 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.220062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.220374) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018172 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.270333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.270701) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 17724486e1591858eea09dc327475a25883854a4 --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-aurora --rev 17724486e1591858eea09dc327475a25883854a4 --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=a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 10:51:44,402 truncating revision to first 12 chars 2016-05-17 10:51:44,402 Setting DEBUG logging. 2016-05-17 10:51:44,402 attempt 1/10 2016-05-17 10:51:44,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/17724486e159?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 10:51:44,688 unpacking tar archive at: mozilla-aurora-17724486e159/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603144 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.886807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.887121) ========= script_repo_revision: 17724486e1591858eea09dc327475a25883854a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.887576) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.887921) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.912666) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-17 10:51:44.912981) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:51:45 INFO - MultiFileLogger online at 20160517 10:51:45 in /builds/slave/test 10:51:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:51:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:51:45 INFO - {'append_to_log': False, 10:51:45 INFO - 'base_work_dir': '/builds/slave/test', 10:51:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:51:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:51:45 INFO - 'branch': 'Mozilla-Aurora', 10:51:45 INFO - 'buildbot_json_path': 'buildprops.json', 10:51:45 INFO - 'config_files': ('talos/linux_config.py',), 10:51:45 INFO - 'default_actions': ('clobber', 10:51:45 INFO - 'read-buildbot-config', 10:51:45 INFO - 'download-and-extract', 10:51:45 INFO - 'populate-webroot', 10:51:45 INFO - 'create-virtualenv', 10:51:45 INFO - 'install', 10:51:45 INFO - 'run-tests'), 10:51:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:51:45 INFO - 'download_minidump_stackwalk': True, 10:51:45 INFO - 'download_symbols': 'ondemand', 10:51:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:51:45 INFO - 'tooltool.py': '/tools/tooltool.py', 10:51:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:51:45 INFO - '/tools/misc-python/virtualenv.py')}, 10:51:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:51:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:51:45 INFO - 'installer_path': 'installer.exe', 10:51:45 INFO - 'log_level': 'info', 10:51:45 INFO - 'log_name': 'talos', 10:51:45 INFO - 'log_to_console': True, 10:51:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:51:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:51:45 INFO - 'opt_config_files': (), 10:51:45 INFO - 'pip_index': False, 10:51:45 INFO - 'sps_profile': False, 10:51:45 INFO - 'sps_profile_interval': 0, 10:51:45 INFO - 'suite': 'dromaeojs', 10:51:45 INFO - 'system_bits': '32', 10:51:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:51:45 INFO - 'title': 'talos-linux64-ix-002', 10:51:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:51:45 INFO - 'use_talos_json': True, 10:51:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:51:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:51:45 INFO - 'work_dir': 'build'} 10:51:45 INFO - ##### 10:51:45 INFO - ##### Running clobber step. 10:51:45 INFO - ##### 10:51:45 INFO - Running pre-action listener: _resource_record_pre_action 10:51:45 INFO - Running main action method: clobber 10:51:45 INFO - rmtree: /builds/slave/test/build 10:51:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:51:45 INFO - Running post-action listener: _resource_record_post_action 10:51:45 INFO - ##### 10:51:45 INFO - ##### Running read-buildbot-config step. 10:51:45 INFO - ##### 10:51:45 INFO - Running pre-action listener: _resource_record_pre_action 10:51:45 INFO - Running main action method: read_buildbot_config 10:51:45 INFO - Using buildbot properties: 10:51:45 INFO - { 10:51:45 INFO - "project": "", 10:51:45 INFO - "product": "firefox", 10:51:45 INFO - "script_repo_revision": "production", 10:51:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:51:45 INFO - "repository": "", 10:51:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:51:45 INFO - "buildid": "20160517004009", 10:51:45 INFO - "stage_platform": "linux64-pgo", 10:51:45 INFO - "basedir": "/builds/slave/test", 10:51:45 INFO - "nightly_build": "True", 10:51:45 INFO - "buildnumber": 509, 10:51:45 INFO - "slavename": "talos-linux64-ix-002", 10:51:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:51:45 INFO - "platform": "ubuntu64_hw", 10:51:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:51:45 INFO - "branch": "mozilla-aurora", 10:51:45 INFO - "repo_path": "releases/mozilla-aurora", 10:51:45 INFO - "revision": "17724486e1591858eea09dc327475a25883854a4", 10:51:45 INFO - "pgo_build": "True", 10:51:45 INFO - "builduid": "ef91a013044b49f4abd91345e579e6b6", 10:51:45 INFO - "slavebuilddir": "test" 10:51:45 INFO - } 10:51:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:51:45 INFO - Running post-action listener: _resource_record_post_action 10:51:45 INFO - ##### 10:51:45 INFO - ##### Running download-and-extract step. 10:51:45 INFO - ##### 10:51:45 INFO - Running pre-action listener: _resource_record_pre_action 10:51:45 INFO - Running main action method: download_and_extract 10:51:45 INFO - mkdir: /builds/slave/test/build/tests 10:51:45 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')]} 10:51:45 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:51:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:51:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:51:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:51:58 INFO - Downloaded 1361 bytes. 10:51:58 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:51:58 INFO - Using the following test package requirements: 10:51:58 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:51:58 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:51:58 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:51:58 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:58 INFO - u'jsshell-linux-x86_64.zip'], 10:51:58 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:51:58 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:51:58 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:51:58 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:51:58 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:51:58 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:51:58 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:51:58 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')]} 10:51:58 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:51:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:51:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:51:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:51:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:52:07 INFO - Downloaded 23813806 bytes. 10:52:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:52:09 INFO - Return code: 0 10:52:09 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:52:09 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')]} 10:52:09 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:52:10 INFO - Downloaded 23813806 bytes. 10:52:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:52:12 INFO - Return code: 0 10:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:12 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:52:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:52:13 INFO - Downloaded 10840145 bytes. 10:52:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:52:13 INFO - Return code: 0 10:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:13 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:52:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:52:14 INFO - Downloaded 62686410 bytes. 10:52:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:14 INFO - mkdir: /builds/slave/test/properties 10:52:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:52:14 INFO - Writing to file /builds/slave/test/properties/build_url 10:52:14 INFO - Contents: 10:52:14 INFO - build_url:https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:15 INFO - Running post-action listener: _resource_record_post_action 10:52:15 INFO - Running post-action listener: set_extra_try_arguments 10:52:15 INFO - ##### 10:52:15 INFO - ##### Running populate-webroot step. 10:52:15 INFO - ##### 10:52:15 INFO - Running pre-action listener: _resource_record_pre_action 10:52:15 INFO - Running main action method: populate_webroot 10:52:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:52:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:52:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:52:15 INFO - '--tppagecycles', 10:52:15 INFO - '7'], 10:52:15 INFO - 'tests': ['tsvgm']}}, 10:52:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:52:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:52:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:52:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:52:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:52:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:52:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:15 INFO - 'talos_options': ['--disable-e10s'], 10:52:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:15 INFO - 'talos_options': ['--disable-e10s'], 10:52:15 INFO - 'tests': ['damp', 'tps']}, 10:52:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:15 INFO - 'tests': ['damp', 'tps']}, 10:52:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:52:15 INFO - 'tests': ['dromaeo_dom']}, 10:52:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:52:15 INFO - 'tests': ['a11yr', 10:52:15 INFO - 'ts_paint', 10:52:15 INFO - 'tpaint', 10:52:15 INFO - 'sessionrestore', 10:52:15 INFO - 'sessionrestore_no_auto_restore', 10:52:15 INFO - 'tabpaint']}, 10:52:15 INFO - 'other-e10s': {'tests': ['a11yr', 10:52:15 INFO - 'ts_paint', 10:52:15 INFO - 'tpaint', 10:52:15 INFO - 'sessionrestore', 10:52:15 INFO - 'sessionrestore_no_auto_restore', 10:52:15 INFO - 'tabpaint']}, 10:52:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:52:15 INFO - 'ts_paint', 10:52:15 INFO - 'tpaint', 10:52:15 INFO - 'sessionrestore', 10:52:15 INFO - 'sessionrestore_no_auto_restore', 10:52:15 INFO - 'tabpaint']}, 10:52:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:52:15 INFO - 'ts_paint', 10:52:15 INFO - 'tpaint', 10:52:15 INFO - 'sessionrestore', 10:52:15 INFO - 'sessionrestore_no_auto_restore', 10:52:15 INFO - 'tabpaint']}, 10:52:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:52:15 INFO - 'tests': ['a11yr', 10:52:15 INFO - 'ts_paint', 10:52:15 INFO - 'tpaint', 10:52:15 INFO - 'sessionrestore', 10:52:15 INFO - 'sessionrestore_no_auto_restore', 10:52:15 INFO - 'tabpaint']}, 10:52:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:52:15 INFO - 'tests': ['a11yr', 10:52:15 INFO - 'ts_paint', 10:52:15 INFO - 'tpaint', 10:52:15 INFO - 'sessionrestore', 10:52:15 INFO - 'sessionrestore_no_auto_restore', 10:52:15 INFO - 'tabpaint']}, 10:52:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:52:15 INFO - 'tests': ['tsvgx', 10:52:15 INFO - 'tsvgr_opacity', 10:52:15 INFO - 'tart', 10:52:15 INFO - 'tscrollx', 10:52:15 INFO - 'cart']}, 10:52:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:52:15 INFO - 'tsvgr_opacity', 10:52:15 INFO - 'tart', 10:52:15 INFO - 'tscrollx', 10:52:15 INFO - 'cart']}, 10:52:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:15 INFO - 'talos_options': ['--disable-e10s'], 10:52:15 INFO - 'tests': ['tp5o']}, 10:52:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:15 INFO - 'tests': ['tp5o']}, 10:52:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:15 INFO - 'talos_options': ['--disable-e10s', 10:52:15 INFO - '--xperf_path', 10:52:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:15 INFO - 'tests': ['tp5n']}, 10:52:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:15 INFO - 'talos_options': ['--xperf_path', 10:52:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:15 INFO - 'tests': ['tp5n']}}, 10:52:15 INFO - 'talos.zip': {'path': '', 10:52:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:52:15 INFO - Running post-action listener: _resource_record_post_action 10:52:15 INFO - ##### 10:52:15 INFO - ##### Running create-virtualenv step. 10:52:15 INFO - ##### 10:52:15 INFO - Running pre-action listener: _resource_record_pre_action 10:52:15 INFO - Running main action method: create_virtualenv 10:52:15 INFO - Creating virtualenv /builds/slave/test/build/venv 10:52:15 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 10:52:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:52:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:15 INFO - Using real prefix '/usr' 10:52:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:52:16 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:18 INFO - Installing pip.................done. 10:52:18 INFO - Return code: 0 10:52:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f704d508f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', '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 10:52:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:52:18 INFO - Using env: {'DISPLAY': ':0', 10:52:18 INFO - 'HOME': '/home/cltbld', 10:52:18 INFO - 'LANG': 'en_US.UTF-8', 10:52:18 INFO - 'LANGUAGE': 'en_US:en', 10:52:18 INFO - 'LOGNAME': 'cltbld', 10:52:18 INFO - 'MAIL': '/var/mail/cltbld', 10:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:18 INFO - 'MOZ_NO_REMOTE': '1', 10:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:18 INFO - 'NO_EM_RESTART': '1', 10:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:18 INFO - 'PWD': '/builds/slave/test', 10:52:18 INFO - 'SHELL': '/bin/bash', 10:52:18 INFO - 'SHLVL': '1', 10:52:18 INFO - 'TERM': 'linux', 10:52:18 INFO - 'TMOUT': '86400', 10:52:18 INFO - 'USER': 'cltbld', 10:52:18 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', 10:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:18 INFO - '_': '/tools/buildbot/bin/python'} 10:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:18 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 10:52:18 INFO - Cleaning up... 10:52:18 INFO - Return code: 0 10:52:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f704d508f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', '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 10:52:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:52:18 INFO - Using env: {'DISPLAY': ':0', 10:52:18 INFO - 'HOME': '/home/cltbld', 10:52:18 INFO - 'LANG': 'en_US.UTF-8', 10:52:18 INFO - 'LANGUAGE': 'en_US:en', 10:52:18 INFO - 'LOGNAME': 'cltbld', 10:52:18 INFO - 'MAIL': '/var/mail/cltbld', 10:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:18 INFO - 'MOZ_NO_REMOTE': '1', 10:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:18 INFO - 'NO_EM_RESTART': '1', 10:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:18 INFO - 'PWD': '/builds/slave/test', 10:52:18 INFO - 'SHELL': '/bin/bash', 10:52:18 INFO - 'SHLVL': '1', 10:52:18 INFO - 'TERM': 'linux', 10:52:18 INFO - 'TMOUT': '86400', 10:52:18 INFO - 'USER': 'cltbld', 10:52:18 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', 10:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:18 INFO - '_': '/tools/buildbot/bin/python'} 10:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:18 INFO - Downloading/unpacking psutil>=0.7.1 10:52:18 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 10:52:18 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 10:52:18 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 10:52:18 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 10:52:18 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 10:52:18 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 10:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:20 INFO - Installing collected packages: psutil 10:52:20 INFO - Running setup.py install for psutil 10:52:20 INFO - building 'psutil._psutil_linux' extension 10:52:20 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 10:52:20 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 10:52:20 INFO - building 'psutil._psutil_posix' extension 10:52:20 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 10:52:21 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 10:52:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:21 INFO - Successfully installed psutil 10:52:21 INFO - Cleaning up... 10:52:21 INFO - Return code: 0 10:52:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f704d508f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', '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 10:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:52:21 INFO - Using env: {'DISPLAY': ':0', 10:52:21 INFO - 'HOME': '/home/cltbld', 10:52:21 INFO - 'LANG': 'en_US.UTF-8', 10:52:21 INFO - 'LANGUAGE': 'en_US:en', 10:52:21 INFO - 'LOGNAME': 'cltbld', 10:52:21 INFO - 'MAIL': '/var/mail/cltbld', 10:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:21 INFO - 'MOZ_NO_REMOTE': '1', 10:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:21 INFO - 'NO_EM_RESTART': '1', 10:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:21 INFO - 'PWD': '/builds/slave/test', 10:52:21 INFO - 'SHELL': '/bin/bash', 10:52:21 INFO - 'SHLVL': '1', 10:52:21 INFO - 'TERM': 'linux', 10:52:21 INFO - 'TMOUT': '86400', 10:52:21 INFO - 'USER': 'cltbld', 10:52:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', 10:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:21 INFO - '_': '/tools/buildbot/bin/python'} 10:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:52:23 INFO - Installing collected packages: mozsystemmonitor 10:52:23 INFO - Running setup.py install for mozsystemmonitor 10:52:23 INFO - Successfully installed mozsystemmonitor 10:52:23 INFO - Cleaning up... 10:52:23 INFO - Return code: 0 10:52:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:23 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')]} 10:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:23 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')]} 10:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:23 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 0x7f704d508f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', '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 10:52:23 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 10:52:23 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 10:52:23 INFO - Using env: {'DISPLAY': ':0', 10:52:23 INFO - 'HOME': '/home/cltbld', 10:52:23 INFO - 'LANG': 'en_US.UTF-8', 10:52:23 INFO - 'LANGUAGE': 'en_US:en', 10:52:23 INFO - 'LOGNAME': 'cltbld', 10:52:23 INFO - 'MAIL': '/var/mail/cltbld', 10:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:23 INFO - 'MOZ_NO_REMOTE': '1', 10:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:23 INFO - 'NO_EM_RESTART': '1', 10:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:23 INFO - 'PWD': '/builds/slave/test', 10:52:23 INFO - 'SHELL': '/bin/bash', 10:52:23 INFO - 'SHLVL': '1', 10:52:23 INFO - 'TERM': 'linux', 10:52:23 INFO - 'TMOUT': '86400', 10:52:23 INFO - 'USER': 'cltbld', 10:52:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', 10:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:23 INFO - '_': '/tools/buildbot/bin/python'} 10:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:23 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:25 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52:25 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 10:52:25 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 10:52:25 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 10:52:25 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 10:52:25 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 10:52:25 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 10:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:26 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 10:52:26 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 10:52:26 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 10:52:26 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 10:52:26 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 10:52:26 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 10:52:26 INFO - Downloading docopt-0.6.1.tar.gz 10:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:26 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:26 INFO - Running setup.py install for blobuploader 10:52:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:26 INFO - Running setup.py install for requests 10:52:26 INFO - Running setup.py install for docopt 10:52:26 INFO - Successfully installed blobuploader requests docopt 10:52:26 INFO - Cleaning up... 10:52:26 INFO - Return code: 0 10:52:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:26 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 0x7f704d508f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', '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 10:52:26 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 10:52:26 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 10:52:26 INFO - Using env: {'DISPLAY': ':0', 10:52:26 INFO - 'HOME': '/home/cltbld', 10:52:26 INFO - 'LANG': 'en_US.UTF-8', 10:52:26 INFO - 'LANGUAGE': 'en_US:en', 10:52:26 INFO - 'LOGNAME': 'cltbld', 10:52:26 INFO - 'MAIL': '/var/mail/cltbld', 10:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:26 INFO - 'MOZ_NO_REMOTE': '1', 10:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:26 INFO - 'NO_EM_RESTART': '1', 10:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:26 INFO - 'PWD': '/builds/slave/test', 10:52:26 INFO - 'SHELL': '/bin/bash', 10:52:26 INFO - 'SHLVL': '1', 10:52:26 INFO - 'TERM': 'linux', 10:52:26 INFO - 'TMOUT': '86400', 10:52:26 INFO - 'USER': 'cltbld', 10:52:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', 10:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:26 INFO - '_': '/tools/buildbot/bin/python'} 10:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:27 INFO - Running setup.py (path:/tmp/pip-0sp7Mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:27 INFO - Running setup.py (path:/tmp/pip-AQT7Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:27 INFO - Running setup.py (path:/tmp/pip-ZrRL6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:27 INFO - Running setup.py (path:/tmp/pip-GrqHbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:27 INFO - Running setup.py (path:/tmp/pip-0WcHhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:27 INFO - Running setup.py (path:/tmp/pip-WaIqVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:27 INFO - Running setup.py (path:/tmp/pip-0Eektn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:27 INFO - Running setup.py (path:/tmp/pip-jn1tar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:27 INFO - Running setup.py (path:/tmp/pip-PIGlA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:27 INFO - Running setup.py (path:/tmp/pip-4PfcQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:27 INFO - Running setup.py (path:/tmp/pip-5dy3g7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:27 INFO - Running setup.py (path:/tmp/pip-GAyV8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:28 INFO - Running setup.py (path:/tmp/pip-6GPvGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:28 INFO - Running setup.py (path:/tmp/pip-5cxtYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:28 INFO - Running setup.py (path:/tmp/pip-ZjWTxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:28 INFO - Running setup.py (path:/tmp/pip-7RjYtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:28 INFO - Running setup.py (path:/tmp/pip-wcHpv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:28 INFO - Running setup.py install for manifestparser 10:52:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:28 INFO - Running setup.py install for mozcrash 10:52:28 INFO - Running setup.py install for mozdebug 10:52:28 INFO - Running setup.py install for mozdevice 10:52:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:52:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:28 INFO - Running setup.py install for mozfile 10:52:28 INFO - Running setup.py install for mozhttpd 10:52:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:28 INFO - Running setup.py install for mozinfo 10:52:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Running setup.py install for mozInstall 10:52:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Running setup.py install for mozleak 10:52:29 INFO - Running setup.py install for mozlog 10:52:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Running setup.py install for moznetwork 10:52:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Running setup.py install for mozprocess 10:52:29 INFO - Running setup.py install for mozprofile 10:52:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Running setup.py install for mozrunner 10:52:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Running setup.py install for mozscreenshot 10:52:29 INFO - Running setup.py install for moztest 10:52:30 INFO - Running setup.py install for mozversion 10:52:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:30 INFO - Cleaning up... 10:52:30 INFO - Return code: 0 10:52:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:30 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 0x7f704d508f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', '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 10:52:30 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 10:52:30 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 10:52:30 INFO - Using env: {'DISPLAY': ':0', 10:52:30 INFO - 'HOME': '/home/cltbld', 10:52:30 INFO - 'LANG': 'en_US.UTF-8', 10:52:30 INFO - 'LANGUAGE': 'en_US:en', 10:52:30 INFO - 'LOGNAME': 'cltbld', 10:52:30 INFO - 'MAIL': '/var/mail/cltbld', 10:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:30 INFO - 'MOZ_NO_REMOTE': '1', 10:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:30 INFO - 'NO_EM_RESTART': '1', 10:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:30 INFO - 'PWD': '/builds/slave/test', 10:52:30 INFO - 'SHELL': '/bin/bash', 10:52:30 INFO - 'SHLVL': '1', 10:52:30 INFO - 'TERM': 'linux', 10:52:30 INFO - 'TMOUT': '86400', 10:52:30 INFO - 'USER': 'cltbld', 10:52:30 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', 10:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:30 INFO - '_': '/tools/buildbot/bin/python'} 10:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:30 INFO - Running setup.py (path:/tmp/pip-RRq7qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:30 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)) 10:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:30 INFO - Running setup.py (path:/tmp/pip-orfR1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:30 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)) 10:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:30 INFO - Running setup.py (path:/tmp/pip-lWUZ4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:30 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)) 10:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:30 INFO - Running setup.py (path:/tmp/pip-JQMorz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:30 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)) 10:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:30 INFO - Running setup.py (path:/tmp/pip-PqEntY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:30 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)) 10:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:30 INFO - Running setup.py (path:/tmp/pip-VxKqs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:30 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)) 10:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:30 INFO - Running setup.py (path:/tmp/pip-QYeR9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:30 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)) 10:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:30 INFO - Running setup.py (path:/tmp/pip-F0PE89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:30 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)) 10:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:30 INFO - Running setup.py (path:/tmp/pip-RmIq76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:31 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)) 10:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:31 INFO - Running setup.py (path:/tmp/pip-ibv9UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:31 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)) 10:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:31 INFO - Running setup.py (path:/tmp/pip-89Yjke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:31 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)) 10:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:31 INFO - Running setup.py (path:/tmp/pip-By370k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:31 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)) 10:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:31 INFO - Running setup.py (path:/tmp/pip-8aJBxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:31 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)) 10:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:31 INFO - Running setup.py (path:/tmp/pip-xpwdA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:31 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)) 10:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:31 INFO - Running setup.py (path:/tmp/pip-_n10mB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:31 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)) 10:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:31 INFO - Running setup.py (path:/tmp/pip-cCug5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:31 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)) 10:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:31 INFO - Running setup.py (path:/tmp/pip-7Y5lIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:31 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)) 10:52:31 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)) 10:52:31 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)) 10:52:31 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)) 10:52:31 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)) 10:52:31 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)) 10:52:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:31 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 10:52:31 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 10:52:31 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 10:52:31 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 10:52:31 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 10:52:31 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 10:52:33 INFO - Downloading blessings-1.6.tar.gz 10:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:33 INFO - Installing collected packages: blessings 10:52:33 INFO - Running setup.py install for blessings 10:52:33 INFO - Successfully installed blessings 10:52:33 INFO - Cleaning up... 10:52:33 INFO - Return code: 0 10:52:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:33 INFO - Reading from file tmpfile_stdout 10:52:33 INFO - Current package versions: 10:52:33 INFO - argparse == 1.2.1 10:52:33 INFO - blessings == 1.6 10:52:33 INFO - blobuploader == 1.2.4 10:52:33 INFO - docopt == 0.6.1 10:52:33 INFO - manifestparser == 1.1 10:52:33 INFO - mozInstall == 1.12 10:52:33 INFO - mozcrash == 0.17 10:52:33 INFO - mozdebug == 0.1 10:52:33 INFO - mozdevice == 0.48 10:52:33 INFO - mozfile == 1.2 10:52:33 INFO - mozhttpd == 0.7 10:52:33 INFO - mozinfo == 0.9 10:52:33 INFO - mozleak == 0.1 10:52:33 INFO - mozlog == 3.1 10:52:33 INFO - moznetwork == 0.27 10:52:33 INFO - mozprocess == 0.22 10:52:33 INFO - mozprofile == 0.28 10:52:33 INFO - mozrunner == 6.11 10:52:33 INFO - mozscreenshot == 0.1 10:52:33 INFO - mozsystemmonitor == 0.0 10:52:33 INFO - moztest == 0.7 10:52:33 INFO - mozversion == 1.4 10:52:33 INFO - psutil == 3.1.1 10:52:33 INFO - requests == 1.2.3 10:52:33 INFO - wsgiref == 0.1.2 10:52:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:33 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 0x7f704d508f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', '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 10:52:33 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 10:52:33 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 10:52:33 INFO - Using env: {'DISPLAY': ':0', 10:52:33 INFO - 'HOME': '/home/cltbld', 10:52:33 INFO - 'LANG': 'en_US.UTF-8', 10:52:33 INFO - 'LANGUAGE': 'en_US:en', 10:52:33 INFO - 'LOGNAME': 'cltbld', 10:52:33 INFO - 'MAIL': '/var/mail/cltbld', 10:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:33 INFO - 'MOZ_NO_REMOTE': '1', 10:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:33 INFO - 'NO_EM_RESTART': '1', 10:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:33 INFO - 'PWD': '/builds/slave/test', 10:52:33 INFO - 'SHELL': '/bin/bash', 10:52:33 INFO - 'SHLVL': '1', 10:52:33 INFO - 'TERM': 'linux', 10:52:33 INFO - 'TMOUT': '86400', 10:52:33 INFO - 'USER': 'cltbld', 10:52:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', 10:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:33 INFO - '_': '/tools/buildbot/bin/python'} 10:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:34 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)) 10:52:34 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)) 10:52:34 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)) 10:52:34 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)) 10:52:34 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)) 10:52:34 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)) 10:52:34 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)) 10:52:34 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)) 10:52:34 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)) 10:52:34 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)) 10:52:34 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)) 10:52:34 INFO - Cleaning up... 10:52:34 INFO - Return code: 0 10:52:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f704d508f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', '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 10:52:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:52:34 INFO - Using env: {'DISPLAY': ':0', 10:52:34 INFO - 'HOME': '/home/cltbld', 10:52:34 INFO - 'LANG': 'en_US.UTF-8', 10:52:34 INFO - 'LANGUAGE': 'en_US:en', 10:52:34 INFO - 'LOGNAME': 'cltbld', 10:52:34 INFO - 'MAIL': '/var/mail/cltbld', 10:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:34 INFO - 'MOZ_NO_REMOTE': '1', 10:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:34 INFO - 'NO_EM_RESTART': '1', 10:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:34 INFO - 'PWD': '/builds/slave/test', 10:52:34 INFO - 'SHELL': '/bin/bash', 10:52:34 INFO - 'SHLVL': '1', 10:52:34 INFO - 'TERM': 'linux', 10:52:34 INFO - 'TMOUT': '86400', 10:52:34 INFO - 'USER': 'cltbld', 10:52:34 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', 10:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:34 INFO - '_': '/tools/buildbot/bin/python'} 10:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:34 INFO - Downloading/unpacking jsonschema 10:52:34 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 10:52:34 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 10:52:34 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 10:52:34 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 10:52:34 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 10:52:34 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 10:52:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:52:36 INFO - Downloading/unpacking functools32 (from jsonschema) 10:52:36 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 10:52:36 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 10:52:36 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 10:52:36 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 10:52:36 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 10:52:36 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 10:52:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:52:36 INFO - warning: no files found matching '*.txt' 10:52:36 INFO - no previously-included directories found matching 'build' 10:52:36 INFO - no previously-included directories found matching 'dist' 10:52:36 INFO - no previously-included directories found matching '.git*' 10:52:36 INFO - Installing collected packages: jsonschema, functools32 10:52:36 INFO - Running setup.py install for functools32 10:52:36 INFO - warning: no files found matching '*.txt' 10:52:36 INFO - no previously-included directories found matching 'build' 10:52:36 INFO - no previously-included directories found matching 'dist' 10:52:36 INFO - no previously-included directories found matching '.git*' 10:52:36 INFO - Successfully installed jsonschema functools32 10:52:36 INFO - Cleaning up... 10:52:36 INFO - Return code: 0 10:52:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:36 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 0x7f704d508f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', '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 10:52:36 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 10:52:36 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 10:52:36 INFO - Using env: {'DISPLAY': ':0', 10:52:36 INFO - 'HOME': '/home/cltbld', 10:52:36 INFO - 'LANG': 'en_US.UTF-8', 10:52:36 INFO - 'LANGUAGE': 'en_US:en', 10:52:36 INFO - 'LOGNAME': 'cltbld', 10:52:36 INFO - 'MAIL': '/var/mail/cltbld', 10:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:36 INFO - 'MOZ_NO_REMOTE': '1', 10:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:36 INFO - 'NO_EM_RESTART': '1', 10:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:36 INFO - 'PWD': '/builds/slave/test', 10:52:36 INFO - 'SHELL': '/bin/bash', 10:52:36 INFO - 'SHLVL': '1', 10:52:36 INFO - 'TERM': 'linux', 10:52:36 INFO - 'TMOUT': '86400', 10:52:36 INFO - 'USER': 'cltbld', 10:52:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', 10:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:36 INFO - '_': '/tools/buildbot/bin/python'} 10:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:36 INFO - Downloading/unpacking flake8 10:52:36 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 10:52:36 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 10:52:36 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 10:52:36 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 10:52:36 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 10:52:36 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 10:52:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:52:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:52:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:52:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:52:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:52:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:52:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:52:39 INFO - no previously-included directories found matching 'docs/_build' 10:52:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:52:39 INFO - Running setup.py install for pep8 10:52:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:52:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:52:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:52:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:52:39 INFO - no previously-included directories found matching 'docs/_build' 10:52:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:52:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:52:39 INFO - Cleaning up... 10:52:39 INFO - Return code: 0 10:52:39 INFO - Running post-action listener: _resource_record_post_action 10:52:39 INFO - Running post-action listener: _start_resource_monitoring 10:52:39 INFO - Starting resource monitoring. 10:52:39 INFO - ##### 10:52:39 INFO - ##### Running install step. 10:52:39 INFO - ##### 10:52:39 INFO - Running pre-action listener: _resource_record_pre_action 10:52:39 INFO - Running main action method: install 10:52:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:40 INFO - Reading from file tmpfile_stdout 10:52:40 INFO - Detecting whether we're running mozinstall >=1.0... 10:52:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:52:40 INFO - Reading from file tmpfile_stdout 10:52:40 INFO - Output received: 10:52:40 INFO - Usage: mozinstall [options] installer 10:52:40 INFO - Options: 10:52:40 INFO - -h, --help show this help message and exit 10:52:40 INFO - -d DEST, --destination=DEST 10:52:40 INFO - Directory to install application into. [default: 10:52:40 INFO - "/builds/slave/test"] 10:52:40 INFO - --app=APP Application being installed. [default: firefox] 10:52:40 INFO - mkdir: /builds/slave/test/build/application 10:52:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:52:55 INFO - Reading from file tmpfile_stdout 10:52:55 INFO - Output received: 10:52:55 INFO - /builds/slave/test/build/application/firefox/firefox 10:52:55 INFO - Running post-action listener: _resource_record_post_action 10:52:55 INFO - ##### 10:52:55 INFO - ##### Running run-tests step. 10:52:55 INFO - ##### 10:52:55 INFO - Running pre-action listener: _resource_record_pre_action 10:52:55 INFO - Running main action method: run_tests 10:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:52:55 INFO - Python 2.7.3 10:52:55 INFO - Return code: 0 10:52:55 INFO - grabbing minidump binary from tooltool 10:52:55 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')]} 10:52:55 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 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:52:55 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 10:52:55 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 10:52:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:52:55 INFO - Return code: 0 10:52:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:52:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:52:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:52:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:52:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:52:56 INFO - Return code: 0 10:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 10:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 10:52:56 INFO - Using env: {'DISPLAY': ':0', 10:52:56 INFO - 'HOME': '/home/cltbld', 10:52:56 INFO - 'LANG': 'en_US.UTF-8', 10:52:56 INFO - 'LANGUAGE': 'en_US:en', 10:52:56 INFO - 'LOGNAME': 'cltbld', 10:52:56 INFO - 'MAIL': '/var/mail/cltbld', 10:52:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:52:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:56 INFO - 'MOZ_NO_REMOTE': '1', 10:52:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:56 INFO - 'NO_EM_RESTART': '1', 10:52:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:56 INFO - 'PWD': '/builds/slave/test', 10:52:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:52:56 INFO - 'SHELL': '/bin/bash', 10:52:56 INFO - 'SHLVL': '1', 10:52:56 INFO - 'TERM': 'linux', 10:52:56 INFO - 'TMOUT': '86400', 10:52:56 INFO - 'USER': 'cltbld', 10:52:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618', 10:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:56 INFO - '_': '/tools/buildbot/bin/python'} 10:52:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 10:52:56 INFO - mozversion application_buildid: 20160517004009 10:52:56 INFO - mozversion application_changeset: 17724486e1591858eea09dc327475a25883854a4 10:52:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:52:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:52:56 INFO - mozversion application_name: Firefox 10:52:56 INFO - mozversion application_remotingname: firefox-dev 10:52:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:52:56 INFO - mozversion application_vendor: Mozilla 10:52:56 INFO - mozversion application_version: 48.0a2 10:52:56 INFO - mozversion platform_buildid: 20160517004009 10:52:56 INFO - mozversion platform_changeset: 17724486e1591858eea09dc327475a25883854a4 10:52:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:52:56 INFO - mozversion platform_version: 48.0a2 10:52:56 INFO - using testdate: 1463507576 10:52:56 INFO - actual date: 1463507576 10:52:56 INFO - starting webserver on 'localhost:40241' 10:52:56 INFO - SUITE-START | Running 2 tests 10:52:56 INFO - TEST-START | dromaeo_css 10:52:56 INFO - operating with platform_type : linux_ 10:52:56 INFO - Initialising browser for dromaeo_css test... 10:52:56 INFO - TEST-INFO | started process 3936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxnVRQS/profile http://localhost:40241/getInfo.html) 10:53:01 INFO - PROCESS | 3936 | __metrics Screen width/height:1600/1200 10:53:01 INFO - PROCESS | 3936 | colorDepth:24 10:53:01 INFO - PROCESS | 3936 | Browser inner width/height: 1024/697 10:53:01 INFO - PROCESS | 3936 | __metrics 10:53:02 ERROR - PROCESS | 3936 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:53:03 INFO - TEST-INFO | 3936: exit 0 10:53:03 INFO - Browser initialized. 10:53:03 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:03 INFO - TEST-INFO | started process 4025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxnVRQS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:14 INFO - PROCESS | 4025 | RSS: Main: 142336000 10:53:14 INFO - PROCESS | 4025 | 10:54:06 INFO - PROCESS | 4025 | 1463507646017 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] 10:56:13 INFO - PROCESS | 4025 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40241/tests/dromaeo/cssquery-ext.html) 10:56:14 INFO - PROCESS | 4025 | RSS: Main: 253104128 10:56:14 INFO - PROCESS | 4025 | 10:59:16 INFO - PROCESS | 4025 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-ext.html (next: http://localhost:40241/tests/dromaeo/cssquery-jquery.html) 10:59:17 INFO - PROCESS | 4025 | RSS: Main: 222691328 10:59:17 INFO - PROCESS | 4025 | 11:02:19 INFO - PROCESS | 4025 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40241/tests/dromaeo/cssquery-mootools.html) 11:02:19 INFO - PROCESS | 4025 | RSS: Main: 219394048 11:02:19 INFO - PROCESS | 4025 | 11:05:21 INFO - PROCESS | 4025 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40241/tests/dromaeo/cssquery-prototype.html) 11:05:22 INFO - PROCESS | 4025 | RSS: Main: 216363008 11:05:22 INFO - PROCESS | 4025 | 11:08:24 INFO - PROCESS | 4025 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40241/tests/dromaeo/cssquery-yui.html) 11:08:25 INFO - PROCESS | 4025 | RSS: Main: 187351040 11:08:25 INFO - PROCESS | 4025 | 11:11:27 INFO - PROCESS | 4025 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-yui.html (next: http://localhost:40241/tests/dromaeo/cssquery-dojo.html) 11:11:27 INFO - PROCESS | 4025 | RSS: Main: 244625408 11:11:27 INFO - PROCESS | 4025 | 11:11:27 INFO - PROCESS | 4025 | __start_tp_report 11:11:27 INFO - PROCESS | 4025 | _x_x_mozilla_page_load 11:11:27 INFO - PROCESS | 4025 | _x_x_mozilla_page_load_details 11:11:27 INFO - PROCESS | 4025 | |i|pagename|runs| 11:11:27 INFO - PROCESS | 4025 | |0;dojo.html;3316.751243656726;3366.2930784535233;3386.407378708726;3393.8981830545094;3409.9147521311966;5516.696581688006;5549.1676248562735;5553.278073850399;5559.3328800543995;5596.216529685842;5509.779608815643;5518.475744804247;5525.419830917756;5548.750306236219;5599.356074051485;4943.826966056171;5014.498550144984;5088.313077734496;5136.922946155811;5170.508801663836;5090.9236361454605;5155.407128180251;5160.896782064357;5172.482751724835;5175.715335656538;5056.266841308008;5120.078385890538;5145.922811157836;5149.433562308143;5160.6903585784785;5067.366579177603;5067.543921047123;5084.466131056222;5084.847454576368;5112.744362781865;4990.25146228065;4998.875028124289;5002.974390250027;5011.173156429185;5091.949080509222;5500.862478438031;5513.338399392099;5542.39033706292;5544.168374743821;5555.749991250363;5985.431384018511;5987.820365389045;6006.939930600682;6008.098785182214;6023.156758053876;6020.879582408371;6029.668368239745;6084.767100293744;6108.617639120746;6128.44843964041;5550.417206193332;5602.915956260659;5607.158926161027;5612.494875461228;5641.379448260688;6051.394860513913;6085.726142323606;6092.201981463733;6096.085587161872;6125.387461253839;5858.970705146532;5930.377310382434;5938.762449501972;5947.197128387699;5955.791547295824;6000.249968753906;6037.78867739627;6044.425779550936;6056.727447264883;6060.303065147476;5848.619839710405;5982.73077711504;5993.520518358521;5999.640021598718;6009.399060093956;6022.427869352405;6088.939110608926;6090.36051214625;6090.817275481742;6125.540584456184;4583.152116858325;4598.632109431237;4604.953950460519;4613.861584152413;4633.675642705046;4046.968023154077;4064.9796751016647;4112.321466957918;4113.382992551082;4144.150449157915;5673.319201695823;5679.602427830012;5688.544916406678;5705.400932902068;5714.085746280575;5959.404059594006;6002.369751176151;6011.3086994995265;6012.518998480111;6031.336552979169;5635.605507614509;5648.237487939158;5688.232088667977;5715.657060576379;5749.568782341341;5136.563392111638;5154.175331946945;5157.32954715892;5159.355080614923;5168.147255702767;6242.1261023456755;6258.436740693269;6265.185525881606;6275.874482510324;6276.874462510724;5986.970065149733;6077.696115194134;6139.6454669416935;6143.051335358963;6152.415520525543;6230.657313847782;6276.529260305404;6280.340564240689;6283.7800676976085;6283.937160628335;5706.058500347396;5936.079907614327;5952.732127054206;5969.462748352669;5998.730057147526;5889.499392551681;5991.7603295867675;5992.550558708202;5998.280206375263;6033.698315084316;5897.970510147422;5924.4667979882015;5926.1999630049395;5926.348101708895;5928.318243402064;5769.451902069297;5840.678762667924;5855.824325270249;5883;5895.7052147393315;5802.65184088956;5822.534197264294;5827.3007239131575;5830.650160990354;5859.912101318569;5919.7632094717455;5927.140564618193;5937.376575459514;5939.07944268639;5961;5561.63849349791;5781.335146458211;5815.3603103657715;5850.619709718854;5878.118282257696 11:11:27 INFO - PROCESS | 4025 | |1;ext.html;626.8746250749848;667.933206679332;677.4038845815681;690.2545251128778;755.8715018446863;32498.837505812466;37842.62157378425;39350;39448;39605.405918911165;45296;45738.771306143506;45938;46023.769881150634;46063.539364606346;8924.643014279438;9113;9115.589798459052;9117.817643647122;9123.452592844418;8846.601902914352;8936.8659470108;8944;8959.955200223989;8961.686340978067;8967.327450441211;9014.954925225366;9022.774430639221;9022.774430639221;9030.458172509638;8942.955285223565;8986.68546600866;8998.595063222105;9002.414843035214;9006.639734410583;8967.148120928501;9070.319726020509;9084.137006984325;9086.273098152133;9088.954555227248;41975.1604967902;42633;42657.146857062995;42659;42672.359914600995;3890.4942357493346;4002.779847108408;4090.836366545335;4283;4567.543245675439;33011.6698833011;33095.834520827244;33438;34346.96959091231;34692.306153877034;4645.117427688729;4665.533446655341;4676.134915040694;4718.079974404993;4720.976395118002;327498;330432;330606;331028.3448582766;332030;39431.80284098561;62656;63301;63369.683151583944;63416;39039.6096039036;39201.41197882034;39232.607673922896;39271.41092883609;39273.21453570913;16640.251188696537;16949.237284322237;16966.745498817527;16968.23642936071;16973.066481343398;13010.934945325213;13026.153300035658;13032.087753857139;13037.608871733863;13040.152390094614;9484.19384352324;9499.145076943109;9515.952420237854;9575.473348965874;9590.472524011107;3527.4885141654318;3594.406922857699;3646.9635303647156;3667.4865518827387;3692.1877187018813;1144.2791041643711;1173.9845034045659;1196.4735516372941;1235.6540168752763;1291.625428625688;32893.50659740106;33314.66685333164;33760.662393376246;33868;33989.32021359559;1196.1925700152362;1212.3574505512092;1216.1851559455185;1218.9268643881219;1294.5210272199347;17585.120743963005;17704.822951770577;17757.31305525973;17774.289028438718;17795.377161799533;206832;207612;207637;209660;209893;61037.69481152655;61712.38287617066;61727.38272617306;61791;61806;1406.3319923036477;1414.2009764483034;1477.128494188434;1501.2568778454736;1524.8475152484664;30690.232744181572;32020.6797932027;32052.67947320497;32486.83756581202;32620.347593048482;49454.75272623758;50018.499815001385;50034.49965500298;50040;50144.24783628176;296654;301366;301866;301938;442904;30304.39391212119;30509.389812204077;30840.537391939586;31373.372532549678;31378.372432550765;43384.566154338056;43880.12239755123;43903.12193756171;44777;45075.774621127995;36894.446583300734;36995;36997.26005479929;37008.444873326385;37777.81111094537;35401.645983539835;35586.11034724153;36676.81661591675;39773.40339894846;40284;40337.79831100826;41229.793851030554;41518.1696366077;42204.155916880874;42286;35048.64951350556;36135;36309.63690363168;36324.81837590901;36509;28218.717812821607;28280.43439131247;28509.857450713444;28510.42979140364;28612.284692882844 11:11:27 INFO - PROCESS | 4025 | |2;jquery.html;413.42946733507756;429.2207116340621;433.47765942039837;443.09829496973657;444.3401548700182;19837.801621983777;20322.28871989481;20512.692309615366;20599.794002059974;21079.367618971417;19876.105575249112;20050.097745601448;20741.17035318589;20783;20803;5359.410464848864;5882.029465138268;5891.057430811071;5891.970540147315;5892.116182572606;4397.780110994453;5646.491815736583;5723.227364305828;5919.970400147993;6358.8092357229125;6231.844203894893;6285.465735412496;6294.685265736694;6297.307296197415;6311.936880631204;6078.240219972504;6262.12330273762;6367;6377.426031657127;6377.457916077139;4034.7579145251084;5506.614536982413;5747.5114615257335;5800.4489573490455;5802.7388767505145;24238.87880560586;24479.632805507932;24829.62755558668;25143.245702628767;25144.622830657554;2472.83926544774;2564.2435481532807;2581.1482210870367;2850.3586692994118;3041.9087427377212;14320.928395358062;14952.700945981129;15216.391344346213;15231.162286074261;15340.309686064154;2033.9288124915556;2091.529405883664;2112.0601332407086;2123.108294516307;2310.330004298751;82281.58859205726;83981.16018839856;88844.55577722135;95452.045479545;95837.5208123955;18084;18292.725609115874;18503.90748046278;18709.719354209697;18992.905035474734;33181.66818331834;33299.16752081169;33708.83145584256;34051.829740851135;34095;10173.57569940209;10684.198685098649;10701.78596428067;10778.784424311627;10837.295575787548;8950.68672596456;8955.552222388855;8962.775930601787;9107.908920910706;9138.817223655622;9282.767930801783;9354;9384;9402.71791846232;9710.417374957526;3043.5824232865534;3563.9109022274133;3573.928521429557;3648.7628304160144;3685.5024571683016;986.8569057486624;1050.4065203160342;1058.7035630023606;1074.882839764673;1116.1126904111252;18228.27086916535;18824.15291311894;19099.688722164447;19320.4203873884;19390.321338753358;1080.4273734920505;1086.3916206924148;1095.649392194506;1104.9337039777479;1109.4341885638382;9875.654352097643;11091.778164436666;11097.44512774358;11098.944505277423;11193.272437291713;386648.0667596644;389059;389747;489845;502923;102499.48750256201;108186.45906770573;108556;109223;109972.4501377488;1159.576754484624;1161.506359797083;1182.6156499137815;1198.6224339333082;1246.389269258057;17361.56596085108;17726;17904.55238619045;17951.551211219823;18275.360362387786;28122.156335309974;42269.30922763055;42571.787141064095;42680.786596068065;42837.785811070746;51634.74182629063;52281.47718522766;52953.47046529486;53814;61168;8967.506787126771;9017.729468115967;9109.22571581423;9229.077092290985;9277.396969196981;9197.816043678955;10690;13637.454501819817;13864.861351386357;13906.443742250196;11814.468348924147;11952.282863028246;12038.879611203776;12120.515179392725;12149.331786751813;11380.089592832719;11467.713307167387;11744.412779360828;12048.698782530157;12089.879101208875;11865.5847045353;11982.340971246666;12045.457954391899;12220.938895305466;12278.693032674255;8798.692045778367;9123.042080581443;9164.083591640783;9283.071692830663;9343;11057.447127643747;11870.525178992744;11896.167268291136;11954.701132471759;12075.637730868088 11:11:27 INFO - PROCESS | 4025 | |3;mootools.html;1453.920034398109;1559.6490789572347;1582.2563395204254;1778.8754787164903;1863.440967709686;7740.612969351531;8397.706080287191;8513.872291915626;8518.659253629863;8527.445716028455;8339.54132522711;8510;8512.233898949093;8515.063343032261;8520.105388934166;2185.846990710651;2404.855708657482;2411.7588241175918;2428.514297140579;2473.4558397152687;2452.141750387359;2479.504099180162;2480.987595062022;2483.13090418353;2486.5275597636482;2430.4652976345174;2452.6443665668467;2453.6074228123503;2453.6319552067243;2455.693038370204;2138.272987184357;2389.032441861049;2433.634954756783;2435.6346548017673;2438.8170887183533;2320.5474932388192;2355.611324131516;2362.232274510791;2368.7157541095007;2378.714554253501;8516.318694504425;8532.31741460688;8538.82922341556;8573.099824518398;8590.484570925764;5252.343457067866;5365.114756065244;5413.593980451482;5413.783448662049;5422.376426710939;3604;3625.909352266188;3661.7802931824176;3677.8344974476213;3692.8552148833946;1208.2689972566645;1208.5407545132882;1223.9816402753966;1227.042906532897;1297.228149251194;12552;12561.371931403393;12571.93714031433;12582.874171258354;12588.68528286791;4807.567318941312;4818;4885.7312847793;4946.530079642428;4956.405231372259;10551.103156231653;10590.89409105899;10632.627858024933;10649.574017039387;10660.466976651136;4760.666753327234;5436.646617969819;5436.864078398072;5439.564834813205;5440.646357986719;4392.253316936129;4398.362237475548;4447.688661793708;4784.354112194878;4897.2898929655;4098.483262033636;4121.175764847043;4200.348945913388;4238.745675259494;4277.871663850089;1366.6173471428017;1389.388668985643;1390.5550223928449;1396.4623619906206;1408.8520705325793;1014.9495272393037;1051.574112484445;1060.9522571484301;1072.1904961753826;1074.7366895110592;6059.757609695651;6108.205933228652;6160.199174107427;6204.503639708812;6219.378062193835;464.8187206989277;467.22207524472054;480.2603989855583;482.12253698268813;487.6464563191658;4174.874753757392;4240.724352917051;4247.256730072225;4260.10537787062;4285.957140428618;10418.166546676399;11081.612143575097;11143.944280278709;11232.3260604364;11236.66290011301;10310.948445257725;10798.67603971882;10918.890811091946;10964.616238431776;10969.396683182502;8125.75622731319;8144.5520496373265;8165.346772258205;8226.465279756916;8227.876581851277;6127.6936153193055;6158.978316612456;6347.936520634735;6391.840203994937;6396.936030639634;9761.316707830667;9784;9807.313488055768;10008.499575021366;10045.799084018132;9539.33224674266;9765.560549775135;9771.364861283993;9803.950980245054;9807.117359437685;6792;7375.004374409386;7563.697452101855;7583.810404739926;7672.117706463605;8248.505089694638;8257.917420825715;8295.087540370676;8314.833703326021;8318.085010648945;7226.458015648953;7459.552426854406;7498.925010750041;7569.962150189434;7594.544327340156;7124.323189297009;7371.963140184264;7398.038255026812;7506.474546781673;7668.731594394169;6957.547759395623;6970.895436568557;7013.579185248697;7016.964915175391;7018.438524917892;5020.305626992156;5099.719515426687;5107.361579802525;5132.897342053064;5234.162533994542;5174.637775355689;5233.319668443078;5256.920932085333;5313.787448502017;5402.51377376038 11:11:27 INFO - PROCESS | 4025 | |4;prototype.html;359.1416514530271;368.9612590677977;370.3555812885579;371.35013725979536;372.5231703419624;6073.635581865091;6220.3468635793215;6221.222347206599;6226.68866556672;6268.310485846559;6153.723082461289;6210.223722034746;6210.751569937208;6212.534059945499;6223.097650840626;4593.908121837561;4684;4760.857174284768;4791.544803243686;4793.209120495114;4777.570018698317;4786.138495070886;4788;4794.280857871312;4799.928001079987;4751.382320298374;4751.714897106184;4754.049190161964;4757.381540399743;4760.309755085511;4760.642951778613;4761;4763.7141771493825;4771.5467030632035;4773.498782627844;4221.493420789494;4227.196832601796;4229.709938468765;4232.661387089025;4232.76719780412;5818.5054270386645;5992.8501787455225;5997.640141591519;6003.459688628044;6003.939960600425;5480.205370221295;5500.862478438031;5506.339239291311;5511.9724401378135;5515.558755299567;6629.138212032453;6634.369734875179;6635.601863888182;6637.137172167636;6643.169603799525;4461.5984561389305;4568.497465278817;4593.678442509025;4604.976975115136;4614.330922016289;6814.863702725967;6857.485688573377;6898;6902.723891044352;6910.516263861481;4695.882602934954;4699.342092107107;4705.364775755298;4705.5059218781535;4710.623150148049;4758.97681998372;4761.523847615211;4765.499622539653;4770;4775.2598347256235;5196.32447781786;5301.602379821529;5485.50630443262;5502.422245664147;5502.779888804483;6525.412712855771;6543.672816359163;6546.672666366758;6561.311062338481;6565.80302590923;1642.3841059602648;1660.842219989099;1662.609286817597;1669.766232727419;1670.5573023148875;1083.5557421457165;1089.096050278267;1098.9120870330355;1101.124605938281;1105.4914739219887;6358.427741503195;6422.197225346832;6439.323870993572;6446.967765161238;6450.258220304631;6817.522773405814;6822.147231596051;6827.0783444235385;6827.112475378169;6834.419074378733;6388.361163883575;6418.935810641834;6419.422251997343;6428.742850286029;6430.582012169194;3649.5620525536574;3680.3743363628246;3681.226942342138;3684.097396137963;3692.3538380783257;6897.517173797786;7067.328603782633;7076.540024898365;7076.575405475585;7076.610786406797;6935.202451718016;6944.375006249462;6946.93053069473;6949.235584085746;6973.407260382823;7050.435965122778;7052.858942821217;7062.71749130029;7064.364207221375;7069.78790636292;6797.762078327235;6800.421964133104;6803.829904252433;6816.727330906709;6826.93173068263;6558.639274839738;6669.566478178903;6702.899456508058;6710.295418980937;6711.3288671132495;7019.2629773873;7034.859302813813;7044;7048.154221493453;7053.470989675898;4700.083483720641;4708.599769019672;4713.269443236304;4717.245240761599;4717.740524271198;6559.442447391834;6660.966695166493;6784.59292442455;6795.252522222453;6797.830054248683;6568.540202185801;6696.5647232929705;6725.159355080615;6727.360900714424;6734.528582999143;6630.83422914431;6656.500762442933;6659.367360100783;6664.400203981665;6689.899651505134;6560.376764207393;6573.474122070127;6577.868442631217;6585.703643336157;6589.4069533742195;6584.934150658623;6711.731530738716;6728.428083612947;6729.865402692017;6742.258351581224;6537.673116344259;6547.476201903741;6553.311902250195;6557.344265573404;6561.540692151694 11:11:27 INFO - PROCESS | 4025 | |5;yui.html;815.3966065111816;861.892263467067;880.7910276225572;885.8272636835816;899.9595018224181;15279.159646219467;15648.687026259468;15837.12895790731;15853.84146158538;15858.127802970832;13797.448102075905;13855.307234638278;13879.375428105734;13888.652783680413;13900.235487048209;741.5847125609675;865.1780808232173;875.9211670949613;897;899.8920129584459;887.1439061305839;887.6183241206279;890.977725556863;891.1266958380791;892.1569117184264;921.9723408297762;926.9165775080241;927.7495076329387;927.8979312275644;928.1229238369743;792.4373694676758;914.5838643417229;928.3223247029706;928.726025822384;928.9210417114554;682.3551743602297;684.3806355248508;684.8561802021582;687.2783577243924;688.9345512176335;13830.792538111937;13897.305134743223;13910;13919.930400348036;13948.860511394858;14409;14779.852201477956;15177;15351.155686437241;15469.767953480707;12164.923788541808;12173.08701847365;12380.735127843984;12467.75064498714;12541.874581254162;3933.2920074386598;3968.8412463501427;4047.271491131595;4090.406891000818;4097.815598298083;58148;58150.41849581492;58254.41745582532;58475.41524584742;58521.41478585202;11457.369844658457;11502.07983361329;11647.301161930141;11837.289762614098;11947.283163010074;21228.044737986827;21439.142434302452;21445;21485.892570537046;21514;8727;8817.647294108292;8828.205461508367;8947.910520894839;9105.635774569075;5031.471695471996;5034.093863104603;5034.320366750515;5059.671121377099;5082.949170508322;3697.0387699197863;3720.051386896324;3760.266747984117;3761.962380376216;3772.2078363543965;664.5481072870398;670.7250027488803;674.4199988010307;675.6554157379771;677.1603212017063;768.8308572114126;787.4330482052912;788.7318311774025;797.6450479536667;806.4032615864219;9185.908140918506;9231.123043310874;9257.166854983085;9257.90742092584;9621.663241786504;618.4990157972057;634.6985182038495;646.1599920103846;718.690962885964;778.4745296924553;4162.313218319004;4272.5727427257025;4298.20483210607;4316.352547117957;4327.394164816928;67369.6631516849;67930.3206967924;68361.31638683549;68422;68430.3156968424;54023.45976540263;54239.186412203846;54688.45311546913;55253.44746552483;55791.44208557862;53058;53259.46740532545;53304.733476333146;53439.46560534422;53673;10189.898101019191;10276.869544349966;10313.9484302578;10390.220733445172;10395.16838652921;39497.407538886364;40464.39303410392;40536.59463405328;40591.59408405878;40715.98210044654;50270.748646256536;51787.48212517826;52358.21462677987;52819.20771188358;53513.19730203972;12640.431180596712;12873.935630321788;12968.610941671765;13034.283114428417;13144.474221031434;12759.74480510366;12885.742285154432;13637.79543306871;13644.727105458034;13816.309184540934;12869.806952895902;13302.600921972356;13714.314284285945;13908.235047072509;14192.929035354757;13640.65898352549;13652.590422287347;14076.296185190904;14088.15471071739;14136.222507762172;13267.137636053625;13389.866101338863;13450.663733406744;13617.25105119228;13910.234937078558;11033.44832758375;11335.03652189573;11430.657080287605;11575.88424115748;11606.70983225426;11337.716557086138;11361.318320900773;11546.538138474367;11593.478293476983;11594.246373985665 11:11:27 INFO - PROCESS | 4025 | __end_tp_report 11:11:27 INFO - PROCESS | 4025 | __start_cc_report 11:11:27 INFO - PROCESS | 4025 | _x_x_mozilla_cycle_collect,872 11:11:27 INFO - PROCESS | 4025 | __end_cc_report 11:11:27 INFO - PROCESS | 4025 | __startTimestamp1463508687842__endTimestamp 11:11:27 INFO - PROCESS | 4025 | 11:11:27 INFO - PROCESS | 4025 | ------- Summary: start ------- 11:11:27 INFO - PROCESS | 4025 | Number of tests: 6 11:11:27 INFO - PROCESS | 4025 | 11:11:27 INFO - PROCESS | 4025 | [#0] dojo.html Cycles:165 Average:5585.48 Median:5827.30 stddev:629.37 (10.8%) stddev-sans-first:605.61 11:11:27 INFO - PROCESS | 4025 | Values: 3316.8 3366.3 3386.4 3393.9 3409.9 5516.7 5549.2 5553.3 5559.3 5596.2 5509.8 5518.5 5525.4 5548.8 5599.4 4943.8 5014.5 5088.3 5136.9 5170.5 5090.9 5155.4 5160.9 5172.5 5175.7 5056.3 5120.1 5145.9 5149.4 5160.7 5067.4 5067.5 5084.5 5084.8 5112.7 4990.3 4998.9 5003.0 5011.2 5091.9 5500.9 5513.3 5542.4 5544.2 5555.7 5985.4 5987.8 6006.9 6008.1 6023.2 6020.9 6029.7 6084.8 6108.6 6128.4 5550.4 5602.9 5607.2 5612.5 5641.4 6051.4 6085.7 6092.2 6096.1 6125.4 5859.0 5930.4 5938.8 5947.2 5955.8 6000.2 6037.8 6044.4 6056.7 6060.3 5848.6 5982.7 5993.5 5999.6 6009.4 6022.4 6088.9 6090.4 6090.8 6125.5 4583.2 4598.6 4605.0 4613.9 4633.7 4047.0 4065.0 4112.3 4113.4 4144.2 5673.3 5679.6 5688.5 5705.4 5714.1 5959.4 6002.4 6011.3 6012.5 6031.3 5635.6 5648.2 5688.2 5715.7 5749.6 5136.6 5154.2 5157.3 5159.4 5168.1 6242.1 6258.4 6265.2 6275.9 6276.9 5987.0 6077.7 6139.6 6143.1 6152.4 6230.7 6276.5 6280.3 6283.8 6283.9 5706.1 5936.1 5952.7 5969.5 5998.7 5889.5 5991.8 5992.6 5998.3 6033.7 5898.0 5924.5 5926.2 5926.3 5928.3 5769.5 5840.7 5855.8 5883.0 5895.7 5802.7 5822.5 5827.3 5830.7 5859.9 5919.8 5927.1 5937.4 5939.1 5961.0 5561.6 5781.3 5815.4 5850.6 5878.1 11:11:27 INFO - PROCESS | 4025 | 11:11:27 INFO - PROCESS | 4025 | [#1] ext.html Cycles:180 Average:46589.05 Median:39120.51 stddev:77792.16 (198.9%) stddev-sans-first:77933.84 11:11:27 INFO - PROCESS | 4025 | Values: 626.9 667.9 677.4 690.3 755.9 32498.8 37842.6 39350.0 39448.0 39605.4 45296.0 45738.8 45938.0 46023.8 46063.5 8924.6 9113.0 9115.6 9117.8 9123.5 8846.6 8936.9 8944.0 8960.0 8961.7 8967.3 9015.0 9022.8 9022.8 9030.5 8943.0 8986.7 8998.6 9002.4 9006.6 8967.1 9070.3 9084.1 9086.3 9089.0 41975.2 42633.0 42657.1 42659.0 42672.4 3890.5 4002.8 4090.8 4283.0 4567.5 33011.7 33095.8 33438.0 34347.0 34692.3 4645.1 4665.5 4676.1 4718.1 4721.0 327498.0 330432.0 330606.0 331028.3 332030.0 39431.8 62656.0 63301.0 63369.7 63416.0 39039.6 39201.4 39232.6 39271.4 39273.2 16640.3 16949.2 16966.7 16968.2 16973.1 13010.9 13026.2 13032.1 13037.6 13040.2 9484.2 9499.1 9516.0 9575.5 9590.5 3527.5 3594.4 3647.0 3667.5 3692.2 1144.3 1174.0 1196.5 1235.7 1291.6 32893.5 33314.7 33760.7 33868.0 33989.3 1196.2 1212.4 1216.2 1218.9 1294.5 17585.1 17704.8 17757.3 17774.3 17795.4 206832.0 207612.0 207637.0 209660.0 209893.0 61037.7 61712.4 61727.4 61791.0 61806.0 1406.3 1414.2 1477.1 1501.3 1524.8 30690.2 32020.7 32052.7 32486.8 32620.3 49454.8 50018.5 50034.5 50040.0 50144.2 296654.0 301366.0 301866.0 301938.0 442904.0 30304.4 30509.4 30840.5 31373.4 31378.4 43384.6 43880.1 43903.1 44777.0 45075.8 36894.4 36995.0 36997.3 37008.4 37777.8 35401.6 35586.1 36676.8 39773.4 40284.0 40337.8 41229.8 41518.2 42204.2 42286.0 35048.6 36135.0 36309.6 36324.8 36509.0 28218.7 28280.4 28509.9 28510.4 28612.3 11:11:27 INFO - PROCESS | 4025 | 11:11:27 INFO - PROCESS | 4025 | [#2] jquery.html Cycles:180 Average:29220.29 Median:24986.44 stddev:72447.04 (289.9%) stddev-sans-first:72617.99 11:11:27 INFO - PROCESS | 4025 | Values: 413.4 429.2 433.5 443.1 444.3 19837.8 20322.3 20512.7 20599.8 21079.4 19876.1 20050.1 20741.2 20783.0 20803.0 5359.4 5882.0 5891.1 5892.0 5892.1 4397.8 5646.5 5723.2 5920.0 6358.8 6231.8 6285.5 6294.7 6297.3 6311.9 6078.2 6262.1 6367.0 6377.4 6377.5 4034.8 5506.6 5747.5 5800.4 5802.7 24238.9 24479.6 24829.6 25143.2 25144.6 2472.8 2564.2 2581.1 2850.4 3041.9 14320.9 14952.7 15216.4 15231.2 15340.3 2033.9 2091.5 2112.1 2123.1 2310.3 82281.6 83981.2 88844.6 95452.0 95837.5 18084.0 18292.7 18503.9 18709.7 18992.9 33181.7 33299.2 33708.8 34051.8 34095.0 10173.6 10684.2 10701.8 10778.8 10837.3 8950.7 8955.6 8962.8 9107.9 9138.8 9282.8 9354.0 9384.0 9402.7 9710.4 3043.6 3563.9 3573.9 3648.8 3685.5 986.9 1050.4 1058.7 1074.9 1116.1 18228.3 18824.2 19099.7 19320.4 19390.3 1080.4 1086.4 1095.6 1104.9 1109.4 9875.7 11091.8 11097.4 11098.9 11193.3 386648.1 389059.0 389747.0 489845.0 502923.0 102499.5 108186.5 108556.0 109223.0 109972.5 1159.6 1161.5 1182.6 1198.6 1246.4 17361.6 17726.0 17904.6 17951.6 18275.4 28122.2 42269.3 42571.8 42680.8 42837.8 51634.7 52281.5 52953.5 53814.0 61168.0 8967.5 9017.7 9109.2 9229.1 9277.4 9197.8 10690.0 13637.5 13864.9 13906.4 11814.5 11952.3 12038.9 12120.5 12149.3 11380.1 11467.7 11744.4 12048.7 12089.9 11865.6 11982.3 12045.5 12220.9 12278.7 8798.7 9123.0 9164.1 9283.1 9343.0 11057.4 11870.5 11896.2 11954.7 12075.6 11:11:27 INFO - PROCESS | 4025 | 11:11:27 INFO - PROCESS | 4025 | [#3] mootools.html Cycles:180 Average:5795.03 Median:4812.78 stddev:3240.60 (67.3%) stddev-sans-first:3233.27 11:11:27 INFO - PROCESS | 4025 | Values: 1453.9 1559.6 1582.3 1778.9 1863.4 7740.6 8397.7 8513.9 8518.7 8527.4 8339.5 8510.0 8512.2 8515.1 8520.1 2185.8 2404.9 2411.8 2428.5 2473.5 2452.1 2479.5 2481.0 2483.1 2486.5 2430.5 2452.6 2453.6 2453.6 2455.7 2138.3 2389.0 2433.6 2435.6 2438.8 2320.5 2355.6 2362.2 2368.7 2378.7 8516.3 8532.3 8538.8 8573.1 8590.5 5252.3 5365.1 5413.6 5413.8 5422.4 3604.0 3625.9 3661.8 3677.8 3692.9 1208.3 1208.5 1224.0 1227.0 1297.2 12552.0 12561.4 12571.9 12582.9 12588.7 4807.6 4818.0 4885.7 4946.5 4956.4 10551.1 10590.9 10632.6 10649.6 10660.5 4760.7 5436.6 5436.9 5439.6 5440.6 4392.3 4398.4 4447.7 4784.4 4897.3 4098.5 4121.2 4200.3 4238.7 4277.9 1366.6 1389.4 1390.6 1396.5 1408.9 1014.9 1051.6 1061.0 1072.2 1074.7 6059.8 6108.2 6160.2 6204.5 6219.4 464.8 467.2 480.3 482.1 487.6 4174.9 4240.7 4247.3 4260.1 4286.0 10418.2 11081.6 11143.9 11232.3 11236.7 10310.9 10798.7 10918.9 10964.6 10969.4 8125.8 8144.6 8165.3 8226.5 8227.9 6127.7 6159.0 6347.9 6391.8 6396.9 9761.3 9784.0 9807.3 10008.5 10045.8 9539.3 9765.6 9771.4 9804.0 9807.1 6792.0 7375.0 7563.7 7583.8 7672.1 8248.5 8257.9 8295.1 8314.8 8318.1 7226.5 7459.6 7498.9 7570.0 7594.5 7124.3 7372.0 7398.0 7506.5 7668.7 6957.5 6970.9 7013.6 7017.0 7018.4 5020.3 5099.7 5107.4 5132.9 5234.2 5174.6 5233.3 5256.9 5313.8 5402.5 11:11:27 INFO - PROCESS | 4025 | 11:11:27 INFO - PROCESS | 4025 | [#4] prototype.html Cycles:180 Average:5535.52 Median:6373.39 stddev:1667.54 (26.2%) stddev-sans-first:1626.33 11:11:27 INFO - PROCESS | 4025 | Values: 359.1 369.0 370.4 371.4 372.5 6073.6 6220.3 6221.2 6226.7 6268.3 6153.7 6210.2 6210.8 6212.5 6223.1 4593.9 4684.0 4760.9 4791.5 4793.2 4777.6 4786.1 4788.0 4794.3 4799.9 4751.4 4751.7 4754.0 4757.4 4760.3 4760.6 4761.0 4763.7 4771.5 4773.5 4221.5 4227.2 4229.7 4232.7 4232.8 5818.5 5992.9 5997.6 6003.5 6003.9 5480.2 5500.9 5506.3 5512.0 5515.6 6629.1 6634.4 6635.6 6637.1 6643.2 4461.6 4568.5 4593.7 4605.0 4614.3 6814.9 6857.5 6898.0 6902.7 6910.5 4695.9 4699.3 4705.4 4705.5 4710.6 4759.0 4761.5 4765.5 4770.0 4775.3 5196.3 5301.6 5485.5 5502.4 5502.8 6525.4 6543.7 6546.7 6561.3 6565.8 1642.4 1660.8 1662.6 1669.8 1670.6 1083.6 1089.1 1098.9 1101.1 1105.5 6358.4 6422.2 6439.3 6447.0 6450.3 6817.5 6822.1 6827.1 6827.1 6834.4 6388.4 6418.9 6419.4 6428.7 6430.6 3649.6 3680.4 3681.2 3684.1 3692.4 6897.5 7067.3 7076.5 7076.6 7076.6 6935.2 6944.4 6946.9 6949.2 6973.4 7050.4 7052.9 7062.7 7064.4 7069.8 6797.8 6800.4 6803.8 6816.7 6826.9 6558.6 6669.6 6702.9 6710.3 6711.3 7019.3 7034.9 7044.0 7048.2 7053.5 4700.1 4708.6 4713.3 4717.2 4717.7 6559.4 6661.0 6784.6 6795.3 6797.8 6568.5 6696.6 6725.2 6727.4 6734.5 6630.8 6656.5 6659.4 6664.4 6689.9 6560.4 6573.5 6577.9 6585.7 6589.4 6584.9 6711.7 6728.4 6729.9 6742.3 6537.7 6547.5 6553.3 6557.3 6561.5 11:11:27 INFO - PROCESS | 4025 | 11:11:27 INFO - PROCESS | 4025 | [#5] yui.html Cycles:180 Average:15946.99 Median:4217.44 stddev:18467.78 (437.9%) stddev-sans-first:18484.63 11:11:27 INFO - PROCESS | 4025 | Values: 815.4 861.9 880.8 885.8 900.0 15279.2 15648.7 15837.1 15853.8 15858.1 13797.4 13855.3 13879.4 13888.7 13900.2 741.6 865.2 875.9 897.0 899.9 887.1 887.6 891.0 891.1 892.2 922.0 926.9 927.7 927.9 928.1 792.4 914.6 928.3 928.7 928.9 682.4 684.4 684.9 687.3 688.9 13830.8 13897.3 13910.0 13919.9 13948.9 14409.0 14779.9 15177.0 15351.2 15469.8 12164.9 12173.1 12380.7 12467.8 12541.9 3933.3 3968.8 4047.3 4090.4 4097.8 58148.0 58150.4 58254.4 58475.4 58521.4 11457.4 11502.1 11647.3 11837.3 11947.3 21228.0 21439.1 21445.0 21485.9 21514.0 8727.0 8817.6 8828.2 8947.9 9105.6 5031.5 5034.1 5034.3 5059.7 5082.9 3697.0 3720.1 3760.3 3762.0 3772.2 664.5 670.7 674.4 675.7 677.2 768.8 787.4 788.7 797.6 806.4 9185.9 9231.1 9257.2 9257.9 9621.7 618.5 634.7 646.2 718.7 778.5 4162.3 4272.6 4298.2 4316.4 4327.4 67369.7 67930.3 68361.3 68422.0 68430.3 54023.5 54239.2 54688.5 55253.4 55791.4 53058.0 53259.5 53304.7 53439.5 53673.0 10189.9 10276.9 10313.9 10390.2 10395.2 39497.4 40464.4 40536.6 40591.6 40716.0 50270.7 51787.5 52358.2 52819.2 53513.2 12640.4 12873.9 12968.6 13034.3 13144.5 12759.7 12885.7 13637.8 13644.7 13816.3 12869.8 13302.6 13714.3 13908.2 14192.9 13640.7 13652.6 14076.3 14088.2 14136.2 13267.1 13389.9 13450.7 13617.3 13910.2 11033.4 11335.0 11430.7 11575.9 11606.7 11337.7 11361.3 11546.5 11593.5 11594.2 11:11:27 INFO - PROCESS | 4025 | -------- Summary: end -------- 11:11:27 INFO - PROCESS | 4025 | 11:11:28 INFO - TEST-INFO | 4025: exit 0 11:11:28 INFO - TEST-OK | dromaeo_css | took 1111588ms 11:11:28 INFO - TEST-START | kraken 11:11:28 INFO - operating with platform_type : linux_ 11:11:28 INFO - Initialising browser for kraken test... 11:11:28 INFO - TEST-INFO | started process 4213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZPvNT4/profile http://localhost:40241/getInfo.html) 11:11:32 INFO - PROCESS | 4213 | __metrics Screen width/height:1600/1200 11:11:32 INFO - PROCESS | 4213 | colorDepth:24 11:11:32 INFO - PROCESS | 4213 | Browser inner width/height: 1024/697 11:11:32 INFO - PROCESS | 4213 | __metrics 11:11:33 ERROR - PROCESS | 4213 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:11:34 INFO - TEST-INFO | 4213: exit 0 11:11:34 INFO - Browser initialized. 11:11:34 INFO - Running cycle 1/1 for kraken test... 11:11:34 INFO - TEST-INFO | started process 4301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZPvNT4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:46 INFO - PROCESS | 4301 | RSS: Main: 142524416 11:11:46 INFO - PROCESS | 4301 | 11:11:48 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40241/tests/kraken/driver.html?testName=audio-beat-detection) 11:11:49 INFO - PROCESS | 4301 | RSS: Main: 196575232 11:11:49 INFO - PROCESS | 4301 | 11:11:51 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40241/tests/kraken/driver.html?testName=audio-dft) 11:11:52 INFO - PROCESS | 4301 | RSS: Main: 182366208 11:11:52 INFO - PROCESS | 4301 | 11:11:55 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40241/tests/kraken/driver.html?testName=audio-fft) 11:11:55 INFO - PROCESS | 4301 | RSS: Main: 273448960 11:11:55 INFO - PROCESS | 4301 | 11:11:58 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40241/tests/kraken/driver.html?testName=audio-oscillator) 11:11:58 INFO - PROCESS | 4301 | RSS: Main: 179384320 11:11:58 INFO - PROCESS | 4301 | 11:12:00 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:01 INFO - PROCESS | 4301 | RSS: Main: 178098176 11:12:01 INFO - PROCESS | 4301 | 11:12:04 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40241/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:04 INFO - PROCESS | 4301 | RSS: Main: 213106688 11:12:04 INFO - PROCESS | 4301 | 11:12:08 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40241/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:08 INFO - PROCESS | 4301 | RSS: Main: 213217280 11:12:08 INFO - PROCESS | 4301 | 11:12:11 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40241/tests/kraken/driver.html?testName=json-parse-financial) 11:12:12 INFO - PROCESS | 4301 | RSS: Main: 213016576 11:12:12 INFO - PROCESS | 4301 | 11:12:13 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:14 INFO - PROCESS | 4301 | RSS: Main: 192405504 11:12:14 INFO - PROCESS | 4301 | 11:12:16 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:16 INFO - PROCESS | 4301 | RSS: Main: 197214208 11:12:16 INFO - PROCESS | 4301 | 11:12:18 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:19 INFO - PROCESS | 4301 | RSS: Main: 208097280 11:12:19 INFO - PROCESS | 4301 | 11:12:21 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:22 INFO - PROCESS | 4301 | RSS: Main: 213270528 11:12:22 INFO - PROCESS | 4301 | 11:12:24 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:25 INFO - PROCESS | 4301 | RSS: Main: 210427904 11:12:25 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40241/tests/kraken/driver.html?testName=ai-astar) 11:12:27 INFO - PROCESS | 4301 | RSS: Main: 273539072 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | __start_tp_report 11:12:27 INFO - PROCESS | 4301 | _x_x_mozilla_page_load 11:12:27 INFO - PROCESS | 4301 | _x_x_mozilla_page_load_details 11:12:27 INFO - PROCESS | 4301 | |i|pagename|runs| 11:12:27 INFO - PROCESS | 4301 | |0;ai-astar;109;109;109;111;109;110;105;111;109;109 11:12:27 INFO - PROCESS | 4301 | |1;audio-beat-detection;153;124;151;177;132;163;155;128;184;131 11:12:27 INFO - PROCESS | 4301 | |2;audio-dft;161;161;161;162;161;162;160;160;160;163 11:12:27 INFO - PROCESS | 4301 | |3;audio-fft;74;77;76;181;76;73;75;77;167;75 11:12:27 INFO - PROCESS | 4301 | |4;audio-oscillator;91;91;141;93;92;92;145;91;93;151 11:12:27 INFO - PROCESS | 4301 | |5;imaging-gaussian-blur;116;116;117;116;117;117;116;116;117;117 11:12:27 INFO - PROCESS | 4301 | |6;imaging-darkroom;145;145;144;146;145;147;145;145;145;145 11:12:27 INFO - PROCESS | 4301 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 11:12:27 INFO - PROCESS | 4301 | |8;json-parse-financial;54;56;54;55;54;55;57;72;53;52 11:12:27 INFO - PROCESS | 4301 | |9;json-stringify-tinderbox;58;72;57;57;57;58;57;58;58;58 11:12:27 INFO - PROCESS | 4301 | |10;stanford-crypto-aes;72;73;71;72;73;72;73;74;72;73 11:12:27 INFO - PROCESS | 4301 | |11;stanford-crypto-ccm;112;116;111;116;112;112;114;115;132;118 11:12:27 INFO - PROCESS | 4301 | |12;stanford-crypto-pbkdf2;156;163;157;158;158;158;157;164;160;164 11:12:27 INFO - PROCESS | 4301 | |13;stanford-crypto-sha256-iterative;68;67;67;66;65;65;65;66;67;63 11:12:27 INFO - PROCESS | 4301 | __end_tp_report 11:12:27 INFO - PROCESS | 4301 | __start_cc_report 11:12:27 INFO - PROCESS | 4301 | _x_x_mozilla_cycle_collect,1603 11:12:27 INFO - PROCESS | 4301 | __end_cc_report 11:12:27 INFO - PROCESS | 4301 | __startTimestamp1463508747465__endTimestamp 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | ------- Summary: start ------- 11:12:27 INFO - PROCESS | 4301 | Number of tests: 14 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.00 stddev:1.66 (1.5%) stddev-sans-first:1.76 11:12:27 INFO - PROCESS | 4301 | Values: 109.0 109.0 109.0 111.0 109.0 110.0 105.0 111.0 109.0 109.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:154.00 stddev:20.91 (13.6%) stddev-sans-first:22.14 11:12:27 INFO - PROCESS | 4301 | Values: 153.0 124.0 151.0 177.0 132.0 163.0 155.0 128.0 184.0 131.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 11:12:27 INFO - PROCESS | 4301 | Values: 161.0 161.0 161.0 162.0 161.0 162.0 160.0 160.0 160.0 163.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#3] audio-fft Cycles:10 Average:95.10 Median:75.50 stddev:41.73 (55.3%) stddev-sans-first:43.56 11:12:27 INFO - PROCESS | 4301 | Values: 74.0 77.0 76.0 181.0 76.0 73.0 75.0 77.0 167.0 75.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:91.50 stddev:26.11 (28.5%) stddev-sans-first:26.96 11:12:27 INFO - PROCESS | 4301 | Values: 91.0 91.0 141.0 93.0 92.0 92.0 145.0 91.0 93.0 151.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:12:27 INFO - PROCESS | 4301 | Values: 116.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 11:12:27 INFO - PROCESS | 4301 | Values: 145.0 145.0 144.0 146.0 145.0 147.0 145.0 145.0 145.0 145.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:12:27 INFO - PROCESS | 4301 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.00 stddev:5.73 (10.4%) stddev-sans-first:6.02 11:12:27 INFO - PROCESS | 4301 | Values: 54.0 56.0 54.0 55.0 54.0 55.0 57.0 72.0 53.0 52.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:58.00 stddev:4.59 (7.9%) stddev-sans-first:4.86 11:12:27 INFO - PROCESS | 4301 | Values: 58.0 72.0 57.0 57.0 57.0 58.0 57.0 58.0 58.0 58.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#10] stanford-crypto-aes Cycles:10 Average:72.50 Median:73.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 11:12:27 INFO - PROCESS | 4301 | Values: 72.0 73.0 71.0 72.0 73.0 72.0 73.0 74.0 72.0 73.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:115.50 stddev:6.12 (5.3%) stddev-sans-first:6.34 11:12:27 INFO - PROCESS | 4301 | Values: 112.0 116.0 111.0 116.0 112.0 112.0 114.0 115.0 132.0 118.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:159.00 stddev:3.06 (1.9%) stddev-sans-first:2.98 11:12:27 INFO - PROCESS | 4301 | Values: 156.0 163.0 157.0 158.0 158.0 158.0 157.0 164.0 160.0 164.0 11:12:27 INFO - PROCESS | 4301 | 11:12:27 INFO - PROCESS | 4301 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:1.45 (2.2%) stddev-sans-first:1.32 11:12:27 INFO - PROCESS | 4301 | Values: 68.0 67.0 67.0 66.0 65.0 65.0 65.0 66.0 67.0 63.0 11:12:27 INFO - PROCESS | 4301 | -------- Summary: end -------- 11:12:27 INFO - PROCESS | 4301 | 11:12:28 INFO - TEST-INFO | 4301: exit 0 11:12:28 INFO - TEST-OK | kraken | took 59917ms 11:12:28 INFO - SUITE-END | took 1171s 11:12:28 INFO - Completed test suite (00:19:31) 11:12:28 INFO - javascript benchmark 11:12:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.751243656726, 3366.2930784535233, 3386.407378708726, 3393.8981830545094, 3409.9147521311966, 5516.696581688006, 5549.1676248562735, 5553.278073850399, 5559.3328800543995, 5596.216529685842, 5509.779608815643, 5518.475744804247, 5525.419830917756, 5548.750306236219, 5599.356074051485, 4943.826966056171, 5014.498550144984, 5088.313077734496, 5136.922946155811, 5170.508801663836, 5090.9236361454605, 5155.407128180251, 5160.896782064357, 5172.482751724835, 5175.715335656538, 5056.266841308008, 5120.078385890538, 5145.922811157836, 5149.433562308143, 5160.6903585784785, 5067.366579177603, 5067.543921047123, 5084.466131056222, 5084.847454576368, 5112.744362781865, 4990.25146228065, 4998.875028124289, 5002.974390250027, 5011.173156429185, 5091.949080509222, 5500.862478438031, 5513.338399392099, 5542.39033706292, 5544.168374743821, 5555.749991250363, 5985.431384018511, 5987.820365389045, 6006.939930600682, 6008.098785182214, 6023.156758053876, 6020.879582408371, 6029.668368239745, 6084.767100293744, 6108.617639120746, 6128.44843964041, 5550.417206193332, 5602.915956260659, 5607.158926161027, 5612.494875461228, 5641.379448260688, 6051.394860513913, 6085.726142323606, 6092.201981463733, 6096.085587161872, 6125.387461253839, 5858.970705146532, 5930.377310382434, 5938.762449501972, 5947.197128387699, 5955.791547295824, 6000.249968753906, 6037.78867739627, 6044.425779550936, 6056.727447264883, 6060.303065147476, 5848.619839710405, 5982.73077711504, 5993.520518358521, 5999.640021598718, 6009.399060093956, 6022.427869352405, 6088.939110608926, 6090.36051214625, 6090.817275481742, 6125.540584456184, 4583.152116858325, 4598.632109431237, 4604.953950460519, 4613.861584152413, 4633.675642705046, 4046.968023154077, 4064.9796751016647, 4112.321466957918, 4113.382992551082, 4144.150449157915, 5673.319201695823, 5679.602427830012, 5688.544916406678, 5705.400932902068, 5714.085746280575, 5959.404059594006, 6002.369751176151, 6011.3086994995265, 6012.518998480111, 6031.336552979169, 5635.605507614509, 5648.237487939158, 5688.232088667977, 5715.657060576379, 5749.568782341341, 5136.563392111638, 5154.175331946945, 5157.32954715892, 5159.355080614923, 5168.147255702767, 6242.1261023456755, 6258.436740693269, 6265.185525881606, 6275.874482510324, 6276.874462510724, 5986.970065149733, 6077.696115194134, 6139.6454669416935, 6143.051335358963, 6152.415520525543, 6230.657313847782, 6276.529260305404, 6280.340564240689, 6283.7800676976085, 6283.937160628335, 5706.058500347396, 5936.079907614327, 5952.732127054206, 5969.462748352669, 5998.730057147526, 5889.499392551681, 5991.7603295867675, 5992.550558708202, 5998.280206375263, 6033.698315084316, 5897.970510147422, 5924.4667979882015, 5926.1999630049395, 5926.348101708895, 5928.318243402064, 5769.451902069297, 5840.678762667924, 5855.824325270249, 5883.0, 5895.7052147393315, 5802.65184088956, 5822.534197264294, 5827.3007239131575, 5830.650160990354, 5859.912101318569, 5919.7632094717455, 5927.140564618193, 5937.376575459514, 5939.07944268639, 5961.0, 5561.63849349791, 5781.335146458211, 5815.3603103657715, 5850.619709718854, 5878.118282257696], "value": 5544.106754024359, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.8746250749848, 667.933206679332, 677.4038845815681, 690.2545251128778, 755.8715018446863, 32498.837505812466, 37842.62157378425, 39350.0, 39448.0, 39605.405918911165, 45296.0, 45738.771306143506, 45938.0, 46023.769881150634, 46063.539364606346, 8924.643014279438, 9113.0, 9115.589798459052, 9117.817643647122, 9123.452592844418, 8846.601902914352, 8936.8659470108, 8944.0, 8959.955200223989, 8961.686340978067, 8967.327450441211, 9014.954925225366, 9022.774430639221, 9022.774430639221, 9030.458172509638, 8942.955285223565, 8986.68546600866, 8998.595063222105, 9002.414843035214, 9006.639734410583, 8967.148120928501, 9070.319726020509, 9084.137006984325, 9086.273098152133, 9088.954555227248, 41975.1604967902, 42633.0, 42657.146857062995, 42659.0, 42672.359914600995, 3890.4942357493346, 4002.779847108408, 4090.836366545335, 4283.0, 4567.543245675439, 33011.6698833011, 33095.834520827244, 33438.0, 34346.96959091231, 34692.306153877034, 4645.117427688729, 4665.533446655341, 4676.134915040694, 4718.079974404993, 4720.976395118002, 327498.0, 330432.0, 330606.0, 331028.3448582766, 332030.0, 39431.80284098561, 62656.0, 63301.0, 63369.683151583944, 63416.0, 39039.6096039036, 39201.41197882034, 39232.607673922896, 39271.41092883609, 39273.21453570913, 16640.251188696537, 16949.237284322237, 16966.745498817527, 16968.23642936071, 16973.066481343398, 13010.934945325213, 13026.153300035658, 13032.087753857139, 13037.608871733863, 13040.152390094614, 9484.19384352324, 9499.145076943109, 9515.952420237854, 9575.473348965874, 9590.472524011107, 3527.4885141654318, 3594.406922857699, 3646.9635303647156, 3667.4865518827387, 3692.1877187018813, 1144.2791041643711, 1173.9845034045659, 1196.4735516372941, 1235.6540168752763, 1291.625428625688, 32893.50659740106, 33314.66685333164, 33760.662393376246, 33868.0, 33989.32021359559, 1196.1925700152362, 1212.3574505512092, 1216.1851559455185, 1218.9268643881219, 1294.5210272199347, 17585.120743963005, 17704.822951770577, 17757.31305525973, 17774.289028438718, 17795.377161799533, 206832.0, 207612.0, 207637.0, 209660.0, 209893.0, 61037.69481152655, 61712.38287617066, 61727.38272617306, 61791.0, 61806.0, 1406.3319923036477, 1414.2009764483034, 1477.128494188434, 1501.2568778454736, 1524.8475152484664, 30690.232744181572, 32020.6797932027, 32052.67947320497, 32486.83756581202, 32620.347593048482, 49454.75272623758, 50018.499815001385, 50034.49965500298, 50040.0, 50144.24783628176, 296654.0, 301366.0, 301866.0, 301938.0, 442904.0, 30304.39391212119, 30509.389812204077, 30840.537391939586, 31373.372532549678, 31378.372432550765, 43384.566154338056, 43880.12239755123, 43903.12193756171, 44777.0, 45075.774621127995, 36894.446583300734, 36995.0, 36997.26005479929, 37008.444873326385, 37777.81111094537, 35401.645983539835, 35586.11034724153, 36676.81661591675, 39773.40339894846, 40284.0, 40337.79831100826, 41229.793851030554, 41518.1696366077, 42204.155916880874, 42286.0, 35048.64951350556, 36135.0, 36309.63690363168, 36324.81837590901, 36509.0, 28218.717812821607, 28280.43439131247, 28509.857450713444, 28510.42979140364, 28612.284692882844], "value": 18842.446341961375, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.42946733507756, 429.2207116340621, 433.47765942039837, 443.09829496973657, 444.3401548700182, 19837.801621983777, 20322.28871989481, 20512.692309615366, 20599.794002059974, 21079.367618971417, 19876.105575249112, 20050.097745601448, 20741.17035318589, 20783.0, 20803.0, 5359.410464848864, 5882.029465138268, 5891.057430811071, 5891.970540147315, 5892.116182572606, 4397.780110994453, 5646.491815736583, 5723.227364305828, 5919.970400147993, 6358.8092357229125, 6231.844203894893, 6285.465735412496, 6294.685265736694, 6297.307296197415, 6311.936880631204, 6078.240219972504, 6262.12330273762, 6367.0, 6377.426031657127, 6377.457916077139, 4034.7579145251084, 5506.614536982413, 5747.5114615257335, 5800.4489573490455, 5802.7388767505145, 24238.87880560586, 24479.632805507932, 24829.62755558668, 25143.245702628767, 25144.622830657554, 2472.83926544774, 2564.2435481532807, 2581.1482210870367, 2850.3586692994118, 3041.9087427377212, 14320.928395358062, 14952.700945981129, 15216.391344346213, 15231.162286074261, 15340.309686064154, 2033.9288124915556, 2091.529405883664, 2112.0601332407086, 2123.108294516307, 2310.330004298751, 82281.58859205726, 83981.16018839856, 88844.55577722135, 95452.045479545, 95837.5208123955, 18084.0, 18292.725609115874, 18503.90748046278, 18709.719354209697, 18992.905035474734, 33181.66818331834, 33299.16752081169, 33708.83145584256, 34051.829740851135, 34095.0, 10173.57569940209, 10684.198685098649, 10701.78596428067, 10778.784424311627, 10837.295575787548, 8950.68672596456, 8955.552222388855, 8962.775930601787, 9107.908920910706, 9138.817223655622, 9282.767930801783, 9354.0, 9384.0, 9402.71791846232, 9710.417374957526, 3043.5824232865534, 3563.9109022274133, 3573.928521429557, 3648.7628304160144, 3685.5024571683016, 986.8569057486624, 1050.4065203160342, 1058.7035630023606, 1074.882839764673, 1116.1126904111252, 18228.27086916535, 18824.15291311894, 19099.688722164447, 19320.4203873884, 19390.321338753358, 1080.4273734920505, 1086.3916206924148, 1095.649392194506, 1104.9337039777479, 1109.4341885638382, 9875.654352097643, 11091.778164436666, 11097.44512774358, 11098.944505277423, 11193.272437291713, 386648.0667596644, 389059.0, 389747.0, 489845.0, 502923.0, 102499.48750256201, 108186.45906770573, 108556.0, 109223.0, 109972.4501377488, 1159.576754484624, 1161.506359797083, 1182.6156499137815, 1198.6224339333082, 1246.389269258057, 17361.56596085108, 17726.0, 17904.55238619045, 17951.551211219823, 18275.360362387786, 28122.156335309974, 42269.30922763055, 42571.787141064095, 42680.786596068065, 42837.785811070746, 51634.74182629063, 52281.47718522766, 52953.47046529486, 53814.0, 61168.0, 8967.506787126771, 9017.729468115967, 9109.22571581423, 9229.077092290985, 9277.396969196981, 9197.816043678955, 10690.0, 13637.454501819817, 13864.861351386357, 13906.443742250196, 11814.468348924147, 11952.282863028246, 12038.879611203776, 12120.515179392725, 12149.331786751813, 11380.089592832719, 11467.713307167387, 11744.412779360828, 12048.698782530157, 12089.879101208875, 11865.5847045353, 11982.340971246666, 12045.457954391899, 12220.938895305466, 12278.693032674255, 8798.692045778367, 9123.042080581443, 9164.083591640783, 9283.071692830663, 9343.0, 11057.447127643747, 11870.525178992744, 11896.167268291136, 11954.701132471759, 12075.637730868088], "value": 10454.734256445712, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.920034398109, 1559.6490789572347, 1582.2563395204254, 1778.8754787164903, 1863.440967709686, 7740.612969351531, 8397.706080287191, 8513.872291915626, 8518.659253629863, 8527.445716028455, 8339.54132522711, 8510.0, 8512.233898949093, 8515.063343032261, 8520.105388934166, 2185.846990710651, 2404.855708657482, 2411.7588241175918, 2428.514297140579, 2473.4558397152687, 2452.141750387359, 2479.504099180162, 2480.987595062022, 2483.13090418353, 2486.5275597636482, 2430.4652976345174, 2452.6443665668467, 2453.6074228123503, 2453.6319552067243, 2455.693038370204, 2138.272987184357, 2389.032441861049, 2433.634954756783, 2435.6346548017673, 2438.8170887183533, 2320.5474932388192, 2355.611324131516, 2362.232274510791, 2368.7157541095007, 2378.714554253501, 8516.318694504425, 8532.31741460688, 8538.82922341556, 8573.099824518398, 8590.484570925764, 5252.343457067866, 5365.114756065244, 5413.593980451482, 5413.783448662049, 5422.376426710939, 3604.0, 3625.909352266188, 3661.7802931824176, 3677.8344974476213, 3692.8552148833946, 1208.2689972566645, 1208.5407545132882, 1223.9816402753966, 1227.042906532897, 1297.228149251194, 12552.0, 12561.371931403393, 12571.93714031433, 12582.874171258354, 12588.68528286791, 4807.567318941312, 4818.0, 4885.7312847793, 4946.530079642428, 4956.405231372259, 10551.103156231653, 10590.89409105899, 10632.627858024933, 10649.574017039387, 10660.466976651136, 4760.666753327234, 5436.646617969819, 5436.864078398072, 5439.564834813205, 5440.646357986719, 4392.253316936129, 4398.362237475548, 4447.688661793708, 4784.354112194878, 4897.2898929655, 4098.483262033636, 4121.175764847043, 4200.348945913388, 4238.745675259494, 4277.871663850089, 1366.6173471428017, 1389.388668985643, 1390.5550223928449, 1396.4623619906206, 1408.8520705325793, 1014.9495272393037, 1051.574112484445, 1060.9522571484301, 1072.1904961753826, 1074.7366895110592, 6059.757609695651, 6108.205933228652, 6160.199174107427, 6204.503639708812, 6219.378062193835, 464.8187206989277, 467.22207524472054, 480.2603989855583, 482.12253698268813, 487.6464563191658, 4174.874753757392, 4240.724352917051, 4247.256730072225, 4260.10537787062, 4285.957140428618, 10418.166546676399, 11081.612143575097, 11143.944280278709, 11232.3260604364, 11236.66290011301, 10310.948445257725, 10798.67603971882, 10918.890811091946, 10964.616238431776, 10969.396683182502, 8125.75622731319, 8144.5520496373265, 8165.346772258205, 8226.465279756916, 8227.876581851277, 6127.6936153193055, 6158.978316612456, 6347.936520634735, 6391.840203994937, 6396.936030639634, 9761.316707830667, 9784.0, 9807.313488055768, 10008.499575021366, 10045.799084018132, 9539.33224674266, 9765.560549775135, 9771.364861283993, 9803.950980245054, 9807.117359437685, 6792.0, 7375.004374409386, 7563.697452101855, 7583.810404739926, 7672.117706463605, 8248.505089694638, 8257.917420825715, 8295.087540370676, 8314.833703326021, 8318.085010648945, 7226.458015648953, 7459.552426854406, 7498.925010750041, 7569.962150189434, 7594.544327340156, 7124.323189297009, 7371.963140184264, 7398.038255026812, 7506.474546781673, 7668.731594394169, 6957.547759395623, 6970.895436568557, 7013.579185248697, 7016.964915175391, 7018.438524917892, 5020.305626992156, 5099.719515426687, 5107.361579802525, 5132.897342053064, 5234.162533994542, 5174.637775355689, 5233.319668443078, 5256.920932085333, 5313.787448502017, 5402.51377376038], "value": 4626.504885591567, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.1416514530271, 368.9612590677977, 370.3555812885579, 371.35013725979536, 372.5231703419624, 6073.635581865091, 6220.3468635793215, 6221.222347206599, 6226.68866556672, 6268.310485846559, 6153.723082461289, 6210.223722034746, 6210.751569937208, 6212.534059945499, 6223.097650840626, 4593.908121837561, 4684.0, 4760.857174284768, 4791.544803243686, 4793.209120495114, 4777.570018698317, 4786.138495070886, 4788.0, 4794.280857871312, 4799.928001079987, 4751.382320298374, 4751.714897106184, 4754.049190161964, 4757.381540399743, 4760.309755085511, 4760.642951778613, 4761.0, 4763.7141771493825, 4771.5467030632035, 4773.498782627844, 4221.493420789494, 4227.196832601796, 4229.709938468765, 4232.661387089025, 4232.76719780412, 5818.5054270386645, 5992.8501787455225, 5997.640141591519, 6003.459688628044, 6003.939960600425, 5480.205370221295, 5500.862478438031, 5506.339239291311, 5511.9724401378135, 5515.558755299567, 6629.138212032453, 6634.369734875179, 6635.601863888182, 6637.137172167636, 6643.169603799525, 4461.5984561389305, 4568.497465278817, 4593.678442509025, 4604.976975115136, 4614.330922016289, 6814.863702725967, 6857.485688573377, 6898.0, 6902.723891044352, 6910.516263861481, 4695.882602934954, 4699.342092107107, 4705.364775755298, 4705.5059218781535, 4710.623150148049, 4758.97681998372, 4761.523847615211, 4765.499622539653, 4770.0, 4775.2598347256235, 5196.32447781786, 5301.602379821529, 5485.50630443262, 5502.422245664147, 5502.779888804483, 6525.412712855771, 6543.672816359163, 6546.672666366758, 6561.311062338481, 6565.80302590923, 1642.3841059602648, 1660.842219989099, 1662.609286817597, 1669.766232727419, 1670.5573023148875, 1083.5557421457165, 1089.096050278267, 1098.9120870330355, 1101.124605938281, 1105.4914739219887, 6358.427741503195, 6422.197225346832, 6439.323870993572, 6446.967765161238, 6450.258220304631, 6817.522773405814, 6822.147231596051, 6827.0783444235385, 6827.112475378169, 6834.419074378733, 6388.361163883575, 6418.935810641834, 6419.422251997343, 6428.742850286029, 6430.582012169194, 3649.5620525536574, 3680.3743363628246, 3681.226942342138, 3684.097396137963, 3692.3538380783257, 6897.517173797786, 7067.328603782633, 7076.540024898365, 7076.575405475585, 7076.610786406797, 6935.202451718016, 6944.375006249462, 6946.93053069473, 6949.235584085746, 6973.407260382823, 7050.435965122778, 7052.858942821217, 7062.71749130029, 7064.364207221375, 7069.78790636292, 6797.762078327235, 6800.421964133104, 6803.829904252433, 6816.727330906709, 6826.93173068263, 6558.639274839738, 6669.566478178903, 6702.899456508058, 6710.295418980937, 6711.3288671132495, 7019.2629773873, 7034.859302813813, 7044.0, 7048.154221493453, 7053.470989675898, 4700.083483720641, 4708.599769019672, 4713.269443236304, 4717.245240761599, 4717.740524271198, 6559.442447391834, 6660.966695166493, 6784.59292442455, 6795.252522222453, 6797.830054248683, 6568.540202185801, 6696.5647232929705, 6725.159355080615, 6727.360900714424, 6734.528582999143, 6630.83422914431, 6656.500762442933, 6659.367360100783, 6664.400203981665, 6689.899651505134, 6560.376764207393, 6573.474122070127, 6577.868442631217, 6585.703643336157, 6589.4069533742195, 6584.934150658623, 6711.731530738716, 6728.428083612947, 6729.865402692017, 6742.258351581224, 6537.673116344259, 6547.476201903741, 6553.311902250195, 6557.344265573404, 6561.540692151694], "value": 4996.124417536199, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.3966065111816, 861.892263467067, 880.7910276225572, 885.8272636835816, 899.9595018224181, 15279.159646219467, 15648.687026259468, 15837.12895790731, 15853.84146158538, 15858.127802970832, 13797.448102075905, 13855.307234638278, 13879.375428105734, 13888.652783680413, 13900.235487048209, 741.5847125609675, 865.1780808232173, 875.9211670949613, 897.0, 899.8920129584459, 887.1439061305839, 887.6183241206279, 890.977725556863, 891.1266958380791, 892.1569117184264, 921.9723408297762, 926.9165775080241, 927.7495076329387, 927.8979312275644, 928.1229238369743, 792.4373694676758, 914.5838643417229, 928.3223247029706, 928.726025822384, 928.9210417114554, 682.3551743602297, 684.3806355248508, 684.8561802021582, 687.2783577243924, 688.9345512176335, 13830.792538111937, 13897.305134743223, 13910.0, 13919.930400348036, 13948.860511394858, 14409.0, 14779.852201477956, 15177.0, 15351.155686437241, 15469.767953480707, 12164.923788541808, 12173.08701847365, 12380.735127843984, 12467.75064498714, 12541.874581254162, 3933.2920074386598, 3968.8412463501427, 4047.271491131595, 4090.406891000818, 4097.815598298083, 58148.0, 58150.41849581492, 58254.41745582532, 58475.41524584742, 58521.41478585202, 11457.369844658457, 11502.07983361329, 11647.301161930141, 11837.289762614098, 11947.283163010074, 21228.044737986827, 21439.142434302452, 21445.0, 21485.892570537046, 21514.0, 8727.0, 8817.647294108292, 8828.205461508367, 8947.910520894839, 9105.635774569075, 5031.471695471996, 5034.093863104603, 5034.320366750515, 5059.671121377099, 5082.949170508322, 3697.0387699197863, 3720.051386896324, 3760.266747984117, 3761.962380376216, 3772.2078363543965, 664.5481072870398, 670.7250027488803, 674.4199988010307, 675.6554157379771, 677.1603212017063, 768.8308572114126, 787.4330482052912, 788.7318311774025, 797.6450479536667, 806.4032615864219, 9185.908140918506, 9231.123043310874, 9257.166854983085, 9257.90742092584, 9621.663241786504, 618.4990157972057, 634.6985182038495, 646.1599920103846, 718.690962885964, 778.4745296924553, 4162.313218319004, 4272.5727427257025, 4298.20483210607, 4316.352547117957, 4327.394164816928, 67369.6631516849, 67930.3206967924, 68361.31638683549, 68422.0, 68430.3156968424, 54023.45976540263, 54239.186412203846, 54688.45311546913, 55253.44746552483, 55791.44208557862, 53058.0, 53259.46740532545, 53304.733476333146, 53439.46560534422, 53673.0, 10189.898101019191, 10276.869544349966, 10313.9484302578, 10390.220733445172, 10395.16838652921, 39497.407538886364, 40464.39303410392, 40536.59463405328, 40591.59408405878, 40715.98210044654, 50270.748646256536, 51787.48212517826, 52358.21462677987, 52819.20771188358, 53513.19730203972, 12640.431180596712, 12873.935630321788, 12968.610941671765, 13034.283114428417, 13144.474221031434, 12759.74480510366, 12885.742285154432, 13637.79543306871, 13644.727105458034, 13816.309184540934, 12869.806952895902, 13302.600921972356, 13714.314284285945, 13908.235047072509, 14192.929035354757, 13640.65898352549, 13652.590422287347, 14076.296185190904, 14088.15471071739, 14136.222507762172, 13267.137636053625, 13389.866101338863, 13450.663733406744, 13617.25105119228, 13910.234937078558, 11033.44832758375, 11335.03652189573, 11430.657080287605, 11575.88424115748, 11606.70983225426, 11337.716557086138, 11361.318320900773, 11546.538138474367, 11593.478293476983, 11594.246373985665], "value": 7207.17829493993, "unit": "score"}], "name": "dromaeo_css", "value": 7527.692490565418, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 109.0, 111.0, 109.0, 110.0, 105.0, 111.0, 109.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 151.0, 177.0, 132.0, 163.0, 155.0, 128.0, 184.0, 131.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 160.0, 160.0, 160.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 181.0, 76.0, 73.0, 75.0, 77.0, 167.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 141.0, 93.0, 92.0, 92.0, 145.0, 91.0, 93.0, 151.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 144.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 55.0, 54.0, 55.0, 57.0, 72.0, 53.0, 52.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 72.0, 57.0, 57.0, 57.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 71.0, 72.0, 73.0, 72.0, 73.0, 74.0, 72.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 111.0, 116.0, 112.0, 112.0, 114.0, 115.0, 132.0, 118.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 163.0, 157.0, 158.0, 158.0, 158.0, 157.0, 164.0, 160.0, 164.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 65.0, 65.0, 65.0, 66.0, 67.0, 63.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1508.6, "alertThreshold": 2.0}]} 11:12:28 INFO - Return code: 0 11:12:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:12:28 ERROR - # TBPL SUCCESS # 11:12:28 INFO - Running post-action listener: _resource_record_post_action 11:12:28 INFO - Running post-run listener: _resource_record_post_run 11:12:29 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 498872320; Read time: 32; Write time: 415284 11:12:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248225792; Read time: 0; Write time: 278624 11:12:29 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250048512; Read time: 32; Write time: 136660 11:12:29 INFO - Running post-run listener: _upload_blobber_files 11:12:29 INFO - Blob upload gear active. 11:12:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:29 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 11:12:29 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:12:29 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:12:30 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:12:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:12:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:31 INFO - (blobuploader) - INFO - Done attempting. 11:12:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:12:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:12:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:31 INFO - (blobuploader) - INFO - Done attempting. 11:12:31 INFO - (blobuploader) - INFO - Iteration through files over. 11:12:31 INFO - Return code: 0 11:12:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:12:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:12:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62b5e807f184c0e6a9c449eeff1752ad6799bbdc28934437ec5d3d04e34d0aee85b8799458b902c11083d57e65987378af964be8940e6b0df8d8a9ad1281c768", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26a9c72508ace6d4a7635ede8bbef8832e13de7db53cf47e7e5799c88d1b47419350501d852e103da69e16c507879ca5d4ba23fbe16c7ea0858f180214e00585"} 11:12:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:12:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:12:31 INFO - Contents: 11:12:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62b5e807f184c0e6a9c449eeff1752ad6799bbdc28934437ec5d3d04e34d0aee85b8799458b902c11083d57e65987378af964be8940e6b0df8d8a9ad1281c768", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26a9c72508ace6d4a7635ede8bbef8832e13de7db53cf47e7e5799c88d1b47419350501d852e103da69e16c507879ca5d4ba23fbe16c7ea0858f180214e00585"} 11:12:31 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:31 INFO - Copying logs to upload dir... 11:12:31 INFO - mkdir: /builds/slave/test/build/upload/logs 11:12:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.999869 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-17 11:12:31.983490) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:31.989136) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618 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-Aurora/sha512/62b5e807f184c0e6a9c449eeff1752ad6799bbdc28934437ec5d3d04e34d0aee85b8799458b902c11083d57e65987378af964be8940e6b0df8d8a9ad1281c768", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26a9c72508ace6d4a7635ede8bbef8832e13de7db53cf47e7e5799c88d1b47419350501d852e103da69e16c507879ca5d4ba23fbe16c7ea0858f180214e00585"} build_url:https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62b5e807f184c0e6a9c449eeff1752ad6799bbdc28934437ec5d3d04e34d0aee85b8799458b902c11083d57e65987378af964be8940e6b0df8d8a9ad1281c768", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26a9c72508ace6d4a7635ede8bbef8832e13de7db53cf47e7e5799c88d1b47419350501d852e103da69e16c507879ca5d4ba23fbe16c7ea0858f180214e00585"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:32.016323) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:32.016662) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463506072.401755-1160501618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:32.075597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:12:32.075930) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:12:32.076229) ========= ========= Total master_lag: 0.21 =========