builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1466700858.98 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.979231) ========= 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.979696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:18.980104) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.007221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.007532) ========= 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=eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 09:54:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-06-23 09:54:19 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080583 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.102367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.102760) ========= 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=eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014238 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.152421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.152861) ========= 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=eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 09:54:19,286 truncating revision to first 12 chars 2016-06-23 09:54:19,286 Setting DEBUG logging. 2016-06-23 09:54:19,286 attempt 1/10 2016-06-23 09:54:19,286 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,600 unpacking tar archive at: mozilla-beta-8ca1f953645f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626164 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.793243) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.793620) ========= script_repo_revision: 8ca1f953645f537692e62bb7e2d568d5f5f62eb7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.794126) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.794435) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 09:54:19.804584) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-23 09:54:19.804913) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:54:20 INFO - MultiFileLogger online at 20160623 09:54:20 in /builds/slave/test 09:54:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:54:20 INFO - {'append_to_log': False, 09:54:20 INFO - 'base_work_dir': '/builds/slave/test', 09:54:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:54:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:54:20 INFO - 'branch': 'Mozilla-Beta', 09:54:20 INFO - 'buildbot_json_path': 'buildprops.json', 09:54:20 INFO - 'config_files': ('talos/linux_config.py',), 09:54:20 INFO - 'default_actions': ('clobber', 09:54:20 INFO - 'read-buildbot-config', 09:54:20 INFO - 'download-and-extract', 09:54:20 INFO - 'populate-webroot', 09:54:20 INFO - 'create-virtualenv', 09:54:20 INFO - 'install', 09:54:20 INFO - 'run-tests'), 09:54:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:54:20 INFO - 'download_minidump_stackwalk': True, 09:54:20 INFO - 'download_symbols': 'ondemand', 09:54:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:54:20 INFO - 'tooltool.py': '/tools/tooltool.py', 09:54:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:54:20 INFO - '/tools/misc-python/virtualenv.py')}, 09:54:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:54:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:54:20 INFO - 'installer_path': 'installer.exe', 09:54:20 INFO - 'log_level': 'info', 09:54:20 INFO - 'log_name': 'talos', 09:54:20 INFO - 'log_to_console': True, 09:54:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:54:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:54:20 INFO - 'opt_config_files': (), 09:54:20 INFO - 'pip_index': False, 09:54:20 INFO - 'sps_profile': False, 09:54:20 INFO - 'sps_profile_interval': 0, 09:54:20 INFO - 'suite': 'dromaeojs-e10s', 09:54:20 INFO - 'system_bits': '32', 09:54:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:54:20 INFO - 'title': 'talos-linux64-ix-010', 09:54:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:54:20 INFO - 'use_talos_json': True, 09:54:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:54:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:54:20 INFO - 'work_dir': 'build'} 09:54:20 INFO - ##### 09:54:20 INFO - ##### Running clobber 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: clobber 09:54:20 INFO - rmtree: /builds/slave/test/build 09:54:20 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-e10s", 09:54:20 INFO - "repository": "", 09:54:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 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": 52, 09:54:20 INFO - "slavename": "talos-linux64-ix-010", 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:21 INFO - Downloaded 1327 bytes. 09:54:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:54:21 INFO - Using the following test package requirements: 09:54:21 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:54:21 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:54:21 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 09:54:21 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'jsshell-linux-x86_64.zip'], 09:54:21 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:54:21 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:54:21 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 09:54:21 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 09:54:21 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:54:21 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:54:21 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:21 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:21 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:21 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:21 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:21 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:22 INFO - Downloaded 24186513 bytes. 09:54:22 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:22 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:24 INFO - Return code: 0 09:54:24 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: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:32 INFO - Downloaded 24186513 bytes. 09:54:32 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:32 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:33 INFO - Return code: 0 09:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:33 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:33 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:33 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:33 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:33 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:34 INFO - Downloaded 10840145 bytes. 09:54:34 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:34 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:35 INFO - Return code: 0 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 - 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:35 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:35 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:35 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:35 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:36 INFO - Downloaded 56014292 bytes. 09:54:36 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:36 INFO - mkdir: /builds/slave/test/properties 09:54:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:54:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:54:36 INFO - Contents: 09:54:36 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:37 INFO - Running post-action listener: _resource_record_post_action 09:54:37 INFO - Running post-action listener: set_extra_try_arguments 09:54:37 INFO - ##### 09:54:37 INFO - ##### Running populate-webroot step. 09:54:37 INFO - ##### 09:54:37 INFO - Running pre-action listener: _resource_record_pre_action 09:54:37 INFO - Running main action method: populate_webroot 09:54:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:54:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:54:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:54:37 INFO - '--tppagecycles', 09:54:37 INFO - '7'], 09:54:37 INFO - 'tests': ['tsvgm']}}, 09:54:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:54:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:54:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:54:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:54:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:54:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:54:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:37 INFO - 'talos_options': ['--disable-e10s'], 09:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:37 INFO - 'talos_options': ['--disable-e10s'], 09:54:37 INFO - 'tests': ['damp', 'tps']}, 09:54:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:37 INFO - 'tests': ['damp', 'tps']}, 09:54:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:54:37 INFO - 'tests': ['dromaeo_dom']}, 09:54:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:54:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:54:37 INFO - 'tests': ['a11yr', 09:54:37 INFO - 'ts_paint', 09:54:37 INFO - 'tpaint', 09:54:37 INFO - 'sessionrestore', 09:54:37 INFO - 'sessionrestore_no_auto_restore', 09:54:37 INFO - 'tabpaint']}, 09:54:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:54:37 INFO - 'ts_paint', 09:54:37 INFO - 'tpaint', 09:54:37 INFO - 'sessionrestore', 09:54:37 INFO - 'sessionrestore_no_auto_restore', 09:54:37 INFO - 'tabpaint']}, 09:54:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:54:37 INFO - 'ts_paint', 09:54:37 INFO - 'tpaint', 09:54:37 INFO - 'sessionrestore', 09:54:37 INFO - 'sessionrestore_no_auto_restore', 09:54:37 INFO - 'tabpaint']}, 09:54:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:54:37 INFO - 'ts_paint', 09:54:37 INFO - 'tpaint', 09:54:37 INFO - 'sessionrestore', 09:54:37 INFO - 'sessionrestore_no_auto_restore', 09:54:37 INFO - 'tabpaint']}, 09:54:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:54:37 INFO - 'tests': ['a11yr', 09:54:37 INFO - 'ts_paint', 09:54:37 INFO - 'tpaint', 09:54:37 INFO - 'sessionrestore', 09:54:37 INFO - 'sessionrestore_no_auto_restore', 09:54:37 INFO - 'tabpaint']}, 09:54:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:54:37 INFO - 'tests': ['a11yr', 09:54:37 INFO - 'ts_paint', 09:54:37 INFO - 'tpaint', 09:54:37 INFO - 'sessionrestore', 09:54:37 INFO - 'sessionrestore_no_auto_restore', 09:54:37 INFO - 'tabpaint']}, 09:54:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:54:37 INFO - 'tests': ['tsvgx', 09:54:37 INFO - 'tsvgr_opacity', 09:54:37 INFO - 'tart', 09:54:37 INFO - 'tscrollx', 09:54:37 INFO - 'cart']}, 09:54:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:54:37 INFO - 'tsvgr_opacity', 09:54:37 INFO - 'tart', 09:54:37 INFO - 'tscrollx', 09:54:37 INFO - 'cart']}, 09:54:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:37 INFO - 'talos_options': ['--disable-e10s'], 09:54:37 INFO - 'tests': ['tp5o']}, 09:54:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:37 INFO - 'tests': ['tp5o']}, 09:54:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:37 INFO - 'talos_options': ['--disable-e10s', 09:54:37 INFO - '--xperf_path', 09:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:37 INFO - 'tests': ['tp5n']}, 09:54:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:37 INFO - 'talos_options': ['--xperf_path', 09:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:37 INFO - 'tests': ['tp5n']}}, 09:54:37 INFO - 'talos.zip': {'path': '', 09:54:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:54:37 INFO - Running post-action listener: _resource_record_post_action 09:54:37 INFO - ##### 09:54:37 INFO - ##### Running create-virtualenv step. 09:54:37 INFO - ##### 09:54:37 INFO - Running pre-action listener: _resource_record_pre_action 09:54:37 INFO - Running main action method: create_virtualenv 09:54:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:54:37 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:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:54:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:54:37 INFO - Using real prefix '/usr' 09:54:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:54:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:54:40 INFO - Installing pip.................done. 09:54:40 INFO - Return code: 0 09:54:40 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97da47af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b3410>, '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 0x19b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b47a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', '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', 'pip>=1.5'] 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 pip>=1.5 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': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', 09:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:40 INFO - '_': '/tools/buildbot/bin/python'} 09:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:40 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:40 INFO - Cleaning up... 09:54:40 INFO - Return code: 0 09:54:40 INFO - Installing psutil>=0.7.1 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', '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 0x7f97da47af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b3410>, '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 0x19b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b47a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', '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', 'psutil>=0.7.1'] 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 psutil>=0.7.1 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': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', 09:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:40 INFO - '_': '/tools/buildbot/bin/python'} 09:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:40 INFO - Downloading/unpacking psutil>=0.7.1 09:54:40 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:40 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 - 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:40 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:40 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:40 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:54:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:42 INFO - Installing collected packages: psutil 09:54:42 INFO - Running setup.py install for psutil 09:54:42 INFO - building 'psutil._psutil_linux' extension 09:54:42 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:43 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:43 INFO - building 'psutil._psutil_posix' extension 09:54:43 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:43 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:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:43 INFO - Successfully installed psutil 09:54:43 INFO - Cleaning up... 09:54:43 INFO - Return code: 0 09:54:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f97da47af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b3410>, '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 0x19b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b47a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', '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:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:54:43 INFO - Using env: {'DISPLAY': ':0', 09:54:43 INFO - 'HOME': '/home/cltbld', 09:54:43 INFO - 'LANG': 'en_US.UTF-8', 09:54:43 INFO - 'LANGUAGE': 'en_US:en', 09:54:43 INFO - 'LOGNAME': 'cltbld', 09:54:43 INFO - 'MAIL': '/var/mail/cltbld', 09:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:43 INFO - 'MOZ_NO_REMOTE': '1', 09:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:43 INFO - 'NO_EM_RESTART': '1', 09:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:43 INFO - 'PWD': '/builds/slave/test', 09:54:43 INFO - 'SHELL': '/bin/bash', 09:54:43 INFO - 'SHLVL': '1', 09:54:43 INFO - 'TERM': 'linux', 09:54:43 INFO - 'TMOUT': '86400', 09:54:43 INFO - 'USER': 'cltbld', 09:54:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', 09:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:43 INFO - '_': '/tools/buildbot/bin/python'} 09:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:54:45 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:45 INFO - Installing collected packages: mozsystemmonitor 09:54:45 INFO - Running setup.py install for mozsystemmonitor 09:54:45 INFO - Successfully installed mozsystemmonitor 09:54:45 INFO - Cleaning up... 09:54:45 INFO - Return code: 0 09:54:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:45 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 0x7f97da47af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b3410>, '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 0x19b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b47a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 09:54:45 INFO - 'HOME': '/home/cltbld', 09:54:45 INFO - 'LANG': 'en_US.UTF-8', 09:54:45 INFO - 'LANGUAGE': 'en_US:en', 09:54:45 INFO - 'LOGNAME': 'cltbld', 09:54:45 INFO - 'MAIL': '/var/mail/cltbld', 09:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:45 INFO - 'MOZ_NO_REMOTE': '1', 09:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:45 INFO - 'NO_EM_RESTART': '1', 09:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:45 INFO - 'PWD': '/builds/slave/test', 09:54:45 INFO - 'SHELL': '/bin/bash', 09:54:45 INFO - 'SHLVL': '1', 09:54:45 INFO - 'TERM': 'linux', 09:54:45 INFO - 'TMOUT': '86400', 09:54:45 INFO - 'USER': 'cltbld', 09:54:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', 09:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:45 INFO - '_': '/tools/buildbot/bin/python'} 09:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:54:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:54:47 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:47 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:47 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:47 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:47 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:47 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:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:54:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:48 INFO - Downloading docopt-0.6.1.tar.gz 09:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:54:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:54:48 INFO - Running setup.py install for blobuploader 09:54:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:54:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:54:48 INFO - Running setup.py install for requests 09:54:49 INFO - Running setup.py install for docopt 09:54:49 INFO - Successfully installed blobuploader requests docopt 09:54:49 INFO - Cleaning up... 09:54:49 INFO - Return code: 0 09:54:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:49 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:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:49 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:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:49 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 0x7f97da47af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b3410>, '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 0x19b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b47a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 09:54:49 INFO - 'HOME': '/home/cltbld', 09:54:49 INFO - 'LANG': 'en_US.UTF-8', 09:54:49 INFO - 'LANGUAGE': 'en_US:en', 09:54:49 INFO - 'LOGNAME': 'cltbld', 09:54:49 INFO - 'MAIL': '/var/mail/cltbld', 09:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:49 INFO - 'MOZ_NO_REMOTE': '1', 09:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:49 INFO - 'NO_EM_RESTART': '1', 09:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:49 INFO - 'PWD': '/builds/slave/test', 09:54:49 INFO - 'SHELL': '/bin/bash', 09:54:49 INFO - 'SHLVL': '1', 09:54:49 INFO - 'TERM': 'linux', 09:54:49 INFO - 'TMOUT': '86400', 09:54:49 INFO - 'USER': 'cltbld', 09:54:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', 09:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:49 INFO - '_': '/tools/buildbot/bin/python'} 09:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:49 INFO - Running setup.py (path:/tmp/pip-VyDtNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:49 INFO - Running setup.py (path:/tmp/pip-p6nu5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:49 INFO - Running setup.py (path:/tmp/pip-7Zgxtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:49 INFO - Running setup.py (path:/tmp/pip-deu0hS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:49 INFO - Running setup.py (path:/tmp/pip-_6s12d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:49 INFO - Running setup.py (path:/tmp/pip-TAW2JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:49 INFO - Running setup.py (path:/tmp/pip-lNzurz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:49 INFO - Running setup.py (path:/tmp/pip-BW9L0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:50 INFO - Running setup.py (path:/tmp/pip-pS8Tkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:50 INFO - Running setup.py (path:/tmp/pip-JNU2Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:50 INFO - Running setup.py (path:/tmp/pip-ju3RbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:50 INFO - Running setup.py (path:/tmp/pip-IJWzIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:50 INFO - Running setup.py (path:/tmp/pip-0LPn6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:50 INFO - Running setup.py (path:/tmp/pip-AWpb2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:50 INFO - Running setup.py (path:/tmp/pip-8UI89_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:50 INFO - Running setup.py (path:/tmp/pip-O2YAVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:50 INFO - Running setup.py (path:/tmp/pip-kaDibb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:54:50 INFO - Running setup.py install for manifestparser 09:54:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:54:50 INFO - Running setup.py install for mozcrash 09:54:50 INFO - Running setup.py install for mozdebug 09:54:50 INFO - Running setup.py install for mozdevice 09:54:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:54:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:54:51 INFO - Running setup.py install for mozfile 09:54:51 INFO - Running setup.py install for mozhttpd 09:54:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:54:51 INFO - Running setup.py install for mozinfo 09:54:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:54:51 INFO - Running setup.py install for mozInstall 09:54:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:54:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:54:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:54:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:54:51 INFO - Running setup.py install for mozleak 09:54:51 INFO - Running setup.py install for mozlog 09:54:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:54:51 INFO - Running setup.py install for moznetwork 09:54:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:54:51 INFO - Running setup.py install for mozprocess 09:54:51 INFO - Running setup.py install for mozprofile 09:54:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:54:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:54:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:54:52 INFO - Running setup.py install for mozrunner 09:54:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:54:52 INFO - Running setup.py install for mozscreenshot 09:54:52 INFO - Running setup.py install for moztest 09:54:52 INFO - Running setup.py install for mozversion 09:54:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:54:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:54:52 INFO - Cleaning up... 09:54:52 INFO - Return code: 0 09:54:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:52 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:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:52 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:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:52 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 0x7f97da47af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b3410>, '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 0x19b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b47a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 09:54:52 INFO - 'HOME': '/home/cltbld', 09:54:52 INFO - 'LANG': 'en_US.UTF-8', 09:54:52 INFO - 'LANGUAGE': 'en_US:en', 09:54:52 INFO - 'LOGNAME': 'cltbld', 09:54:52 INFO - 'MAIL': '/var/mail/cltbld', 09:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:52 INFO - 'MOZ_NO_REMOTE': '1', 09:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:52 INFO - 'NO_EM_RESTART': '1', 09:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:52 INFO - 'PWD': '/builds/slave/test', 09:54:52 INFO - 'SHELL': '/bin/bash', 09:54:52 INFO - 'SHLVL': '1', 09:54:52 INFO - 'TERM': 'linux', 09:54:52 INFO - 'TMOUT': '86400', 09:54:52 INFO - 'USER': 'cltbld', 09:54:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', 09:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:52 INFO - '_': '/tools/buildbot/bin/python'} 09:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:52 INFO - Running setup.py (path:/tmp/pip-DXLHFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:52 INFO - Running setup.py (path:/tmp/pip-qr014e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:52 INFO - Running setup.py (path:/tmp/pip-xg6BMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:52 INFO - Running setup.py (path:/tmp/pip-_MxOkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:52 INFO - Running setup.py (path:/tmp/pip-sHYJNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:53 INFO - Running setup.py (path:/tmp/pip-VnFviz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:53 INFO - Running setup.py (path:/tmp/pip-8dJseh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:53 INFO - Running setup.py (path:/tmp/pip-BWYHjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:53 INFO - Running setup.py (path:/tmp/pip-qsakYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:53 INFO - Running setup.py (path:/tmp/pip-rACM9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:53 INFO - Running setup.py (path:/tmp/pip-4ukrW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:53 INFO - Running setup.py (path:/tmp/pip-rK9XhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:53 INFO - Running setup.py (path:/tmp/pip-pzymWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:53 INFO - Running setup.py (path:/tmp/pip-T2TSpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:53 INFO - Running setup.py (path:/tmp/pip-_5BVyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:53 INFO - Running setup.py (path:/tmp/pip-utrnsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:53 INFO - Running setup.py (path:/tmp/pip-oqJMyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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:55 INFO - Downloading blessings-1.6.tar.gz 09:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:54:55 INFO - Installing collected packages: blessings 09:54:55 INFO - Running setup.py install for blessings 09:54:56 INFO - Successfully installed blessings 09:54:56 INFO - Cleaning up... 09:54:56 INFO - Return code: 0 09:54:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:54:56 INFO - Reading from file tmpfile_stdout 09:54:56 INFO - Current package versions: 09:54:56 INFO - argparse == 1.2.1 09:54:56 INFO - blessings == 1.6 09:54:56 INFO - blobuploader == 1.2.4 09:54:56 INFO - docopt == 0.6.1 09:54:56 INFO - manifestparser == 1.1 09:54:56 INFO - mozInstall == 1.12 09:54:56 INFO - mozcrash == 0.17 09:54:56 INFO - mozdebug == 0.1 09:54:56 INFO - mozdevice == 0.48 09:54:56 INFO - mozfile == 1.2 09:54:56 INFO - mozhttpd == 0.7 09:54:56 INFO - mozinfo == 0.9 09:54:56 INFO - mozleak == 0.1 09:54:56 INFO - mozlog == 3.1 09:54:56 INFO - moznetwork == 0.27 09:54:56 INFO - mozprocess == 0.22 09:54:56 INFO - mozprofile == 0.28 09:54:56 INFO - mozrunner == 6.11 09:54:56 INFO - mozscreenshot == 0.1 09:54:56 INFO - mozsystemmonitor == 0.0 09:54:56 INFO - moztest == 0.7 09:54:56 INFO - mozversion == 1.4 09:54:56 INFO - psutil == 3.1.1 09:54:56 INFO - requests == 1.2.3 09:54:56 INFO - wsgiref == 0.1.2 09:54:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:56 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 0x7f97da47af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b3410>, '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 0x19b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b47a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 09:54:56 INFO - 'HOME': '/home/cltbld', 09:54:56 INFO - 'LANG': 'en_US.UTF-8', 09:54:56 INFO - 'LANGUAGE': 'en_US:en', 09:54:56 INFO - 'LOGNAME': 'cltbld', 09:54:56 INFO - 'MAIL': '/var/mail/cltbld', 09:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:56 INFO - 'MOZ_NO_REMOTE': '1', 09:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:56 INFO - 'NO_EM_RESTART': '1', 09:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:56 INFO - 'PWD': '/builds/slave/test', 09:54:56 INFO - 'SHELL': '/bin/bash', 09:54:56 INFO - 'SHLVL': '1', 09:54:56 INFO - 'TERM': 'linux', 09:54:56 INFO - 'TMOUT': '86400', 09:54:56 INFO - 'USER': 'cltbld', 09:54:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', 09:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:56 INFO - '_': '/tools/buildbot/bin/python'} 09:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 INFO - Cleaning up... 09:54:56 INFO - Return code: 0 09:54:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97da47af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b3410>, '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 0x19b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b47a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', '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:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:54:56 INFO - Using env: {'DISPLAY': ':0', 09:54:56 INFO - 'HOME': '/home/cltbld', 09:54:56 INFO - 'LANG': 'en_US.UTF-8', 09:54:56 INFO - 'LANGUAGE': 'en_US:en', 09:54:56 INFO - 'LOGNAME': 'cltbld', 09:54:56 INFO - 'MAIL': '/var/mail/cltbld', 09:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:56 INFO - 'MOZ_NO_REMOTE': '1', 09:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:56 INFO - 'NO_EM_RESTART': '1', 09:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:56 INFO - 'PWD': '/builds/slave/test', 09:54:56 INFO - 'SHELL': '/bin/bash', 09:54:56 INFO - 'SHLVL': '1', 09:54:56 INFO - 'TERM': 'linux', 09:54:56 INFO - 'TMOUT': '86400', 09:54:56 INFO - 'USER': 'cltbld', 09:54:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', 09:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:56 INFO - '_': '/tools/buildbot/bin/python'} 09:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:56 INFO - Downloading/unpacking jsonschema 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:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:54:58 INFO - Downloading/unpacking functools32 (from jsonschema) 09:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:54:58 INFO - warning: no files found matching '*.txt' 09:54:58 INFO - no previously-included directories found matching 'build' 09:54:58 INFO - no previously-included directories found matching 'dist' 09:54:58 INFO - no previously-included directories found matching '.git*' 09:54:58 INFO - Installing collected packages: jsonschema, functools32 09:54:58 INFO - Running setup.py install for functools32 09:54:59 INFO - warning: no files found matching '*.txt' 09:54:59 INFO - no previously-included directories found matching 'build' 09:54:59 INFO - no previously-included directories found matching 'dist' 09:54:59 INFO - no previously-included directories found matching '.git*' 09:54:59 INFO - Successfully installed jsonschema functools32 09:54:59 INFO - Cleaning up... 09:54:59 INFO - Return code: 0 09:54:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:54:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:59 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 0x7f97da47af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b3410>, '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 0x19b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b47a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 09:54:59 INFO - 'HOME': '/home/cltbld', 09:54:59 INFO - 'LANG': 'en_US.UTF-8', 09:54:59 INFO - 'LANGUAGE': 'en_US:en', 09:54:59 INFO - 'LOGNAME': 'cltbld', 09:54:59 INFO - 'MAIL': '/var/mail/cltbld', 09:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:59 INFO - 'MOZ_NO_REMOTE': '1', 09:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:59 INFO - 'NO_EM_RESTART': '1', 09:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:59 INFO - 'PWD': '/builds/slave/test', 09:54:59 INFO - 'SHELL': '/bin/bash', 09:54:59 INFO - 'SHLVL': '1', 09:54:59 INFO - 'TERM': 'linux', 09:54:59 INFO - 'TMOUT': '86400', 09:54:59 INFO - 'USER': 'cltbld', 09:54:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', 09:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:59 INFO - '_': '/tools/buildbot/bin/python'} 09:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:59 INFO - Downloading/unpacking flake8 09:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:55:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:55:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:55:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:55:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:55:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:55:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:55:01 INFO - no previously-included directories found matching 'docs/_build' 09:55:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:55:02 INFO - Running setup.py install for pep8 09:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:55:02 INFO - no previously-included directories found matching 'docs/_build' 09:55:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:55:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:55:02 INFO - Cleaning up... 09:55:02 INFO - Return code: 0 09:55:02 INFO - Running post-action listener: _resource_record_post_action 09:55:02 INFO - Running post-action listener: _start_resource_monitoring 09:55:02 INFO - Starting resource monitoring. 09:55:02 INFO - ##### 09:55:02 INFO - ##### Running install step. 09:55:02 INFO - ##### 09:55:02 INFO - Running pre-action listener: _resource_record_pre_action 09:55:02 INFO - Running main action method: install 09:55:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:55:02 INFO - Reading from file tmpfile_stdout 09:55:02 INFO - Detecting whether we're running mozinstall >=1.0... 09:55:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:55:02 INFO - Reading from file tmpfile_stdout 09:55:02 INFO - Output received: 09:55:02 INFO - Usage: mozinstall [options] installer 09:55:02 INFO - Options: 09:55:02 INFO - -h, --help show this help message and exit 09:55:02 INFO - -d DEST, --destination=DEST 09:55:02 INFO - Directory to install application into. [default: 09:55:02 INFO - "/builds/slave/test"] 09:55:02 INFO - --app=APP Application being installed. [default: firefox] 09:55:02 INFO - mkdir: /builds/slave/test/build/application 09:55:02 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:55:02 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:15 INFO - Reading from file tmpfile_stdout 09:55:15 INFO - Output received: 09:55:15 INFO - /builds/slave/test/build/application/firefox/firefox 09:55:15 INFO - Running post-action listener: _resource_record_post_action 09:55:15 INFO - ##### 09:55:15 INFO - ##### Running run-tests step. 09:55:15 INFO - ##### 09:55:15 INFO - Running pre-action listener: _resource_record_pre_action 09:55:15 INFO - Running main action method: run_tests 09:55:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:55:15 INFO - Python 2.7.3 09:55:15 INFO - Return code: 0 09:55:15 INFO - grabbing minidump binary from tooltool 09:55:15 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:15 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 0x19b3410>, '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 0x19b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:55:15 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:15 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:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:55:15 INFO - Return code: 0 09:55:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:55:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:55:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:55:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:55:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:55:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:55:16 INFO - Return code: 0 09:55:16 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-e10s', '--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-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:55:16 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-e10s --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-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:55:16 INFO - Using env: {'DISPLAY': ':0', 09:55:16 INFO - 'HOME': '/home/cltbld', 09:55:16 INFO - 'LANG': 'en_US.UTF-8', 09:55:16 INFO - 'LANGUAGE': 'en_US:en', 09:55:16 INFO - 'LOGNAME': 'cltbld', 09:55:16 INFO - 'MAIL': '/var/mail/cltbld', 09:55:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:55:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:16 INFO - 'MOZ_NO_REMOTE': '1', 09:55:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:55:16 INFO - 'NO_EM_RESTART': '1', 09:55:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:16 INFO - 'PWD': '/builds/slave/test', 09:55:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:55:16 INFO - 'SHELL': '/bin/bash', 09:55:16 INFO - 'SHLVL': '1', 09:55:16 INFO - 'TERM': 'linux', 09:55:16 INFO - 'TMOUT': '86400', 09:55:16 INFO - 'USER': 'cltbld', 09:55:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025', 09:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:16 INFO - '_': '/tools/buildbot/bin/python'} 09:55:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--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-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:55:16 INFO - mozversion application_buildid: 20160623070424 09:55:16 INFO - mozversion application_changeset: 8ca1f953645f537692e62bb7e2d568d5f5f62eb7 09:55:16 INFO - mozversion application_display_name: Firefox 09:55:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:55:16 INFO - mozversion application_name: Firefox 09:55:16 INFO - mozversion application_remotingname: firefox 09:55:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:55:16 INFO - mozversion application_vendor: Mozilla 09:55:16 INFO - mozversion application_version: 48.0 09:55:16 INFO - mozversion platform_buildid: 20160623070424 09:55:16 INFO - mozversion platform_changeset: 8ca1f953645f537692e62bb7e2d568d5f5f62eb7 09:55:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:55:16 INFO - mozversion platform_version: 48.0 09:55:16 INFO - using testdate: 1466700916 09:55:16 INFO - actual date: 1466700916 09:55:16 INFO - starting webserver on 'localhost:40921' 09:55:16 INFO - SUITE-START | Running 2 tests 09:55:16 INFO - TEST-START | dromaeo_css 09:55:16 INFO - operating with platform_type : linux_ 09:55:16 INFO - Initialising browser for dromaeo_css test... 09:55:16 INFO - TEST-INFO | started process 2143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfCsOjV/profile http://localhost:40921/getInfo.html) 09:55:20 INFO - PROCESS | 2143 | 09:55:20 INFO - PROCESS | 2143 | (process:2221): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:55:21 INFO - PROCESS | 2143 | __metrics Screen width/height:1600/1200 09:55:21 INFO - PROCESS | 2143 | colorDepth:24 09:55:21 INFO - PROCESS | 2143 | Browser inner width/height: 1024/697 09:55:21 INFO - PROCESS | 2143 | __metrics 09:55:22 ERROR - PROCESS | 2143 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:55:23 INFO - TEST-INFO | 2143: exit 0 09:55:23 INFO - Browser initialized. 09:55:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:55:23 INFO - TEST-INFO | started process 2271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfCsOjV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:24 INFO - PROCESS | 2271 | 09:55:24 INFO - PROCESS | 2271 | (process:2338): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:55:34 INFO - PROCESS | 2271 | RSS: Main: 150941696 09:55:34 INFO - PROCESS | 2271 | 09:56:24 INFO - PROCESS | 2271 | 1466700984493 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:32 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:40921/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40921/tests/dromaeo/cssquery-ext.html) 09:58:33 INFO - PROCESS | 2271 | RSS: Main: 154030080 09:58:33 INFO - PROCESS | 2271 | 10:01:34 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:40921/tests/dromaeo/cssquery-ext.html (next: http://localhost:40921/tests/dromaeo/cssquery-jquery.html) 10:01:35 INFO - PROCESS | 2271 | RSS: Main: 152133632 10:01:35 INFO - PROCESS | 2271 | 10:04:37 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:40921/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40921/tests/dromaeo/cssquery-mootools.html) 10:04:37 INFO - PROCESS | 2271 | RSS: Main: 152469504 10:04:37 INFO - PROCESS | 2271 | 10:07:39 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:40921/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40921/tests/dromaeo/cssquery-prototype.html) 10:07:39 INFO - PROCESS | 2271 | RSS: Main: 152666112 10:07:39 INFO - PROCESS | 2271 | 10:10:42 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:40921/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40921/tests/dromaeo/cssquery-yui.html) 10:10:42 INFO - PROCESS | 2271 | RSS: Main: 151990272 10:10:42 INFO - PROCESS | 2271 | 10:13:44 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:40921/tests/dromaeo/cssquery-yui.html (next: http://localhost:40921/tests/dromaeo/cssquery-dojo.html) 10:13:45 INFO - PROCESS | 2271 | RSS: Main: 155963392 10:13:45 INFO - PROCESS | 2271 | 10:13:45 INFO - PROCESS | 2271 | __start_tp_report 10:13:45 INFO - PROCESS | 2271 | _x_x_mozilla_page_load 10:13:45 INFO - PROCESS | 2271 | _x_x_mozilla_page_load_details 10:13:45 INFO - PROCESS | 2271 | |i|pagename|runs| 10:13:45 INFO - PROCESS | 2271 | |0;dojo.html;3397.2186397128658;3447.6035255945576;3460.878869239577;3490.773099748518;3503.264314493956;5742.770289188427;5757.596968212227;5770.047942089555;5803.535717142629;5839.270091238601;5763.279590051244;5785.450382213693;5795.420457954203;5818.912716309259;5823.708814559266;5173.793048278064;5211.140161873286;5266.578673706094;5268.0780863348955;5313.442088580701;5166.147585648364;5182.170852663575;5348.331458567679;5350.224217488462;5361.061814182522;5232.00591887542;5273.367195936493;5335.759890804904;5341.252224688546;5356.276902618136;5249.973750131263;5257.789688412459;5258.92111618326;5269.683818970836;5282.603804714662;5072.315237442972;5101;5163.328767260232;5175.689458632494;5186.299849520342;5603.2715746953045;5611.579131565108;5630.042892708249;5660.094384898396;5672.40439753824;6180.196574445338;6182.381761823826;6184.381561843779;6192.411720886508;6202.255729312466;6001.639901605918;6129.1419201311855;6218.751249949996;6248.87502249957;6280.2777680566405;5725.2843394575675;5726.9140962886;5728.770849166029;5732.828015159552;5775.740091695884;6209.782657606962;6241.843953901098;6245.750169993149;6255.249370075529;6269.561130720897;5894.440028197314;5965.612235204698;6040.546958978094;6052.092186172109;6075.756969721162;6152.354002829638;6153.323134455206;6153.907691384633;6176.413240742122;6215.192025036807;6000.33996260411;6141.85471652979;6150.323464418911;6156.507479401637;6189.597676151036;5984.940150598525;6039.818805435844;6064.818055458343;6067.726952287069;6121.3572574879;4610.608098311614;4611.262198048364;4611.608013318838;4634.23535116702;4659.254519276899;4121.196366708523;4126.051008268055;4153.460050193456;4155;4156.210320039183;5810.157527158538;5862.208601838783;5872.412758724094;5920.052791553331;6006.909896351558;6104.328523862371;6116.731440059295;6185.659788711574;6220.968895155495;6225.564210505221;5941.356096537;5954.166416701665;5978.3124940631515;5992.011318132547;6026.969865150734;5184.792608295701;5284.735763211824;5318.335208098988;5327.227552005015;5350.357957045179;6439.5170362223025;6461.967690161613;6468.482521398277;6470.838229044311;6477.319881412383;6250.406211409818;6267.592606480564;6267.655278959701;6269.185005949197;6279.623222606659;6144.3717414884195;6279.780207692709;6344.524160688059;6392.93607063942;6425.58233714807;6093.29927058394;6107.938920610737;6115.1438798569125;6121.908171377344;6126.754929802758;6052.939470605414;6187.938120618736;6198.876022479615;6200.534959877937;6210.441060304594;5963.701814909324;6046.183765191643;6061.212042434456;6084.7566097357385;6094.085887116968;5938.049912014057;5968.731407086779;5973.193618861572;5978.372270911492;6011.519078473799;5669.54643628517;5836.591438599257;5836.912446313394;5853.151293062397;5883.499902508334;6024.939750602438;6056.697165141637;6088.086786981989;6089.025755879038;6110.2550082019825;5948.583599148191;5953.047512397996;5975;5992.760289588542;6024.427679370453 10:13:45 INFO - PROCESS | 2271 | |1;ext.html;668.8160755792156;677.079172325637;688.8140202145418;728.6975904999425;740.5519660605333;39514.2097158057;40484.39273410901;40528.79735601318;40711.796441017825;40732;42963.785181074054;44063.33904991428;44093.33859992103;44116.3382549262;44189.7790511047;8910.910890891106;9053.185213330798;9067.727968160965;9080.046595107484;9082.636694532244;8863.11368863115;8891.733248002538;8908.24279936203;8956.373053886231;8970;9209.907900921005;9216.815663686755;9248.352615316931;9275.814483710321;9297.023812499692;9118.40730352525;9144.314176436761;9146.085391460867;9163.862542061874;9173.082691730808;9042.140996605378;9087.909120908773;9100.36297459178;9108.316876234243;9110.316726245557;45025.54974450247;45796.54203457956;45809;45848.77075614634;45993.5400645996;3939.03493644059;3980.5621381647998;4026.094128821021;4084.326086195774;4158.4178215049615;33524;33959.83020084884;34257.314853703036;34351;35137;4598.126355992351;4646.9767651161865;4673.182193116225;4687.99208170245;4760.714357138548;332376;332568;333239;336212.99999999756;337661;66831.66584167047;67273.3272667267;67403.3259667397;67813.3218667807;67948.66025669938;71791;73521;73978.63010684912;74148.25851741414;74413;19075.809241907682;19473;19529.511762205773;19529.707054394195;19584.412467625993;14348.426062957573;14408.063475874034;14458.132512049311;14461.49384771528;14508.274586270643;20589.48526286825;20719.482012949797;20950.26674066431;20979.790202097785;21915.452113696967;7643.312101910855;7696.461247712607;7888.48724832884;7926.207379262028;8032.357411407191;1163.4589915689246;1180.5690922813112;1181.8640856301463;1210.2375503432957;1245.3524167432884;34221.82889085539;34463.48304775431;34586.654133458345;34686.13284667853;35076.82461587727;1219.0735041368446;1221.3648902570792;1281.551456990046;1283.595667364777;1320.2276668149048;17830;17936.461906142835;17958;18139.274429022957;18143.72784408235;477427;553818;560657;567320;569371;66062.66968665126;67277.66361168162;67286.32713672899;67365;67396.32603673999;1539.7143385273423;1556.9065856048674;1560.6098475381154;1568.2942675796166;1587.1588058329105;32449.83775081204;32801;33099.84150554719;33245.50131748074;33970;56482.43517564772;56934.14598781105;57248.42751572431;57638.423615763306;57641;431227;434029;434202;434972;436473;32489.512657309686;32579.34841303208;32647;33280.1679958003;33304.33391332208;52773;52975;53035;53840;54074.45925540852;42607.337003998065;44123.89690257769;44203.33694994514;45262.77368613136;45674;43644.56355436405;43789.78105109454;44942.3258651127;44943.32585011293;45546;44822.775886121664;45148.77425612851;45604.543954561355;46003.76998114988;46742;36127.27745445129;38086;38672.41991370188;38817;39015.219695606494;29879.701202987693;30438.239044024078;30624.693753063075;30812.22969425782;31076.84461577768 10:13:45 INFO - PROCESS | 2271 | |2;jquery.html;427.4507258173248;430.264248135688;434.3398034986818;436.8143538995927;438.82008376565614;19074.809251907493;19258.22967081317;19353;19732.802671973277;19913.701294480594;18938.526536836587;19120.713189302172;19355.225790968343;19593;19648;5786.594938354307;5832.620879642831;5940.732667029994;5962.73167707452;5966.105084237356;5868.471837534621;5894.823155305347;5906.675132867691;5911.645301281916;5931.495822855041;5739.110437882114;5857.85355366115;5872.882542349151;5925.7925972590965;5952.136940143677;5865.325487568942;5865.560082993771;5880.176775251468;5896.97051514744;5899.734511946973;5269.367675878881;5280.128778751501;5312.150055991062;5313.760880760375;5348.866278343034;24094.518109637884;24268.878655606786;24609.261722148363;25025.874870625714;25058.248252552454;2570.9228723138335;2717.701052884181;2882.538793792983;3154.41643295991;3168.350488149924;15344.846551534454;15525.146116963562;15775.368985240577;15926.203689815462;16144.354225830954;2144.0673307111456;2152.440365504964;2169.8155656769195;2170.6201414752354;2214.557088582274;80259.59870200611;84032;88547;91576.54211728966;92077.53961230151;11098.944505277423;11911.166218364804;12112.273263604213;12177.208481448855;12280.754384912252;17049.829501704826;17145.399911003056;17230.741538876926;17247.74128388075;17250.396236131925;9331.16019558243;9348.252139828797;9385.38994965325;9415.952920235355;9569.138777510057;9248.953755231181;9413.105754953269;9446.433214007044;9473.952630236805;9495.952520237355;4962.950370496321;5099.643024988215;5113.565346945551;5282.894342113136;5297.284866542967;2103.2533450625115;2123.4094404826087;2160.2547121243147;2169.2949791317883;2186.813186813187;454.2981094209454;464.6863367227108;474.75312837324395;974.7758015656296;1043.9217058720626;11235.59634858077;12332.691682708004;12434.067444941666;12538.122331436713;12664.113512054068;471.2954133570266;482.011875654913;482.5415854937823;494.1327969413656;504.9621278404134;6802.251752307341;6807.183138023469;6859.314068593101;6871.14110736158;6898.241193468714;541625;541839;556342;557885;559223;100745.49627251964;102179;103235;103999.48000260102;105190;498.72570086452305;499.0941441284058;499.43563772937074;506.09156563967764;508.15392371701444;11349.659510214708;11438.485268162785;11448.484818183035;11493.54025838957;11493.597724079616;39615.603843962344;40271.39592906168;40792.79603601963;41476.792616037936;42135.15729685451;53787;55581;57211.427885722274;63406;63766.36233637604;8782.473051616924;8884.86672699923;9006.50464224474;9050.592723327334;9444;9373.765655858659;9592.184664303611;9714.854277185988;9714.902850971683;9970.55132519024;8549.615267312862;8783.253423459077;8861.73414797557;9052.185303322469;9080.591373388346;8711.25954293892;8908.55457227123;8936.597853096497;9021.548922553977;9185.908140918506;8960.551972401223;9065.41074830134;9072.682456114004;9130.77173070652;9443.480608566595;13803.723925521634;13898.791518127035;13900.652483687989;13983.650408739455;14252.287385630885;13819.032667713163;13834.861651383357;13969.720605587629;14025;14194.574162775134 10:13:45 INFO - PROCESS | 2271 | |3;mootools.html;1557.299215353091;1559.321695062648;1789.5973405983655;1942.6697461431556;1944.7666280046387;7713.807154821132;8104.230098140667;8491.91508084919;8755;8785.5607219639;8523.232909038185;8568.228859402652;8606.0963598822;8655.783605409852;8671.86992195116;2474.9876250618768;2483.466054798218;2504.3113143885485;2504.5241404133158;2512.849229046254;2492.0779311654715;2498.8875500602426;2500.2624225853324;2500.72492025877;2506.523760485511;2466.1615050882697;2475.3192871960264;2484.142970675114;2485.7389974052644;2486.1298545509107;2419.9153029643876;2431.57447446697;2457.1031573475643;2474.035126300744;2478.281298423455;2485.5774518331928;2489.576771948773;2512.773850353477;2516.8615726135054;2524.5077209943884;8831.293496520262;8874.955625221832;8916.465012099296;8923.063078376741;8960.55197240142;5441.83674489762;5611.3266408031295;5635.887282254332;5650.350209725893;5661.660300381949;3628.51015112959;3655.6527129922615;3681.4293784463453;3685.1524149445777;3719.9070023249365;1246.9314187719672;1258.081600431681;1265.259823003544;1275.585434733706;1289.374653293152;12340.642529321767;12393.194442361308;12400.75198496025;12417.565385211565;12439.067069969698;4574.794134263966;4651.116287905287;4669.299605059268;4692.483826779052;4722.811087556459;9951.900480995242;9970.750731231778;9977;9978.850317245247;9984.701988741417;5469.835904922858;5486.094794358966;5501.037318469252;5503.2020357048;5521.254630624894;4456.442944631921;5002.674826136289;5031.169856973632;5109.514596113363;5113.590912726973;4088.7546747195265;4123.7523956492405;4188.769617671057;4204.488778054862;4215.683823713233;1217.1054275107788;1217.592106644284;1219.3232755820604;1222.1506053292876;1224.2715584227371;1037.8339465685453;1060.4008735064817;1062.792755412687;1066.386827574148;1067.4022547373495;5883.205767221456;5965.075413310944;6019.458248757633;6021.42796434338;6124.356942520971;472.94324681038495;474.17493561203946;477.4080140625599;480.7788417328068;484.980600775965;4123.299039163349;4135.7518548887165;4141.8964525886495;4174.186033723456;4200.537940826506;10698.51856666452;11120.499577519031;11168.385738784282;11174.720631984103;11187.664370068911;10907.236493445384;10967.232293739362;11071.889281107085;11073.280236784583;11099.389533575732;7507.774766757006;7725.690972361155;7791;8040.396970227256;8147.79630509242;5856.531477481706;5888;5945;6003.979323514925;6023.156758053964;9125;9276.768080798034;9417;9585.185259252763;9633.807323853624;9626.518674066408;9750.414975101517;9765.414075155513;9778.36440631385;9794.21646268311;8040.839183216186;8062.193780621891;8186.877196841933;8258.091609922783;8331.083580806227;8367.832643346977;8398.916010839814;8411.62147703367;8448.408611397143;8455.408121431441;7465.3654439371085;7594.278543538355;7600.46796724224;7746.457747957589;7765.262300081483;7605.847883042419;7649.464537482323;7660.961695191489;7722.420818438527;7769.067711874612;7199.856002879808;7222.74720384784;7226.638668066471;7236.710531578678;7246.347828695442;5362.785488580569;5392;5418.729063546728;5464.961657285103;5502.119660854244;5110.616703747308;5148.407933087743;5229.973850130725;5287.101192797157;5314.548263397654 10:13:45 INFO - PROCESS | 2271 | |4;prototype.html;320.2010982598417;321.0897106702498;324.4079554812468;351.3675384308246;351.5939090350646;6639.668016599169;6702.497312701548;6765.627890466022;6818.897716534244;6826.931730682698;6663.833404164899;6669.466442684586;6685.164354455693;6687.966560167192;6689.297623749497;4833.75831208439;4919.581835543965;4947.381577302837;4960.454350021495;4990.500949905017;4976.154053810861;4985.077760614298;5000.0999820032375;5009.04828082665;5013.874653133683;4942.061008408409;4952.405711314629;4955.331030310898;4955.628327875405;4975.029869175512;4956.7025978441225;4973.825916092956;4974.77613507393;4975.5522003019905;4978.726170060663;4305.935410968838;4307.633851122659;4311.805968731414;4317.309230523133;4319.373690814814;6187.659678717669;6328.968355158241;6452.903206451907;6456.451201647866;6467.5472716909835;5792.27596550427;5806.390329015477;5820.883582328372;5824.475797178232;5831.5334773218465;7082.256363081854;7088.71645134194;7096.112985876765;7107.502474826764;7117.288271172842;4778.784954677013;4779.426468823764;4779.856604301876;4782.928256076161;4786.329913812069;7332.0468339116105;7400.555966642019;7412.666430010662;7414.740484083085;7421.035265415461;4802.303665968415;4881.658283920092;4896.436909755353;4904.288878112654;4906.779194936165;4925.655204135748;4949.851504454872;4950.975245123751;4958.454569997298;4963.8262660806695;5782.277215348082;5791.942080579141;5796.594238403356;5801.53587712982;5804.1293805929445;7108.182559005677;7111.040009598742;7113.359797618239;7115.89326160108;7118.644067796589;1710.8973461592095;1711.5549957011267;1714.040137522991;1715.1510002548819;1718.613312004814;1078.8219943709357;1122.4892673833385;1124.0557931337553;1134.126722423729;1141.0187238974474;6901.102856628606;6919.7232110715;6925.58446493212;6929.064576282238;6938.41023512997;7230.530015548972;7294;7303.926960730325;7313.670884810196;7320.341169294789;6961.477889158334;6967.1291088613925;6994.8950765738555;6998.650067496605;7002.719891204397;3979.8010099495486;4018.738781979162;4019.1559772448113;4019.678425725935;4024.215278020758;7718.266764657348;7738.767836964787;7743.651535680908;7747.573883436352;7748.961255193688;7279.1265048194555;7483.363914067257;7564.583947882809;7566.281203285679;7568.091828980558;7612.352949999312;7688.961555192188;7702.075750909927;7710.961445192738;7727.65225564851;7409.962950185214;7414.332710056121;7418.109826820816;7420.591867447126;7455.627218638938;7280.817979550554;7290.3438690518105;7294.525855819567;7305.598192099273;7328.5969271690565;7595.506292090997;7642.04474440695;7697.807554810951;7713.382929365525;7717.845643087219;4871.34236878017;4896.387951506062;4923.852284431473;4923.901521969612;4936.827211047596;7387.852242955219;7394.112706475043;7394.260573942563;7395.482316237812;7403.333699967029;7148.535345202546;7155.3202445767565;7158.391536719437;7162.391196748335;7184.533005354635;6976.720931162899;7114.395276401564;7130.643467826691;7134.536255143399;7166.713331466683;6935.826604334932;6939.167299924042;6951.617661028489;6962.9903663967425;6972.825679358057;7194.676239569337;7209.675564599501;7210.531315464478;7210.675519601526;7213.819654508679;6961;7022.2275549688475;7023.051887995055;7029.226785053742;7031.226565077735 10:13:45 INFO - PROCESS | 2271 | |5;yui.html;897.6947837735169;901.7970956534781;912.3066469483191;921.5806807902405;926.7173512078813;15167.848321516782;15320.69358612827;15337.309821058065;16514;17311;16353.83646163538;16389.754153687703;16450;16451.2596933138;16485.67028659426;914.1224424552421;922.2299380017694;926.5182105305237;927.5918595817852;943.3726571829759;934.3693007220133;935.4293880732747;936.0125068053201;937.1659223291276;938.9906100939006;975.1370037516778;986.6448078691701;987.279286121132;991.9504024798767;992.3004281981185;970.1947383671571;975.9268054895875;976.3409698453515;977.130353984954;983.4246965525176;720.1322406500154;721.3183541553234;722.9421646268286;723.081686258454;723.2658851265969;16383;16467.258973346226;16483.175841208013;16489.67020659592;16496.587585310343;14914.552563423114;14995.526394273764;15028.474003409829;15098.320575574126;15198.544043678707;11660.12549058824;11856.40717964107;12319;12428.75142497145;12513.812292815615;4009.910576412243;4087.3664581989838;4111.691623128278;4117.97941010296;4119.155573107506;60580.39419605792;61093.6945315275;61152;61193.082103768924;61560.076598851054;11398.430078496041;11465.140114491447;11610.129240307011;11716.121290903217;11758.647240582795;21072.473188170417;21103.26138585173;21138.154473820876;21183;21260.149594016377;7950.165232650604;7975.680972761024;7998.880016799752;8039.316658084012;8412.8317433651;5064.873378165576;5085.516875896784;5116.104681680691;5152.62503060496;5274.525292723673;3561.7506774525536;3620.456931460302;3621.2214373909737;3624.7281453890537;3625.3655610268097;626.708580510065;636.926753423353;643.6781609195402;644.9387308205713;653.4315145823069;734.9191588925214;752.8080339513499;842.8946381702287;854.3208149521146;863.2144748279036;10133.290669653054;10380.221483388625;10524.26330156897;10601.787964240671;10627.734306642242;745.470715791783;793.3771988988616;814.0321760048247;848.1730312944952;850.4812064640564;4636;4809.831655892027;4871.707697538159;4878.804847806048;5001.19980803077;64395.35604643894;66633;66687.33312666908;67133;67337.32662673408;56520.71739641358;57580.13629795556;57591.42408575944;57628.71185644045;58125.709371452875;51737.482625174016;52054.21918671223;52682.20976685353;52714;52918.20622690663;9308.720738377859;9411.29415293842;9445.480498572644;9555.761105972128;9710.854337184806;38933.41599876061;39355.409668854416;39650.60349396584;40189.1962160761;40618;45467;46336.304955425025;49259.26111108265;50605.74697126491;51404;11839.230450020721;12024.819627705416;12236.327002014974;13045.412956416794;13486.66283342885;14182.951624850191;14236.786448203493;14518.927405362905;14744.170758673032;14785.778213326594;13597.660058498617;13683.315834208448;13719.519816806363;14129.929350353183;14754.409823607364;13593.958681912258;13928.79106813419;14078.929605351908;14100.153990760587;14578.489752858599;11916.582919597773;12910.031747618777;13237.073404861952;13323.13399629021;13800.723985520433;10959.232853700165;11085.50115244832;11224.035793736226;11236.775264494501;11750.059995200192;10675.452059451181;11049.779004419706;11050.778984420427;11132.777344453227;11134.610288639858 10:13:45 INFO - PROCESS | 2271 | __end_tp_report 10:13:45 INFO - PROCESS | 2271 | __start_cc_report 10:13:45 INFO - PROCESS | 2271 | _x_x_mozilla_cycle_collect,329 10:13:45 INFO - PROCESS | 2271 | __end_cc_report 10:13:45 INFO - PROCESS | 2271 | __startTimestamp1466702025101__endTimestamp 10:13:45 INFO - PROCESS | 2271 | 10:13:45 INFO - PROCESS | 2271 | ------- Summary: start ------- 10:13:45 INFO - PROCESS | 2271 | Number of tests: 6 10:13:45 INFO - PROCESS | 2271 | 10:13:45 INFO - PROCESS | 2271 | [#0] dojo.html Cycles:165 Average:5725.72 Median:5968.73 stddev:646.46 (10.8%) stddev-sans-first:622.10 10:13:45 INFO - PROCESS | 2271 | Values: 3397.2 3447.6 3460.9 3490.8 3503.3 5742.8 5757.6 5770.0 5803.5 5839.3 5763.3 5785.5 5795.4 5818.9 5823.7 5173.8 5211.1 5266.6 5268.1 5313.4 5166.1 5182.2 5348.3 5350.2 5361.1 5232.0 5273.4 5335.8 5341.3 5356.3 5250.0 5257.8 5258.9 5269.7 5282.6 5072.3 5101.0 5163.3 5175.7 5186.3 5603.3 5611.6 5630.0 5660.1 5672.4 6180.2 6182.4 6184.4 6192.4 6202.3 6001.6 6129.1 6218.8 6248.9 6280.3 5725.3 5726.9 5728.8 5732.8 5775.7 6209.8 6241.8 6245.8 6255.2 6269.6 5894.4 5965.6 6040.5 6052.1 6075.8 6152.4 6153.3 6153.9 6176.4 6215.2 6000.3 6141.9 6150.3 6156.5 6189.6 5984.9 6039.8 6064.8 6067.7 6121.4 4610.6 4611.3 4611.6 4634.2 4659.3 4121.2 4126.1 4153.5 4155.0 4156.2 5810.2 5862.2 5872.4 5920.1 6006.9 6104.3 6116.7 6185.7 6221.0 6225.6 5941.4 5954.2 5978.3 5992.0 6027.0 5184.8 5284.7 5318.3 5327.2 5350.4 6439.5 6462.0 6468.5 6470.8 6477.3 6250.4 6267.6 6267.7 6269.2 6279.6 6144.4 6279.8 6344.5 6392.9 6425.6 6093.3 6107.9 6115.1 6121.9 6126.8 6052.9 6187.9 6198.9 6200.5 6210.4 5963.7 6046.2 6061.2 6084.8 6094.1 5938.0 5968.7 5973.2 5978.4 6011.5 5669.5 5836.6 5836.9 5853.2 5883.5 6024.9 6056.7 6088.1 6089.0 6110.3 5948.6 5953.0 5975.0 5992.8 6024.4 10:13:45 INFO - PROCESS | 2271 | 10:13:45 INFO - PROCESS | 2271 | [#1] ext.html Cycles:180 Average:62241.37 Median:44104.84 stddev:118294.51 (268.2%) stddev-sans-first:118536.02 10:13:45 INFO - PROCESS | 2271 | Values: 668.8 677.1 688.8 728.7 740.6 39514.2 40484.4 40528.8 40711.8 40732.0 42963.8 44063.3 44093.3 44116.3 44189.8 8910.9 9053.2 9067.7 9080.0 9082.6 8863.1 8891.7 8908.2 8956.4 8970.0 9209.9 9216.8 9248.4 9275.8 9297.0 9118.4 9144.3 9146.1 9163.9 9173.1 9042.1 9087.9 9100.4 9108.3 9110.3 45025.5 45796.5 45809.0 45848.8 45993.5 3939.0 3980.6 4026.1 4084.3 4158.4 33524.0 33959.8 34257.3 34351.0 35137.0 4598.1 4647.0 4673.2 4688.0 4760.7 332376.0 332568.0 333239.0 336213.0 337661.0 66831.7 67273.3 67403.3 67813.3 67948.7 71791.0 73521.0 73978.6 74148.3 74413.0 19075.8 19473.0 19529.5 19529.7 19584.4 14348.4 14408.1 14458.1 14461.5 14508.3 20589.5 20719.5 20950.3 20979.8 21915.5 7643.3 7696.5 7888.5 7926.2 8032.4 1163.5 1180.6 1181.9 1210.2 1245.4 34221.8 34463.5 34586.7 34686.1 35076.8 1219.1 1221.4 1281.6 1283.6 1320.2 17830.0 17936.5 17958.0 18139.3 18143.7 477427.0 553818.0 560657.0 567320.0 569371.0 66062.7 67277.7 67286.3 67365.0 67396.3 1539.7 1556.9 1560.6 1568.3 1587.2 32449.8 32801.0 33099.8 33245.5 33970.0 56482.4 56934.1 57248.4 57638.4 57641.0 431227.0 434029.0 434202.0 434972.0 436473.0 32489.5 32579.3 32647.0 33280.2 33304.3 52773.0 52975.0 53035.0 53840.0 54074.5 42607.3 44123.9 44203.3 45262.8 45674.0 43644.6 43789.8 44942.3 44943.3 45546.0 44822.8 45148.8 45604.5 46003.8 46742.0 36127.3 38086.0 38672.4 38817.0 39015.2 29879.7 30438.2 30624.7 30812.2 31076.8 10:13:45 INFO - PROCESS | 2271 | 10:13:45 INFO - PROCESS | 2271 | [#2] jquery.html Cycles:180 Average:30997.19 Median:499.26 stddev:91001.81 (18227.2%) stddev-sans-first:91228.14 10:13:45 INFO - PROCESS | 2271 | Values: 427.5 430.3 434.3 436.8 438.8 19074.8 19258.2 19353.0 19732.8 19913.7 18938.5 19120.7 19355.2 19593.0 19648.0 5786.6 5832.6 5940.7 5962.7 5966.1 5868.5 5894.8 5906.7 5911.6 5931.5 5739.1 5857.9 5872.9 5925.8 5952.1 5865.3 5865.6 5880.2 5897.0 5899.7 5269.4 5280.1 5312.2 5313.8 5348.9 24094.5 24268.9 24609.3 25025.9 25058.2 2570.9 2717.7 2882.5 3154.4 3168.4 15344.8 15525.1 15775.4 15926.2 16144.4 2144.1 2152.4 2169.8 2170.6 2214.6 80259.6 84032.0 88547.0 91576.5 92077.5 11098.9 11911.2 12112.3 12177.2 12280.8 17049.8 17145.4 17230.7 17247.7 17250.4 9331.2 9348.3 9385.4 9416.0 9569.1 9249.0 9413.1 9446.4 9474.0 9496.0 4963.0 5099.6 5113.6 5282.9 5297.3 2103.3 2123.4 2160.3 2169.3 2186.8 454.3 464.7 474.8 974.8 1043.9 11235.6 12332.7 12434.1 12538.1 12664.1 471.3 482.0 482.5 494.1 505.0 6802.3 6807.2 6859.3 6871.1 6898.2 541625.0 541839.0 556342.0 557885.0 559223.0 100745.5 102179.0 103235.0 103999.5 105190.0 498.7 499.1 499.4 506.1 508.2 11349.7 11438.5 11448.5 11493.5 11493.6 39615.6 40271.4 40792.8 41476.8 42135.2 53787.0 55581.0 57211.4 63406.0 63766.4 8782.5 8884.9 9006.5 9050.6 9444.0 9373.8 9592.2 9714.9 9714.9 9970.6 8549.6 8783.3 8861.7 9052.2 9080.6 8711.3 8908.6 8936.6 9021.5 9185.9 8960.6 9065.4 9072.7 9130.8 9443.5 13803.7 13898.8 13900.7 13983.7 14252.3 13819.0 13834.9 13969.7 14025.0 14194.6 10:13:45 INFO - PROCESS | 2271 | 10:13:45 INFO - PROCESS | 2271 | [#3] mootools.html Cycles:180 Average:5832.56 Median:5131.00 stddev:3218.47 (62.7%) stddev-sans-first:3211.46 10:13:45 INFO - PROCESS | 2271 | Values: 1557.3 1559.3 1789.6 1942.7 1944.8 7713.8 8104.2 8491.9 8755.0 8785.6 8523.2 8568.2 8606.1 8655.8 8671.9 2475.0 2483.5 2504.3 2504.5 2512.8 2492.1 2498.9 2500.3 2500.7 2506.5 2466.2 2475.3 2484.1 2485.7 2486.1 2419.9 2431.6 2457.1 2474.0 2478.3 2485.6 2489.6 2512.8 2516.9 2524.5 8831.3 8875.0 8916.5 8923.1 8960.6 5441.8 5611.3 5635.9 5650.4 5661.7 3628.5 3655.7 3681.4 3685.2 3719.9 1246.9 1258.1 1265.3 1275.6 1289.4 12340.6 12393.2 12400.8 12417.6 12439.1 4574.8 4651.1 4669.3 4692.5 4722.8 9951.9 9970.8 9977.0 9978.9 9984.7 5469.8 5486.1 5501.0 5503.2 5521.3 4456.4 5002.7 5031.2 5109.5 5113.6 4088.8 4123.8 4188.8 4204.5 4215.7 1217.1 1217.6 1219.3 1222.2 1224.3 1037.8 1060.4 1062.8 1066.4 1067.4 5883.2 5965.1 6019.5 6021.4 6124.4 472.9 474.2 477.4 480.8 485.0 4123.3 4135.8 4141.9 4174.2 4200.5 10698.5 11120.5 11168.4 11174.7 11187.7 10907.2 10967.2 11071.9 11073.3 11099.4 7507.8 7725.7 7791.0 8040.4 8147.8 5856.5 5888.0 5945.0 6004.0 6023.2 9125.0 9276.8 9417.0 9585.2 9633.8 9626.5 9750.4 9765.4 9778.4 9794.2 8040.8 8062.2 8186.9 8258.1 8331.1 8367.8 8398.9 8411.6 8448.4 8455.4 7465.4 7594.3 7600.5 7746.5 7765.3 7605.8 7649.5 7661.0 7722.4 7769.1 7199.9 7222.7 7226.6 7236.7 7246.3 5362.8 5392.0 5418.7 5465.0 5502.1 5110.6 5148.4 5230.0 5287.1 5314.5 10:13:45 INFO - PROCESS | 2271 | 10:13:45 INFO - PROCESS | 2271 | [#4] prototype.html Cycles:180 Average:5923.54 Median:6910.41 stddev:1845.41 (26.7%) stddev-sans-first:1802.02 10:13:45 INFO - PROCESS | 2271 | Values: 320.2 321.1 324.4 351.4 351.6 6639.7 6702.5 6765.6 6818.9 6826.9 6663.8 6669.5 6685.2 6688.0 6689.3 4833.8 4919.6 4947.4 4960.5 4990.5 4976.2 4985.1 5000.1 5009.0 5013.9 4942.1 4952.4 4955.3 4955.6 4975.0 4956.7 4973.8 4974.8 4975.6 4978.7 4305.9 4307.6 4311.8 4317.3 4319.4 6187.7 6329.0 6452.9 6456.5 6467.5 5792.3 5806.4 5820.9 5824.5 5831.5 7082.3 7088.7 7096.1 7107.5 7117.3 4778.8 4779.4 4779.9 4782.9 4786.3 7332.0 7400.6 7412.7 7414.7 7421.0 4802.3 4881.7 4896.4 4904.3 4906.8 4925.7 4949.9 4951.0 4958.5 4963.8 5782.3 5791.9 5796.6 5801.5 5804.1 7108.2 7111.0 7113.4 7115.9 7118.6 1710.9 1711.6 1714.0 1715.2 1718.6 1078.8 1122.5 1124.1 1134.1 1141.0 6901.1 6919.7 6925.6 6929.1 6938.4 7230.5 7294.0 7303.9 7313.7 7320.3 6961.5 6967.1 6994.9 6998.7 7002.7 3979.8 4018.7 4019.2 4019.7 4024.2 7718.3 7738.8 7743.7 7747.6 7749.0 7279.1 7483.4 7564.6 7566.3 7568.1 7612.4 7689.0 7702.1 7711.0 7727.7 7410.0 7414.3 7418.1 7420.6 7455.6 7280.8 7290.3 7294.5 7305.6 7328.6 7595.5 7642.0 7697.8 7713.4 7717.8 4871.3 4896.4 4923.9 4923.9 4936.8 7387.9 7394.1 7394.3 7395.5 7403.3 7148.5 7155.3 7158.4 7162.4 7184.5 6976.7 7114.4 7130.6 7134.5 7166.7 6935.8 6939.2 6951.6 6963.0 6972.8 7194.7 7209.7 7210.5 7210.7 7213.8 6961.0 7022.2 7023.1 7029.2 7031.2 10:13:45 INFO - PROCESS | 2271 | 10:13:45 INFO - PROCESS | 2271 | [#5] yui.html Cycles:180 Average:16065.47 Median:45901.65 stddev:18416.77 (40.1%) stddev-sans-first:18433.21 10:13:45 INFO - PROCESS | 2271 | Values: 897.7 901.8 912.3 921.6 926.7 15167.8 15320.7 15337.3 16514.0 17311.0 16353.8 16389.8 16450.0 16451.3 16485.7 914.1 922.2 926.5 927.6 943.4 934.4 935.4 936.0 937.2 939.0 975.1 986.6 987.3 992.0 992.3 970.2 975.9 976.3 977.1 983.4 720.1 721.3 722.9 723.1 723.3 16383.0 16467.3 16483.2 16489.7 16496.6 14914.6 14995.5 15028.5 15098.3 15198.5 11660.1 11856.4 12319.0 12428.8 12513.8 4009.9 4087.4 4111.7 4118.0 4119.2 60580.4 61093.7 61152.0 61193.1 61560.1 11398.4 11465.1 11610.1 11716.1 11758.6 21072.5 21103.3 21138.2 21183.0 21260.1 7950.2 7975.7 7998.9 8039.3 8412.8 5064.9 5085.5 5116.1 5152.6 5274.5 3561.8 3620.5 3621.2 3624.7 3625.4 626.7 636.9 643.7 644.9 653.4 734.9 752.8 842.9 854.3 863.2 10133.3 10380.2 10524.3 10601.8 10627.7 745.5 793.4 814.0 848.2 850.5 4636.0 4809.8 4871.7 4878.8 5001.2 64395.4 66633.0 66687.3 67133.0 67337.3 56520.7 57580.1 57591.4 57628.7 58125.7 51737.5 52054.2 52682.2 52714.0 52918.2 9308.7 9411.3 9445.5 9555.8 9710.9 38933.4 39355.4 39650.6 40189.2 40618.0 45467.0 46336.3 49259.3 50605.7 51404.0 11839.2 12024.8 12236.3 13045.4 13486.7 14183.0 14236.8 14518.9 14744.2 14785.8 13597.7 13683.3 13719.5 14129.9 14754.4 13594.0 13928.8 14078.9 14100.2 14578.5 11916.6 12910.0 13237.1 13323.1 13800.7 10959.2 11085.5 11224.0 11236.8 11750.1 10675.5 11049.8 11050.8 11132.8 11134.6 10:13:45 INFO - PROCESS | 2271 | -------- Summary: end -------- 10:13:45 INFO - PROCESS | 2271 | 10:13:45 INFO - TEST-INFO | 2271: exit 0 10:13:45 INFO - TEST-OK | dromaeo_css | took 1108810ms 10:13:45 INFO - TEST-START | kraken 10:13:45 INFO - operating with platform_type : linux_ 10:13:45 INFO - Initialising browser for kraken test... 10:13:45 INFO - TEST-INFO | started process 2599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjV2C26/profile http://localhost:40921/getInfo.html) 10:13:49 INFO - PROCESS | 2599 | 10:13:49 INFO - PROCESS | 2599 | (process:2680): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:13:50 INFO - PROCESS | 2599 | __metrics Screen width/height:1600/1200 10:13:50 INFO - PROCESS | 2599 | colorDepth:24 10:13:50 INFO - PROCESS | 2599 | Browser inner width/height: 1024/697 10:13:50 INFO - PROCESS | 2599 | __metrics 10:13:51 ERROR - PROCESS | 2599 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:13:51 INFO - TEST-INFO | 2599: exit 0 10:13:51 INFO - Browser initialized. 10:13:51 INFO - Running cycle 1/1 for kraken test... 10:13:51 INFO - TEST-INFO | started process 2763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjV2C26/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:53 INFO - PROCESS | 2763 | 10:13:53 INFO - PROCESS | 2763 | (process:2886): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:14:03 INFO - PROCESS | 2763 | RSS: Main: 150790144 10:14:03 INFO - PROCESS | 2763 | 10:14:06 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40921/tests/kraken/driver.html?testName=audio-beat-detection) 10:14:06 INFO - PROCESS | 2763 | RSS: Main: 156123136 10:14:06 INFO - PROCESS | 2763 | 10:14:09 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40921/tests/kraken/driver.html?testName=audio-dft) 10:14:10 INFO - PROCESS | 2763 | RSS: Main: 156250112 10:14:10 INFO - PROCESS | 2763 | 10:14:13 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40921/tests/kraken/driver.html?testName=audio-fft) 10:14:13 INFO - PROCESS | 2763 | RSS: Main: 156438528 10:14:13 INFO - PROCESS | 2763 | 10:14:15 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40921/tests/kraken/driver.html?testName=audio-oscillator) 10:14:16 INFO - PROCESS | 2763 | RSS: Main: 156143616 10:14:16 INFO - PROCESS | 2763 | 10:14:18 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40921/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:14:19 INFO - PROCESS | 2763 | RSS: Main: 156094464 10:14:19 INFO - PROCESS | 2763 | 10:14:22 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40921/tests/kraken/driver.html?testName=imaging-darkroom) 10:14:22 INFO - PROCESS | 2763 | RSS: Main: 156303360 10:14:22 INFO - PROCESS | 2763 | 10:14:26 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40921/tests/kraken/driver.html?testName=imaging-desaturate) 10:14:26 INFO - PROCESS | 2763 | RSS: Main: 156463104 10:14:26 INFO - PROCESS | 2763 | 10:14:29 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40921/tests/kraken/driver.html?testName=json-parse-financial) 10:14:30 INFO - PROCESS | 2763 | RSS: Main: 156110848 10:14:30 INFO - PROCESS | 2763 | 10:14:31 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40921/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:14:32 INFO - PROCESS | 2763 | RSS: Main: 156057600 10:14:32 INFO - PROCESS | 2763 | 10:14:33 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40921/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:14:34 INFO - PROCESS | 2763 | RSS: Main: 156229632 10:14:34 INFO - PROCESS | 2763 | 10:14:36 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40921/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:14:37 INFO - PROCESS | 2763 | RSS: Main: 156508160 10:14:37 INFO - PROCESS | 2763 | 10:14:39 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:14:40 INFO - PROCESS | 2763 | RSS: Main: 156979200 10:14:40 INFO - PROCESS | 2763 | 10:14:42 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:14:43 INFO - PROCESS | 2763 | RSS: Main: 157216768 10:14:43 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | Cycle 1(1): loaded http://localhost:40921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40921/tests/kraken/driver.html?testName=ai-astar) 10:14:45 INFO - PROCESS | 2763 | RSS: Main: 158679040 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | __start_tp_report 10:14:45 INFO - PROCESS | 2763 | _x_x_mozilla_page_load 10:14:45 INFO - PROCESS | 2763 | _x_x_mozilla_page_load_details 10:14:45 INFO - PROCESS | 2763 | |i|pagename|runs| 10:14:45 INFO - PROCESS | 2763 | |0;ai-astar;108;110;103;111;110;111;100;110;110;110 10:14:45 INFO - PROCESS | 2763 | |1;audio-beat-detection;167;125;156;182;141;155;158;127;173;134 10:14:45 INFO - PROCESS | 2763 | |2;audio-dft;163;163;161;161;161;163;162;163;161;161 10:14:45 INFO - PROCESS | 2763 | |3;audio-fft;75;79;77;168;74;75;77;74;174;75 10:14:45 INFO - PROCESS | 2763 | |4;audio-oscillator;93;93;155;93;92;92;156;93;92;142 10:14:45 INFO - PROCESS | 2763 | |5;imaging-gaussian-blur;118;117;117;117;118;117;117;117;118;117 10:14:45 INFO - PROCESS | 2763 | |6;imaging-darkroom;148;146;148;147;146;145;147;147;147;147 10:14:45 INFO - PROCESS | 2763 | |7;imaging-desaturate;95;95;95;97;95;95;95;95;95;95 10:14:45 INFO - PROCESS | 2763 | |8;json-parse-financial;55;55;55;55;55;56;64;75;61;53 10:14:45 INFO - PROCESS | 2763 | |9;json-stringify-tinderbox;57;57;58;57;59;58;57;57;58;61 10:14:45 INFO - PROCESS | 2763 | |10;stanford-crypto-aes;73;73;72;73;74;75;75;77;73;73 10:14:45 INFO - PROCESS | 2763 | |11;stanford-crypto-ccm;124;117;112;124;113;120;126;111;134;127 10:14:45 INFO - PROCESS | 2763 | |12;stanford-crypto-pbkdf2;157;161;161;161;158;155;153;153;154;153 10:14:45 INFO - PROCESS | 2763 | |13;stanford-crypto-sha256-iterative;68;66;64;66;68;64;65;65;65;66 10:14:45 INFO - PROCESS | 2763 | __end_tp_report 10:14:45 INFO - PROCESS | 2763 | __start_cc_report 10:14:45 INFO - PROCESS | 2763 | _x_x_mozilla_cycle_collect,831 10:14:45 INFO - PROCESS | 2763 | __end_cc_report 10:14:45 INFO - PROCESS | 2763 | __startTimestamp1466702085501__endTimestamp 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | ------- Summary: start ------- 10:14:45 INFO - PROCESS | 2763 | Number of tests: 14 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.74 (3.4%) stddev-sans-first:3.97 10:14:45 INFO - PROCESS | 2763 | Values: 108.0 110.0 103.0 111.0 110.0 111.0 100.0 110.0 110.0 110.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:157.00 stddev:19.51 (12.4%) stddev-sans-first:19.90 10:14:45 INFO - PROCESS | 2763 | Values: 167.0 125.0 156.0 182.0 141.0 155.0 158.0 127.0 173.0 134.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:0.99 (0.6%) stddev-sans-first:0.97 10:14:45 INFO - PROCESS | 2763 | Values: 163.0 163.0 161.0 161.0 161.0 163.0 162.0 163.0 161.0 161.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.00 stddev:40.22 (53.6%) stddev-sans-first:42.01 10:14:45 INFO - PROCESS | 2763 | Values: 75.0 79.0 77.0 168.0 74.0 75.0 77.0 74.0 174.0 75.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:92.50 stddev:28.47 (30.8%) stddev-sans-first:29.51 10:14:45 INFO - PROCESS | 2763 | Values: 93.0 93.0 155.0 93.0 92.0 92.0 156.0 93.0 92.0 142.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 10:14:45 INFO - PROCESS | 2763 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 10:14:45 INFO - PROCESS | 2763 | Values: 148.0 146.0 148.0 147.0 146.0 145.0 147.0 147.0 147.0 147.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:14:45 INFO - PROCESS | 2763 | Values: 95.0 95.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:55.50 stddev:6.72 (12.1%) stddev-sans-first:7.01 10:14:45 INFO - PROCESS | 2763 | Values: 55.0 55.0 55.0 55.0 55.0 56.0 64.0 75.0 61.0 53.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:1.29 (2.2%) stddev-sans-first:1.32 10:14:45 INFO - PROCESS | 2763 | Values: 57.0 57.0 58.0 57.0 59.0 58.0 57.0 57.0 58.0 61.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.50 stddev:1.48 (2.0%) stddev-sans-first:1.54 10:14:45 INFO - PROCESS | 2763 | Values: 73.0 73.0 72.0 73.0 74.0 75.0 75.0 77.0 73.0 73.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:124.00 stddev:7.52 (6.1%) stddev-sans-first:7.89 10:14:45 INFO - PROCESS | 2763 | Values: 124.0 117.0 112.0 124.0 113.0 120.0 126.0 111.0 134.0 127.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:157.50 stddev:3.47 (2.2%) stddev-sans-first:3.68 10:14:45 INFO - PROCESS | 2763 | Values: 157.0 161.0 161.0 161.0 158.0 155.0 153.0 153.0 154.0 153.0 10:14:45 INFO - PROCESS | 2763 | 10:14:45 INFO - PROCESS | 2763 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.42 (2.1%) stddev-sans-first:1.24 10:14:45 INFO - PROCESS | 2763 | Values: 68.0 66.0 64.0 66.0 68.0 64.0 65.0 65.0 65.0 66.0 10:14:45 INFO - PROCESS | 2763 | -------- Summary: end -------- 10:14:45 INFO - PROCESS | 2763 | 10:14:46 INFO - TEST-INFO | 2763: exit 0 10:14:46 INFO - TEST-OK | kraken | took 60648ms 10:14:46 INFO - SUITE-END | took 1169s 10:14:46 INFO - Completed test suite (00:19:29) 10:14:46 INFO - javascript benchmark 10:14:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3397.2186397128658, 3447.6035255945576, 3460.878869239577, 3490.773099748518, 3503.264314493956, 5742.770289188427, 5757.596968212227, 5770.047942089555, 5803.535717142629, 5839.270091238601, 5763.279590051244, 5785.450382213693, 5795.420457954203, 5818.912716309259, 5823.708814559266, 5173.793048278064, 5211.140161873286, 5266.578673706094, 5268.0780863348955, 5313.442088580701, 5166.147585648364, 5182.170852663575, 5348.331458567679, 5350.224217488462, 5361.061814182522, 5232.00591887542, 5273.367195936493, 5335.759890804904, 5341.252224688546, 5356.276902618136, 5249.973750131263, 5257.789688412459, 5258.92111618326, 5269.683818970836, 5282.603804714662, 5072.315237442972, 5101.0, 5163.328767260232, 5175.689458632494, 5186.299849520342, 5603.2715746953045, 5611.579131565108, 5630.042892708249, 5660.094384898396, 5672.40439753824, 6180.196574445338, 6182.381761823826, 6184.381561843779, 6192.411720886508, 6202.255729312466, 6001.639901605918, 6129.1419201311855, 6218.751249949996, 6248.87502249957, 6280.2777680566405, 5725.2843394575675, 5726.9140962886, 5728.770849166029, 5732.828015159552, 5775.740091695884, 6209.782657606962, 6241.843953901098, 6245.750169993149, 6255.249370075529, 6269.561130720897, 5894.440028197314, 5965.612235204698, 6040.546958978094, 6052.092186172109, 6075.756969721162, 6152.354002829638, 6153.323134455206, 6153.907691384633, 6176.413240742122, 6215.192025036807, 6000.33996260411, 6141.85471652979, 6150.323464418911, 6156.507479401637, 6189.597676151036, 5984.940150598525, 6039.818805435844, 6064.818055458343, 6067.726952287069, 6121.3572574879, 4610.608098311614, 4611.262198048364, 4611.608013318838, 4634.23535116702, 4659.254519276899, 4121.196366708523, 4126.051008268055, 4153.460050193456, 4155.0, 4156.210320039183, 5810.157527158538, 5862.208601838783, 5872.412758724094, 5920.052791553331, 6006.909896351558, 6104.328523862371, 6116.731440059295, 6185.659788711574, 6220.968895155495, 6225.564210505221, 5941.356096537, 5954.166416701665, 5978.3124940631515, 5992.011318132547, 6026.969865150734, 5184.792608295701, 5284.735763211824, 5318.335208098988, 5327.227552005015, 5350.357957045179, 6439.5170362223025, 6461.967690161613, 6468.482521398277, 6470.838229044311, 6477.319881412383, 6250.406211409818, 6267.592606480564, 6267.655278959701, 6269.185005949197, 6279.623222606659, 6144.3717414884195, 6279.780207692709, 6344.524160688059, 6392.93607063942, 6425.58233714807, 6093.29927058394, 6107.938920610737, 6115.1438798569125, 6121.908171377344, 6126.754929802758, 6052.939470605414, 6187.938120618736, 6198.876022479615, 6200.534959877937, 6210.441060304594, 5963.701814909324, 6046.183765191643, 6061.212042434456, 6084.7566097357385, 6094.085887116968, 5938.049912014057, 5968.731407086779, 5973.193618861572, 5978.372270911492, 6011.519078473799, 5669.54643628517, 5836.591438599257, 5836.912446313394, 5853.151293062397, 5883.499902508334, 6024.939750602438, 6056.697165141637, 6088.086786981989, 6089.025755879038, 6110.2550082019825, 5948.583599148191, 5953.047512397996, 5975.0, 5992.760289588542, 6024.427679370453], "value": 5682.900422942084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.8160755792156, 677.079172325637, 688.8140202145418, 728.6975904999425, 740.5519660605333, 39514.2097158057, 40484.39273410901, 40528.79735601318, 40711.796441017825, 40732.0, 42963.785181074054, 44063.33904991428, 44093.33859992103, 44116.3382549262, 44189.7790511047, 8910.910890891106, 9053.185213330798, 9067.727968160965, 9080.046595107484, 9082.636694532244, 8863.11368863115, 8891.733248002538, 8908.24279936203, 8956.373053886231, 8970.0, 9209.907900921005, 9216.815663686755, 9248.352615316931, 9275.814483710321, 9297.023812499692, 9118.40730352525, 9144.314176436761, 9146.085391460867, 9163.862542061874, 9173.082691730808, 9042.140996605378, 9087.909120908773, 9100.36297459178, 9108.316876234243, 9110.316726245557, 45025.54974450247, 45796.54203457956, 45809.0, 45848.77075614634, 45993.5400645996, 3939.03493644059, 3980.5621381647998, 4026.094128821021, 4084.326086195774, 4158.4178215049615, 33524.0, 33959.83020084884, 34257.314853703036, 34351.0, 35137.0, 4598.126355992351, 4646.9767651161865, 4673.182193116225, 4687.99208170245, 4760.714357138548, 332376.0, 332568.0, 333239.0, 336212.99999999756, 337661.0, 66831.66584167047, 67273.3272667267, 67403.3259667397, 67813.3218667807, 67948.66025669938, 71791.0, 73521.0, 73978.63010684912, 74148.25851741414, 74413.0, 19075.809241907682, 19473.0, 19529.511762205773, 19529.707054394195, 19584.412467625993, 14348.426062957573, 14408.063475874034, 14458.132512049311, 14461.49384771528, 14508.274586270643, 20589.48526286825, 20719.482012949797, 20950.26674066431, 20979.790202097785, 21915.452113696967, 7643.312101910855, 7696.461247712607, 7888.48724832884, 7926.207379262028, 8032.357411407191, 1163.4589915689246, 1180.5690922813112, 1181.8640856301463, 1210.2375503432957, 1245.3524167432884, 34221.82889085539, 34463.48304775431, 34586.654133458345, 34686.13284667853, 35076.82461587727, 1219.0735041368446, 1221.3648902570792, 1281.551456990046, 1283.595667364777, 1320.2276668149048, 17830.0, 17936.461906142835, 17958.0, 18139.274429022957, 18143.72784408235, 477427.0, 553818.0, 560657.0, 567320.0, 569371.0, 66062.66968665126, 67277.66361168162, 67286.32713672899, 67365.0, 67396.32603673999, 1539.7143385273423, 1556.9065856048674, 1560.6098475381154, 1568.2942675796166, 1587.1588058329105, 32449.83775081204, 32801.0, 33099.84150554719, 33245.50131748074, 33970.0, 56482.43517564772, 56934.14598781105, 57248.42751572431, 57638.423615763306, 57641.0, 431227.0, 434029.0, 434202.0, 434972.0, 436473.0, 32489.512657309686, 32579.34841303208, 32647.0, 33280.1679958003, 33304.33391332208, 52773.0, 52975.0, 53035.0, 53840.0, 54074.45925540852, 42607.337003998065, 44123.89690257769, 44203.33694994514, 45262.77368613136, 45674.0, 43644.56355436405, 43789.78105109454, 44942.3258651127, 44943.32585011293, 45546.0, 44822.775886121664, 45148.77425612851, 45604.543954561355, 46003.76998114988, 46742.0, 36127.27745445129, 38086.0, 38672.41991370188, 38817.0, 39015.219695606494, 29879.701202987693, 30438.239044024078, 30624.693753063075, 30812.22969425782, 31076.84461577768], "value": 21761.351325471816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.4507258173248, 430.264248135688, 434.3398034986818, 436.8143538995927, 438.82008376565614, 19074.809251907493, 19258.22967081317, 19353.0, 19732.802671973277, 19913.701294480594, 18938.526536836587, 19120.713189302172, 19355.225790968343, 19593.0, 19648.0, 5786.594938354307, 5832.620879642831, 5940.732667029994, 5962.73167707452, 5966.105084237356, 5868.471837534621, 5894.823155305347, 5906.675132867691, 5911.645301281916, 5931.495822855041, 5739.110437882114, 5857.85355366115, 5872.882542349151, 5925.7925972590965, 5952.136940143677, 5865.325487568942, 5865.560082993771, 5880.176775251468, 5896.97051514744, 5899.734511946973, 5269.367675878881, 5280.128778751501, 5312.150055991062, 5313.760880760375, 5348.866278343034, 24094.518109637884, 24268.878655606786, 24609.261722148363, 25025.874870625714, 25058.248252552454, 2570.9228723138335, 2717.701052884181, 2882.538793792983, 3154.41643295991, 3168.350488149924, 15344.846551534454, 15525.146116963562, 15775.368985240577, 15926.203689815462, 16144.354225830954, 2144.0673307111456, 2152.440365504964, 2169.8155656769195, 2170.6201414752354, 2214.557088582274, 80259.59870200611, 84032.0, 88547.0, 91576.54211728966, 92077.53961230151, 11098.944505277423, 11911.166218364804, 12112.273263604213, 12177.208481448855, 12280.754384912252, 17049.829501704826, 17145.399911003056, 17230.741538876926, 17247.74128388075, 17250.396236131925, 9331.16019558243, 9348.252139828797, 9385.38994965325, 9415.952920235355, 9569.138777510057, 9248.953755231181, 9413.105754953269, 9446.433214007044, 9473.952630236805, 9495.952520237355, 4962.950370496321, 5099.643024988215, 5113.565346945551, 5282.894342113136, 5297.284866542967, 2103.2533450625115, 2123.4094404826087, 2160.2547121243147, 2169.2949791317883, 2186.813186813187, 454.2981094209454, 464.6863367227108, 474.75312837324395, 974.7758015656296, 1043.9217058720626, 11235.59634858077, 12332.691682708004, 12434.067444941666, 12538.122331436713, 12664.113512054068, 471.2954133570266, 482.011875654913, 482.5415854937823, 494.1327969413656, 504.9621278404134, 6802.251752307341, 6807.183138023469, 6859.314068593101, 6871.14110736158, 6898.241193468714, 541625.0, 541839.0, 556342.0, 557885.0, 559223.0, 100745.49627251964, 102179.0, 103235.0, 103999.48000260102, 105190.0, 498.72570086452305, 499.0941441284058, 499.43563772937074, 506.09156563967764, 508.15392371701444, 11349.659510214708, 11438.485268162785, 11448.484818183035, 11493.54025838957, 11493.597724079616, 39615.603843962344, 40271.39592906168, 40792.79603601963, 41476.792616037936, 42135.15729685451, 53787.0, 55581.0, 57211.427885722274, 63406.0, 63766.36233637604, 8782.473051616924, 8884.86672699923, 9006.50464224474, 9050.592723327334, 9444.0, 9373.765655858659, 9592.184664303611, 9714.854277185988, 9714.902850971683, 9970.55132519024, 8549.615267312862, 8783.253423459077, 8861.73414797557, 9052.185303322469, 9080.591373388346, 8711.25954293892, 8908.55457227123, 8936.597853096497, 9021.548922553977, 9185.908140918506, 8960.551972401223, 9065.41074830134, 9072.682456114004, 9130.77173070652, 9443.480608566595, 13803.723925521634, 13898.791518127035, 13900.652483687989, 13983.650408739455, 14252.287385630885, 13819.032667713163, 13834.861651383357, 13969.720605587629, 14025.0, 14194.574162775134], "value": 8845.87102573456, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.299215353091, 1559.321695062648, 1789.5973405983655, 1942.6697461431556, 1944.7666280046387, 7713.807154821132, 8104.230098140667, 8491.91508084919, 8755.0, 8785.5607219639, 8523.232909038185, 8568.228859402652, 8606.0963598822, 8655.783605409852, 8671.86992195116, 2474.9876250618768, 2483.466054798218, 2504.3113143885485, 2504.5241404133158, 2512.849229046254, 2492.0779311654715, 2498.8875500602426, 2500.2624225853324, 2500.72492025877, 2506.523760485511, 2466.1615050882697, 2475.3192871960264, 2484.142970675114, 2485.7389974052644, 2486.1298545509107, 2419.9153029643876, 2431.57447446697, 2457.1031573475643, 2474.035126300744, 2478.281298423455, 2485.5774518331928, 2489.576771948773, 2512.773850353477, 2516.8615726135054, 2524.5077209943884, 8831.293496520262, 8874.955625221832, 8916.465012099296, 8923.063078376741, 8960.55197240142, 5441.83674489762, 5611.3266408031295, 5635.887282254332, 5650.350209725893, 5661.660300381949, 3628.51015112959, 3655.6527129922615, 3681.4293784463453, 3685.1524149445777, 3719.9070023249365, 1246.9314187719672, 1258.081600431681, 1265.259823003544, 1275.585434733706, 1289.374653293152, 12340.642529321767, 12393.194442361308, 12400.75198496025, 12417.565385211565, 12439.067069969698, 4574.794134263966, 4651.116287905287, 4669.299605059268, 4692.483826779052, 4722.811087556459, 9951.900480995242, 9970.750731231778, 9977.0, 9978.850317245247, 9984.701988741417, 5469.835904922858, 5486.094794358966, 5501.037318469252, 5503.2020357048, 5521.254630624894, 4456.442944631921, 5002.674826136289, 5031.169856973632, 5109.514596113363, 5113.590912726973, 4088.7546747195265, 4123.7523956492405, 4188.769617671057, 4204.488778054862, 4215.683823713233, 1217.1054275107788, 1217.592106644284, 1219.3232755820604, 1222.1506053292876, 1224.2715584227371, 1037.8339465685453, 1060.4008735064817, 1062.792755412687, 1066.386827574148, 1067.4022547373495, 5883.205767221456, 5965.075413310944, 6019.458248757633, 6021.42796434338, 6124.356942520971, 472.94324681038495, 474.17493561203946, 477.4080140625599, 480.7788417328068, 484.980600775965, 4123.299039163349, 4135.7518548887165, 4141.8964525886495, 4174.186033723456, 4200.537940826506, 10698.51856666452, 11120.499577519031, 11168.385738784282, 11174.720631984103, 11187.664370068911, 10907.236493445384, 10967.232293739362, 11071.889281107085, 11073.280236784583, 11099.389533575732, 7507.774766757006, 7725.690972361155, 7791.0, 8040.396970227256, 8147.79630509242, 5856.531477481706, 5888.0, 5945.0, 6003.979323514925, 6023.156758053964, 9125.0, 9276.768080798034, 9417.0, 9585.185259252763, 9633.807323853624, 9626.518674066408, 9750.414975101517, 9765.414075155513, 9778.36440631385, 9794.21646268311, 8040.839183216186, 8062.193780621891, 8186.877196841933, 8258.091609922783, 8331.083580806227, 8367.832643346977, 8398.916010839814, 8411.62147703367, 8448.408611397143, 8455.408121431441, 7465.3654439371085, 7594.278543538355, 7600.46796724224, 7746.457747957589, 7765.262300081483, 7605.847883042419, 7649.464537482323, 7660.961695191489, 7722.420818438527, 7769.067711874612, 7199.856002879808, 7222.74720384784, 7226.638668066471, 7236.710531578678, 7246.347828695442, 5362.785488580569, 5392.0, 5418.729063546728, 5464.961657285103, 5502.119660854244, 5110.616703747308, 5148.407933087743, 5229.973850130725, 5287.101192797157, 5314.548263397654], "value": 4666.5641494554475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.2010982598417, 321.0897106702498, 324.4079554812468, 351.3675384308246, 351.5939090350646, 6639.668016599169, 6702.497312701548, 6765.627890466022, 6818.897716534244, 6826.931730682698, 6663.833404164899, 6669.466442684586, 6685.164354455693, 6687.966560167192, 6689.297623749497, 4833.75831208439, 4919.581835543965, 4947.381577302837, 4960.454350021495, 4990.500949905017, 4976.154053810861, 4985.077760614298, 5000.0999820032375, 5009.04828082665, 5013.874653133683, 4942.061008408409, 4952.405711314629, 4955.331030310898, 4955.628327875405, 4975.029869175512, 4956.7025978441225, 4973.825916092956, 4974.77613507393, 4975.5522003019905, 4978.726170060663, 4305.935410968838, 4307.633851122659, 4311.805968731414, 4317.309230523133, 4319.373690814814, 6187.659678717669, 6328.968355158241, 6452.903206451907, 6456.451201647866, 6467.5472716909835, 5792.27596550427, 5806.390329015477, 5820.883582328372, 5824.475797178232, 5831.5334773218465, 7082.256363081854, 7088.71645134194, 7096.112985876765, 7107.502474826764, 7117.288271172842, 4778.784954677013, 4779.426468823764, 4779.856604301876, 4782.928256076161, 4786.329913812069, 7332.0468339116105, 7400.555966642019, 7412.666430010662, 7414.740484083085, 7421.035265415461, 4802.303665968415, 4881.658283920092, 4896.436909755353, 4904.288878112654, 4906.779194936165, 4925.655204135748, 4949.851504454872, 4950.975245123751, 4958.454569997298, 4963.8262660806695, 5782.277215348082, 5791.942080579141, 5796.594238403356, 5801.53587712982, 5804.1293805929445, 7108.182559005677, 7111.040009598742, 7113.359797618239, 7115.89326160108, 7118.644067796589, 1710.8973461592095, 1711.5549957011267, 1714.040137522991, 1715.1510002548819, 1718.613312004814, 1078.8219943709357, 1122.4892673833385, 1124.0557931337553, 1134.126722423729, 1141.0187238974474, 6901.102856628606, 6919.7232110715, 6925.58446493212, 6929.064576282238, 6938.41023512997, 7230.530015548972, 7294.0, 7303.926960730325, 7313.670884810196, 7320.341169294789, 6961.477889158334, 6967.1291088613925, 6994.8950765738555, 6998.650067496605, 7002.719891204397, 3979.8010099495486, 4018.738781979162, 4019.1559772448113, 4019.678425725935, 4024.215278020758, 7718.266764657348, 7738.767836964787, 7743.651535680908, 7747.573883436352, 7748.961255193688, 7279.1265048194555, 7483.363914067257, 7564.583947882809, 7566.281203285679, 7568.091828980558, 7612.352949999312, 7688.961555192188, 7702.075750909927, 7710.961445192738, 7727.65225564851, 7409.962950185214, 7414.332710056121, 7418.109826820816, 7420.591867447126, 7455.627218638938, 7280.817979550554, 7290.3438690518105, 7294.525855819567, 7305.598192099273, 7328.5969271690565, 7595.506292090997, 7642.04474440695, 7697.807554810951, 7713.382929365525, 7717.845643087219, 4871.34236878017, 4896.387951506062, 4923.852284431473, 4923.901521969612, 4936.827211047596, 7387.852242955219, 7394.112706475043, 7394.260573942563, 7395.482316237812, 7403.333699967029, 7148.535345202546, 7155.3202445767565, 7158.391536719437, 7162.391196748335, 7184.533005354635, 6976.720931162899, 7114.395276401564, 7130.643467826691, 7134.536255143399, 7166.713331466683, 6935.826604334932, 6939.167299924042, 6951.617661028489, 6962.9903663967425, 6972.825679358057, 7194.676239569337, 7209.675564599501, 7210.531315464478, 7210.675519601526, 7213.819654508679, 6961.0, 7022.2275549688475, 7023.051887995055, 7029.226785053742, 7031.226565077735], "value": 5301.502385268092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.6947837735169, 901.7970956534781, 912.3066469483191, 921.5806807902405, 926.7173512078813, 15167.848321516782, 15320.69358612827, 15337.309821058065, 16514.0, 17311.0, 16353.83646163538, 16389.754153687703, 16450.0, 16451.2596933138, 16485.67028659426, 914.1224424552421, 922.2299380017694, 926.5182105305237, 927.5918595817852, 943.3726571829759, 934.3693007220133, 935.4293880732747, 936.0125068053201, 937.1659223291276, 938.9906100939006, 975.1370037516778, 986.6448078691701, 987.279286121132, 991.9504024798767, 992.3004281981185, 970.1947383671571, 975.9268054895875, 976.3409698453515, 977.130353984954, 983.4246965525176, 720.1322406500154, 721.3183541553234, 722.9421646268286, 723.081686258454, 723.2658851265969, 16383.0, 16467.258973346226, 16483.175841208013, 16489.67020659592, 16496.587585310343, 14914.552563423114, 14995.526394273764, 15028.474003409829, 15098.320575574126, 15198.544043678707, 11660.12549058824, 11856.40717964107, 12319.0, 12428.75142497145, 12513.812292815615, 4009.910576412243, 4087.3664581989838, 4111.691623128278, 4117.97941010296, 4119.155573107506, 60580.39419605792, 61093.6945315275, 61152.0, 61193.082103768924, 61560.076598851054, 11398.430078496041, 11465.140114491447, 11610.129240307011, 11716.121290903217, 11758.647240582795, 21072.473188170417, 21103.26138585173, 21138.154473820876, 21183.0, 21260.149594016377, 7950.165232650604, 7975.680972761024, 7998.880016799752, 8039.316658084012, 8412.8317433651, 5064.873378165576, 5085.516875896784, 5116.104681680691, 5152.62503060496, 5274.525292723673, 3561.7506774525536, 3620.456931460302, 3621.2214373909737, 3624.7281453890537, 3625.3655610268097, 626.708580510065, 636.926753423353, 643.6781609195402, 644.9387308205713, 653.4315145823069, 734.9191588925214, 752.8080339513499, 842.8946381702287, 854.3208149521146, 863.2144748279036, 10133.290669653054, 10380.221483388625, 10524.26330156897, 10601.787964240671, 10627.734306642242, 745.470715791783, 793.3771988988616, 814.0321760048247, 848.1730312944952, 850.4812064640564, 4636.0, 4809.831655892027, 4871.707697538159, 4878.804847806048, 5001.19980803077, 64395.35604643894, 66633.0, 66687.33312666908, 67133.0, 67337.32662673408, 56520.71739641358, 57580.13629795556, 57591.42408575944, 57628.71185644045, 58125.709371452875, 51737.482625174016, 52054.21918671223, 52682.20976685353, 52714.0, 52918.20622690663, 9308.720738377859, 9411.29415293842, 9445.480498572644, 9555.761105972128, 9710.854337184806, 38933.41599876061, 39355.409668854416, 39650.60349396584, 40189.1962160761, 40618.0, 45467.0, 46336.304955425025, 49259.26111108265, 50605.74697126491, 51404.0, 11839.230450020721, 12024.819627705416, 12236.327002014974, 13045.412956416794, 13486.66283342885, 14182.951624850191, 14236.786448203493, 14518.927405362905, 14744.170758673032, 14785.778213326594, 13597.660058498617, 13683.315834208448, 13719.519816806363, 14129.929350353183, 14754.409823607364, 13593.958681912258, 13928.79106813419, 14078.929605351908, 14100.153990760587, 14578.489752858599, 11916.582919597773, 12910.031747618777, 13237.073404861952, 13323.13399629021, 13800.723985520433, 10959.232853700165, 11085.50115244832, 11224.035793736226, 11236.775264494501, 11750.059995200192, 10675.452059451181, 11049.779004419706, 11050.778984420427, 11132.777344453227, 11134.610288639858], "value": 7383.244244960058, "unit": "score"}], "name": "dromaeo_css", "value": 7646.213216742066, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 103.0, 111.0, 110.0, 111.0, 100.0, 110.0, 110.0, 110.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 125.0, 156.0, 182.0, 141.0, 155.0, 158.0, 127.0, 173.0, 134.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 161.0, 161.0, 163.0, 162.0, 163.0, 161.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 77.0, 168.0, 74.0, 75.0, 77.0, 74.0, 174.0, 75.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 155.0, 93.0, 92.0, 92.0, 156.0, 93.0, 92.0, 142.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 148.0, 147.0, 146.0, 145.0, 147.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 64.0, 75.0, 61.0, 53.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 59.0, 58.0, 57.0, 57.0, 58.0, 61.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 73.0, 74.0, 75.0, 75.0, 77.0, 73.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 117.0, 112.0, 124.0, 113.0, 120.0, 126.0, 111.0, 134.0, 127.0], "value": 120.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 161.0, 161.0, 158.0, 155.0, 153.0, 153.0, 154.0, 153.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 64.0, 66.0, 68.0, 64.0, 65.0, 65.0, 65.0, 66.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1519.4, "alertThreshold": 2.0}]} 10:14:46 INFO - Return code: 0 10:14:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:14:46 ERROR - # TBPL SUCCESS # 10:14:46 INFO - Running post-action listener: _resource_record_post_action 10:14:46 INFO - Running post-run listener: _resource_record_post_run 10:14:47 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 461799424; Read time: 204; Write time: 308440 10:14:47 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 242532352; Read time: 0; Write time: 197788 10:14:47 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 219267072; Read time: 204; Write time: 110652 10:14:47 INFO - Running post-run listener: _upload_blobber_files 10:14:47 INFO - Blob upload gear active. 10:14:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:14:47 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:47 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:47 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:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:14:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:14:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:14:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:49 INFO - (blobuploader) - INFO - Done attempting. 10:14:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:14:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:14:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:50 INFO - (blobuploader) - INFO - Done attempting. 10:14:50 INFO - (blobuploader) - INFO - Iteration through files over. 10:14:50 INFO - Return code: 0 10:14:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:14:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:14:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/803756f5e2c8916e46b7bb160ea6fc6e29bf93c4379e8249d0476de3a664ab9a7f8d15540ce267072d9bebde1bd8e327ab4fbf62208c0374e62c793f7d6a1116", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/896575599dc43e4d1d9aea3b58392401f57ff421b996617da9569aa892709e9f1b13b85bebc68933554a896db0f786d2f4689b62686d13814eaa99da643984ba"} 10:14:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:14:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:14:50 INFO - Contents: 10:14:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/803756f5e2c8916e46b7bb160ea6fc6e29bf93c4379e8249d0476de3a664ab9a7f8d15540ce267072d9bebde1bd8e327ab4fbf62208c0374e62c793f7d6a1116", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/896575599dc43e4d1d9aea3b58392401f57ff421b996617da9569aa892709e9f1b13b85bebc68933554a896db0f786d2f4689b62686d13814eaa99da643984ba"} 10:14:50 INFO - Running post-run listener: copy_logs_to_upload_dir 10:14:50 INFO - Copying logs to upload dir... 10:14:50 INFO - mkdir: /builds/slave/test/build/upload/logs 10:14:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.198573 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-23 10:14:50.025313) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:14:50.029058) ========= 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=eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/803756f5e2c8916e46b7bb160ea6fc6e29bf93c4379e8249d0476de3a664ab9a7f8d15540ce267072d9bebde1bd8e327ab4fbf62208c0374e62c793f7d6a1116", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/896575599dc43e4d1d9aea3b58392401f57ff421b996617da9569aa892709e9f1b13b85bebc68933554a896db0f786d2f4689b62686d13814eaa99da643984ba"} 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.011519 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/803756f5e2c8916e46b7bb160ea6fc6e29bf93c4379e8249d0476de3a664ab9a7f8d15540ce267072d9bebde1bd8e327ab4fbf62208c0374e62c793f7d6a1116", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/896575599dc43e4d1d9aea3b58392401f57ff421b996617da9569aa892709e9f1b13b85bebc68933554a896db0f786d2f4689b62686d13814eaa99da643984ba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:14:50.058042) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:14:50.058421) ========= 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=eca2ab57546de7b41f256b19000001ef-1466700659.632777-779194025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:14:50.139417) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:14:50.142809) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:14:50.143111) ========= ========= Total master_lag: 0.18 =========