builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1466700858.65 results: success (0) buildid: 20160623070424 builduid: bda36766b4ab4119abe7d2b701b2f1b9 revision: 8ca1f953645f537692e62bb7e2d568d5f5f62eb7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:18.650676) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:18.652926) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:18.653304) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:18.670533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:18.670832) ========= 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=ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 09:54:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-06-23 09:54:18 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125614 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:18.812763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:18.813122) ========= 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=ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020415 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:18.862362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:18.862739) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8ca1f953645f537692e62bb7e2d568d5f5f62eb7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8ca1f953645f537692e62bb7e2d568d5f5f62eb7 --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=ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 09:54:18,955 truncating revision to first 12 chars 2016-06-23 09:54:18,955 Setting DEBUG logging. 2016-06-23 09:54:18,955 attempt 1/10 2016-06-23 09:54:18,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8ca1f953645f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 09:54:19,284 unpacking tar archive at: mozilla-beta-8ca1f953645f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.536782) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.537137) ========= script_repo_revision: 8ca1f953645f537692e62bb7e2d568d5f5f62eb7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.537596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.537908) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.547791) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-23 09:54:19.548096) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:54:19 INFO - MultiFileLogger online at 20160623 09:54:19 in /builds/slave/test 09:54:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:54:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:54:19 INFO - {'append_to_log': False, 09:54:19 INFO - 'base_work_dir': '/builds/slave/test', 09:54:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:54:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:54:19 INFO - 'branch': 'Mozilla-Beta', 09:54:19 INFO - 'buildbot_json_path': 'buildprops.json', 09:54:19 INFO - 'config_files': ('talos/linux_config.py',), 09:54:19 INFO - 'default_actions': ('clobber', 09:54:19 INFO - 'read-buildbot-config', 09:54:19 INFO - 'download-and-extract', 09:54:19 INFO - 'populate-webroot', 09:54:19 INFO - 'create-virtualenv', 09:54:19 INFO - 'install', 09:54:19 INFO - 'run-tests'), 09:54:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:54:19 INFO - 'download_minidump_stackwalk': True, 09:54:19 INFO - 'download_symbols': 'ondemand', 09:54:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:54:19 INFO - 'tooltool.py': '/tools/tooltool.py', 09:54:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:54:19 INFO - '/tools/misc-python/virtualenv.py')}, 09:54:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:54:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:54:19 INFO - 'installer_path': 'installer.exe', 09:54:19 INFO - 'log_level': 'info', 09:54:19 INFO - 'log_name': 'talos', 09:54:19 INFO - 'log_to_console': True, 09:54:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:54:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:54:19 INFO - 'opt_config_files': (), 09:54:19 INFO - 'pip_index': False, 09:54:19 INFO - 'sps_profile': False, 09:54:19 INFO - 'sps_profile_interval': 0, 09:54:19 INFO - 'suite': 'dromaeojs', 09:54:19 INFO - 'system_bits': '32', 09:54:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:54:19 INFO - 'title': 'talos-linux64-ix-035', 09:54:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:54:19 INFO - 'use_talos_json': True, 09:54:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:54:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:54:19 INFO - 'work_dir': 'build'} 09:54:19 INFO - ##### 09:54:19 INFO - ##### Running clobber step. 09:54:19 INFO - ##### 09:54:19 INFO - Running pre-action listener: _resource_record_pre_action 09:54:19 INFO - Running main action method: clobber 09:54:19 INFO - rmtree: /builds/slave/test/build 09:54:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:54:20 INFO - Running post-action listener: _resource_record_post_action 09:54:20 INFO - ##### 09:54:20 INFO - ##### Running read-buildbot-config step. 09:54:20 INFO - ##### 09:54:20 INFO - Running pre-action listener: _resource_record_pre_action 09:54:20 INFO - Running main action method: read_buildbot_config 09:54:20 INFO - Using buildbot properties: 09:54:20 INFO - { 09:54:20 INFO - "project": "", 09:54:20 INFO - "product": "firefox", 09:54:20 INFO - "script_repo_revision": "production", 09:54:20 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:54:20 INFO - "repository": "", 09:54:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:54:20 INFO - "buildid": "20160623070424", 09:54:20 INFO - "pgo_build": "True", 09:54:20 INFO - "basedir": "/builds/slave/test", 09:54:20 INFO - "buildnumber": 64, 09:54:20 INFO - "slavename": "talos-linux64-ix-035", 09:54:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:54:20 INFO - "platform": "ubuntu64_hw", 09:54:20 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:54:20 INFO - "branch": "mozilla-beta", 09:54:20 INFO - "repo_path": "releases/mozilla-beta", 09:54:20 INFO - "revision": "8ca1f953645f537692e62bb7e2d568d5f5f62eb7", 09:54:20 INFO - "stage_platform": "linux64-pgo", 09:54:20 INFO - "builduid": "bda36766b4ab4119abe7d2b701b2f1b9", 09:54:20 INFO - "slavebuilddir": "test" 09:54:20 INFO - } 09:54:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 09:54:20 INFO - Running post-action listener: _resource_record_post_action 09:54:20 INFO - ##### 09:54:20 INFO - ##### Running download-and-extract step. 09:54:20 INFO - ##### 09:54:20 INFO - Running pre-action listener: _resource_record_pre_action 09:54:20 INFO - Running main action method: download_and_extract 09:54:20 INFO - mkdir: /builds/slave/test/build/tests 09:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:20 INFO - https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:54:24 INFO - Downloaded 1327 bytes. 09:54:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:54:24 INFO - Using the following test package requirements: 09:54:24 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:54:24 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:24 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:54:24 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:24 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 09:54:24 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:24 INFO - u'jsshell-linux-x86_64.zip'], 09:54:24 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:24 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:54:24 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:54:24 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:24 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 09:54:24 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:24 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 09:54:24 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:24 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:54:24 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:24 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:54:24 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:24 INFO - https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:54:25 INFO - Downloaded 24186513 bytes. 09:54:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:54:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:54:26 INFO - Return code: 0 09:54:26 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:26 INFO - https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:54:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:54:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:54:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:54:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:54:28 INFO - Downloaded 24186513 bytes. 09:54:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:54:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:54:29 INFO - Return code: 0 09:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:29 INFO - https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:54:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:54:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:54:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:54:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:54:30 INFO - Downloaded 10840145 bytes. 09:54:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:54:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:54:30 INFO - Return code: 0 09:54: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')]} 09:54:30 INFO - https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:54:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:54:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:54:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:54:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:54:32 INFO - Downloaded 56014292 bytes. 09:54:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:54:32 INFO - mkdir: /builds/slave/test/properties 09:54:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:54:32 INFO - Writing to file /builds/slave/test/properties/build_url 09:54:32 INFO - Contents: 09:54:32 INFO - build_url:https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:54:32 INFO - Running post-action listener: _resource_record_post_action 09:54:32 INFO - Running post-action listener: set_extra_try_arguments 09:54:32 INFO - ##### 09:54:32 INFO - ##### Running populate-webroot step. 09:54:32 INFO - ##### 09:54:32 INFO - Running pre-action listener: _resource_record_pre_action 09:54:32 INFO - Running main action method: populate_webroot 09:54:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:54:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:54:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:54:32 INFO - '--tppagecycles', 09:54:32 INFO - '7'], 09:54:32 INFO - 'tests': ['tsvgm']}}, 09:54:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:54:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:54:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:54:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:54:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:54:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:54:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:32 INFO - 'talos_options': ['--disable-e10s'], 09:54:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:32 INFO - 'talos_options': ['--disable-e10s'], 09:54:32 INFO - 'tests': ['damp', 'tps']}, 09:54:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:32 INFO - 'tests': ['damp', 'tps']}, 09:54:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:54:32 INFO - 'tests': ['dromaeo_dom']}, 09:54:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:54:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:54:32 INFO - 'tests': ['a11yr', 09:54:32 INFO - 'ts_paint', 09:54:32 INFO - 'tpaint', 09:54:32 INFO - 'sessionrestore', 09:54:32 INFO - 'sessionrestore_no_auto_restore', 09:54:32 INFO - 'tabpaint']}, 09:54:32 INFO - 'other-e10s': {'tests': ['a11yr', 09:54:32 INFO - 'ts_paint', 09:54:32 INFO - 'tpaint', 09:54:32 INFO - 'sessionrestore', 09:54:32 INFO - 'sessionrestore_no_auto_restore', 09:54:32 INFO - 'tabpaint']}, 09:54:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:54:32 INFO - 'ts_paint', 09:54:32 INFO - 'tpaint', 09:54:32 INFO - 'sessionrestore', 09:54:32 INFO - 'sessionrestore_no_auto_restore', 09:54:32 INFO - 'tabpaint']}, 09:54:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:54:32 INFO - 'ts_paint', 09:54:32 INFO - 'tpaint', 09:54:32 INFO - 'sessionrestore', 09:54:32 INFO - 'sessionrestore_no_auto_restore', 09:54:32 INFO - 'tabpaint']}, 09:54:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:54:32 INFO - 'tests': ['a11yr', 09:54:32 INFO - 'ts_paint', 09:54:32 INFO - 'tpaint', 09:54:32 INFO - 'sessionrestore', 09:54:32 INFO - 'sessionrestore_no_auto_restore', 09:54:32 INFO - 'tabpaint']}, 09:54:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:54:32 INFO - 'tests': ['a11yr', 09:54:32 INFO - 'ts_paint', 09:54:32 INFO - 'tpaint', 09:54:32 INFO - 'sessionrestore', 09:54:32 INFO - 'sessionrestore_no_auto_restore', 09:54:32 INFO - 'tabpaint']}, 09:54:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:54:32 INFO - 'tests': ['tsvgx', 09:54:32 INFO - 'tsvgr_opacity', 09:54:32 INFO - 'tart', 09:54:32 INFO - 'tscrollx', 09:54:32 INFO - 'cart']}, 09:54:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:54:32 INFO - 'tsvgr_opacity', 09:54:32 INFO - 'tart', 09:54:32 INFO - 'tscrollx', 09:54:32 INFO - 'cart']}, 09:54:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:32 INFO - 'talos_options': ['--disable-e10s'], 09:54:32 INFO - 'tests': ['tp5o']}, 09:54:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:32 INFO - 'tests': ['tp5o']}, 09:54:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:32 INFO - 'talos_options': ['--disable-e10s', 09:54:32 INFO - '--xperf_path', 09:54:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:32 INFO - 'tests': ['tp5n']}, 09:54:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:32 INFO - 'talos_options': ['--xperf_path', 09:54:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:32 INFO - 'tests': ['tp5n']}}, 09:54:32 INFO - 'talos.zip': {'path': '', 09:54:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:54:32 INFO - Running post-action listener: _resource_record_post_action 09:54:32 INFO - ##### 09:54:32 INFO - ##### Running create-virtualenv step. 09:54:32 INFO - ##### 09:54:32 INFO - Running pre-action listener: _resource_record_pre_action 09:54:32 INFO - Running main action method: create_virtualenv 09:54:32 INFO - Creating virtualenv /builds/slave/test/build/venv 09:54:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:54:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:54:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:54:33 INFO - Using real prefix '/usr' 09:54:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:54:33 INFO - Installing distribute.............................................................................................................................................................................................done. 09:54:35 INFO - Installing pip.................done. 09:54:35 INFO - Return code: 0 09:54:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:35 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 0x7f3f39568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e4410>, '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 0x24e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e57a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:54:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:54:35 INFO - Using env: {'DISPLAY': ':0', 09:54:35 INFO - 'HOME': '/home/cltbld', 09:54:35 INFO - 'LANG': 'en_US.UTF-8', 09:54:35 INFO - 'LANGUAGE': 'en_US:en', 09:54:35 INFO - 'LOGNAME': 'cltbld', 09:54:35 INFO - 'MAIL': '/var/mail/cltbld', 09:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:35 INFO - 'MOZ_NO_REMOTE': '1', 09:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:35 INFO - 'NO_EM_RESTART': '1', 09:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:35 INFO - 'PWD': '/builds/slave/test', 09:54:35 INFO - 'SHELL': '/bin/bash', 09:54:35 INFO - 'SHLVL': '1', 09:54:35 INFO - 'TERM': 'linux', 09:54:35 INFO - 'TMOUT': '86400', 09:54:35 INFO - 'USER': 'cltbld', 09:54:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 09:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:35 INFO - '_': '/tools/buildbot/bin/python'} 09:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:54:35 INFO - Cleaning up... 09:54:35 INFO - Return code: 0 09:54:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:35 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 0x7f3f39568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e4410>, '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 0x24e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e57a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:54:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:54:35 INFO - Using env: {'DISPLAY': ':0', 09:54:35 INFO - 'HOME': '/home/cltbld', 09:54:35 INFO - 'LANG': 'en_US.UTF-8', 09:54:35 INFO - 'LANGUAGE': 'en_US:en', 09:54:35 INFO - 'LOGNAME': 'cltbld', 09:54:35 INFO - 'MAIL': '/var/mail/cltbld', 09:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:35 INFO - 'MOZ_NO_REMOTE': '1', 09:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:35 INFO - 'NO_EM_RESTART': '1', 09:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:35 INFO - 'PWD': '/builds/slave/test', 09:54:35 INFO - 'SHELL': '/bin/bash', 09:54:35 INFO - 'SHLVL': '1', 09:54:35 INFO - 'TERM': 'linux', 09:54:35 INFO - 'TMOUT': '86400', 09:54:35 INFO - 'USER': 'cltbld', 09:54:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 09:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:35 INFO - '_': '/tools/buildbot/bin/python'} 09:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:36 INFO - Downloading/unpacking psutil>=0.7.1 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:54:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:38 INFO - Installing collected packages: psutil 09:54:38 INFO - Running setup.py install for psutil 09:54:38 INFO - building 'psutil._psutil_linux' extension 09:54:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:54:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:54:38 INFO - building 'psutil._psutil_posix' extension 09:54:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:54:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:54:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:38 INFO - Successfully installed psutil 09:54:38 INFO - Cleaning up... 09:54:38 INFO - Return code: 0 09:54:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f39568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e4410>, '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 0x24e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e57a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:54:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:54:38 INFO - Using env: {'DISPLAY': ':0', 09:54:38 INFO - 'HOME': '/home/cltbld', 09:54:38 INFO - 'LANG': 'en_US.UTF-8', 09:54:38 INFO - 'LANGUAGE': 'en_US:en', 09:54:38 INFO - 'LOGNAME': 'cltbld', 09:54:38 INFO - 'MAIL': '/var/mail/cltbld', 09:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:38 INFO - 'MOZ_NO_REMOTE': '1', 09:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:38 INFO - 'NO_EM_RESTART': '1', 09:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:38 INFO - 'PWD': '/builds/slave/test', 09:54:38 INFO - 'SHELL': '/bin/bash', 09:54:38 INFO - 'SHLVL': '1', 09:54:38 INFO - 'TERM': 'linux', 09:54:38 INFO - 'TMOUT': '86400', 09:54:38 INFO - 'USER': 'cltbld', 09:54:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 09:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:38 INFO - '_': '/tools/buildbot/bin/python'} 09:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:54:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:54:40 INFO - Installing collected packages: mozsystemmonitor 09:54:40 INFO - Running setup.py install for mozsystemmonitor 09:54:40 INFO - Successfully installed mozsystemmonitor 09:54:40 INFO - Cleaning up... 09:54:40 INFO - Return code: 0 09:54:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:40 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 0x7f3f39568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e4410>, '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 0x24e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e57a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:54:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:54:40 INFO - Using env: {'DISPLAY': ':0', 09:54:40 INFO - 'HOME': '/home/cltbld', 09:54:40 INFO - 'LANG': 'en_US.UTF-8', 09:54:40 INFO - 'LANGUAGE': 'en_US:en', 09:54:40 INFO - 'LOGNAME': 'cltbld', 09:54:40 INFO - 'MAIL': '/var/mail/cltbld', 09:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:40 INFO - 'MOZ_NO_REMOTE': '1', 09:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:40 INFO - 'NO_EM_RESTART': '1', 09:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:40 INFO - 'PWD': '/builds/slave/test', 09:54:40 INFO - 'SHELL': '/bin/bash', 09:54:40 INFO - 'SHLVL': '1', 09:54:40 INFO - 'TERM': 'linux', 09:54:40 INFO - 'TMOUT': '86400', 09:54:40 INFO - 'USER': 'cltbld', 09:54:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 09:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:40 INFO - '_': '/tools/buildbot/bin/python'} 09:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:41 INFO - Downloading/unpacking blobuploader==1.2.4 09:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:54:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:54:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:43 INFO - Downloading docopt-0.6.1.tar.gz 09:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:54:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:54:43 INFO - Running setup.py install for blobuploader 09:54:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:54:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:54:43 INFO - Running setup.py install for requests 09:54:44 INFO - Running setup.py install for docopt 09:54:44 INFO - Successfully installed blobuploader requests docopt 09:54:44 INFO - Cleaning up... 09:54:44 INFO - Return code: 0 09:54:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:44 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 0x7f3f39568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e4410>, '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 0x24e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e57a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:54:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:54:44 INFO - Using env: {'DISPLAY': ':0', 09:54:44 INFO - 'HOME': '/home/cltbld', 09:54:44 INFO - 'LANG': 'en_US.UTF-8', 09:54:44 INFO - 'LANGUAGE': 'en_US:en', 09:54:44 INFO - 'LOGNAME': 'cltbld', 09:54:44 INFO - 'MAIL': '/var/mail/cltbld', 09:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:44 INFO - 'MOZ_NO_REMOTE': '1', 09:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:44 INFO - 'NO_EM_RESTART': '1', 09:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:44 INFO - 'PWD': '/builds/slave/test', 09:54:44 INFO - 'SHELL': '/bin/bash', 09:54:44 INFO - 'SHLVL': '1', 09:54:44 INFO - 'TERM': 'linux', 09:54:44 INFO - 'TMOUT': '86400', 09:54:44 INFO - 'USER': 'cltbld', 09:54:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 09:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:44 INFO - '_': '/tools/buildbot/bin/python'} 09:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:44 INFO - Running setup.py (path:/tmp/pip-OWwVvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:44 INFO - Running setup.py (path:/tmp/pip-GfgmSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:44 INFO - Running setup.py (path:/tmp/pip-Fk2sp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:44 INFO - Running setup.py (path:/tmp/pip-vbwJwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:44 INFO - Running setup.py (path:/tmp/pip-dwIiYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:44 INFO - Running setup.py (path:/tmp/pip-MtNX3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:45 INFO - Running setup.py (path:/tmp/pip-CUmkqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:45 INFO - Running setup.py (path:/tmp/pip-7G4Q0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:45 INFO - Running setup.py (path:/tmp/pip-igW_aH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:45 INFO - Running setup.py (path:/tmp/pip-buthyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:45 INFO - Running setup.py (path:/tmp/pip-pLq_1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:45 INFO - Running setup.py (path:/tmp/pip-BM14wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:45 INFO - Running setup.py (path:/tmp/pip-tcNBVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:45 INFO - Running setup.py (path:/tmp/pip-Qn9ncF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:45 INFO - Running setup.py (path:/tmp/pip-_DQPzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:45 INFO - Running setup.py (path:/tmp/pip-1qbIQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:45 INFO - Running setup.py (path:/tmp/pip-1WJMn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:54:45 INFO - Running setup.py install for manifestparser 09:54:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:54:45 INFO - Running setup.py install for mozcrash 09:54:46 INFO - Running setup.py install for mozdebug 09:54:46 INFO - Running setup.py install for mozdevice 09:54:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:54:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:54:46 INFO - Running setup.py install for mozfile 09:54:46 INFO - Running setup.py install for mozhttpd 09:54:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:54:46 INFO - Running setup.py install for mozinfo 09:54:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:54:46 INFO - Running setup.py install for mozInstall 09:54:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:54:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:54:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:54:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:54:46 INFO - Running setup.py install for mozleak 09:54:46 INFO - Running setup.py install for mozlog 09:54:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:54:46 INFO - Running setup.py install for moznetwork 09:54:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:54:46 INFO - Running setup.py install for mozprocess 09:54:47 INFO - Running setup.py install for mozprofile 09:54:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:54:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:54:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:54:47 INFO - Running setup.py install for mozrunner 09:54:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:54:47 INFO - Running setup.py install for mozscreenshot 09:54:47 INFO - Running setup.py install for moztest 09:54:47 INFO - Running setup.py install for mozversion 09:54:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:54:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:54:47 INFO - Cleaning up... 09:54:47 INFO - Return code: 0 09:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:47 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 0x7f3f39568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e4410>, '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 0x24e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e57a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:54:47 INFO - Using env: {'DISPLAY': ':0', 09:54:47 INFO - 'HOME': '/home/cltbld', 09:54:47 INFO - 'LANG': 'en_US.UTF-8', 09:54:47 INFO - 'LANGUAGE': 'en_US:en', 09:54:47 INFO - 'LOGNAME': 'cltbld', 09:54:47 INFO - 'MAIL': '/var/mail/cltbld', 09:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:47 INFO - 'MOZ_NO_REMOTE': '1', 09:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:47 INFO - 'NO_EM_RESTART': '1', 09:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:47 INFO - 'PWD': '/builds/slave/test', 09:54:47 INFO - 'SHELL': '/bin/bash', 09:54:47 INFO - 'SHLVL': '1', 09:54:47 INFO - 'TERM': 'linux', 09:54:47 INFO - 'TMOUT': '86400', 09:54:47 INFO - 'USER': 'cltbld', 09:54:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 09:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:47 INFO - '_': '/tools/buildbot/bin/python'} 09:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:47 INFO - Running setup.py (path:/tmp/pip-Fg4bNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:47 INFO - Running setup.py (path:/tmp/pip-A_b8Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:47 INFO - Running setup.py (path:/tmp/pip-bz0CcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:48 INFO - Running setup.py (path:/tmp/pip-jSvW6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:48 INFO - Running setup.py (path:/tmp/pip-2VCma2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:48 INFO - Running setup.py (path:/tmp/pip-PyqPrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:48 INFO - Running setup.py (path:/tmp/pip-GFSKsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:48 INFO - Running setup.py (path:/tmp/pip-8PEalx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:48 INFO - Running setup.py (path:/tmp/pip-50Lg03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:48 INFO - Running setup.py (path:/tmp/pip-TQqOCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:48 INFO - Running setup.py (path:/tmp/pip-v8Vace-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:48 INFO - Running setup.py (path:/tmp/pip-qKt7Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:48 INFO - Running setup.py (path:/tmp/pip-Kd1DvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:48 INFO - Running setup.py (path:/tmp/pip-o2uqEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:48 INFO - Running setup.py (path:/tmp/pip-2KqrRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:48 INFO - Running setup.py (path:/tmp/pip-k8RimY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:48 INFO - Running setup.py (path:/tmp/pip-irKRiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:54:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:50 INFO - Downloading blessings-1.6.tar.gz 09:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:54:51 INFO - Installing collected packages: blessings 09:54:51 INFO - Running setup.py install for blessings 09:54:51 INFO - Successfully installed blessings 09:54:51 INFO - Cleaning up... 09:54:51 INFO - Return code: 0 09:54:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:54:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:54:51 INFO - Reading from file tmpfile_stdout 09:54:51 INFO - Current package versions: 09:54:51 INFO - argparse == 1.2.1 09:54:51 INFO - blessings == 1.6 09:54:51 INFO - blobuploader == 1.2.4 09:54:51 INFO - docopt == 0.6.1 09:54:51 INFO - manifestparser == 1.1 09:54:51 INFO - mozInstall == 1.12 09:54:51 INFO - mozcrash == 0.17 09:54:51 INFO - mozdebug == 0.1 09:54:51 INFO - mozdevice == 0.48 09:54:51 INFO - mozfile == 1.2 09:54:51 INFO - mozhttpd == 0.7 09:54:51 INFO - mozinfo == 0.9 09:54:51 INFO - mozleak == 0.1 09:54:51 INFO - mozlog == 3.1 09:54:51 INFO - moznetwork == 0.27 09:54:51 INFO - mozprocess == 0.22 09:54:51 INFO - mozprofile == 0.28 09:54:51 INFO - mozrunner == 6.11 09:54:51 INFO - mozscreenshot == 0.1 09:54:51 INFO - mozsystemmonitor == 0.0 09:54:51 INFO - moztest == 0.7 09:54:51 INFO - mozversion == 1.4 09:54:51 INFO - psutil == 3.1.1 09:54:51 INFO - requests == 1.2.3 09:54:51 INFO - wsgiref == 0.1.2 09:54:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:51 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 0x7f3f39568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e4410>, '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 0x24e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e57a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:54:51 INFO - Using env: {'DISPLAY': ':0', 09:54:51 INFO - 'HOME': '/home/cltbld', 09:54:51 INFO - 'LANG': 'en_US.UTF-8', 09:54:51 INFO - 'LANGUAGE': 'en_US:en', 09:54:51 INFO - 'LOGNAME': 'cltbld', 09:54:51 INFO - 'MAIL': '/var/mail/cltbld', 09:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:51 INFO - 'MOZ_NO_REMOTE': '1', 09:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:51 INFO - 'NO_EM_RESTART': '1', 09:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:51 INFO - 'PWD': '/builds/slave/test', 09:54:51 INFO - 'SHELL': '/bin/bash', 09:54:51 INFO - 'SHLVL': '1', 09:54:51 INFO - 'TERM': 'linux', 09:54:51 INFO - 'TMOUT': '86400', 09:54:51 INFO - 'USER': 'cltbld', 09:54:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 09:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:51 INFO - '_': '/tools/buildbot/bin/python'} 09:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:54:51 INFO - Cleaning up... 09:54:51 INFO - Return code: 0 09:54:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:51 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 0x7f3f39568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e4410>, '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 0x24e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e57a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:54:51 INFO - Using env: {'DISPLAY': ':0', 09:54:51 INFO - 'HOME': '/home/cltbld', 09:54:51 INFO - 'LANG': 'en_US.UTF-8', 09:54:51 INFO - 'LANGUAGE': 'en_US:en', 09:54:51 INFO - 'LOGNAME': 'cltbld', 09:54:51 INFO - 'MAIL': '/var/mail/cltbld', 09:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:51 INFO - 'MOZ_NO_REMOTE': '1', 09:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:51 INFO - 'NO_EM_RESTART': '1', 09:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:51 INFO - 'PWD': '/builds/slave/test', 09:54:51 INFO - 'SHELL': '/bin/bash', 09:54:51 INFO - 'SHLVL': '1', 09:54:51 INFO - 'TERM': 'linux', 09:54:51 INFO - 'TMOUT': '86400', 09:54:51 INFO - 'USER': 'cltbld', 09:54:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 09:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:51 INFO - '_': '/tools/buildbot/bin/python'} 09:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:51 INFO - Downloading/unpacking jsonschema 09:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:54:53 INFO - Downloading/unpacking functools32 (from jsonschema) 09:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:53 INFO - Downloading functools32-3.2.3-2.tar.gz 09:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:54:54 INFO - warning: no files found matching '*.txt' 09:54:54 INFO - no previously-included directories found matching 'build' 09:54:54 INFO - no previously-included directories found matching 'dist' 09:54:54 INFO - no previously-included directories found matching '.git*' 09:54:54 INFO - Installing collected packages: jsonschema, functools32 09:54:54 INFO - Running setup.py install for functools32 09:54:54 INFO - warning: no files found matching '*.txt' 09:54:54 INFO - no previously-included directories found matching 'build' 09:54:54 INFO - no previously-included directories found matching 'dist' 09:54:54 INFO - no previously-included directories found matching '.git*' 09:54:54 INFO - Successfully installed jsonschema functools32 09:54:54 INFO - Cleaning up... 09:54:54 INFO - Return code: 0 09:54:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f39568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e4410>, '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 0x24e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e57a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:54:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:54:54 INFO - Using env: {'DISPLAY': ':0', 09:54:54 INFO - 'HOME': '/home/cltbld', 09:54:54 INFO - 'LANG': 'en_US.UTF-8', 09:54:54 INFO - 'LANGUAGE': 'en_US:en', 09:54:54 INFO - 'LOGNAME': 'cltbld', 09:54:54 INFO - 'MAIL': '/var/mail/cltbld', 09:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:54 INFO - 'MOZ_NO_REMOTE': '1', 09:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:54 INFO - 'NO_EM_RESTART': '1', 09:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:54 INFO - 'PWD': '/builds/slave/test', 09:54:54 INFO - 'SHELL': '/bin/bash', 09:54:54 INFO - 'SHLVL': '1', 09:54:54 INFO - 'TERM': 'linux', 09:54:54 INFO - 'TMOUT': '86400', 09:54:54 INFO - 'USER': 'cltbld', 09:54:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 09:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:54 INFO - '_': '/tools/buildbot/bin/python'} 09:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:54 INFO - Downloading/unpacking flake8 09:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:54:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:54:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:54:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:54:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:54:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:54:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:54:57 INFO - no previously-included directories found matching 'docs/_build' 09:54:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:54:57 INFO - Running setup.py install for pep8 09:54:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:54:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:54:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:54:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:54:57 INFO - no previously-included directories found matching 'docs/_build' 09:54:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:54:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:54:57 INFO - Cleaning up... 09:54:57 INFO - Return code: 0 09:54:57 INFO - Running post-action listener: _resource_record_post_action 09:54:57 INFO - Running post-action listener: _start_resource_monitoring 09:54:57 INFO - Starting resource monitoring. 09:54:57 INFO - ##### 09:54:57 INFO - ##### Running install step. 09:54:57 INFO - ##### 09:54:57 INFO - Running pre-action listener: _resource_record_pre_action 09:54:57 INFO - Running main action method: install 09:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:54:57 INFO - Reading from file tmpfile_stdout 09:54:57 INFO - Detecting whether we're running mozinstall >=1.0... 09:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:54:57 INFO - Reading from file tmpfile_stdout 09:54:57 INFO - Output received: 09:54:57 INFO - Usage: mozinstall [options] installer 09:54:57 INFO - Options: 09:54:57 INFO - -h, --help show this help message and exit 09:54:57 INFO - -d DEST, --destination=DEST 09:54:57 INFO - Directory to install application into. [default: 09:54:57 INFO - "/builds/slave/test"] 09:54:57 INFO - --app=APP Application being installed. [default: firefox] 09:54:57 INFO - mkdir: /builds/slave/test/build/application 09:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:55:10 INFO - Reading from file tmpfile_stdout 09:55:10 INFO - Output received: 09:55:10 INFO - /builds/slave/test/build/application/firefox/firefox 09:55:10 INFO - Running post-action listener: _resource_record_post_action 09:55:10 INFO - ##### 09:55:10 INFO - ##### Running run-tests step. 09:55:10 INFO - ##### 09:55:10 INFO - Running pre-action listener: _resource_record_pre_action 09:55:10 INFO - Running main action method: run_tests 09:55:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:55:10 INFO - Python 2.7.3 09:55:10 INFO - Return code: 0 09:55:10 INFO - grabbing minidump binary from tooltool 09:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:10 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 0x24e4410>, '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 0x24e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:55:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:55:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:55:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:55:10 INFO - Return code: 0 09:55:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:55:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:55:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:55:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:55:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:55:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:55:11 INFO - Return code: 0 09:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:55:11 INFO - Using env: {'DISPLAY': ':0', 09:55:11 INFO - 'HOME': '/home/cltbld', 09:55:11 INFO - 'LANG': 'en_US.UTF-8', 09:55:11 INFO - 'LANGUAGE': 'en_US:en', 09:55:11 INFO - 'LOGNAME': 'cltbld', 09:55:11 INFO - 'MAIL': '/var/mail/cltbld', 09:55:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:55:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:11 INFO - 'MOZ_NO_REMOTE': '1', 09:55:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:55:11 INFO - 'NO_EM_RESTART': '1', 09:55:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:11 INFO - 'PWD': '/builds/slave/test', 09:55:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:55:11 INFO - 'SHELL': '/bin/bash', 09:55:11 INFO - 'SHLVL': '1', 09:55:11 INFO - 'TERM': 'linux', 09:55:11 INFO - 'TMOUT': '86400', 09:55:11 INFO - 'USER': 'cltbld', 09:55:11 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032', 09:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:11 INFO - '_': '/tools/buildbot/bin/python'} 09:55:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:55:12 INFO - mozversion application_buildid: 20160623070424 09:55:12 INFO - mozversion application_changeset: 8ca1f953645f537692e62bb7e2d568d5f5f62eb7 09:55:12 INFO - mozversion application_display_name: Firefox 09:55:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:55:12 INFO - mozversion application_name: Firefox 09:55:12 INFO - mozversion application_remotingname: firefox 09:55:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:55:12 INFO - mozversion application_vendor: Mozilla 09:55:12 INFO - mozversion application_version: 48.0 09:55:12 INFO - mozversion platform_buildid: 20160623070424 09:55:12 INFO - mozversion platform_changeset: 8ca1f953645f537692e62bb7e2d568d5f5f62eb7 09:55:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:55:12 INFO - mozversion platform_version: 48.0 09:55:12 INFO - using testdate: 1466700912 09:55:12 INFO - actual date: 1466700912 09:55:12 INFO - starting webserver on 'localhost:47628' 09:55:12 INFO - SUITE-START | Running 2 tests 09:55:12 INFO - TEST-START | dromaeo_css 09:55:12 INFO - operating with platform_type : linux_ 09:55:12 INFO - Initialising browser for dromaeo_css test... 09:55:12 INFO - TEST-INFO | started process 23421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhwdyo/profile http://localhost:47628/getInfo.html) 09:55:15 INFO - PROCESS | 23421 | __metrics Screen width/height:1600/1200 09:55:15 INFO - PROCESS | 23421 | colorDepth:24 09:55:15 INFO - PROCESS | 23421 | Browser inner width/height: 1024/697 09:55:15 INFO - PROCESS | 23421 | __metrics 09:55:16 ERROR - PROCESS | 23421 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:55:17 INFO - TEST-INFO | 23421: exit 0 09:55:17 INFO - Browser initialized. 09:55:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:55:17 INFO - TEST-INFO | started process 23512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhwdyo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:29 INFO - PROCESS | 23512 | RSS: Main: 139776000 09:55:29 INFO - PROCESS | 23512 | 09:56:20 INFO - PROCESS | 23512 | 1466700980474 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:58:27 INFO - PROCESS | 23512 | Cycle 1(1): loaded http://localhost:47628/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47628/tests/dromaeo/cssquery-ext.html) 09:58:28 INFO - PROCESS | 23512 | RSS: Main: 255066112 09:58:28 INFO - PROCESS | 23512 | 10:01:31 INFO - PROCESS | 23512 | Cycle 1(1): loaded http://localhost:47628/tests/dromaeo/cssquery-ext.html (next: http://localhost:47628/tests/dromaeo/cssquery-jquery.html) 10:01:31 INFO - PROCESS | 23512 | RSS: Main: 230334464 10:01:31 INFO - PROCESS | 23512 | 10:04:33 INFO - PROCESS | 23512 | Cycle 1(1): loaded http://localhost:47628/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47628/tests/dromaeo/cssquery-mootools.html) 10:04:34 INFO - PROCESS | 23512 | RSS: Main: 228900864 10:04:34 INFO - PROCESS | 23512 | 10:07:36 INFO - PROCESS | 23512 | Cycle 1(1): loaded http://localhost:47628/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47628/tests/dromaeo/cssquery-prototype.html) 10:07:36 INFO - PROCESS | 23512 | RSS: Main: 214552576 10:07:36 INFO - PROCESS | 23512 | 10:10:39 INFO - PROCESS | 23512 | Cycle 1(1): loaded http://localhost:47628/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47628/tests/dromaeo/cssquery-yui.html) 10:10:39 INFO - PROCESS | 23512 | RSS: Main: 210034688 10:10:39 INFO - PROCESS | 23512 | 10:13:42 INFO - PROCESS | 23512 | Cycle 1(1): loaded http://localhost:47628/tests/dromaeo/cssquery-yui.html (next: http://localhost:47628/tests/dromaeo/cssquery-dojo.html) 10:13:42 INFO - PROCESS | 23512 | RSS: Main: 254676992 10:13:42 INFO - PROCESS | 23512 | 10:13:42 INFO - PROCESS | 23512 | __start_tp_report 10:13:42 INFO - PROCESS | 23512 | _x_x_mozilla_page_load 10:13:42 INFO - PROCESS | 23512 | _x_x_mozilla_page_load_details 10:13:42 INFO - PROCESS | 23512 | |i|pagename|runs| 10:13:42 INFO - PROCESS | 23512 | |0;dojo.html;3309.7352211823054;3378.52700621913;3378.6452422495636;3413.4026545354586;3438.570178727659;5588.105903055512;5614;5617.831465056045;5624.71876406179;5631.60578759486;5560.833175004746;5642.633228840123;5650.51970582501;5657.179708942201;5659.066254068084;4981.352424184851;5084.847454576368;5164.251183578379;5212.609054320922;5240.44975277596;5053.292539044537;5103.948960510403;5106.923396149061;5138.691678499302;5145.176771716526;5054.241863720453;5135.768890399941;5144.8971020579565;5151.639385243035;5178.896422071556;5146.356705411824;5148.742562871879;5173.249878767595;5175;5193.143131383317;4967.453580106186;4990.6257030722845;5026;5076.060928728197;5076.720780357079;5486.533644640211;5524.558035357162;5542.057850165482;5543.6119471637;5585.609007369486;5940.2871655401195;5944.494717948979;5946.226990491208;5952.077427998667;5955.493783028448;5896.675682837442;5975.043992961106;5996.430339117776;6020.337762846083;6031.306399763996;5558.805441809558;5589.524890384322;5602.971985140089;5604.6917419542315;5607.299087614048;5931.822045338647;6113.816585502442;6122.54080943931;6127.356627554132;6131.386861313922;5844.970775146182;5871.266091738533;5877.882442351214;5887.116932460165;5889.1755154278435;5930.377310382434;5946.791862284799;5948.583599148018;5950.494207992369;5957.731902064417;5898.351181370046;5905.409459054146;5905.970470147622;5906.468417842415;5915.58590898633;5956.047032474783;5964.31410387811;5975.970120149372;5991.400859913973;6024.8795024100145;4547.272436410159;4547.272436410159;4547.954520454819;4548.704334218265;4572.017016341502;4017.055991841915;4025.879223623296;4053.1488387438967;4077.4087757275624;4114.033202197481;5695.373508914016;5739.971300143473;5746.42535746422;5749.798757043567;5765.509931655773;6010.188624535719;6030.879382412327;6043.48630366415;6048.42539958712;6049.818505444844;5600.719964001783;5627.8593035174445;5684.971575142098;5696.8006119785605;5737.540996720252;5113.488651134857;5120.462351453119;5132.101882170605;5152.252923326097;5157.097507936096;6116.938830611637;6137.202163718688;6138.846528836725;6141.57009009374;6148.4773794227995;5899.675517846474;6016.368281330398;6073.089036644538;6085.1480792689945;6118.051701986199;6225.408586184305;6239.0953311770445;6250.124982502362;6250.937490625036;6259.3427690091885;5761.884762304647;5919.792807251725;5934.7922822701;5938.881222375442;5960.8807823844145;6032.034874420072;6035.305939816802;6060.181875446935;6068.4841788448475;6101.115338276014;5794.362620111869;5823.563232757645;5837.562182836389;5838;5843.1235314703135;5765.913511297418;5794.217780599565;5837.883242335214;5858.882822343444;5861;5787.131930210502;5797.826065218051;5815.360310365941;5825.446582574648;5855.268091488564;5919.4080591940465;5947.821565353046;5952.553558483044;5959.582829201914;5974.492168165754;5683.516901063456;5707.1724599933605;5738.368779434342;5800.854978625568;5839.970800145972 10:13:42 INFO - PROCESS | 23512 | |1;ext.html;672.0826072411161;684.6987325576747;691.2085661917105;742.6583771465125;767.3324207939094;36971.81514092429;37665.435018474745;37688.05779855505;37706.8114659427;41688.16623667525;45133.77433112838;45729;45784;45787.31319030217;45859.54140458603;8897.1102889711;9032.412893161956;9110.180083792457;9117.726468205965;9120.726378208632;8437.789055273606;8990.640374385017;10983.61557345493;11273.37996410197;11277.32336059839;10860.891391086107;10882.72793180169;10936.453177341142;10951.671449856518;10952.835707464394;10792.298500597437;10809.135269178447;10851.240413171081;10860.511276992554;10875;10621.84067238992;10711.303765255234;10712.78574428515;10723.571057157704;10734.141268698486;44952.77523612394;45224;45331.32003019924;45544;45567.544324556664;4062.8171732272117;4170.249355116078;4300.118475712471;4390.8902277443;4522.909541809146;34383.656163438296;34845.30309393798;36348.0912977175;36620.26759464823;37094;4627.282771170474;4630.560096790799;4646.83736069236;4816.084943860656;4937.037277730844;327856;329074;329705;330208.9999999976;330521;66962;68183.3181668177;68322;68539;68570;72830.63584682043;72931.63534182402;73217;73301.6334918322;73390.63304683549;20244.59510809805;20511.17955281802;20533.076011579516;20545.897270513553;20561.89719051395;14563.708725825636;14908.403663853325;14933;14936.925315373353;14979.251037448303;17711.557211069827;17933.551661208574;19496.220151194077;19688.803111968697;20672.793272067087;6424.518161137933;6534.183227096613;6581.769638062645;6644.568103073285;6658.800235992928;1085.7719878825378;1155.1278784517635;1177.4054102678092;1223.9265644061384;1248.6878280429892;35153;35607;36064.27871442556;36087.278254434765;36695.26609467796;1243.247835059794;1274.7323062156865;1313.756954963335;1319.4458327502473;1323.2655875988726;16302.918485407734;17102.572435689206;17410.738838917427;17577.56056098582;17734.379296724812;452676;456226;457630;458355;459561;64706.67646661736;65732;65749;65813.67093164503;65814.34185658082;1486.6729319549681;1510.124128005754;1514.4472267622239;1518.32434566619;1578.2661062605944;29079.563806542497;30061.098167055025;30708.232294192825;32550.186245344055;33204.66795332016;52627.21059184039;53225.46774532205;53250;53268.46731532635;53278.4672153289;305082;306874;307819;307898;308415;27270.863645681646;29256.56115158317;31708.365832683678;32222.83888580542;34175.829120854236;49869.25196122134;50008.74995624999;50134.24798628096;50330.748346258035;51356;41874.37188442237;43108.35337470003;43404.34893476663;43522.56477435185;44067;41837.37243941282;42523;42742.57257427386;43447.78276108599;43504;42011.579884200764;42630.78684606557;43199.784001079795;43728;43937.56062439334;36891.81554092212;37739.62260377471;37799.81100094482;38033.619663804115;38094.04764880789;28409.28976775597;28875.5668664966;28891;29081.418371632873;29177 10:13:42 INFO - PROCESS | 23512 | |2;jquery.html;425.179403750761;428.60568277185007;428.8734823227148;437.46847580190064;438.2396541999631;18773.530661733446;19234.845909245436;19564.510887227825;19831.107600157993;20396.694049589267;19682;19987.500312492193;20674.173033078696;20718.792812071875;20725.378238652826;5437.293151890259;5904.527637788988;5918.319393269764;5931.88136237275;5933.762649494015;4361.956380436202;5772.971135144339;5919.911201331984;6220.47125994291;6508.9023664645065;6455.677216139197;6484.870302593945;6492.480601551888;6499.772507962222;6516.055172000057;6326.873462530747;6353.491720662359;6500.479961603084;6514.283428822826;6521.706523206467;3968.8214030368704;5605.243292155547;5783.5951483396175;5796.942030579682;5837.620554663933;22423;22718;22738.317850464347;23010.65484017741;23028.194013209457;2446.8898899549563;2485.72657007729;2710.837349759001;2757.7793776497833;3041.6654168041496;14617.707645847024;15123.924380378028;15266.084034957827;15424.768628470581;15432;2018.828399586037;2022.5449273913398;2063.8555301128927;2094.099537199004;2129.9467513312293;79891.60054199692;81219.59390203012;83715.5814220931;83719;84296.10825721067;10834.945825270823;10995.835062474069;11204.439778011067;11393.658190254306;11446.084313255085;16013.839861601235;16075.276612552463;16115.19424028794;16122.677546449006;16132.838671613134;8658.39391242607;8659.567021648892;8801.735947921572;8807.943046834422;8830.072842351461;8330;8330.208630180123;8370.0374456937;8485.95757021211;8504.064552899175;6839.794806155824;6897.689603967833;6941.548799328028;6992.580445173204;7091.787246382617;1839.7792264928028;1916.8370688491634;1927.160703069701;1989.150992828852;1999.0504510357464;1034.5809946971337;1037.2687255484866;1176.3059794720984;1199.9340036297913;1221.7312191317897;19545.413637590897;20020.899895500428;20241.493962651053;20451.28420505305;20831.166753329697;1085.8045551800594;1101.1961268274204;1112.1881026850444;1133.393634405589;1152.9538818447336;11349.943250283695;11673.88326116745;11794.646160615195;11833.704157396134;11833.763324733629;483283;498098;500479;508115;527298;81103.59448202839;82223.5888820552;82357.58821205856;82416;82679;1109.545086514525;1118.530217308716;1124.5052177041912;1145.5532342386475;1148.2937993134328;16959.576010599834;17539.386121485688;17551.122443878012;17591.912040439714;17693;37843.243135137694;37885;38786.612133879426;39056.609433905294;39660.60339396569;49975.25037124373;51539.74230128825;51864;51874;51929.740351298;8991.550422478718;9270;9280.535973201448;9359.438433694;9382.29632777558;13688.384022719201;14012.579622611338;14014.509492167725;14152.929235353757;14181.574552763434;11870.881291187323;11888.167828251939;11923.82114268304;11995.40022998864;12191.695207619881;11304.660860174208;11717.707057323634;11786.233894796811;11847.229930054518;11894.821577676516;12149.453274602487;12283.140180187302;12324.938375308066;12521.123521353782;12599.748005040032;8928.419652722552;8974.41666291689;9122.726318210463;9186.127317904788;9194.95402522983;12022.579209727617;12102.273863568214;12171.330576818005;12186.146969712036;12293.262404255773 10:13:42 INFO - PROCESS | 23512 | |3;mootools.html;1488.479032338681;1587.531678154944;1616.8302328255534;1853.1938606706076;1921.3371386871534;7749.263819937111;8344.415890887632;8540.914590854105;8544.829103417927;8551.401401901861;8289;8490.023647280565;8492.235698787108;8500.74497765068;8510.319174466043;2456.5209784092153;2474.3566672665147;2478.6529885816;2479.045567456524;2482.987585062072;2338.4738433852417;2357.068957761683;2360.527894421114;2361.53949979754;2376.512814872947;2319.6172631515865;2380.3573035280465;2383.8212134090013;2391.4619210677633;2398.8200884933613;2406.6149416093517;2422.7092748870073;2433.9634905476432;2435.3424575364643;2461.8030557555353;2359.752226016261;2401.675773770536;2418.383312255381;2421.8183636227177;2427.1383658801046;7526.698932042712;7787.610619469004;8683.56582170889;8728.25809806161;8734.432261902955;5265.657732247391;5361.812336568201;5393.83818485446;5402.270693456372;5418.566514678816;3485.076454739496;3503.562054743157;3513.508108864761;3554.8578056877695;3622.728295377857;1143.588308209044;1150.7410832562691;1160.5009845766317;1161.9360935148563;1183.0476466444509;11924.940375298069;12364.505419783198;12390.938045309806;12403.62789116328;12439.129260951737;4789.404712670613;4796.9760151199025;4798.880027999258;4848.95151048485;4858.951410485921;10615.363078215178;10639.25525213243;10648;10660.573577056832;10664.573417063231;5500.1749737538885;5546.195801608744;5550.0564903965615;5556;5558.72206389687;4916.336294600254;4996.225585034325;4999.825006124768;5002.99940011999;5010.824621138243;4094.3244364679495;4183.213400615047;4195.748255104703;4201.663866890642;4210.2842516772225;1325.9138156019828;1336.946522139123;1351.8242628458238;1352.2832898563777;1368.9589312320647;906.2025417632573;931.9394239374554;998.9810393398693;1004.3521928356315;1028.6142696488816;6063.454289114001;6088.391160883964;6191.071339299141;6229.034499652561;6249.125122482856;461.1169610196503;476.8998510312804;479.3337261206925;481.5329130743174;488.46757034831495;4104.4664193654635;4171.270027745132;4173.353130264813;4178.6657067434535;4191.203671302443;9977.301588888708;10297.12474439666;10454.895451045544;10462.110720588684;10464.843027354596;10169.745756356002;10196.99999999985;10304;10312.32969856972;10334.689959301233;7504.399648028145;7583.090029196532;7596.430267729942;7607.847843043219;7614;5427.104527753035;5447.237386765935;5491.258680078138;5500.257465242141;6050.7277172526465;9250.074992500697;9325.813483730422;9399.624015039322;9435.24518038569;9615.9038409615;9363.85954210701;9540.90459095428;9564;9746.512674366395;9759.560819762986;7732;7795.41534384912;7833.1383547808555;7845.490043147177;7859.17478664732;8359.414840961075;8411.285040771603;8450.873236901329;8453.704120355758;8457.112003239572;7655.617219139132;7696.961515192388;7739.845203096019;7854.921450785419;7969.402294827795;7818.843623127392;7834.412419068707;7858.096318923397;7927.563983980936;7994.280514753467;7079.858402831812;7290.890636640349;7305.379042781423;7374.225706300976;7385.704571817282;4536.296873984537;5306.124489459196;5349.679019258857;5352.732363381893;5363.678179309254;5337.759800808895;5350.9732451337495;5361.758720857492;5382.542483888913;5399.29809124827 10:13:42 INFO - PROCESS | 23512 | |4;prototype.html;347.16853136737507;349.9440089585666;353.1260131175341;356.2803137661925;358.66285691450054;6271.937280627198;6323.24121105468;6336.57427078907;6349.206349206349;6372.713227904744;6289.748410063592;6291.4337709606125;6296.464800491964;6306.527010474221;6328.24061112666;4648.581627653511;4659.207934651101;4755.881102972436;4760.785764640582;4767.404074490689;4750.524947505239;4762.190427627294;4776.211925032366;4794.760261986904;4820;4657.138429390557;4713.457952335474;4730.385049943503;4745.240761478164;4756.1914474539235;4609.67732258742;4635.8377456789185;4742.596879265284;4751.572358487752;4756.97621511892;4130.91738165238;4135.483064616923;4135.834566617332;4139.834406623731;4146.0464093258415;6023.759049638009;6052.243469566304;6059.394060593905;6066.96966515169;6075.483583895374;5573.804916827932;5574.247476590649;5577.972110139464;5581.358143813472;5582.302212223472;6659.966700166517;6669.43309818666;6670.932650775852;6674.666266686695;6683.398494135503;4400.251957167289;4531.977340113278;4646.7444290564345;4648.465426475965;4656.95343046572;6909.481788865855;6946.7221311148;6964.616946067964;6985.82535436613;6989.755358562476;4633.351330813689;4645.210314246586;4646.279826626878;4651.953480465152;4677.391939047902;4721;4722.976385118052;4728.881777955578;4732.787024583902;4733.053389322081;5491.945080549223;5507.697076660822;5509.917351239735;5513.972430137904;5522;6465.515086368447;6651.567648102955;6730;6731.360520750521;6733.158355205599;1625.081828766743;1647.3328302037694;1652.9256183471773;1655.3461382753744;1660.7093758592198;1014.8071866345371;1067.3969207397795;1078.8813230544633;1088.8366744988316;1089.4661615808197;6359.713812878432;6373.649449280241;6467.062275969958;6504.121943537656;6596.274409814917;7009.4392448603985;7017.631561845391;7020.964895175492;7030.156381234285;7032.472564557576;6574.211094668671;6583.736650534021;6587.110740050032;6589.934100658932;6592.0111983202905;3714.0343510687417;3769.453429252798;3769.7361184717356;3774.999625099351;3776.5090538229856;7016.824579385556;7273;7291.052163218854;7293.452991025694;7304.780856574312;7038.260982596856;7097.254788247263;7105.32499412555;7107.538010029331;7113.430925525946;7256.89114663291;7264.237255088246;7265.600391978386;7272.927270727331;7280.490365674352;7001.544899581511;7077.787666370017;7085.964570177116;7088.964555177397;7089.680964356719;6746.898796518154;6847.965760171167;6878.415334696607;6884.93115068863;6901;7202.675879585536;7208.495405321577;7222.09723784527;7245.05814244166;7267.091613548307;4665.906681866411;4692.835750748707;4701.670883038291;4711.787969541448;4715.929261061018;6944.756933507505;6948.062011628365;6965.582065076112;6969.58182509051;6971.51199416036;6610.900836487361;6724.697388617622;6738.7304507819135;6750.729970801113;6780.762673306411;6718.160229971254;6738.629375384205;6739.494537909578;6744.898826517508;6756.898646520208;6546.541742078009;6566.015097735378;6572.34276572339;6573.441257493167;6587.538872278895;6783.18601767791;6785.796426107225;6796.83007924786;6807.965960170168;6809.285025072494;6329.49364050884;6365.427111559982;6467.708953097216;6620.63586502747;6644 10:13:42 INFO - PROCESS | 23512 | |5;yui.html;912.21549467458;913.5432283858071;926.180330407589;932.1517419148577;935.326564873291;15116.697666046672;15408.61478463039;15604.687906241883;15622.609434764137;15777;16103.436379726712;16224.351025958977;16236.675266494693;16248.918755406206;16268.593285167877;793.3217099380005;804.7666176808718;805.4683908620311;905.4702998745726;921.4701546610692;792.7700966719644;925.3984909808611;945.957431915562;946.3706635087658;947.5404428852002;983.6606370802098;983.9704808855746;986.842105263158;986.8815742110957;987.2052997337141;828.6105530400702;838.6687258532845;977.3256453047375;978.3493976505615;979.0601023017912;617.9165812615329;703.0894990986684;714.731975509184;714.9857002859966;715.9856802863914;14205.431782728678;14221.21783301918;14225.430982760678;14236.145831250158;14273.643158921006;13931.860681393258;14470.638234044129;14538.854611453962;14609.561713148623;14935.626609334744;10723.249372543925;10929.56281748729;11060.391678457681;11121.22151449399;12156.635300940987;4623.9768801156115;4703.15343238217;4713.905721885543;4884.731339776311;4894.314795928537;59788.402115978715;60699.696501517654;60936.39063609396;61071.38928610746;61270.38729612647;11486.770264594661;11520.94239528797;11744.647660570197;12005.09961752872;12172.330521821208;20795.272165474136;20881.164753409692;20967.895160524098;21009.369718908456;21028.684569731467;8605.397622166389;8692.826143477096;8711.21599056088;8715.782105447415;9147.908520914838;5006.6495345325475;5129.79480820763;5160.0969830279555;5207.297014903015;5345.679259244458;3604.945925811115;3673.1184515716036;3673.8714145004797;3680.981595092061;3683.9447408288897;643.2731013954202;644.2108417188906;649.0847904454696;650.3951325267547;670.3899451499112;764.6329761714297;767.140802301426;793.5357815677893;857.5712143928037;872.7774417523618;9938.403695778277;10036.197104231644;10181.287309888237;10213.897861021444;10229.897701023043;778.2528772378466;795.7652492514723;846.0735494633367;857.4126723194507;874.1913729800036;4871.439784424837;4929.309896614477;4976.626752993468;5021.4116254432865;5065.341505604321;64131.35868641254;65332.673336633015;65333;65936;66107;56445;56701;57086;57378;57704;22540.66189007166;52007;52042.73978630082;52451.47548524542;53031.99999999923;9630.374025688308;9703.223742100756;9742.610295588098;9843.704688859345;9929.950350248202;38970;39302.6069739299;40017.1996560073;40088.1982360357;40215.1956960865;48714;51318;51668.22497662463;52199.21701174409;52274;11602.47788849487;11794.52821887115;11886.81131886839;11957.282563046245;12073.57742479009;13572.86427135716;13884.166949983033;14092.78860817068;14272;14302.642433939234;11123.464313459137;12528.686782830138;13251.933740331237;13401.396937138048;13661.521846735317;12445.937770311091;13624.93187534056;13918.164910105426;14151.363188656742;14225;13140.145890517086;13168.473261069834;13451.663708406977;13492.257925814174;13759.380827862971;10802.810955774377;10981.341119532854;11036.779264414827;11081.833772493257;11494.482748276181;11530.308181509135;11598;11748;11812.645620631394;11858 10:13:42 INFO - PROCESS | 23512 | __end_tp_report 10:13:42 INFO - PROCESS | 23512 | __start_cc_report 10:13:42 INFO - PROCESS | 23512 | _x_x_mozilla_cycle_collect,819 10:13:42 INFO - PROCESS | 23512 | __end_cc_report 10:13:42 INFO - PROCESS | 23512 | __startTimestamp1466702022446__endTimestamp 10:13:42 INFO - PROCESS | 23512 | 10:13:42 INFO - PROCESS | 23512 | ------- Summary: start ------- 10:13:42 INFO - PROCESS | 23512 | Number of tests: 6 10:13:42 INFO - PROCESS | 23512 | 10:13:42 INFO - PROCESS | 23512 | [#0] dojo.html Cycles:165 Average:5569.95 Median:5794.36 stddev:616.53 (10.6%) stddev-sans-first:592.37 10:13:42 INFO - PROCESS | 23512 | Values: 3309.7 3378.5 3378.6 3413.4 3438.6 5588.1 5614.0 5617.8 5624.7 5631.6 5560.8 5642.6 5650.5 5657.2 5659.1 4981.4 5084.8 5164.3 5212.6 5240.4 5053.3 5103.9 5106.9 5138.7 5145.2 5054.2 5135.8 5144.9 5151.6 5178.9 5146.4 5148.7 5173.2 5175.0 5193.1 4967.5 4990.6 5026.0 5076.1 5076.7 5486.5 5524.6 5542.1 5543.6 5585.6 5940.3 5944.5 5946.2 5952.1 5955.5 5896.7 5975.0 5996.4 6020.3 6031.3 5558.8 5589.5 5603.0 5604.7 5607.3 5931.8 6113.8 6122.5 6127.4 6131.4 5845.0 5871.3 5877.9 5887.1 5889.2 5930.4 5946.8 5948.6 5950.5 5957.7 5898.4 5905.4 5906.0 5906.5 5915.6 5956.0 5964.3 5976.0 5991.4 6024.9 4547.3 4547.3 4548.0 4548.7 4572.0 4017.1 4025.9 4053.1 4077.4 4114.0 5695.4 5740.0 5746.4 5749.8 5765.5 6010.2 6030.9 6043.5 6048.4 6049.8 5600.7 5627.9 5685.0 5696.8 5737.5 5113.5 5120.5 5132.1 5152.3 5157.1 6116.9 6137.2 6138.8 6141.6 6148.5 5899.7 6016.4 6073.1 6085.1 6118.1 6225.4 6239.1 6250.1 6250.9 6259.3 5761.9 5919.8 5934.8 5938.9 5960.9 6032.0 6035.3 6060.2 6068.5 6101.1 5794.4 5823.6 5837.6 5838.0 5843.1 5765.9 5794.2 5837.9 5858.9 5861.0 5787.1 5797.8 5815.4 5825.4 5855.3 5919.4 5947.8 5952.6 5959.6 5974.5 5683.5 5707.2 5738.4 5800.9 5840.0 10:13:42 INFO - PROCESS | 23512 | 10:13:42 INFO - PROCESS | 23512 | [#1] ext.html Cycles:180 Average:55733.12 Median:37676.75 stddev:97365.11 (258.4%) stddev-sans-first:97550.47 10:13:42 INFO - PROCESS | 23512 | Values: 672.1 684.7 691.2 742.7 767.3 36971.8 37665.4 37688.1 37706.8 41688.2 45133.8 45729.0 45784.0 45787.3 45859.5 8897.1 9032.4 9110.2 9117.7 9120.7 8437.8 8990.6 10983.6 11273.4 11277.3 10860.9 10882.7 10936.5 10951.7 10952.8 10792.3 10809.1 10851.2 10860.5 10875.0 10621.8 10711.3 10712.8 10723.6 10734.1 44952.8 45224.0 45331.3 45544.0 45567.5 4062.8 4170.2 4300.1 4390.9 4522.9 34383.7 34845.3 36348.1 36620.3 37094.0 4627.3 4630.6 4646.8 4816.1 4937.0 327856.0 329074.0 329705.0 330209.0 330521.0 66962.0 68183.3 68322.0 68539.0 68570.0 72830.6 72931.6 73217.0 73301.6 73390.6 20244.6 20511.2 20533.1 20545.9 20561.9 14563.7 14908.4 14933.0 14936.9 14979.3 17711.6 17933.6 19496.2 19688.8 20672.8 6424.5 6534.2 6581.8 6644.6 6658.8 1085.8 1155.1 1177.4 1223.9 1248.7 35153.0 35607.0 36064.3 36087.3 36695.3 1243.2 1274.7 1313.8 1319.4 1323.3 16302.9 17102.6 17410.7 17577.6 17734.4 452676.0 456226.0 457630.0 458355.0 459561.0 64706.7 65732.0 65749.0 65813.7 65814.3 1486.7 1510.1 1514.4 1518.3 1578.3 29079.6 30061.1 30708.2 32550.2 33204.7 52627.2 53225.5 53250.0 53268.5 53278.5 305082.0 306874.0 307819.0 307898.0 308415.0 27270.9 29256.6 31708.4 32222.8 34175.8 49869.3 50008.7 50134.2 50330.7 51356.0 41874.4 43108.4 43404.3 43522.6 44067.0 41837.4 42523.0 42742.6 43447.8 43504.0 42011.6 42630.8 43199.8 43728.0 43937.6 36891.8 37739.6 37799.8 38033.6 38094.0 28409.3 28875.6 28891.0 29081.4 29177.0 10:13:42 INFO - PROCESS | 23512 | 10:13:42 INFO - PROCESS | 23512 | [#2] jquery.html Cycles:180 Average:29385.31 Median:22570.50 stddev:82628.25 (366.1%) stddev-sans-first:82831.43 10:13:42 INFO - PROCESS | 23512 | Values: 425.2 428.6 428.9 437.5 438.2 18773.5 19234.8 19564.5 19831.1 20396.7 19682.0 19987.5 20674.2 20718.8 20725.4 5437.3 5904.5 5918.3 5931.9 5933.8 4362.0 5773.0 5919.9 6220.5 6508.9 6455.7 6484.9 6492.5 6499.8 6516.1 6326.9 6353.5 6500.5 6514.3 6521.7 3968.8 5605.2 5783.6 5796.9 5837.6 22423.0 22718.0 22738.3 23010.7 23028.2 2446.9 2485.7 2710.8 2757.8 3041.7 14617.7 15123.9 15266.1 15424.8 15432.0 2018.8 2022.5 2063.9 2094.1 2129.9 79891.6 81219.6 83715.6 83719.0 84296.1 10834.9 10995.8 11204.4 11393.7 11446.1 16013.8 16075.3 16115.2 16122.7 16132.8 8658.4 8659.6 8801.7 8807.9 8830.1 8330.0 8330.2 8370.0 8486.0 8504.1 6839.8 6897.7 6941.5 6992.6 7091.8 1839.8 1916.8 1927.2 1989.2 1999.1 1034.6 1037.3 1176.3 1199.9 1221.7 19545.4 20020.9 20241.5 20451.3 20831.2 1085.8 1101.2 1112.2 1133.4 1153.0 11349.9 11673.9 11794.6 11833.7 11833.8 483283.0 498098.0 500479.0 508115.0 527298.0 81103.6 82223.6 82357.6 82416.0 82679.0 1109.5 1118.5 1124.5 1145.6 1148.3 16959.6 17539.4 17551.1 17591.9 17693.0 37843.2 37885.0 38786.6 39056.6 39660.6 49975.3 51539.7 51864.0 51874.0 51929.7 8991.6 9270.0 9280.5 9359.4 9382.3 13688.4 14012.6 14014.5 14152.9 14181.6 11870.9 11888.2 11923.8 11995.4 12191.7 11304.7 11717.7 11786.2 11847.2 11894.8 12149.5 12283.1 12324.9 12521.1 12599.7 8928.4 8974.4 9122.7 9186.1 9195.0 12022.6 12102.3 12171.3 12186.1 12293.3 10:13:42 INFO - PROCESS | 23512 | 10:13:42 INFO - PROCESS | 23512 | [#3] mootools.html Cycles:180 Average:5750.08 Median:5006.91 stddev:3166.99 (63.3%) stddev-sans-first:3159.68 10:13:42 INFO - PROCESS | 23512 | Values: 1488.5 1587.5 1616.8 1853.2 1921.3 7749.3 8344.4 8540.9 8544.8 8551.4 8289.0 8490.0 8492.2 8500.7 8510.3 2456.5 2474.4 2478.7 2479.0 2483.0 2338.5 2357.1 2360.5 2361.5 2376.5 2319.6 2380.4 2383.8 2391.5 2398.8 2406.6 2422.7 2434.0 2435.3 2461.8 2359.8 2401.7 2418.4 2421.8 2427.1 7526.7 7787.6 8683.6 8728.3 8734.4 5265.7 5361.8 5393.8 5402.3 5418.6 3485.1 3503.6 3513.5 3554.9 3622.7 1143.6 1150.7 1160.5 1161.9 1183.0 11924.9 12364.5 12390.9 12403.6 12439.1 4789.4 4797.0 4798.9 4849.0 4859.0 10615.4 10639.3 10648.0 10660.6 10664.6 5500.2 5546.2 5550.1 5556.0 5558.7 4916.3 4996.2 4999.8 5003.0 5010.8 4094.3 4183.2 4195.7 4201.7 4210.3 1325.9 1336.9 1351.8 1352.3 1369.0 906.2 931.9 999.0 1004.4 1028.6 6063.5 6088.4 6191.1 6229.0 6249.1 461.1 476.9 479.3 481.5 488.5 4104.5 4171.3 4173.4 4178.7 4191.2 9977.3 10297.1 10454.9 10462.1 10464.8 10169.7 10197.0 10304.0 10312.3 10334.7 7504.4 7583.1 7596.4 7607.8 7614.0 5427.1 5447.2 5491.3 5500.3 6050.7 9250.1 9325.8 9399.6 9435.2 9615.9 9363.9 9540.9 9564.0 9746.5 9759.6 7732.0 7795.4 7833.1 7845.5 7859.2 8359.4 8411.3 8450.9 8453.7 8457.1 7655.6 7697.0 7739.8 7854.9 7969.4 7818.8 7834.4 7858.1 7927.6 7994.3 7079.9 7290.9 7305.4 7374.2 7385.7 4536.3 5306.1 5349.7 5352.7 5363.7 5337.8 5351.0 5361.8 5382.5 5399.3 10:13:42 INFO - PROCESS | 23512 | 10:13:42 INFO - PROCESS | 23512 | [#4] prototype.html Cycles:180 Average:5602.62 Median:6362.57 stddev:1725.34 (27.1%) stddev-sans-first:1684.48 10:13:42 INFO - PROCESS | 23512 | Values: 347.2 349.9 353.1 356.3 358.7 6271.9 6323.2 6336.6 6349.2 6372.7 6289.7 6291.4 6296.5 6306.5 6328.2 4648.6 4659.2 4755.9 4760.8 4767.4 4750.5 4762.2 4776.2 4794.8 4820.0 4657.1 4713.5 4730.4 4745.2 4756.2 4609.7 4635.8 4742.6 4751.6 4757.0 4130.9 4135.5 4135.8 4139.8 4146.0 6023.8 6052.2 6059.4 6067.0 6075.5 5573.8 5574.2 5578.0 5581.4 5582.3 6660.0 6669.4 6670.9 6674.7 6683.4 4400.3 4532.0 4646.7 4648.5 4657.0 6909.5 6946.7 6964.6 6985.8 6989.8 4633.4 4645.2 4646.3 4652.0 4677.4 4721.0 4723.0 4728.9 4732.8 4733.1 5491.9 5507.7 5509.9 5514.0 5522.0 6465.5 6651.6 6730.0 6731.4 6733.2 1625.1 1647.3 1652.9 1655.3 1660.7 1014.8 1067.4 1078.9 1088.8 1089.5 6359.7 6373.6 6467.1 6504.1 6596.3 7009.4 7017.6 7021.0 7030.2 7032.5 6574.2 6583.7 6587.1 6589.9 6592.0 3714.0 3769.5 3769.7 3775.0 3776.5 7016.8 7273.0 7291.1 7293.5 7304.8 7038.3 7097.3 7105.3 7107.5 7113.4 7256.9 7264.2 7265.6 7272.9 7280.5 7001.5 7077.8 7086.0 7089.0 7089.7 6746.9 6848.0 6878.4 6884.9 6901.0 7202.7 7208.5 7222.1 7245.1 7267.1 4665.9 4692.8 4701.7 4711.8 4715.9 6944.8 6948.1 6965.6 6969.6 6971.5 6610.9 6724.7 6738.7 6750.7 6780.8 6718.2 6738.6 6739.5 6744.9 6756.9 6546.5 6566.0 6572.3 6573.4 6587.5 6783.2 6785.8 6796.8 6808.0 6809.3 6329.5 6365.4 6467.7 6620.6 6644.0 10:13:42 INFO - PROCESS | 23512 | 10:13:42 INFO - PROCESS | 23512 | [#5] yui.html Cycles:180 Average:15785.53 Median:4889.52 stddev:18208.32 (372.4%) stddev-sans-first:18225.15 10:13:42 INFO - PROCESS | 23512 | Values: 912.2 913.5 926.2 932.2 935.3 15116.7 15408.6 15604.7 15622.6 15777.0 16103.4 16224.4 16236.7 16248.9 16268.6 793.3 804.8 805.5 905.5 921.5 792.8 925.4 946.0 946.4 947.5 983.7 984.0 986.8 986.9 987.2 828.6 838.7 977.3 978.3 979.1 617.9 703.1 714.7 715.0 716.0 14205.4 14221.2 14225.4 14236.1 14273.6 13931.9 14470.6 14538.9 14609.6 14935.6 10723.2 10929.6 11060.4 11121.2 12156.6 4624.0 4703.2 4713.9 4884.7 4894.3 59788.4 60699.7 60936.4 61071.4 61270.4 11486.8 11520.9 11744.6 12005.1 12172.3 20795.3 20881.2 20967.9 21009.4 21028.7 8605.4 8692.8 8711.2 8715.8 9147.9 5006.6 5129.8 5160.1 5207.3 5345.7 3604.9 3673.1 3673.9 3681.0 3683.9 643.3 644.2 649.1 650.4 670.4 764.6 767.1 793.5 857.6 872.8 9938.4 10036.2 10181.3 10213.9 10229.9 778.3 795.8 846.1 857.4 874.2 4871.4 4929.3 4976.6 5021.4 5065.3 64131.4 65332.7 65333.0 65936.0 66107.0 56445.0 56701.0 57086.0 57378.0 57704.0 22540.7 52007.0 52042.7 52451.5 53032.0 9630.4 9703.2 9742.6 9843.7 9930.0 38970.0 39302.6 40017.2 40088.2 40215.2 48714.0 51318.0 51668.2 52199.2 52274.0 11602.5 11794.5 11886.8 11957.3 12073.6 13572.9 13884.2 14092.8 14272.0 14302.6 11123.5 12528.7 13251.9 13401.4 13661.5 12445.9 13624.9 13918.2 14151.4 14225.0 13140.1 13168.5 13451.7 13492.3 13759.4 10802.8 10981.3 11036.8 11081.8 11494.5 11530.3 11598.0 11748.0 11812.6 11858.0 10:13:42 INFO - PROCESS | 23512 | -------- Summary: end -------- 10:13:42 INFO - PROCESS | 23512 | 10:13:43 INFO - TEST-INFO | 23512: exit 0 10:13:43 INFO - TEST-OK | dromaeo_css | took 1111031ms 10:13:43 INFO - TEST-START | kraken 10:13:43 INFO - operating with platform_type : linux_ 10:13:43 INFO - Initialising browser for kraken test... 10:13:43 INFO - TEST-INFO | started process 23706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0fZHy0/profile http://localhost:47628/getInfo.html) 10:13:46 INFO - PROCESS | 23706 | __metrics Screen width/height:1600/1200 10:13:46 INFO - PROCESS | 23706 | colorDepth:24 10:13:46 INFO - PROCESS | 23706 | Browser inner width/height: 1024/697 10:13:46 INFO - PROCESS | 23706 | __metrics 10:13:47 ERROR - PROCESS | 23706 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:13:48 INFO - TEST-INFO | 23706: exit 0 10:13:48 INFO - Browser initialized. 10:13:48 INFO - Running cycle 1/1 for kraken test... 10:13:48 INFO - TEST-INFO | started process 23794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0fZHy0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:00 INFO - PROCESS | 23794 | RSS: Main: 139542528 10:14:00 INFO - PROCESS | 23794 | 10:14:02 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47628/tests/kraken/driver.html?testName=audio-beat-detection) 10:14:03 INFO - PROCESS | 23794 | RSS: Main: 198053888 10:14:03 INFO - PROCESS | 23794 | 10:14:06 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47628/tests/kraken/driver.html?testName=audio-dft) 10:14:06 INFO - PROCESS | 23794 | RSS: Main: 185745408 10:14:06 INFO - PROCESS | 23794 | 10:14:09 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47628/tests/kraken/driver.html?testName=audio-fft) 10:14:10 INFO - PROCESS | 23794 | RSS: Main: 274530304 10:14:10 INFO - PROCESS | 23794 | 10:14:12 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47628/tests/kraken/driver.html?testName=audio-oscillator) 10:14:12 INFO - PROCESS | 23794 | RSS: Main: 180510720 10:14:12 INFO - PROCESS | 23794 | 10:14:15 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47628/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:14:15 INFO - PROCESS | 23794 | RSS: Main: 179335168 10:14:15 INFO - PROCESS | 23794 | 10:14:18 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47628/tests/kraken/driver.html?testName=imaging-darkroom) 10:14:19 INFO - PROCESS | 23794 | RSS: Main: 214069248 10:14:19 INFO - PROCESS | 23794 | 10:14:22 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47628/tests/kraken/driver.html?testName=imaging-desaturate) 10:14:23 INFO - PROCESS | 23794 | RSS: Main: 213614592 10:14:23 INFO - PROCESS | 23794 | 10:14:25 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47628/tests/kraken/driver.html?testName=json-parse-financial) 10:14:26 INFO - PROCESS | 23794 | RSS: Main: 213200896 10:14:26 INFO - PROCESS | 23794 | 10:14:27 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47628/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:14:28 INFO - PROCESS | 23794 | RSS: Main: 194125824 10:14:28 INFO - PROCESS | 23794 | 10:14:30 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47628/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:14:30 INFO - PROCESS | 23794 | RSS: Main: 196923392 10:14:30 INFO - PROCESS | 23794 | 10:14:32 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47628/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:14:33 INFO - PROCESS | 23794 | RSS: Main: 210022400 10:14:33 INFO - PROCESS | 23794 | 10:14:35 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:14:36 INFO - PROCESS | 23794 | RSS: Main: 217903104 10:14:36 INFO - PROCESS | 23794 | 10:14:39 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:14:39 INFO - PROCESS | 23794 | RSS: Main: 214138880 10:14:39 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | Cycle 1(1): loaded http://localhost:47628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47628/tests/kraken/driver.html?testName=ai-astar) 10:14:41 INFO - PROCESS | 23794 | RSS: Main: 274997248 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | __start_tp_report 10:14:41 INFO - PROCESS | 23794 | _x_x_mozilla_page_load 10:14:41 INFO - PROCESS | 23794 | _x_x_mozilla_page_load_details 10:14:41 INFO - PROCESS | 23794 | |i|pagename|runs| 10:14:41 INFO - PROCESS | 23794 | |0;ai-astar;110;109;111;111;110;111;104;111;109;111 10:14:41 INFO - PROCESS | 23794 | |1;audio-beat-detection;150;125;158;180;125;161;157;126;177;125 10:14:41 INFO - PROCESS | 23794 | |2;audio-dft;162;162;162;162;162;161;161;160;160;162 10:14:41 INFO - PROCESS | 23794 | |3;audio-fft;75;74;75;176;76;73;75;76;178;75 10:14:41 INFO - PROCESS | 23794 | |4;audio-oscillator;91;91;162;91;91;91;148;91;91;151 10:14:41 INFO - PROCESS | 23794 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;116;117 10:14:41 INFO - PROCESS | 23794 | |6;imaging-darkroom;145;145;145;144;145;144;145;145;146;145 10:14:41 INFO - PROCESS | 23794 | |7;imaging-desaturate;94;94;94;95;94;94;94;95;94;94 10:14:41 INFO - PROCESS | 23794 | |8;json-parse-financial;53;53;53;54;55;53;55;77;51;52 10:14:41 INFO - PROCESS | 23794 | |9;json-stringify-tinderbox;57;57;58;58;57;57;57;56;58;58 10:14:41 INFO - PROCESS | 23794 | |10;stanford-crypto-aes;78;70;71;71;74;72;72;73;80;72 10:14:41 INFO - PROCESS | 23794 | |11;stanford-crypto-ccm;120;113;121;115;115;111;113;111;127;114 10:14:41 INFO - PROCESS | 23794 | |12;stanford-crypto-pbkdf2;155;155;164;156;162;158;155;157;151;152 10:14:41 INFO - PROCESS | 23794 | |13;stanford-crypto-sha256-iterative;66;68;67;65;62;66;63;66;64;63 10:14:41 INFO - PROCESS | 23794 | __end_tp_report 10:14:41 INFO - PROCESS | 23794 | __start_cc_report 10:14:41 INFO - PROCESS | 23794 | _x_x_mozilla_cycle_collect,1569 10:14:41 INFO - PROCESS | 23794 | __end_cc_report 10:14:41 INFO - PROCESS | 23794 | __startTimestamp1466702081591__endTimestamp 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | ------- Summary: start ------- 10:14:41 INFO - PROCESS | 23794 | Number of tests: 14 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:2.16 (1.9%) stddev-sans-first:2.29 10:14:41 INFO - PROCESS | 23794 | Values: 110.0 109.0 111.0 111.0 110.0 111.0 104.0 111.0 109.0 111.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:157.50 stddev:21.83 (13.9%) stddev-sans-first:23.15 10:14:41 INFO - PROCESS | 23794 | Values: 150.0 125.0 158.0 180.0 125.0 161.0 157.0 126.0 177.0 125.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 10:14:41 INFO - PROCESS | 23794 | Values: 162.0 162.0 162.0 162.0 162.0 161.0 161.0 160.0 160.0 162.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.00 stddev:43.07 (57.4%) stddev-sans-first:45.05 10:14:41 INFO - PROCESS | 23794 | Values: 75.0 74.0 75.0 176.0 76.0 73.0 75.0 76.0 178.0 75.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:91.00 stddev:30.47 (33.5%) stddev-sans-first:31.55 10:14:41 INFO - PROCESS | 23794 | Values: 91.0 91.0 162.0 91.0 91.0 91.0 148.0 91.0 91.0 151.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:14:41 INFO - PROCESS | 23794 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:14:41 INFO - PROCESS | 23794 | Values: 145.0 145.0 145.0 144.0 145.0 144.0 145.0 145.0 146.0 145.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:14:41 INFO - PROCESS | 23794 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:53.50 stddev:7.62 (14.2%) stddev-sans-first:8.02 10:14:41 INFO - PROCESS | 23794 | Values: 53.0 53.0 53.0 54.0 55.0 53.0 55.0 77.0 51.0 52.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.50 stddev:0.67 (1.2%) stddev-sans-first:0.71 10:14:41 INFO - PROCESS | 23794 | Values: 57.0 57.0 58.0 58.0 57.0 57.0 57.0 56.0 58.0 58.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:72.50 stddev:3.23 (4.5%) stddev-sans-first:2.95 10:14:41 INFO - PROCESS | 23794 | Values: 78.0 70.0 71.0 71.0 74.0 72.0 72.0 73.0 80.0 72.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:115.00 stddev:5.12 (4.5%) stddev-sans-first:5.22 10:14:41 INFO - PROCESS | 23794 | Values: 120.0 113.0 121.0 115.0 115.0 111.0 113.0 111.0 127.0 114.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:156.50 stddev:4.03 (2.6%) stddev-sans-first:4.24 10:14:41 INFO - PROCESS | 23794 | Values: 155.0 155.0 164.0 156.0 162.0 158.0 155.0 157.0 151.0 152.0 10:14:41 INFO - PROCESS | 23794 | 10:14:41 INFO - PROCESS | 23794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:66.00 stddev:1.94 (2.9%) stddev-sans-first:2.03 10:14:41 INFO - PROCESS | 23794 | Values: 66.0 68.0 67.0 65.0 62.0 66.0 63.0 66.0 64.0 63.0 10:14:41 INFO - PROCESS | 23794 | -------- Summary: end -------- 10:14:41 INFO - PROCESS | 23794 | 10:14:42 INFO - TEST-INFO | 23794: exit 0 10:14:42 INFO - TEST-OK | kraken | took 59396ms 10:14:42 INFO - SUITE-END | took 1170s 10:14:42 INFO - Completed test suite (00:19:30) 10:14:42 INFO - javascript benchmark 10:14:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.7352211823054, 3378.52700621913, 3378.6452422495636, 3413.4026545354586, 3438.570178727659, 5588.105903055512, 5614.0, 5617.831465056045, 5624.71876406179, 5631.60578759486, 5560.833175004746, 5642.633228840123, 5650.51970582501, 5657.179708942201, 5659.066254068084, 4981.352424184851, 5084.847454576368, 5164.251183578379, 5212.609054320922, 5240.44975277596, 5053.292539044537, 5103.948960510403, 5106.923396149061, 5138.691678499302, 5145.176771716526, 5054.241863720453, 5135.768890399941, 5144.8971020579565, 5151.639385243035, 5178.896422071556, 5146.356705411824, 5148.742562871879, 5173.249878767595, 5175.0, 5193.143131383317, 4967.453580106186, 4990.6257030722845, 5026.0, 5076.060928728197, 5076.720780357079, 5486.533644640211, 5524.558035357162, 5542.057850165482, 5543.6119471637, 5585.609007369486, 5940.2871655401195, 5944.494717948979, 5946.226990491208, 5952.077427998667, 5955.493783028448, 5896.675682837442, 5975.043992961106, 5996.430339117776, 6020.337762846083, 6031.306399763996, 5558.805441809558, 5589.524890384322, 5602.971985140089, 5604.6917419542315, 5607.299087614048, 5931.822045338647, 6113.816585502442, 6122.54080943931, 6127.356627554132, 6131.386861313922, 5844.970775146182, 5871.266091738533, 5877.882442351214, 5887.116932460165, 5889.1755154278435, 5930.377310382434, 5946.791862284799, 5948.583599148018, 5950.494207992369, 5957.731902064417, 5898.351181370046, 5905.409459054146, 5905.970470147622, 5906.468417842415, 5915.58590898633, 5956.047032474783, 5964.31410387811, 5975.970120149372, 5991.400859913973, 6024.8795024100145, 4547.272436410159, 4547.272436410159, 4547.954520454819, 4548.704334218265, 4572.017016341502, 4017.055991841915, 4025.879223623296, 4053.1488387438967, 4077.4087757275624, 4114.033202197481, 5695.373508914016, 5739.971300143473, 5746.42535746422, 5749.798757043567, 5765.509931655773, 6010.188624535719, 6030.879382412327, 6043.48630366415, 6048.42539958712, 6049.818505444844, 5600.719964001783, 5627.8593035174445, 5684.971575142098, 5696.8006119785605, 5737.540996720252, 5113.488651134857, 5120.462351453119, 5132.101882170605, 5152.252923326097, 5157.097507936096, 6116.938830611637, 6137.202163718688, 6138.846528836725, 6141.57009009374, 6148.4773794227995, 5899.675517846474, 6016.368281330398, 6073.089036644538, 6085.1480792689945, 6118.051701986199, 6225.408586184305, 6239.0953311770445, 6250.124982502362, 6250.937490625036, 6259.3427690091885, 5761.884762304647, 5919.792807251725, 5934.7922822701, 5938.881222375442, 5960.8807823844145, 6032.034874420072, 6035.305939816802, 6060.181875446935, 6068.4841788448475, 6101.115338276014, 5794.362620111869, 5823.563232757645, 5837.562182836389, 5838.0, 5843.1235314703135, 5765.913511297418, 5794.217780599565, 5837.883242335214, 5858.882822343444, 5861.0, 5787.131930210502, 5797.826065218051, 5815.360310365941, 5825.446582574648, 5855.268091488564, 5919.4080591940465, 5947.821565353046, 5952.553558483044, 5959.582829201914, 5974.492168165754, 5683.516901063456, 5707.1724599933605, 5738.368779434342, 5800.854978625568, 5839.970800145972], "value": 5529.873492495432, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.0826072411161, 684.6987325576747, 691.2085661917105, 742.6583771465125, 767.3324207939094, 36971.81514092429, 37665.435018474745, 37688.05779855505, 37706.8114659427, 41688.16623667525, 45133.77433112838, 45729.0, 45784.0, 45787.31319030217, 45859.54140458603, 8897.1102889711, 9032.412893161956, 9110.180083792457, 9117.726468205965, 9120.726378208632, 8437.789055273606, 8990.640374385017, 10983.61557345493, 11273.37996410197, 11277.32336059839, 10860.891391086107, 10882.72793180169, 10936.453177341142, 10951.671449856518, 10952.835707464394, 10792.298500597437, 10809.135269178447, 10851.240413171081, 10860.511276992554, 10875.0, 10621.84067238992, 10711.303765255234, 10712.78574428515, 10723.571057157704, 10734.141268698486, 44952.77523612394, 45224.0, 45331.32003019924, 45544.0, 45567.544324556664, 4062.8171732272117, 4170.249355116078, 4300.118475712471, 4390.8902277443, 4522.909541809146, 34383.656163438296, 34845.30309393798, 36348.0912977175, 36620.26759464823, 37094.0, 4627.282771170474, 4630.560096790799, 4646.83736069236, 4816.084943860656, 4937.037277730844, 327856.0, 329074.0, 329705.0, 330208.9999999976, 330521.0, 66962.0, 68183.3181668177, 68322.0, 68539.0, 68570.0, 72830.63584682043, 72931.63534182402, 73217.0, 73301.6334918322, 73390.63304683549, 20244.59510809805, 20511.17955281802, 20533.076011579516, 20545.897270513553, 20561.89719051395, 14563.708725825636, 14908.403663853325, 14933.0, 14936.925315373353, 14979.251037448303, 17711.557211069827, 17933.551661208574, 19496.220151194077, 19688.803111968697, 20672.793272067087, 6424.518161137933, 6534.183227096613, 6581.769638062645, 6644.568103073285, 6658.800235992928, 1085.7719878825378, 1155.1278784517635, 1177.4054102678092, 1223.9265644061384, 1248.6878280429892, 35153.0, 35607.0, 36064.27871442556, 36087.278254434765, 36695.26609467796, 1243.247835059794, 1274.7323062156865, 1313.756954963335, 1319.4458327502473, 1323.2655875988726, 16302.918485407734, 17102.572435689206, 17410.738838917427, 17577.56056098582, 17734.379296724812, 452676.0, 456226.0, 457630.0, 458355.0, 459561.0, 64706.67646661736, 65732.0, 65749.0, 65813.67093164503, 65814.34185658082, 1486.6729319549681, 1510.124128005754, 1514.4472267622239, 1518.32434566619, 1578.2661062605944, 29079.563806542497, 30061.098167055025, 30708.232294192825, 32550.186245344055, 33204.66795332016, 52627.21059184039, 53225.46774532205, 53250.0, 53268.46731532635, 53278.4672153289, 305082.0, 306874.0, 307819.0, 307898.0, 308415.0, 27270.863645681646, 29256.56115158317, 31708.365832683678, 32222.83888580542, 34175.829120854236, 49869.25196122134, 50008.74995624999, 50134.24798628096, 50330.748346258035, 51356.0, 41874.37188442237, 43108.35337470003, 43404.34893476663, 43522.56477435185, 44067.0, 41837.37243941282, 42523.0, 42742.57257427386, 43447.78276108599, 43504.0, 42011.579884200764, 42630.78684606557, 43199.784001079795, 43728.0, 43937.56062439334, 36891.81554092212, 37739.62260377471, 37799.81100094482, 38033.619663804115, 38094.04764880789, 28409.28976775597, 28875.5668664966, 28891.0, 29081.418371632873, 29177.0], "value": 21476.51401252328, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.179403750761, 428.60568277185007, 428.8734823227148, 437.46847580190064, 438.2396541999631, 18773.530661733446, 19234.845909245436, 19564.510887227825, 19831.107600157993, 20396.694049589267, 19682.0, 19987.500312492193, 20674.173033078696, 20718.792812071875, 20725.378238652826, 5437.293151890259, 5904.527637788988, 5918.319393269764, 5931.88136237275, 5933.762649494015, 4361.956380436202, 5772.971135144339, 5919.911201331984, 6220.47125994291, 6508.9023664645065, 6455.677216139197, 6484.870302593945, 6492.480601551888, 6499.772507962222, 6516.055172000057, 6326.873462530747, 6353.491720662359, 6500.479961603084, 6514.283428822826, 6521.706523206467, 3968.8214030368704, 5605.243292155547, 5783.5951483396175, 5796.942030579682, 5837.620554663933, 22423.0, 22718.0, 22738.317850464347, 23010.65484017741, 23028.194013209457, 2446.8898899549563, 2485.72657007729, 2710.837349759001, 2757.7793776497833, 3041.6654168041496, 14617.707645847024, 15123.924380378028, 15266.084034957827, 15424.768628470581, 15432.0, 2018.828399586037, 2022.5449273913398, 2063.8555301128927, 2094.099537199004, 2129.9467513312293, 79891.60054199692, 81219.59390203012, 83715.5814220931, 83719.0, 84296.10825721067, 10834.945825270823, 10995.835062474069, 11204.439778011067, 11393.658190254306, 11446.084313255085, 16013.839861601235, 16075.276612552463, 16115.19424028794, 16122.677546449006, 16132.838671613134, 8658.39391242607, 8659.567021648892, 8801.735947921572, 8807.943046834422, 8830.072842351461, 8330.0, 8330.208630180123, 8370.0374456937, 8485.95757021211, 8504.064552899175, 6839.794806155824, 6897.689603967833, 6941.548799328028, 6992.580445173204, 7091.787246382617, 1839.7792264928028, 1916.8370688491634, 1927.160703069701, 1989.150992828852, 1999.0504510357464, 1034.5809946971337, 1037.2687255484866, 1176.3059794720984, 1199.9340036297913, 1221.7312191317897, 19545.413637590897, 20020.899895500428, 20241.493962651053, 20451.28420505305, 20831.166753329697, 1085.8045551800594, 1101.1961268274204, 1112.1881026850444, 1133.393634405589, 1152.9538818447336, 11349.943250283695, 11673.88326116745, 11794.646160615195, 11833.704157396134, 11833.763324733629, 483283.0, 498098.0, 500479.0, 508115.0, 527298.0, 81103.59448202839, 82223.5888820552, 82357.58821205856, 82416.0, 82679.0, 1109.545086514525, 1118.530217308716, 1124.5052177041912, 1145.5532342386475, 1148.2937993134328, 16959.576010599834, 17539.386121485688, 17551.122443878012, 17591.912040439714, 17693.0, 37843.243135137694, 37885.0, 38786.612133879426, 39056.609433905294, 39660.60339396569, 49975.25037124373, 51539.74230128825, 51864.0, 51874.0, 51929.740351298, 8991.550422478718, 9270.0, 9280.535973201448, 9359.438433694, 9382.29632777558, 13688.384022719201, 14012.579622611338, 14014.509492167725, 14152.929235353757, 14181.574552763434, 11870.881291187323, 11888.167828251939, 11923.82114268304, 11995.40022998864, 12191.695207619881, 11304.660860174208, 11717.707057323634, 11786.233894796811, 11847.229930054518, 11894.821577676516, 12149.453274602487, 12283.140180187302, 12324.938375308066, 12521.123521353782, 12599.748005040032, 8928.419652722552, 8974.41666291689, 9122.726318210463, 9186.127317904788, 9194.95402522983, 12022.579209727617, 12102.273863568214, 12171.330576818005, 12186.146969712036, 12293.262404255773], "value": 9777.706716816514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.479032338681, 1587.531678154944, 1616.8302328255534, 1853.1938606706076, 1921.3371386871534, 7749.263819937111, 8344.415890887632, 8540.914590854105, 8544.829103417927, 8551.401401901861, 8289.0, 8490.023647280565, 8492.235698787108, 8500.74497765068, 8510.319174466043, 2456.5209784092153, 2474.3566672665147, 2478.6529885816, 2479.045567456524, 2482.987585062072, 2338.4738433852417, 2357.068957761683, 2360.527894421114, 2361.53949979754, 2376.512814872947, 2319.6172631515865, 2380.3573035280465, 2383.8212134090013, 2391.4619210677633, 2398.8200884933613, 2406.6149416093517, 2422.7092748870073, 2433.9634905476432, 2435.3424575364643, 2461.8030557555353, 2359.752226016261, 2401.675773770536, 2418.383312255381, 2421.8183636227177, 2427.1383658801046, 7526.698932042712, 7787.610619469004, 8683.56582170889, 8728.25809806161, 8734.432261902955, 5265.657732247391, 5361.812336568201, 5393.83818485446, 5402.270693456372, 5418.566514678816, 3485.076454739496, 3503.562054743157, 3513.508108864761, 3554.8578056877695, 3622.728295377857, 1143.588308209044, 1150.7410832562691, 1160.5009845766317, 1161.9360935148563, 1183.0476466444509, 11924.940375298069, 12364.505419783198, 12390.938045309806, 12403.62789116328, 12439.129260951737, 4789.404712670613, 4796.9760151199025, 4798.880027999258, 4848.95151048485, 4858.951410485921, 10615.363078215178, 10639.25525213243, 10648.0, 10660.573577056832, 10664.573417063231, 5500.1749737538885, 5546.195801608744, 5550.0564903965615, 5556.0, 5558.72206389687, 4916.336294600254, 4996.225585034325, 4999.825006124768, 5002.99940011999, 5010.824621138243, 4094.3244364679495, 4183.213400615047, 4195.748255104703, 4201.663866890642, 4210.2842516772225, 1325.9138156019828, 1336.946522139123, 1351.8242628458238, 1352.2832898563777, 1368.9589312320647, 906.2025417632573, 931.9394239374554, 998.9810393398693, 1004.3521928356315, 1028.6142696488816, 6063.454289114001, 6088.391160883964, 6191.071339299141, 6229.034499652561, 6249.125122482856, 461.1169610196503, 476.8998510312804, 479.3337261206925, 481.5329130743174, 488.46757034831495, 4104.4664193654635, 4171.270027745132, 4173.353130264813, 4178.6657067434535, 4191.203671302443, 9977.301588888708, 10297.12474439666, 10454.895451045544, 10462.110720588684, 10464.843027354596, 10169.745756356002, 10196.99999999985, 10304.0, 10312.32969856972, 10334.689959301233, 7504.399648028145, 7583.090029196532, 7596.430267729942, 7607.847843043219, 7614.0, 5427.104527753035, 5447.237386765935, 5491.258680078138, 5500.257465242141, 6050.7277172526465, 9250.074992500697, 9325.813483730422, 9399.624015039322, 9435.24518038569, 9615.9038409615, 9363.85954210701, 9540.90459095428, 9564.0, 9746.512674366395, 9759.560819762986, 7732.0, 7795.41534384912, 7833.1383547808555, 7845.490043147177, 7859.17478664732, 8359.414840961075, 8411.285040771603, 8450.873236901329, 8453.704120355758, 8457.112003239572, 7655.617219139132, 7696.961515192388, 7739.845203096019, 7854.921450785419, 7969.402294827795, 7818.843623127392, 7834.412419068707, 7858.096318923397, 7927.563983980936, 7994.280514753467, 7079.858402831812, 7290.890636640349, 7305.379042781423, 7374.225706300976, 7385.704571817282, 4536.296873984537, 5306.124489459196, 5349.679019258857, 5352.732363381893, 5363.678179309254, 5337.759800808895, 5350.9732451337495, 5361.758720857492, 5382.542483888913, 5399.29809124827], "value": 4594.009150485269, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.16853136737507, 349.9440089585666, 353.1260131175341, 356.2803137661925, 358.66285691450054, 6271.937280627198, 6323.24121105468, 6336.57427078907, 6349.206349206349, 6372.713227904744, 6289.748410063592, 6291.4337709606125, 6296.464800491964, 6306.527010474221, 6328.24061112666, 4648.581627653511, 4659.207934651101, 4755.881102972436, 4760.785764640582, 4767.404074490689, 4750.524947505239, 4762.190427627294, 4776.211925032366, 4794.760261986904, 4820.0, 4657.138429390557, 4713.457952335474, 4730.385049943503, 4745.240761478164, 4756.1914474539235, 4609.67732258742, 4635.8377456789185, 4742.596879265284, 4751.572358487752, 4756.97621511892, 4130.91738165238, 4135.483064616923, 4135.834566617332, 4139.834406623731, 4146.0464093258415, 6023.759049638009, 6052.243469566304, 6059.394060593905, 6066.96966515169, 6075.483583895374, 5573.804916827932, 5574.247476590649, 5577.972110139464, 5581.358143813472, 5582.302212223472, 6659.966700166517, 6669.43309818666, 6670.932650775852, 6674.666266686695, 6683.398494135503, 4400.251957167289, 4531.977340113278, 4646.7444290564345, 4648.465426475965, 4656.95343046572, 6909.481788865855, 6946.7221311148, 6964.616946067964, 6985.82535436613, 6989.755358562476, 4633.351330813689, 4645.210314246586, 4646.279826626878, 4651.953480465152, 4677.391939047902, 4721.0, 4722.976385118052, 4728.881777955578, 4732.787024583902, 4733.053389322081, 5491.945080549223, 5507.697076660822, 5509.917351239735, 5513.972430137904, 5522.0, 6465.515086368447, 6651.567648102955, 6730.0, 6731.360520750521, 6733.158355205599, 1625.081828766743, 1647.3328302037694, 1652.9256183471773, 1655.3461382753744, 1660.7093758592198, 1014.8071866345371, 1067.3969207397795, 1078.8813230544633, 1088.8366744988316, 1089.4661615808197, 6359.713812878432, 6373.649449280241, 6467.062275969958, 6504.121943537656, 6596.274409814917, 7009.4392448603985, 7017.631561845391, 7020.964895175492, 7030.156381234285, 7032.472564557576, 6574.211094668671, 6583.736650534021, 6587.110740050032, 6589.934100658932, 6592.0111983202905, 3714.0343510687417, 3769.453429252798, 3769.7361184717356, 3774.999625099351, 3776.5090538229856, 7016.824579385556, 7273.0, 7291.052163218854, 7293.452991025694, 7304.780856574312, 7038.260982596856, 7097.254788247263, 7105.32499412555, 7107.538010029331, 7113.430925525946, 7256.89114663291, 7264.237255088246, 7265.600391978386, 7272.927270727331, 7280.490365674352, 7001.544899581511, 7077.787666370017, 7085.964570177116, 7088.964555177397, 7089.680964356719, 6746.898796518154, 6847.965760171167, 6878.415334696607, 6884.93115068863, 6901.0, 7202.675879585536, 7208.495405321577, 7222.09723784527, 7245.05814244166, 7267.091613548307, 4665.906681866411, 4692.835750748707, 4701.670883038291, 4711.787969541448, 4715.929261061018, 6944.756933507505, 6948.062011628365, 6965.582065076112, 6969.58182509051, 6971.51199416036, 6610.900836487361, 6724.697388617622, 6738.7304507819135, 6750.729970801113, 6780.762673306411, 6718.160229971254, 6738.629375384205, 6739.494537909578, 6744.898826517508, 6756.898646520208, 6546.541742078009, 6566.015097735378, 6572.34276572339, 6573.441257493167, 6587.538872278895, 6783.18601767791, 6785.796426107225, 6796.83007924786, 6807.965960170168, 6809.285025072494, 6329.49364050884, 6365.427111559982, 6467.708953097216, 6620.63586502747, 6644.0], "value": 5035.449413953459, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.21549467458, 913.5432283858071, 926.180330407589, 932.1517419148577, 935.326564873291, 15116.697666046672, 15408.61478463039, 15604.687906241883, 15622.609434764137, 15777.0, 16103.436379726712, 16224.351025958977, 16236.675266494693, 16248.918755406206, 16268.593285167877, 793.3217099380005, 804.7666176808718, 805.4683908620311, 905.4702998745726, 921.4701546610692, 792.7700966719644, 925.3984909808611, 945.957431915562, 946.3706635087658, 947.5404428852002, 983.6606370802098, 983.9704808855746, 986.842105263158, 986.8815742110957, 987.2052997337141, 828.6105530400702, 838.6687258532845, 977.3256453047375, 978.3493976505615, 979.0601023017912, 617.9165812615329, 703.0894990986684, 714.731975509184, 714.9857002859966, 715.9856802863914, 14205.431782728678, 14221.21783301918, 14225.430982760678, 14236.145831250158, 14273.643158921006, 13931.860681393258, 14470.638234044129, 14538.854611453962, 14609.561713148623, 14935.626609334744, 10723.249372543925, 10929.56281748729, 11060.391678457681, 11121.22151449399, 12156.635300940987, 4623.9768801156115, 4703.15343238217, 4713.905721885543, 4884.731339776311, 4894.314795928537, 59788.402115978715, 60699.696501517654, 60936.39063609396, 61071.38928610746, 61270.38729612647, 11486.770264594661, 11520.94239528797, 11744.647660570197, 12005.09961752872, 12172.330521821208, 20795.272165474136, 20881.164753409692, 20967.895160524098, 21009.369718908456, 21028.684569731467, 8605.397622166389, 8692.826143477096, 8711.21599056088, 8715.782105447415, 9147.908520914838, 5006.6495345325475, 5129.79480820763, 5160.0969830279555, 5207.297014903015, 5345.679259244458, 3604.945925811115, 3673.1184515716036, 3673.8714145004797, 3680.981595092061, 3683.9447408288897, 643.2731013954202, 644.2108417188906, 649.0847904454696, 650.3951325267547, 670.3899451499112, 764.6329761714297, 767.140802301426, 793.5357815677893, 857.5712143928037, 872.7774417523618, 9938.403695778277, 10036.197104231644, 10181.287309888237, 10213.897861021444, 10229.897701023043, 778.2528772378466, 795.7652492514723, 846.0735494633367, 857.4126723194507, 874.1913729800036, 4871.439784424837, 4929.309896614477, 4976.626752993468, 5021.4116254432865, 5065.341505604321, 64131.35868641254, 65332.673336633015, 65333.0, 65936.0, 66107.0, 56445.0, 56701.0, 57086.0, 57378.0, 57704.0, 22540.66189007166, 52007.0, 52042.73978630082, 52451.47548524542, 53031.99999999923, 9630.374025688308, 9703.223742100756, 9742.610295588098, 9843.704688859345, 9929.950350248202, 38970.0, 39302.6069739299, 40017.1996560073, 40088.1982360357, 40215.1956960865, 48714.0, 51318.0, 51668.22497662463, 52199.21701174409, 52274.0, 11602.47788849487, 11794.52821887115, 11886.81131886839, 11957.282563046245, 12073.57742479009, 13572.86427135716, 13884.166949983033, 14092.78860817068, 14272.0, 14302.642433939234, 11123.464313459137, 12528.686782830138, 13251.933740331237, 13401.396937138048, 13661.521846735317, 12445.937770311091, 13624.93187534056, 13918.164910105426, 14151.363188656742, 14225.0, 13140.145890517086, 13168.473261069834, 13451.663708406977, 13492.257925814174, 13759.380827862971, 10802.810955774377, 10981.341119532854, 11036.779264414827, 11081.833772493257, 11494.482748276181, 11530.308181509135, 11598.0, 11748.0, 11812.645620631394, 11858.0], "value": 7299.578026204795, "unit": "score"}], "name": "dromaeo_css", "value": 7622.20987975995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 111.0, 111.0, 110.0, 111.0, 104.0, 111.0, 109.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 158.0, 180.0, 125.0, 161.0, 157.0, 126.0, 177.0, 125.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 160.0, 160.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 176.0, 76.0, 73.0, 75.0, 76.0, 178.0, 75.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 162.0, 91.0, 91.0, 91.0, 148.0, 91.0, 91.0, 151.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 144.0, 145.0, 144.0, 145.0, 145.0, 146.0, 145.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 55.0, 53.0, 55.0, 77.0, 51.0, 52.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 58.0, 57.0, 57.0, 57.0, 56.0, 58.0, 58.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 70.0, 71.0, 71.0, 74.0, 72.0, 72.0, 73.0, 80.0, 72.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 113.0, 121.0, 115.0, 115.0, 111.0, 113.0, 111.0, 127.0, 114.0], "value": 116.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 164.0, 156.0, 162.0, 158.0, 155.0, 157.0, 151.0, 152.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 65.0, 62.0, 66.0, 63.0, 66.0, 64.0, 63.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1504.1, "alertThreshold": 2.0}]} 10:14:42 INFO - Return code: 0 10:14:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:14:42 ERROR - # TBPL SUCCESS # 10:14:42 INFO - Running post-action listener: _resource_record_post_action 10:14:42 INFO - Running post-run listener: _resource_record_post_run 10:14:43 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 12288; Write bytes: 481665024; Read time: 392; Write time: 452024 10:14:43 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 4096; Write bytes: 258732032; Read time: 180; Write time: 318872 10:14:43 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 222359552; Read time: 212; Write time: 133152 10:14:43 INFO - Running post-run listener: _upload_blobber_files 10:14:43 INFO - Blob upload gear active. 10:14:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:14:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:14:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:14:44 INFO - (blobuploader) - INFO - Open directory for files ... 10:14:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:14:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:45 INFO - (blobuploader) - INFO - Done attempting. 10:14:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:14:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:45 INFO - (blobuploader) - INFO - Done attempting. 10:14:45 INFO - (blobuploader) - INFO - Iteration through files over. 10:14:45 INFO - Return code: 0 10:14:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:14:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:14:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b70e12d5c74d1ffce5b51eb611d0b205c43f8612ad751f4ccdc6892168da54dc26040c6708d9899f5bbb96208b338d74d25c7ab34b63f4f382e0706de8accd64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4653f5d1eb06c4fcd8a17eac8acf849eee4896d4cae6b0aa9dcf4462cb009689a7cbd42a9270fc30bb8181a3847c3b4ee292a3ec02ac40e24b70936302ef90cd"} 10:14:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:14:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:14:45 INFO - Contents: 10:14:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b70e12d5c74d1ffce5b51eb611d0b205c43f8612ad751f4ccdc6892168da54dc26040c6708d9899f5bbb96208b338d74d25c7ab34b63f4f382e0706de8accd64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4653f5d1eb06c4fcd8a17eac8acf849eee4896d4cae6b0aa9dcf4462cb009689a7cbd42a9270fc30bb8181a3847c3b4ee292a3ec02ac40e24b70936302ef90cd"} 10:14:45 INFO - Running post-run listener: copy_logs_to_upload_dir 10:14:45 INFO - Copying logs to upload dir... 10:14:45 INFO - mkdir: /builds/slave/test/build/upload/logs 10:14:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.379712 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-23 10:14:45.939429) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:14:45.943046) ========= 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=ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b70e12d5c74d1ffce5b51eb611d0b205c43f8612ad751f4ccdc6892168da54dc26040c6708d9899f5bbb96208b338d74d25c7ab34b63f4f382e0706de8accd64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4653f5d1eb06c4fcd8a17eac8acf849eee4896d4cae6b0aa9dcf4462cb009689a7cbd42a9270fc30bb8181a3847c3b4ee292a3ec02ac40e24b70936302ef90cd"} build_url:https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/ddRlnNbrSgudSfti4LCXbw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b70e12d5c74d1ffce5b51eb611d0b205c43f8612ad751f4ccdc6892168da54dc26040c6708d9899f5bbb96208b338d74d25c7ab34b63f4f382e0706de8accd64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4653f5d1eb06c4fcd8a17eac8acf849eee4896d4cae6b0aa9dcf4462cb009689a7cbd42a9270fc30bb8181a3847c3b4ee292a3ec02ac40e24b70936302ef90cd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:14:45.969179) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:14:45.969592) ========= 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=ed14279e38b05397cf4aa391000001a4-1466700769.567652-1723359032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:14:46.054890) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:14:46.055208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:14:46.055534) ========= ========= Total master_lag: 0.17 =========