builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1465236572.08 results: success (0) buildid: 20160606053329 builduid: d7acf4330f0b47b6844d82d15649fe74 revision: 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.077175) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.077744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.078123) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.086950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.087260) ========= 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=523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 11:09:32-- 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% 99.7M=0s 2016-06-06 11:09:32 (99.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116359 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.214382) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.214984) ========= 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=523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009632 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.262377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.262947) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 --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=523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 11:09:32,475 truncating revision to first 12 chars 2016-06-06 11:09:32,475 Setting DEBUG logging. 2016-06-06 11:09:32,475 attempt 1/10 2016-06-06 11:09:32,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5c8f37e61ac7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 11:09:32,790 unpacking tar archive at: mozilla-aurora-5c8f37e61ac7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.874688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.875059) ========= script_repo_revision: 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.875517) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.875852) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:09:32.882183) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-06-06 11:09:32.882501) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:09:33 INFO - MultiFileLogger online at 20160606 11:09:33 in /builds/slave/test 11:09:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:09:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:09:33 INFO - {'append_to_log': False, 11:09:33 INFO - 'base_work_dir': '/builds/slave/test', 11:09:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:09:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:09:33 INFO - 'branch': 'Mozilla-Aurora', 11:09:33 INFO - 'buildbot_json_path': 'buildprops.json', 11:09:33 INFO - 'config_files': ('talos/linux_config.py',), 11:09:33 INFO - 'default_actions': ('clobber', 11:09:33 INFO - 'read-buildbot-config', 11:09:33 INFO - 'download-and-extract', 11:09:33 INFO - 'populate-webroot', 11:09:33 INFO - 'create-virtualenv', 11:09:33 INFO - 'install', 11:09:33 INFO - 'run-tests'), 11:09:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:09:33 INFO - 'download_minidump_stackwalk': True, 11:09:33 INFO - 'download_symbols': 'ondemand', 11:09:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:09:33 INFO - 'tooltool.py': '/tools/tooltool.py', 11:09:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:09:33 INFO - '/tools/misc-python/virtualenv.py')}, 11:09:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:09:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:09:33 INFO - 'installer_path': 'installer.exe', 11:09:33 INFO - 'log_level': 'info', 11:09:33 INFO - 'log_name': 'talos', 11:09:33 INFO - 'log_to_console': True, 11:09:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:09:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:09:33 INFO - 'opt_config_files': (), 11:09:33 INFO - 'pip_index': False, 11:09:33 INFO - 'sps_profile': False, 11:09:33 INFO - 'sps_profile_interval': 0, 11:09:33 INFO - 'suite': 'dromaeojs-e10s', 11:09:33 INFO - 'system_bits': '32', 11:09:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:09:33 INFO - 'title': 'talos-linux64-ix-065', 11:09:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:09:33 INFO - 'use_talos_json': True, 11:09:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:09:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:09:33 INFO - 'work_dir': 'build'} 11:09:33 INFO - ##### 11:09:33 INFO - ##### Running clobber step. 11:09:33 INFO - ##### 11:09:33 INFO - Running pre-action listener: _resource_record_pre_action 11:09:33 INFO - Running main action method: clobber 11:09:33 INFO - rmtree: /builds/slave/test/build 11:09:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:09:34 INFO - Running post-action listener: _resource_record_post_action 11:09:34 INFO - ##### 11:09:34 INFO - ##### Running read-buildbot-config step. 11:09:34 INFO - ##### 11:09:34 INFO - Running pre-action listener: _resource_record_pre_action 11:09:34 INFO - Running main action method: read_buildbot_config 11:09:34 INFO - Using buildbot properties: 11:09:34 INFO - { 11:09:34 INFO - "project": "", 11:09:34 INFO - "product": "firefox", 11:09:34 INFO - "script_repo_revision": "production", 11:09:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:09:34 INFO - "repository": "", 11:09:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:09:34 INFO - "buildid": "20160606053329", 11:09:34 INFO - "pgo_build": "True", 11:09:34 INFO - "basedir": "/builds/slave/test", 11:09:34 INFO - "buildnumber": 390, 11:09:34 INFO - "slavename": "talos-linux64-ix-065", 11:09:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:09:34 INFO - "platform": "ubuntu64_hw", 11:09:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:09:34 INFO - "branch": "mozilla-aurora", 11:09:34 INFO - "repo_path": "releases/mozilla-aurora", 11:09:34 INFO - "revision": "5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64", 11:09:34 INFO - "stage_platform": "linux64-pgo", 11:09:34 INFO - "builduid": "d7acf4330f0b47b6844d82d15649fe74", 11:09:34 INFO - "slavebuilddir": "test" 11:09:34 INFO - } 11:09:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 11:09:34 INFO - Running post-action listener: _resource_record_post_action 11:09:34 INFO - ##### 11:09:34 INFO - ##### Running download-and-extract step. 11:09:34 INFO - ##### 11:09:34 INFO - Running pre-action listener: _resource_record_pre_action 11:09:34 INFO - Running main action method: download_and_extract 11:09:34 INFO - mkdir: /builds/slave/test/build/tests 11:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:34 INFO - https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:09:34 INFO - Downloaded 1361 bytes. 11:09:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:09:34 INFO - Using the following test package requirements: 11:09:34 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 11:09:34 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:09:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:09:34 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:09:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:09:34 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:09:34 INFO - u'jsshell-linux-x86_64.zip'], 11:09:34 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:09:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:09:34 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 11:09:34 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:09:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:09:34 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:09:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:09:34 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:09:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:09:34 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:09:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:09:34 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:34 INFO - https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:09:36 INFO - Downloaded 24176279 bytes. 11:09:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:09:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:09:37 INFO - Return code: 0 11:09:37 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:37 INFO - https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:09:38 INFO - Downloaded 24176279 bytes. 11:09:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:09:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:09:39 INFO - Return code: 0 11:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:39 INFO - https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:09:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:09:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:09:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:09:40 INFO - Downloaded 10840145 bytes. 11:09:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:09:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:09:41 INFO - Return code: 0 11:09:41 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')]} 11:09:41 INFO - https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:09:43 INFO - Downloaded 62799916 bytes. 11:09:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:09:43 INFO - mkdir: /builds/slave/test/properties 11:09:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:09:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:09:43 INFO - Contents: 11:09:43 INFO - build_url:https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:09:44 INFO - Running post-action listener: _resource_record_post_action 11:09:44 INFO - Running post-action listener: set_extra_try_arguments 11:09:44 INFO - ##### 11:09:44 INFO - ##### Running populate-webroot step. 11:09:44 INFO - ##### 11:09:44 INFO - Running pre-action listener: _resource_record_pre_action 11:09:44 INFO - Running main action method: populate_webroot 11:09:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:09:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:09:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:09:44 INFO - '--tppagecycles', 11:09:44 INFO - '7'], 11:09:44 INFO - 'tests': ['tsvgm']}}, 11:09:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:09:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:09:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:09:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:09:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:09:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:09:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:44 INFO - 'talos_options': ['--disable-e10s'], 11:09:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:44 INFO - 'talos_options': ['--disable-e10s'], 11:09:44 INFO - 'tests': ['damp', 'tps']}, 11:09:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:44 INFO - 'tests': ['damp', 'tps']}, 11:09:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:09:44 INFO - 'tests': ['dromaeo_dom']}, 11:09:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:09:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:09:44 INFO - 'tests': ['a11yr', 11:09:44 INFO - 'ts_paint', 11:09:44 INFO - 'tpaint', 11:09:44 INFO - 'sessionrestore', 11:09:44 INFO - 'sessionrestore_no_auto_restore', 11:09:44 INFO - 'tabpaint']}, 11:09:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:09:44 INFO - 'ts_paint', 11:09:44 INFO - 'tpaint', 11:09:44 INFO - 'sessionrestore', 11:09:44 INFO - 'sessionrestore_no_auto_restore', 11:09:44 INFO - 'tabpaint']}, 11:09:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:09:44 INFO - 'ts_paint', 11:09:44 INFO - 'tpaint', 11:09:44 INFO - 'sessionrestore', 11:09:44 INFO - 'sessionrestore_no_auto_restore', 11:09:44 INFO - 'tabpaint']}, 11:09:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:09:44 INFO - 'ts_paint', 11:09:44 INFO - 'tpaint', 11:09:44 INFO - 'sessionrestore', 11:09:44 INFO - 'sessionrestore_no_auto_restore', 11:09:44 INFO - 'tabpaint']}, 11:09:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:09:44 INFO - 'tests': ['a11yr', 11:09:44 INFO - 'ts_paint', 11:09:44 INFO - 'tpaint', 11:09:44 INFO - 'sessionrestore', 11:09:44 INFO - 'sessionrestore_no_auto_restore', 11:09:44 INFO - 'tabpaint']}, 11:09:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:09:44 INFO - 'tests': ['a11yr', 11:09:44 INFO - 'ts_paint', 11:09:44 INFO - 'tpaint', 11:09:44 INFO - 'sessionrestore', 11:09:44 INFO - 'sessionrestore_no_auto_restore', 11:09:44 INFO - 'tabpaint']}, 11:09:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:09:44 INFO - 'tests': ['tsvgx', 11:09:44 INFO - 'tsvgr_opacity', 11:09:44 INFO - 'tart', 11:09:44 INFO - 'tscrollx', 11:09:44 INFO - 'cart']}, 11:09:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:09:44 INFO - 'tsvgr_opacity', 11:09:44 INFO - 'tart', 11:09:44 INFO - 'tscrollx', 11:09:44 INFO - 'cart']}, 11:09:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:44 INFO - 'talos_options': ['--disable-e10s'], 11:09:44 INFO - 'tests': ['tp5o']}, 11:09:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:44 INFO - 'tests': ['tp5o']}, 11:09:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:44 INFO - 'talos_options': ['--disable-e10s', 11:09:44 INFO - '--xperf_path', 11:09:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:44 INFO - 'tests': ['tp5n']}, 11:09:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:44 INFO - 'talos_options': ['--xperf_path', 11:09:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:44 INFO - 'tests': ['tp5n']}}, 11:09:44 INFO - 'talos.zip': {'path': '', 11:09:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:09:44 INFO - Running post-action listener: _resource_record_post_action 11:09:44 INFO - ##### 11:09:44 INFO - ##### Running create-virtualenv step. 11:09:44 INFO - ##### 11:09:44 INFO - Running pre-action listener: _resource_record_pre_action 11:09:44 INFO - Running main action method: create_virtualenv 11:09:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:09:44 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 11:09:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:09:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:09:44 INFO - Using real prefix '/usr' 11:09:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:09:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:47 INFO - Installing pip.................done. 11:09:47 INFO - Return code: 0 11:09:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88055cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c92410>, '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 0x2c93310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c937a0>, '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': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', '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 11:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:09:47 INFO - Using env: {'DISPLAY': ':0', 11:09:47 INFO - 'HOME': '/home/cltbld', 11:09:47 INFO - 'LANG': 'en_US.UTF-8', 11:09:47 INFO - 'LANGUAGE': 'en_US:en', 11:09:47 INFO - 'LOGNAME': 'cltbld', 11:09:47 INFO - 'MAIL': '/var/mail/cltbld', 11:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:47 INFO - 'MOZ_NO_REMOTE': '1', 11:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:47 INFO - 'NO_EM_RESTART': '1', 11:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:47 INFO - 'PWD': '/builds/slave/test', 11:09:47 INFO - 'SHELL': '/bin/bash', 11:09:47 INFO - 'SHLVL': '1', 11:09:47 INFO - 'TERM': 'linux', 11:09:47 INFO - 'TMOUT': '86400', 11:09:47 INFO - 'USER': 'cltbld', 11:09:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', 11:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:47 INFO - '_': '/tools/buildbot/bin/python'} 11:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:47 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 11:09:47 INFO - Cleaning up... 11:09:47 INFO - Return code: 0 11:09:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f88055cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c92410>, '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 0x2c93310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c937a0>, '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': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', '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 11:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:09:47 INFO - Using env: {'DISPLAY': ':0', 11:09:47 INFO - 'HOME': '/home/cltbld', 11:09:47 INFO - 'LANG': 'en_US.UTF-8', 11:09:47 INFO - 'LANGUAGE': 'en_US:en', 11:09:47 INFO - 'LOGNAME': 'cltbld', 11:09:47 INFO - 'MAIL': '/var/mail/cltbld', 11:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:47 INFO - 'MOZ_NO_REMOTE': '1', 11:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:47 INFO - 'NO_EM_RESTART': '1', 11:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:47 INFO - 'PWD': '/builds/slave/test', 11:09:47 INFO - 'SHELL': '/bin/bash', 11:09:47 INFO - 'SHLVL': '1', 11:09:47 INFO - 'TERM': 'linux', 11:09:47 INFO - 'TMOUT': '86400', 11:09:47 INFO - 'USER': 'cltbld', 11:09:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', 11:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:47 INFO - '_': '/tools/buildbot/bin/python'} 11:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:47 INFO - Downloading/unpacking psutil>=0.7.1 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:49 INFO - Installing collected packages: psutil 11:09:49 INFO - Running setup.py install for psutil 11:09:49 INFO - building 'psutil._psutil_linux' extension 11:09:49 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 11:09:49 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 11:09:49 INFO - building 'psutil._psutil_posix' extension 11:09:49 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 11:09:49 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 11:09:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:49 INFO - Successfully installed psutil 11:09:49 INFO - Cleaning up... 11:09:49 INFO - Return code: 0 11:09:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:09: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')]} 11:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09: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')]} 11:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:49 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 0x7f88055cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c92410>, '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 0x2c93310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c937a0>, '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': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', '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 11:09:49 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 11:09:49 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 11:09:49 INFO - Using env: {'DISPLAY': ':0', 11:09:49 INFO - 'HOME': '/home/cltbld', 11:09:49 INFO - 'LANG': 'en_US.UTF-8', 11:09:49 INFO - 'LANGUAGE': 'en_US:en', 11:09:49 INFO - 'LOGNAME': 'cltbld', 11:09:49 INFO - 'MAIL': '/var/mail/cltbld', 11:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:49 INFO - 'MOZ_NO_REMOTE': '1', 11:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:49 INFO - 'NO_EM_RESTART': '1', 11:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:49 INFO - 'PWD': '/builds/slave/test', 11:09:49 INFO - 'SHELL': '/bin/bash', 11:09:49 INFO - 'SHLVL': '1', 11:09:49 INFO - 'TERM': 'linux', 11:09:49 INFO - 'TMOUT': '86400', 11:09:49 INFO - 'USER': 'cltbld', 11:09:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', 11:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:49 INFO - '_': '/tools/buildbot/bin/python'} 11:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:09:51 INFO - Installing collected packages: mozsystemmonitor 11:09:51 INFO - Running setup.py install for mozsystemmonitor 11:09:52 INFO - Successfully installed mozsystemmonitor 11:09:52 INFO - Cleaning up... 11:09:52 INFO - Return code: 0 11:09:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09: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')]} 11:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09: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')]} 11:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:52 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 0x7f88055cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c92410>, '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 0x2c93310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c937a0>, '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': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', '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 11:09:52 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 11:09:52 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 11:09:52 INFO - Using env: {'DISPLAY': ':0', 11:09:52 INFO - 'HOME': '/home/cltbld', 11:09:52 INFO - 'LANG': 'en_US.UTF-8', 11:09:52 INFO - 'LANGUAGE': 'en_US:en', 11:09:52 INFO - 'LOGNAME': 'cltbld', 11:09:52 INFO - 'MAIL': '/var/mail/cltbld', 11:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:52 INFO - 'MOZ_NO_REMOTE': '1', 11:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:52 INFO - 'NO_EM_RESTART': '1', 11:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:52 INFO - 'PWD': '/builds/slave/test', 11:09:52 INFO - 'SHELL': '/bin/bash', 11:09:52 INFO - 'SHLVL': '1', 11:09:52 INFO - 'TERM': 'linux', 11:09:52 INFO - 'TMOUT': '86400', 11:09:52 INFO - 'USER': 'cltbld', 11:09:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', 11:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:52 INFO - '_': '/tools/buildbot/bin/python'} 11:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:09:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:09:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:54 INFO - Downloading docopt-0.6.1.tar.gz 11:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:09:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:09:54 INFO - Running setup.py install for blobuploader 11:09:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:09:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:09:54 INFO - Running setup.py install for requests 11:09:55 INFO - Running setup.py install for docopt 11:09:55 INFO - Successfully installed blobuploader requests docopt 11:09:55 INFO - Cleaning up... 11:09:55 INFO - Return code: 0 11:09:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:55 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 0x7f88055cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c92410>, '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 0x2c93310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c937a0>, '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': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', '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 11:09:55 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 11:09:55 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 11:09:55 INFO - Using env: {'DISPLAY': ':0', 11:09:55 INFO - 'HOME': '/home/cltbld', 11:09:55 INFO - 'LANG': 'en_US.UTF-8', 11:09:55 INFO - 'LANGUAGE': 'en_US:en', 11:09:55 INFO - 'LOGNAME': 'cltbld', 11:09:55 INFO - 'MAIL': '/var/mail/cltbld', 11:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:55 INFO - 'MOZ_NO_REMOTE': '1', 11:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:55 INFO - 'NO_EM_RESTART': '1', 11:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:55 INFO - 'PWD': '/builds/slave/test', 11:09:55 INFO - 'SHELL': '/bin/bash', 11:09:55 INFO - 'SHLVL': '1', 11:09:55 INFO - 'TERM': 'linux', 11:09:55 INFO - 'TMOUT': '86400', 11:09:55 INFO - 'USER': 'cltbld', 11:09:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', 11:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:55 INFO - '_': '/tools/buildbot/bin/python'} 11:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:55 INFO - Running setup.py (path:/tmp/pip-fGcdHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:55 INFO - Running setup.py (path:/tmp/pip-GiH3Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:55 INFO - Running setup.py (path:/tmp/pip-8Vr0P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:55 INFO - Running setup.py (path:/tmp/pip-ERKBwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:55 INFO - Running setup.py (path:/tmp/pip-qUdjM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:55 INFO - Running setup.py (path:/tmp/pip-qV5Ukc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:55 INFO - Running setup.py (path:/tmp/pip-zaezD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:56 INFO - Running setup.py (path:/tmp/pip-fzw1Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:56 INFO - Running setup.py (path:/tmp/pip-t71tUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:56 INFO - Running setup.py (path:/tmp/pip-dMoeJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:56 INFO - Running setup.py (path:/tmp/pip-GU0Qwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:56 INFO - Running setup.py (path:/tmp/pip-lhxNIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:56 INFO - Running setup.py (path:/tmp/pip-tWA_2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:56 INFO - Running setup.py (path:/tmp/pip-ugnYZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:56 INFO - Running setup.py (path:/tmp/pip-WtcE3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:56 INFO - Running setup.py (path:/tmp/pip-854YIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:56 INFO - Running setup.py (path:/tmp/pip-V9Vbmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:09:56 INFO - Running setup.py install for manifestparser 11:09:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Running setup.py install for mozcrash 11:09:56 INFO - Running setup.py install for mozdebug 11:09:56 INFO - Running setup.py install for mozdevice 11:09:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Running setup.py install for mozfile 11:09:57 INFO - Running setup.py install for mozhttpd 11:09:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Running setup.py install for mozinfo 11:09:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Running setup.py install for mozInstall 11:09:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Running setup.py install for mozleak 11:09:57 INFO - Running setup.py install for mozlog 11:09:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Running setup.py install for moznetwork 11:09:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Running setup.py install for mozprocess 11:09:57 INFO - Running setup.py install for mozprofile 11:09:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Running setup.py install for mozrunner 11:09:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Running setup.py install for mozscreenshot 11:09:57 INFO - Running setup.py install for moztest 11:09:58 INFO - Running setup.py install for mozversion 11:09:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:09:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:09:58 INFO - Cleaning up... 11:09:58 INFO - Return code: 0 11:09:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:58 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 0x7f88055cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c92410>, '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 0x2c93310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c937a0>, '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': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', '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 11:09:58 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 11:09:58 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 11:09:58 INFO - Using env: {'DISPLAY': ':0', 11:09:58 INFO - 'HOME': '/home/cltbld', 11:09:58 INFO - 'LANG': 'en_US.UTF-8', 11:09:58 INFO - 'LANGUAGE': 'en_US:en', 11:09:58 INFO - 'LOGNAME': 'cltbld', 11:09:58 INFO - 'MAIL': '/var/mail/cltbld', 11:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:58 INFO - 'MOZ_NO_REMOTE': '1', 11:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:58 INFO - 'NO_EM_RESTART': '1', 11:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:58 INFO - 'PWD': '/builds/slave/test', 11:09:58 INFO - 'SHELL': '/bin/bash', 11:09:58 INFO - 'SHLVL': '1', 11:09:58 INFO - 'TERM': 'linux', 11:09:58 INFO - 'TMOUT': '86400', 11:09:58 INFO - 'USER': 'cltbld', 11:09:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', 11:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:58 INFO - '_': '/tools/buildbot/bin/python'} 11:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:58 INFO - Running setup.py (path:/tmp/pip-VU5spj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:58 INFO - Running setup.py (path:/tmp/pip-AjjxTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:58 INFO - Running setup.py (path:/tmp/pip-IlGiSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:58 INFO - Running setup.py (path:/tmp/pip-F5hdLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:58 INFO - Running setup.py (path:/tmp/pip-dWVoMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:58 INFO - Running setup.py (path:/tmp/pip-nXKSRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:58 INFO - Running setup.py (path:/tmp/pip-FEjmjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:58 INFO - Running setup.py (path:/tmp/pip-Ehcvp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:58 INFO - Running setup.py (path:/tmp/pip-X7yYWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:58 INFO - Running setup.py (path:/tmp/pip-M52daU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:58 INFO - Running setup.py (path:/tmp/pip-8n_ra9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:59 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)) 11:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:59 INFO - Running setup.py (path:/tmp/pip-vBqg7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:59 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)) 11:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:59 INFO - Running setup.py (path:/tmp/pip-jLOiHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:59 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)) 11:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:59 INFO - Running setup.py (path:/tmp/pip-7gkPDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:59 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)) 11:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:59 INFO - Running setup.py (path:/tmp/pip-exLQ4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:59 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)) 11:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:59 INFO - Running setup.py (path:/tmp/pip-8dEMm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:59 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)) 11:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:59 INFO - Running setup.py (path:/tmp/pip-j4UYFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:59 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)) 11:09:59 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)) 11:09:59 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)) 11:09:59 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)) 11:09:59 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)) 11:09:59 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)) 11:09:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:10:01 INFO - Downloading blessings-1.6.tar.gz 11:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:10:01 INFO - Installing collected packages: blessings 11:10:01 INFO - Running setup.py install for blessings 11:10:01 INFO - Successfully installed blessings 11:10:01 INFO - Cleaning up... 11:10:01 INFO - Return code: 0 11:10:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:10:01 INFO - Reading from file tmpfile_stdout 11:10:01 INFO - Current package versions: 11:10:01 INFO - argparse == 1.2.1 11:10:01 INFO - blessings == 1.6 11:10:01 INFO - blobuploader == 1.2.4 11:10:01 INFO - docopt == 0.6.1 11:10:01 INFO - manifestparser == 1.1 11:10:01 INFO - mozInstall == 1.12 11:10:01 INFO - mozcrash == 0.17 11:10:01 INFO - mozdebug == 0.1 11:10:01 INFO - mozdevice == 0.48 11:10:01 INFO - mozfile == 1.2 11:10:01 INFO - mozhttpd == 0.7 11:10:01 INFO - mozinfo == 0.9 11:10:01 INFO - mozleak == 0.1 11:10:01 INFO - mozlog == 3.1 11:10:01 INFO - moznetwork == 0.27 11:10:01 INFO - mozprocess == 0.22 11:10:01 INFO - mozprofile == 0.28 11:10:01 INFO - mozrunner == 6.11 11:10:01 INFO - mozscreenshot == 0.1 11:10:01 INFO - mozsystemmonitor == 0.0 11:10:01 INFO - moztest == 0.7 11:10:01 INFO - mozversion == 1.4 11:10:01 INFO - psutil == 3.1.1 11:10:01 INFO - requests == 1.2.3 11:10:01 INFO - wsgiref == 0.1.2 11:10:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:10:01 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')]} 11:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:01 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')]} 11:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:01 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 0x7f88055cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c92410>, '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 0x2c93310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c937a0>, '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': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', '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 11:10:01 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 11:10:01 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 11:10:01 INFO - Using env: {'DISPLAY': ':0', 11:10:01 INFO - 'HOME': '/home/cltbld', 11:10:01 INFO - 'LANG': 'en_US.UTF-8', 11:10:01 INFO - 'LANGUAGE': 'en_US:en', 11:10:01 INFO - 'LOGNAME': 'cltbld', 11:10:01 INFO - 'MAIL': '/var/mail/cltbld', 11:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:01 INFO - 'MOZ_NO_REMOTE': '1', 11:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:01 INFO - 'NO_EM_RESTART': '1', 11:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:01 INFO - 'PWD': '/builds/slave/test', 11:10:01 INFO - 'SHELL': '/bin/bash', 11:10:01 INFO - 'SHLVL': '1', 11:10:01 INFO - 'TERM': 'linux', 11:10:01 INFO - 'TMOUT': '86400', 11:10:01 INFO - 'USER': 'cltbld', 11:10:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', 11:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:01 INFO - '_': '/tools/buildbot/bin/python'} 11:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:01 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)) 11:10:01 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)) 11:10:01 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)) 11:10:01 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)) 11:10:01 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)) 11:10:01 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)) 11:10:01 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)) 11:10:01 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)) 11:10:01 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)) 11:10:01 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)) 11:10:01 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)) 11:10:01 INFO - Cleaning up... 11:10:01 INFO - Return code: 0 11:10:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:10:01 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')]} 11:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:01 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')]} 11:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:01 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 0x7f88055cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c92410>, '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 0x2c93310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c937a0>, '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': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', '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 11:10:01 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 11:10:01 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 11:10:01 INFO - Using env: {'DISPLAY': ':0', 11:10:01 INFO - 'HOME': '/home/cltbld', 11:10:01 INFO - 'LANG': 'en_US.UTF-8', 11:10:01 INFO - 'LANGUAGE': 'en_US:en', 11:10:01 INFO - 'LOGNAME': 'cltbld', 11:10:01 INFO - 'MAIL': '/var/mail/cltbld', 11:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:01 INFO - 'MOZ_NO_REMOTE': '1', 11:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:01 INFO - 'NO_EM_RESTART': '1', 11:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:01 INFO - 'PWD': '/builds/slave/test', 11:10:01 INFO - 'SHELL': '/bin/bash', 11:10:01 INFO - 'SHLVL': '1', 11:10:01 INFO - 'TERM': 'linux', 11:10:01 INFO - 'TMOUT': '86400', 11:10:01 INFO - 'USER': 'cltbld', 11:10:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', 11:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:01 INFO - '_': '/tools/buildbot/bin/python'} 11:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:02 INFO - Downloading/unpacking jsonschema 11:10:02 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 11:10:02 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 11:10:02 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 11:10:02 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 11:10:02 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 11:10:02 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 11:10:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:10:03 INFO - Downloading/unpacking functools32 (from jsonschema) 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:10:04 INFO - warning: no files found matching '*.txt' 11:10:04 INFO - no previously-included directories found matching 'build' 11:10:04 INFO - no previously-included directories found matching 'dist' 11:10:04 INFO - no previously-included directories found matching '.git*' 11:10:04 INFO - Installing collected packages: jsonschema, functools32 11:10:04 INFO - Running setup.py install for functools32 11:10:04 INFO - warning: no files found matching '*.txt' 11:10:04 INFO - no previously-included directories found matching 'build' 11:10:04 INFO - no previously-included directories found matching 'dist' 11:10:04 INFO - no previously-included directories found matching '.git*' 11:10:04 INFO - Successfully installed jsonschema functools32 11:10:04 INFO - Cleaning up... 11:10:04 INFO - Return code: 0 11:10:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:10:04 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')]} 11:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:04 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')]} 11:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:04 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 0x7f88055cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c92410>, '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 0x2c93310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c937a0>, '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': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', '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 11:10:04 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 11:10:04 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 11:10:04 INFO - Using env: {'DISPLAY': ':0', 11:10:04 INFO - 'HOME': '/home/cltbld', 11:10:04 INFO - 'LANG': 'en_US.UTF-8', 11:10:04 INFO - 'LANGUAGE': 'en_US:en', 11:10:04 INFO - 'LOGNAME': 'cltbld', 11:10:04 INFO - 'MAIL': '/var/mail/cltbld', 11:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:04 INFO - 'MOZ_NO_REMOTE': '1', 11:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:04 INFO - 'NO_EM_RESTART': '1', 11:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:04 INFO - 'PWD': '/builds/slave/test', 11:10:04 INFO - 'SHELL': '/bin/bash', 11:10:04 INFO - 'SHLVL': '1', 11:10:04 INFO - 'TERM': 'linux', 11:10:04 INFO - 'TMOUT': '86400', 11:10:04 INFO - 'USER': 'cltbld', 11:10:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', 11:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:04 INFO - '_': '/tools/buildbot/bin/python'} 11:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:04 INFO - Downloading/unpacking flake8 11:10:04 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 11:10:04 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 11:10:04 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 11:10:04 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 11:10:04 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 11:10:04 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 11:10:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:10:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:10:06 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 11:10:06 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 11:10:06 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 11:10:06 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 11:10:06 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 11:10:06 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 11:10:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:10:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:10:06 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 11:10:06 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 11:10:06 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 11:10:06 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 11:10:06 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 11:10:06 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 11:10:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:10:06 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 11:10:06 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 11:10:06 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 11:10:06 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 11:10:06 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 11:10:06 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 11:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:10:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:10:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:10:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:10:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:10:07 INFO - no previously-included directories found matching 'docs/_build' 11:10:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:10:07 INFO - Running setup.py install for pep8 11:10:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:10:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:10:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:10:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:10:07 INFO - no previously-included directories found matching 'docs/_build' 11:10:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:10:07 INFO - Cleaning up... 11:10:07 INFO - Return code: 0 11:10:07 INFO - Running post-action listener: _resource_record_post_action 11:10:07 INFO - Running post-action listener: _start_resource_monitoring 11:10:07 INFO - Starting resource monitoring. 11:10:07 INFO - ##### 11:10:07 INFO - ##### Running install step. 11:10:07 INFO - ##### 11:10:07 INFO - Running pre-action listener: _resource_record_pre_action 11:10:07 INFO - Running main action method: install 11:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:10:07 INFO - Reading from file tmpfile_stdout 11:10:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:10:07 INFO - Reading from file tmpfile_stdout 11:10:07 INFO - Output received: 11:10:07 INFO - Usage: mozinstall [options] installer 11:10:07 INFO - Options: 11:10:07 INFO - -h, --help show this help message and exit 11:10:07 INFO - -d DEST, --destination=DEST 11:10:07 INFO - Directory to install application into. [default: 11:10:07 INFO - "/builds/slave/test"] 11:10:07 INFO - --app=APP Application being installed. [default: firefox] 11:10:07 INFO - mkdir: /builds/slave/test/build/application 11:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:10:23 INFO - Reading from file tmpfile_stdout 11:10:23 INFO - Output received: 11:10:23 INFO - /builds/slave/test/build/application/firefox/firefox 11:10:23 INFO - Running post-action listener: _resource_record_post_action 11:10:23 INFO - ##### 11:10:23 INFO - ##### Running run-tests step. 11:10:23 INFO - ##### 11:10:23 INFO - Running pre-action listener: _resource_record_pre_action 11:10:23 INFO - Running main action method: run_tests 11:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:10:23 INFO - Python 2.7.3 11:10:23 INFO - Return code: 0 11:10:23 INFO - grabbing minidump binary from tooltool 11:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:23 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 0x2c92410>, '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 0x2c93310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c937a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:10:23 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 11:10:23 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 11:10:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:10:23 INFO - Return code: 0 11:10:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:10:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:10:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:10:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:10:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:10:24 INFO - Return code: 0 11:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 11:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 11:10:24 INFO - Using env: {'DISPLAY': ':0', 11:10:24 INFO - 'HOME': '/home/cltbld', 11:10:24 INFO - 'LANG': 'en_US.UTF-8', 11:10:24 INFO - 'LANGUAGE': 'en_US:en', 11:10:24 INFO - 'LOGNAME': 'cltbld', 11:10:24 INFO - 'MAIL': '/var/mail/cltbld', 11:10:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:10:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:24 INFO - 'MOZ_NO_REMOTE': '1', 11:10:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:24 INFO - 'NO_EM_RESTART': '1', 11:10:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:24 INFO - 'PWD': '/builds/slave/test', 11:10:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:10:24 INFO - 'SHELL': '/bin/bash', 11:10:24 INFO - 'SHLVL': '1', 11:10:24 INFO - 'TERM': 'linux', 11:10:24 INFO - 'TMOUT': '86400', 11:10:24 INFO - 'USER': 'cltbld', 11:10:24 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843', 11:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:24 INFO - '_': '/tools/buildbot/bin/python'} 11:10:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 11:10:24 INFO - mozversion application_buildid: 20160606053329 11:10:24 INFO - mozversion application_changeset: 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 11:10:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:10:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:10:24 INFO - mozversion application_name: Firefox 11:10:24 INFO - mozversion application_remotingname: firefox-dev 11:10:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:10:24 INFO - mozversion application_vendor: Mozilla 11:10:24 INFO - mozversion application_version: 48.0a2 11:10:24 INFO - mozversion platform_buildid: 20160606053329 11:10:24 INFO - mozversion platform_changeset: 5c8f37e61ac7af86accd5d86f6c9d10cd0eadf64 11:10:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:10:24 INFO - mozversion platform_version: 48.0a2 11:10:24 INFO - using testdate: 1465236624 11:10:24 INFO - actual date: 1465236624 11:10:24 INFO - starting webserver on 'localhost:35479' 11:10:24 INFO - SUITE-START | Running 2 tests 11:10:24 INFO - TEST-START | dromaeo_css 11:10:24 INFO - operating with platform_type : linux_ 11:10:24 INFO - Initialising browser for dromaeo_css test... 11:10:24 INFO - TEST-INFO | started process 22259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFt3vf/profile http://localhost:35479/getInfo.html) 11:10:27 INFO - PROCESS | 22259 | 11:10:27 INFO - PROCESS | 22259 | (process:22338): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:10:28 INFO - PROCESS | 22259 | __metrics Screen width/height:1600/1200 11:10:28 INFO - PROCESS | 22259 | colorDepth:24 11:10:28 INFO - PROCESS | 22259 | Browser inner width/height: 1024/697 11:10:28 INFO - PROCESS | 22259 | __metrics 11:10:29 ERROR - PROCESS | 22259 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 11:10:29 INFO - TEST-INFO | 22259: exit 0 11:10:29 INFO - Browser initialized. 11:10:29 INFO - Running cycle 1/1 for dromaeo_css test... 11:10:29 INFO - TEST-INFO | started process 22389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFt3vf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:31 INFO - PROCESS | 22389 | 11:10:31 INFO - PROCESS | 22389 | (process:22458): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:10:41 INFO - PROCESS | 22389 | RSS: Main: 151240704 11:10:41 INFO - PROCESS | 22389 | 11:11:30 INFO - PROCESS | 22389 | 1465236690894 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] 11:13:38 INFO - PROCESS | 22389 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35479/tests/dromaeo/cssquery-ext.html) 11:13:39 INFO - PROCESS | 22389 | RSS: Main: 155074560 11:13:39 INFO - PROCESS | 22389 | 11:16:40 INFO - PROCESS | 22389 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-ext.html (next: http://localhost:35479/tests/dromaeo/cssquery-jquery.html) 11:16:41 INFO - PROCESS | 22389 | RSS: Main: 153116672 11:16:41 INFO - PROCESS | 22389 | 11:19:43 INFO - PROCESS | 22389 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35479/tests/dromaeo/cssquery-mootools.html) 11:19:43 INFO - PROCESS | 22389 | RSS: Main: 152879104 11:19:43 INFO - PROCESS | 22389 | 11:22:45 INFO - PROCESS | 22389 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35479/tests/dromaeo/cssquery-prototype.html) 11:22:46 INFO - PROCESS | 22389 | RSS: Main: 152309760 11:22:46 INFO - PROCESS | 22389 | 11:25:48 INFO - PROCESS | 22389 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35479/tests/dromaeo/cssquery-yui.html) 11:25:48 INFO - PROCESS | 22389 | RSS: Main: 154095616 11:25:48 INFO - PROCESS | 22389 | 11:28:51 INFO - PROCESS | 22389 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-yui.html (next: http://localhost:35479/tests/dromaeo/cssquery-dojo.html) 11:28:51 INFO - PROCESS | 22389 | RSS: Main: 154947584 11:28:51 INFO - PROCESS | 22389 | 11:28:51 INFO - PROCESS | 22389 | __start_tp_report 11:28:51 INFO - PROCESS | 22389 | _x_x_mozilla_page_load 11:28:51 INFO - PROCESS | 22389 | _x_x_mozilla_page_load_details 11:28:51 INFO - PROCESS | 22389 | |i|pagename|runs| 11:28:51 INFO - PROCESS | 22389 | |0;dojo.html;3289.9013029609114;3316.618588862281;3331.034000139958;3350.6816852399043;3393.6097348804897;5448.8365349039495;5497.8075767348155;5507.366652834925;5507.4767897049815;5542.806001789938;5474.698891560963;5500;5503.642263252886;5530.557555395569;5537.390887002437;4935.136351138554;4994.300797888299;5078.5175408336145;5090.287359769617;5127.692338459686;4846.878828029292;4925.7537123143875;4945.604351651878;5130.563902068328;5189.42916279209;5042.445331013586;5080;5127.948720512803;5150.613703972217;5154.201098829669;5074.999999999982;5084.669496482717;5106.259592359106;5111;5131.1277082895995;4786.329913812069;4861.829835955725;4993.151164302078;5019.14674505335;5048.318477005594;5203.505666961632;5243.659162154448;5245.26566280721;5279.944011197737;5328.280682107905;5679.772809087632;5755.856103597402;5769.0192667246665;5778.942210577925;5793.391693872167;5837.153612726131;5843.795467158629;5971.910421343683;6066.514678825683;6071.028635418356;5432.837014889559;5453.590980676426;5483.7806487740445;5491.121420572729;5514.779408823602;5928.903152916724;5931.377205393458;5933.080372542263;5934.495567876779;5936.762529498858;5036.345275114285;5464.480874316933;5760.74076666551;5830.067189249699;5881.264841894763;5787.2476578045425;5879.470847623735;5898.292204935436;5899.46904778572;5905.40945905406;5845.678487683218;5848.181254624356;5883.735231914574;5887.8233652990475;5896;5865.648061116347;5873.119032145212;5900.793472228452;5912.970435147797;5918.822435326947;4449.154660614473;4512.909741805145;4518.525554816762;4526.366308716782;4540.750258735801;3952.8418863245724;3981.5819338969573;4010.939835902464;4017.0961533654695;4092;5561.944380556142;5712.428757124254;5713.457221563945;5733.741981610838;5741.971290143522;5875.941240587625;5899.646021238739;5902.61632993854;5911.9113213301835;5913.319968203712;5403.243545903577;5534.75093620788;5597.216389705444;5615;5615.578831587565;4964.379452568429;4964.478729733398;5023.648344615842;5029.06962211992;5045.217991211368;5932.3474417814;6010.038393856962;6010.879782404328;6031.668258245751;6046.667433291123;5804.361520232856;5825.271841019872;5880.411958804086;5964.343922168471;5983.760649574142;6087.391260873877;6091.177691011834;6123.14276001369;6149.877002459836;6156.661383623944;5821.563382746226;5838.970805145947;5885.94114058871;5887.793927212699;5913.940860591339;5760.798372057126;5807.303123625192;5817.505512031525;5863.706814659336;5868.2664666916635;5802.071668533014;5808.07070868659;5845.912311315419;5851.21008663825;5869.735861886311;5613.438656134354;5781.017227071324;5806.390329015561;5806.738696758572;5815.621984570989;5725.799597014085;5730.942690573041;5746.138079287973;5763.366029736641;5764.654120752768;5686.175504551734;5723;5771.826845194651;5788.131780232999;5790.218320526675;5515.283013208257;5696.458836410535;5706.915686019643;5710.600257982068;5711.571632127524 11:28:51 INFO - PROCESS | 22389 | |1;ext.html;595.4432605513842;649.2533586375667;650.5283669339732;662.7978466567698;665.663839760921;39414.40878386827;40351.59648403515;40385.7980710096;40444.19111617766;40478.59521404785;42354.57645423545;42829.357559636555;43028.354574681405;43102.491412800555;43193.7840310798;8663.48019118855;8764.43031202973;8776.60505277264;8777.2100510954;8787.340949428786;8593;8694.434861733998;8707.390482666184;8712.172343627377;8772.03507614162;8852.5573721314;8958.776030599221;9015.549222538879;9022.954885225598;9045.954770226139;8888;8956.507392093432;8958.507282099481;8980.191782739552;9011.098890111001;8867.379283450096;8920.420172688755;8954.910450895539;8961.641534338618;8988.011318754932;41848.58151418477;42235.36646950298;42353.364699529535;42547.78726106381;42752.3587146193;3576.2311103112697;3724.1062145085257;3771.9057023574355;3808.1622043150464;4172.332426811726;32217.51673724896;32473;32620.673793262238;32622.347553048807;33303.66696333054;4489;4534.31985202219;4541.682082254243;4553.567411095941;4564.1328147652175;219995;220767;221876;221893.89053054794;222592;38627.22745545073;59216.70391648014;60052.09921851176;60234;60338;37029.629703703155;37140.44289335662;37238.8138059308;37384;37392.25215495675;16813.327466901188;16886.74669879953;16899.493015209562;17044.744328835077;17057.402990895258;14011.369488373048;14066.507672231422;14096.295185240697;14110.85889141116;14133.293335333192;8969.282457403391;8999.280057595377;9013.504257265782;9056.818863622691;9083.091690830865;3572.696320812708;3577.94633080504;3587.192881601619;3609.9458508122398;3628.129248980226;1125.876153623101;1146.8623765148068;1204.3978010994504;1220.9145359824904;1267.3916520070418;32166;32602.673973260436;32628.347433051207;33363.332733345196;33666;1198.820176973461;1212.805951047828;1229.932353720554;1270.964164206169;1386.8058471813954;16877.40929067477;16978.660426791394;17227.3970411035;17265.309387624606;17302.394416195624;503180;520906;560487;570672;609332;56460.435395645516;57012.42987570071;57227.42772572304;57309.71345143248;57695.42304576984;1514.5986313626897;1527.3585094260438;1529.587011506887;1531.089002043782;1572.701186774509;29611.555826662185;30683.693163068085;30811.691883080883;31292;33106.83446582752;52542.474575255284;52830.735846320524;53285.7335713319;53420.4657953431;53454.73272633767;448936;450390;452217;452456;453980;29395.85302073476;29727.405451891274;30079.398412032075;30139.69860301369;30350.696493034786;46922.29616555686;47332.05335893332;47792;48303.516964829905;48901;40722.59277407306;40922.59077409188;40982.59017409788;41822.163556729305;42530.57469425266;40570.59429405668;41010.17979640331;41703.58296416997;42370.364444533974;43416.56583434125;37836.24327513379;38482.230355393294;38956;39140.60859391483;39435.40846887356;33297;33821.32357352888;33935.83032084824;34283.828580856934;34572.13569660779;27790.305242369104;28566.714332856405;28608.856955715088;28696.569551456327;28846.278843029093 11:28:51 INFO - PROCESS | 22389 | |2;jquery.html;430.44257686296254;434.7652267775401;435.2929668394795;438.05598934296603;449.68971409727305;18151.909240453795;18322.175502102404;18441.893486390825;18868.716969245474;18917.52706182346;18270.269189232447;18653.440396788083;18735.62528749424;19608.803911960877;19622.117004734784;5290.788368465257;5295.4704529546925;5446.264754258164;5454.699991500466;5461.808836690717;5399.406065332811;5423.891522169554;5445.319335083114;5469.972650136744;5472.20653005314;5273.288106105684;5481.725913704299;5494.203340515623;5509.944900550983;5534.0592099343;5479.260299859528;5513.5864810139;5529.723513824333;5545.611807173499;5549.223108764776;5347.82347883465;5412.512873841373;5418.91871621926;5439.728013599304;5446.1558458439;14218.28908554568;14505;14669.70660586793;14700.191489468076;16274.593135171597;2464.938376540583;2530.9493810123695;2534.9873250633814;2551.285640020797;2620.3842097107163;10225.181985441146;10275.845862312071;10759.193060520493;13476.93261533686;14485.985980981335;2071.3475255294534;2117.68234764785;2167.7398712154486;2171.5873983943;2172.945676358088;78853.21146788573;82533.17466825375;83082;83130;84261.57869210615;11214.775704486028;11919.165658404001;12028.63914082579;12156.209846359958;12687.238765674088;16247.67504649924;16405.933614315032;16407.507774766775;16432.178391080397;16486.917565412336;8903.06517815633;8975.820483590292;8985.146411090936;8988.820223595492;9103.089691030844;8846.203841654282;8873.73378798624;8897.421667591585;8952.462852228888;8979;5043.697378157322;5108.463611320833;5109.08036553424;5129.358830146231;5165.767540460688;2090.916363345449;2114.418534902883;2175.738911330619;2179.6294629912954;2187.9453013674784;986.2849434160177;1018.8624535687587;1097.8353247013013;1183.1599564309436;1184.9526018959318;18404.35584754527;19177.904110479638;19265.614687706166;19386;19584.902075489532;1060.7083052160563;1073.9624113156;1078.9244752867223;1101.2566517600749;1111.222144498854;10903.400312982862;11125;11216.66350009501;11221.158413118885;11243.269187502787;500860;519098;519158;522824;533912;86081;87452.5627371859;89730.55134724284;101038;103260.48369758253;1072.9409882456384;1102.0962810495316;1102.399192440122;1105.1379923659558;1123.2867129373071;16817.495475135765;18273.908630457296;18304.633907321513;18351.908240458713;18503.35238266654;37753.81123094367;39071.218575628896;40594.67809099187;40637.390439142844;41149.79425102975;53655.19517207323;57640.135397968224;58095.41904581069;58180.70909645594;58628;9144.63421463134;9214.901201161965;9275.814483710154;9323.86014209801;9507.382020168943;13643.249621270925;14011.08927919682;14135.222562759147;14283.71432571322;14374.640633984234;11639.941800290944;11672.241304315192;11868.287902725864;12272.938635306766;12284.324362160167;12290.770922907637;12416.813747793609;12422.813657794959;12556.748865022832;12657.050721195763;11565.653030409101;11750.94124529372;11899.76200476003;12011.81982270284;12478.126531143096;9165.220956218796;9213.815723685355;9230.492322922304;9372.34393592442;9433.764155896157;8857.468551886908;10855.891441085803;10983.340999540053;11315.20793544444;11342.20604557673 11:28:51 INFO - PROCESS | 22389 | |3;mootools.html;1311.0887932886642;1364.7202323523675;1452.527928423262;1841.0058568373088;1849.6763066463366;7273.418126549876;7686.308232259095;7904.367650587954;8098.271155596002;8130.796730081751;7962.960185199066;8013;8040.155783642721;8041.035075790899;8060;2306.2504685977;2340.871252081135;2341.016772955354;2341.4146463384154;2342.0397636968846;2278.4076140203583;2316.8494047886916;2347.6947996760396;2369.8104151667826;2374.76252374762;2308.411355104446;2333.3349995251356;2344.0272287000876;2365.2076554354226;2371.6323969784626;2325.6046472099615;2329.406001469623;2334.369720175543;2343.7773411525877;2368.585497537941;2338.4270853640796;2340.6723058771786;2353.1058197884695;2364.066193853418;2370.7510711375403;8196.54918979456;8213.753587392388;8223.671053157866;8227.465214761021;8245.83508329836;5099.4900509949075;5142.357205349332;5185.585153187736;5201.869953251161;5236.947630523722;3436.3127374524943;3471.2363280078594;3489.6510348965153;3539.4159963605975;3554.59122200945;1096.8903109689047;1203.2900588652737;1234.3026190202506;1237.189640785287;1242.9502819887193;11175;11218.831717524243;11252.49363778632;11269.436528173559;11529.538818447252;4479.260921947907;4519.909601807945;4585.243434833282;4589.908201836011;4593.793279302439;9747;9761.463119528353;9770.511474426392;9778.31551791382;9814.950925245328;5314.73426328682;5324.4675532446445;5328.49379308965;5338.252644629755;5360.731963401892;4502.482214545304;4553.772311384418;4664.113818374566;4696;4850.054239423349;3735.3836616957897;3782.981085094557;3784.7729136251914;3823.770573765583;3837.5394952605866;1127.2391135983178;1127.9887201128047;1137.70988397958;1162.7965106106396;1162.8720840707515;947.7820101376584;1038.1539045677748;1046.5133712823574;1055.6516349604613;1059.8357254625546;5904.7933322334375;6023.45788879003;6097;6157.291911430153;6278.6860656966965;993.1409330928694;1008.8991100889853;1013.1945103642622;1018.9847152292722;1086.6522712732008;4121.835126594902;4162.791860406967;4214.199302132585;4229.238737027365;4277.700560960765;9852.655157069468;10030.949845250727;10151.543180556893;10183.33808302458;10189.9810018999;9831.115199631924;9950.751231219278;9962.750931226632;10002.749931251632;10032.69901902944;7331.450141239322;7596.582187979714;7619.4285428593075;7686.961565192139;7754.92245077542;5791.768329266951;5860.501857342174;5956.225690660186;5986.491148252448;6057.697115144313;8607.784805379915;8620.396572239883;8636.740897773077;8760.649574016968;8868.600912959062;8577.742667719978;8641.438306510057;8738.91261087381;8771.16673915977;9050.637974480947;6761.661916904037;7312.268773122645;7539.962300188464;7670.654820532978;7755.2632499912415;7655.157932627518;7659.4255430841795;7687.769366919001;7704.26809453101;7737.690492380467;6923.238443771081;7070.964645176741;7097.964510177416;7137.393321567725;7154;6760.797176084725;6788.694508747217;6837.487188460786;6877.484188685969;6973.721051157897;6549.214094308523;6596.835079122869;6651.43462805667;6745.5952642841585;6774.491913106635;4972.428170760264;4999.475055119306;5023.7739301732245;5037.949620503748;5151;4941.6293777966075;4977.328060711758;4992.550670439678;5007.749612519432;5058.696478211319 11:28:51 INFO - PROCESS | 22389 | |4;prototype.html;346.9757117001809;349.1707195410899;356.39057212167194;360.2165290493177;365.51751687772145;6545.5418120731565;6589;6597.670116494174;6624.933750662492;6753.628550429725;6533.934660653392;6535.11775910252;6535.575187612813;6557.082008518812;6566.080748695174;4650.000249946261;4784.138855006097;4879.804807807684;4906.460289368167;4921.163402221631;4887.095887260851;4890.095332363507;4890.902181956359;4906.681065730716;4920.065187614359;4854;4856.05306965142;4857.538533839297;4858.368412106422;4860.927086093711;4853.660243782919;4865.586425153866;4867.659263851532;4867.805287788502;4869.488703686097;4248.086661367821;4251.107267473834;4262.829486820523;4264.616184543375;4276.973526353684;6138.685516290982;6148.477379422754;6248;6252.218472690914;6278.937210627881;5702.686352250625;5721.226419809872;5733.455321744469;5733.541316694655;5751.942480575224;6787.947868080455;6811.386975172209;6813.3527314905;6814.284500127515;6829.692663830139;4731.219348807443;4733.431988161408;4741.502142275046;4746.4541577718655;4769.475357710649;7130.786076417716;7157.6063316517575;7166.498345115844;7177.605231712254;7182.569045857265;4591.081783643284;4684.976575117103;4688.765561721969;4690.929636055462;4928.6303527235605;4714.972561798391;4762.97596016858;4773.7374444405195;4775.737334446639;4779.426468823764;5566.526845218121;5600.803971860965;5603.047481928082;5604.719764011783;5614.859628509238;6924.826879328057;6936.306369363023;6955.339242771928;6956.165260168711;6962.721491140399;1684.0485125903824;1710.0167403742898;1712.8458438740572;1713.6144367517209;1730.8009578898336;1095.6001059613343;1103.2167161315394;1122.7698321844002;1128.0693427921997;1139.7948369293606;6741.157355330583;6742.056112144303;6745.2242992056545;6746.460283177432;6767.763128290486;7086.50394472382;7193.964030179815;7211.062561866924;7221.855562888818;7277.090363704537;6818.556793808486;6830.077939478107;6887.414569761526;6887.586744795329;6908.723651054002;3886.1644746379666;3927.4108883667677;3938.8621398250925;3946.7829269389886;3946.881593552198;7670.27132422419;7693.923060769433;7722.189170137167;7765.883511747328;7779.611019449118;7284.453665975073;7377.852442951111;7413.851722965511;7436.628168591549;7449.14334851499;7463.552186868806;7466.290702383265;7473.813154671177;7509.324160825552;7715.189905060112;7333.816654583465;7337.192908780136;7337.229590892879;7340.67867783804;7345.412367010733;7132.144142702701;7145.356917877416;7157.997880296867;7181.317774811385;7190.71237150529;7449.739259125905;7531.849363012819;7538.509996850187;7580.507267027626;7587.62061896914;4805.183118869871;4807.351007613927;4822.987172693774;4823.5658790709;4837.927431088607;7293.781186564412;7295.598742069024;7307.1231452226075;7314.597697126709;7322.633868306457;6954.860902781815;6974.825629359307;6997.160340759141;7042.190148132825;7051.083359163276;6821.147356580427;6956.95645653156;7017.578945263096;7046.154461464657;7059.788206353817;6855.383015528626;6857.108575885302;6860.211075726355;6860.4168645663685;6896.137982752156;6982.546134501241;7030.718771249298;7033.296670332926;7035.437165026683;7035.964820175866;6809.89785153233;6819.522633415613;6822.181338239443;6834.829129271808;6860.588364698134 11:28:51 INFO - PROCESS | 22389 | |5;yui.html;794.4835856693153;794.7854079398562;842.2546046748625;873.9774463877263;939.2861425316759;14667.559973200809;15367.769483457758;15572.065676059445;15644.687106257868;15701.136437495934;14138.858611413883;14244.643883902907;14280.000399972007;14391.136531808099;14398.208098554602;893.5219657483248;909.790748127931;912.32943786317;913.4427998920653;933.7432206143297;920.9915142918494;932.1889955738517;932.3100905330041;933.351320832022;939.2908354192609;943.3349488610513;948.3172116076414;955.7180631713626;960.865478832964;961.7307153996892;935.2985261054209;935.822193783179;940.5626383731563;945.985810212844;948.4356807699407;698.4272896225098;699.7935608995358;699.9720011199546;702.0382076555101;702.3292755418563;14219.004669673128;14257.85742142586;14259.928700356535;14289.428422863073;14325.426982920671;14359.353829077716;14626.999999999893;14724.926375368163;14759;14774.26128693561;11417.724781190807;11498.367589782558;11661.358625275607;11704.707382315424;12060.216085954473;3968.1666849961543;4001.2597669431248;4046.8785936421955;4060.4518390017265;4061.776602286873;58031.41968580303;58567.414325856626;60163;60175.69912150455;60593.394066058776;11207;11233.775324493465;11266.380349080715;11318.717032074264;11442.599509017144;20438.79561204369;20481.89759051195;20533;20575.176992920115;20656.896715516326;8615.91384086151;8664.8700269496;8666.523341216167;8692.478451292942;8847.51338676379;4938.506149385104;5029.119904016782;5040.8658051938755;5069.518395752471;5092.592592592584;3517.8592856285463;3587.497750314958;3614.2410093880053;3622.529071220777;3637.1998160405196;690.0718533572438;690.975815846453;691.5263044814318;699.5383047188831;706.2372637551432;712.6294326949957;716.4304378019488;753.5365750063671;793.0523024985088;816.808050108224;9055.637774488947;9289.72130836076;10021.849672254923;10331.571120936123;10351.585936562453;627.802242293676;693.874726947441;722.0757430488983;740.6185814305637;809.9190080991972;4485.327200919823;4548.295014272793;4787.784549695202;4976.1757610797285;4991.67554108989;64805;66618.66690666613;66869.6656516724;66873.33126668769;66950.33049669539;52564.47435525672;53751;56547.71726141343;58305.70847145737;60260.69869650624;51530.48469515332;52212.47787522152;52424.21363679548;52652.47347526476;53049.73475132677;9713.271504637321;9941.801163976825;10195;10235.894468526512;10289.794204115726;37372.2525549482;37482.812585936896;37653.435198471496;38217;39225.411618826314;46328.76835615935;48959.510404895496;49111.75444122899;49352.25971610501;50862.23706644477;12764.079706084845;12795.232286062866;12796.296203708886;12886.90461310799;13092.214467132002;14190.716185676436;14345.64135896611;14433.134011959317;14473.348699308346;14509.637259068608;13389.397477113358;13424.194548327132;13466.461341546228;13656.317184140555;13688.65778355549;13331.533396331082;13859.514916977858;13904.51334203298;13911.304434778423;13968.58094257174;13147.474101035852;13197.274149921846;13275.66810829737;13360.732785344433;13486.12340197884;11137.610183643534;11274.323540587591;11294.49174787153;11370.886291136983;11507.482163302839;11149.832752508557;11410;11520.94239528797;11611.825822612498;11659.067274618179 11:28:51 INFO - PROCESS | 22389 | __end_tp_report 11:28:51 INFO - PROCESS | 22389 | __start_cc_report 11:28:51 INFO - PROCESS | 22389 | _x_x_mozilla_cycle_collect,290 11:28:51 INFO - PROCESS | 22389 | __end_cc_report 11:28:51 INFO - PROCESS | 22389 | __startTimestamp1465237731296__endTimestamp 11:28:51 INFO - PROCESS | 22389 | 11:28:51 INFO - PROCESS | 22389 | ------- Summary: start ------- 11:28:51 INFO - PROCESS | 22389 | Number of tests: 6 11:28:51 INFO - PROCESS | 22389 | 11:28:51 INFO - PROCESS | 22389 | [#0] dojo.html Cycles:165 Average:5464.30 Median:5713.46 stddev:601.90 (10.5%) stddev-sans-first:579.07 11:28:51 INFO - PROCESS | 22389 | Values: 3289.9 3316.6 3331.0 3350.7 3393.6 5448.8 5497.8 5507.4 5507.5 5542.8 5474.7 5500.0 5503.6 5530.6 5537.4 4935.1 4994.3 5078.5 5090.3 5127.7 4846.9 4925.8 4945.6 5130.6 5189.4 5042.4 5080.0 5127.9 5150.6 5154.2 5075.0 5084.7 5106.3 5111.0 5131.1 4786.3 4861.8 4993.2 5019.1 5048.3 5203.5 5243.7 5245.3 5279.9 5328.3 5679.8 5755.9 5769.0 5778.9 5793.4 5837.2 5843.8 5971.9 6066.5 6071.0 5432.8 5453.6 5483.8 5491.1 5514.8 5928.9 5931.4 5933.1 5934.5 5936.8 5036.3 5464.5 5760.7 5830.1 5881.3 5787.2 5879.5 5898.3 5899.5 5905.4 5845.7 5848.2 5883.7 5887.8 5896.0 5865.6 5873.1 5900.8 5913.0 5918.8 4449.2 4512.9 4518.5 4526.4 4540.8 3952.8 3981.6 4010.9 4017.1 4092.0 5561.9 5712.4 5713.5 5733.7 5742.0 5875.9 5899.6 5902.6 5911.9 5913.3 5403.2 5534.8 5597.2 5615.0 5615.6 4964.4 4964.5 5023.6 5029.1 5045.2 5932.3 6010.0 6010.9 6031.7 6046.7 5804.4 5825.3 5880.4 5964.3 5983.8 6087.4 6091.2 6123.1 6149.9 6156.7 5821.6 5839.0 5885.9 5887.8 5913.9 5760.8 5807.3 5817.5 5863.7 5868.3 5802.1 5808.1 5845.9 5851.2 5869.7 5613.4 5781.0 5806.4 5806.7 5815.6 5725.8 5730.9 5746.1 5763.4 5764.7 5686.2 5723.0 5771.8 5788.1 5790.2 5515.3 5696.5 5706.9 5710.6 5711.6 11:28:51 INFO - PROCESS | 22389 | 11:28:51 INFO - PROCESS | 22389 | [#1] ext.html Cycles:180 Average:56431.81 Median:40646.59 stddev:115296.20 (283.7%) stddev-sans-first:115543.41 11:28:51 INFO - PROCESS | 22389 | Values: 595.4 649.3 650.5 662.8 665.7 39414.4 40351.6 40385.8 40444.2 40478.6 42354.6 42829.4 43028.4 43102.5 43193.8 8663.5 8764.4 8776.6 8777.2 8787.3 8593.0 8694.4 8707.4 8712.2 8772.0 8852.6 8958.8 9015.5 9023.0 9046.0 8888.0 8956.5 8958.5 8980.2 9011.1 8867.4 8920.4 8954.9 8961.6 8988.0 41848.6 42235.4 42353.4 42547.8 42752.4 3576.2 3724.1 3771.9 3808.2 4172.3 32217.5 32473.0 32620.7 32622.3 33303.7 4489.0 4534.3 4541.7 4553.6 4564.1 219995.0 220767.0 221876.0 221893.9 222592.0 38627.2 59216.7 60052.1 60234.0 60338.0 37029.6 37140.4 37238.8 37384.0 37392.3 16813.3 16886.7 16899.5 17044.7 17057.4 14011.4 14066.5 14096.3 14110.9 14133.3 8969.3 8999.3 9013.5 9056.8 9083.1 3572.7 3577.9 3587.2 3609.9 3628.1 1125.9 1146.9 1204.4 1220.9 1267.4 32166.0 32602.7 32628.3 33363.3 33666.0 1198.8 1212.8 1229.9 1271.0 1386.8 16877.4 16978.7 17227.4 17265.3 17302.4 503180.0 520906.0 560487.0 570672.0 609332.0 56460.4 57012.4 57227.4 57309.7 57695.4 1514.6 1527.4 1529.6 1531.1 1572.7 29611.6 30683.7 30811.7 31292.0 33106.8 52542.5 52830.7 53285.7 53420.5 53454.7 448936.0 450390.0 452217.0 452456.0 453980.0 29395.9 29727.4 30079.4 30139.7 30350.7 46922.3 47332.1 47792.0 48303.5 48901.0 40722.6 40922.6 40982.6 41822.2 42530.6 40570.6 41010.2 41703.6 42370.4 43416.6 37836.2 38482.2 38956.0 39140.6 39435.4 33297.0 33821.3 33935.8 34283.8 34572.1 27790.3 28566.7 28608.9 28696.6 28846.3 11:28:51 INFO - PROCESS | 22389 | 11:28:51 INFO - PROCESS | 22389 | [#2] jquery.html Cycles:180 Average:29822.46 Median:2172.27 stddev:85493.66 (3935.7%) stddev-sans-first:85705.01 11:28:51 INFO - PROCESS | 22389 | Values: 430.4 434.8 435.3 438.1 449.7 18151.9 18322.2 18441.9 18868.7 18917.5 18270.3 18653.4 18735.6 19608.8 19622.1 5290.8 5295.5 5446.3 5454.7 5461.8 5399.4 5423.9 5445.3 5470.0 5472.2 5273.3 5481.7 5494.2 5509.9 5534.1 5479.3 5513.6 5529.7 5545.6 5549.2 5347.8 5412.5 5418.9 5439.7 5446.2 14218.3 14505.0 14669.7 14700.2 16274.6 2464.9 2530.9 2535.0 2551.3 2620.4 10225.2 10275.8 10759.2 13476.9 14486.0 2071.3 2117.7 2167.7 2171.6 2172.9 78853.2 82533.2 83082.0 83130.0 84261.6 11214.8 11919.2 12028.6 12156.2 12687.2 16247.7 16405.9 16407.5 16432.2 16486.9 8903.1 8975.8 8985.1 8988.8 9103.1 8846.2 8873.7 8897.4 8952.5 8979.0 5043.7 5108.5 5109.1 5129.4 5165.8 2090.9 2114.4 2175.7 2179.6 2187.9 986.3 1018.9 1097.8 1183.2 1185.0 18404.4 19177.9 19265.6 19386.0 19584.9 1060.7 1074.0 1078.9 1101.3 1111.2 10903.4 11125.0 11216.7 11221.2 11243.3 500860.0 519098.0 519158.0 522824.0 533912.0 86081.0 87452.6 89730.6 101038.0 103260.5 1072.9 1102.1 1102.4 1105.1 1123.3 16817.5 18273.9 18304.6 18351.9 18503.4 37753.8 39071.2 40594.7 40637.4 41149.8 53655.2 57640.1 58095.4 58180.7 58628.0 9144.6 9214.9 9275.8 9323.9 9507.4 13643.2 14011.1 14135.2 14283.7 14374.6 11639.9 11672.2 11868.3 12272.9 12284.3 12290.8 12416.8 12422.8 12556.7 12657.1 11565.7 11750.9 11899.8 12011.8 12478.1 9165.2 9213.8 9230.5 9372.3 9433.8 8857.5 10855.9 10983.3 11315.2 11342.2 11:28:51 INFO - PROCESS | 22389 | 11:28:51 INFO - PROCESS | 22389 | [#3] mootools.html Cycles:180 Average:5467.71 Median:5030.86 stddev:2922.21 (58.1%) stddev-sans-first:2913.70 11:28:51 INFO - PROCESS | 22389 | Values: 1311.1 1364.7 1452.5 1841.0 1849.7 7273.4 7686.3 7904.4 8098.3 8130.8 7963.0 8013.0 8040.2 8041.0 8060.0 2306.3 2340.9 2341.0 2341.4 2342.0 2278.4 2316.8 2347.7 2369.8 2374.8 2308.4 2333.3 2344.0 2365.2 2371.6 2325.6 2329.4 2334.4 2343.8 2368.6 2338.4 2340.7 2353.1 2364.1 2370.8 8196.5 8213.8 8223.7 8227.5 8245.8 5099.5 5142.4 5185.6 5201.9 5236.9 3436.3 3471.2 3489.7 3539.4 3554.6 1096.9 1203.3 1234.3 1237.2 1243.0 11175.0 11218.8 11252.5 11269.4 11529.5 4479.3 4519.9 4585.2 4589.9 4593.8 9747.0 9761.5 9770.5 9778.3 9815.0 5314.7 5324.5 5328.5 5338.3 5360.7 4502.5 4553.8 4664.1 4696.0 4850.1 3735.4 3783.0 3784.8 3823.8 3837.5 1127.2 1128.0 1137.7 1162.8 1162.9 947.8 1038.2 1046.5 1055.7 1059.8 5904.8 6023.5 6097.0 6157.3 6278.7 993.1 1008.9 1013.2 1019.0 1086.7 4121.8 4162.8 4214.2 4229.2 4277.7 9852.7 10030.9 10151.5 10183.3 10190.0 9831.1 9950.8 9962.8 10002.7 10032.7 7331.5 7596.6 7619.4 7687.0 7754.9 5791.8 5860.5 5956.2 5986.5 6057.7 8607.8 8620.4 8636.7 8760.6 8868.6 8577.7 8641.4 8738.9 8771.2 9050.6 6761.7 7312.3 7540.0 7670.7 7755.3 7655.2 7659.4 7687.8 7704.3 7737.7 6923.2 7071.0 7098.0 7137.4 7154.0 6760.8 6788.7 6837.5 6877.5 6973.7 6549.2 6596.8 6651.4 6745.6 6774.5 4972.4 4999.5 5023.8 5037.9 5151.0 4941.6 4977.3 4992.6 5007.7 5058.7 11:28:51 INFO - PROCESS | 22389 | 11:28:51 INFO - PROCESS | 22389 | [#4] prototype.html Cycles:180 Average:5805.55 Median:6743.64 stddev:1807.65 (26.8%) stddev-sans-first:1765.68 11:28:51 INFO - PROCESS | 22389 | Values: 347.0 349.2 356.4 360.2 365.5 6545.5 6589.0 6597.7 6624.9 6753.6 6533.9 6535.1 6535.6 6557.1 6566.1 4650.0 4784.1 4879.8 4906.5 4921.2 4887.1 4890.1 4890.9 4906.7 4920.1 4854.0 4856.1 4857.5 4858.4 4860.9 4853.7 4865.6 4867.7 4867.8 4869.5 4248.1 4251.1 4262.8 4264.6 4277.0 6138.7 6148.5 6248.0 6252.2 6278.9 5702.7 5721.2 5733.5 5733.5 5751.9 6787.9 6811.4 6813.4 6814.3 6829.7 4731.2 4733.4 4741.5 4746.5 4769.5 7130.8 7157.6 7166.5 7177.6 7182.6 4591.1 4685.0 4688.8 4690.9 4928.6 4715.0 4763.0 4773.7 4775.7 4779.4 5566.5 5600.8 5603.0 5604.7 5614.9 6924.8 6936.3 6955.3 6956.2 6962.7 1684.0 1710.0 1712.8 1713.6 1730.8 1095.6 1103.2 1122.8 1128.1 1139.8 6741.2 6742.1 6745.2 6746.5 6767.8 7086.5 7194.0 7211.1 7221.9 7277.1 6818.6 6830.1 6887.4 6887.6 6908.7 3886.2 3927.4 3938.9 3946.8 3946.9 7670.3 7693.9 7722.2 7765.9 7779.6 7284.5 7377.9 7413.9 7436.6 7449.1 7463.6 7466.3 7473.8 7509.3 7715.2 7333.8 7337.2 7337.2 7340.7 7345.4 7132.1 7145.4 7158.0 7181.3 7190.7 7449.7 7531.8 7538.5 7580.5 7587.6 4805.2 4807.4 4823.0 4823.6 4837.9 7293.8 7295.6 7307.1 7314.6 7322.6 6954.9 6974.8 6997.2 7042.2 7051.1 6821.1 6957.0 7017.6 7046.2 7059.8 6855.4 6857.1 6860.2 6860.4 6896.1 6982.5 7030.7 7033.3 7035.4 7036.0 6809.9 6819.5 6822.2 6834.8 6860.6 11:28:51 INFO - PROCESS | 22389 | 11:28:51 INFO - PROCESS | 22389 | [#5] yui.html Cycles:180 Average:15770.02 Median:4273.55 stddev:18189.85 (425.6%) stddev-sans-first:18206.11 11:28:51 INFO - PROCESS | 22389 | Values: 794.5 794.8 842.3 874.0 939.3 14667.6 15367.8 15572.1 15644.7 15701.1 14138.9 14244.6 14280.0 14391.1 14398.2 893.5 909.8 912.3 913.4 933.7 921.0 932.2 932.3 933.4 939.3 943.3 948.3 955.7 960.9 961.7 935.3 935.8 940.6 946.0 948.4 698.4 699.8 700.0 702.0 702.3 14219.0 14257.9 14259.9 14289.4 14325.4 14359.4 14627.0 14724.9 14759.0 14774.3 11417.7 11498.4 11661.4 11704.7 12060.2 3968.2 4001.3 4046.9 4060.5 4061.8 58031.4 58567.4 60163.0 60175.7 60593.4 11207.0 11233.8 11266.4 11318.7 11442.6 20438.8 20481.9 20533.0 20575.2 20656.9 8615.9 8664.9 8666.5 8692.5 8847.5 4938.5 5029.1 5040.9 5069.5 5092.6 3517.9 3587.5 3614.2 3622.5 3637.2 690.1 691.0 691.5 699.5 706.2 712.6 716.4 753.5 793.1 816.8 9055.6 9289.7 10021.8 10331.6 10351.6 627.8 693.9 722.1 740.6 809.9 4485.3 4548.3 4787.8 4976.2 4991.7 64805.0 66618.7 66869.7 66873.3 66950.3 52564.5 53751.0 56547.7 58305.7 60260.7 51530.5 52212.5 52424.2 52652.5 53049.7 9713.3 9941.8 10195.0 10235.9 10289.8 37372.3 37482.8 37653.4 38217.0 39225.4 46328.8 48959.5 49111.8 49352.3 50862.2 12764.1 12795.2 12796.3 12886.9 13092.2 14190.7 14345.6 14433.1 14473.3 14509.6 13389.4 13424.2 13466.5 13656.3 13688.7 13331.5 13859.5 13904.5 13911.3 13968.6 13147.5 13197.3 13275.7 13360.7 13486.1 11137.6 11274.3 11294.5 11370.9 11507.5 11149.8 11410.0 11520.9 11611.8 11659.1 11:28:51 INFO - PROCESS | 22389 | -------- Summary: end -------- 11:28:51 INFO - PROCESS | 22389 | 11:28:51 INFO - TEST-INFO | 22389: exit 0 11:28:51 INFO - TEST-OK | dromaeo_css | took 1107167ms 11:28:51 INFO - TEST-START | kraken 11:28:51 INFO - operating with platform_type : linux_ 11:28:51 INFO - Initialising browser for kraken test... 11:28:51 INFO - TEST-INFO | started process 22634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqrEx2F/profile http://localhost:35479/getInfo.html) 11:28:54 INFO - PROCESS | 22634 | 11:28:54 INFO - PROCESS | 22634 | (process:22711): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:28:55 INFO - PROCESS | 22634 | __metrics Screen width/height:1600/1200 11:28:55 INFO - PROCESS | 22634 | colorDepth:24 11:28:55 INFO - PROCESS | 22634 | Browser inner width/height: 1024/697 11:28:55 INFO - PROCESS | 22634 | __metrics 11:28:56 ERROR - PROCESS | 22634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 11:28:57 INFO - TEST-INFO | 22634: exit 0 11:28:57 INFO - Browser initialized. 11:28:57 INFO - Running cycle 1/1 for kraken test... 11:28:57 INFO - TEST-INFO | started process 22762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqrEx2F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:58 INFO - PROCESS | 22762 | 11:28:58 INFO - PROCESS | 22762 | (process:22833): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:29:08 INFO - PROCESS | 22762 | RSS: Main: 152100864 11:29:08 INFO - PROCESS | 22762 | 11:29:11 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35479/tests/kraken/driver.html?testName=audio-beat-detection) 11:29:11 INFO - PROCESS | 22762 | RSS: Main: 157839360 11:29:11 INFO - PROCESS | 22762 | 11:29:14 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35479/tests/kraken/driver.html?testName=audio-dft) 11:29:15 INFO - PROCESS | 22762 | RSS: Main: 157085696 11:29:15 INFO - PROCESS | 22762 | 11:29:17 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35479/tests/kraken/driver.html?testName=audio-fft) 11:29:18 INFO - PROCESS | 22762 | RSS: Main: 157556736 11:29:18 INFO - PROCESS | 22762 | 11:29:20 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35479/tests/kraken/driver.html?testName=audio-oscillator) 11:29:21 INFO - PROCESS | 22762 | RSS: Main: 157122560 11:29:21 INFO - PROCESS | 22762 | 11:29:23 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35479/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:29:23 INFO - PROCESS | 22762 | RSS: Main: 156835840 11:29:23 INFO - PROCESS | 22762 | 11:29:26 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35479/tests/kraken/driver.html?testName=imaging-darkroom) 11:29:27 INFO - PROCESS | 22762 | RSS: Main: 156372992 11:29:27 INFO - PROCESS | 22762 | 11:29:30 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35479/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:31 INFO - PROCESS | 22762 | RSS: Main: 157507584 11:29:31 INFO - PROCESS | 22762 | 11:29:34 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35479/tests/kraken/driver.html?testName=json-parse-financial) 11:29:34 INFO - PROCESS | 22762 | RSS: Main: 156991488 11:29:34 INFO - PROCESS | 22762 | 11:29:36 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35479/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:36 INFO - PROCESS | 22762 | RSS: Main: 157745152 11:29:36 INFO - PROCESS | 22762 | 11:29:38 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:39 INFO - PROCESS | 22762 | RSS: Main: 157450240 11:29:39 INFO - PROCESS | 22762 | 11:29:41 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:29:41 INFO - PROCESS | 22762 | RSS: Main: 157298688 11:29:41 INFO - PROCESS | 22762 | 11:29:44 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:29:44 INFO - PROCESS | 22762 | RSS: Main: 158056448 11:29:44 INFO - PROCESS | 22762 | 11:29:47 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:29:48 INFO - PROCESS | 22762 | RSS: Main: 157872128 11:29:48 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35479/tests/kraken/driver.html?testName=ai-astar) 11:29:49 INFO - PROCESS | 22762 | RSS: Main: 159473664 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | __start_tp_report 11:29:49 INFO - PROCESS | 22762 | _x_x_mozilla_page_load 11:29:49 INFO - PROCESS | 22762 | _x_x_mozilla_page_load_details 11:29:49 INFO - PROCESS | 22762 | |i|pagename|runs| 11:29:49 INFO - PROCESS | 22762 | |0;ai-astar;112;112;104;113;112;115;102;111;111;110 11:29:49 INFO - PROCESS | 22762 | |1;audio-beat-detection;154;131;165;175;133;156;156;134;177;138 11:29:49 INFO - PROCESS | 22762 | |2;audio-dft;165;165;164;166;162;163;163;165;163;163 11:29:49 INFO - PROCESS | 22762 | |3;audio-fft;75;80;75;170;78;74;77;80;169;74 11:29:49 INFO - PROCESS | 22762 | |4;audio-oscillator;95;96;142;95;95;95;140;94;94;137 11:29:49 INFO - PROCESS | 22762 | |5;imaging-gaussian-blur;120;120;119;119;119;119;120;119;120;119 11:29:49 INFO - PROCESS | 22762 | |6;imaging-darkroom;149;149;148;149;149;148;149;151;149;148 11:29:49 INFO - PROCESS | 22762 | |7;imaging-desaturate;97;101;97;96;96;101;96;96;96;97 11:29:49 INFO - PROCESS | 22762 | |8;json-parse-financial;56;56;56;57;56;59;57;70;55;54 11:29:49 INFO - PROCESS | 22762 | |9;json-stringify-tinderbox;59;59;60;60;61;61;60;60;59;60 11:29:49 INFO - PROCESS | 22762 | |10;stanford-crypto-aes;74;75;75;75;75;78;76;75;76;76 11:29:49 INFO - PROCESS | 22762 | |11;stanford-crypto-ccm;140;120;123;121;118;119;123;116;131;132 11:29:49 INFO - PROCESS | 22762 | |12;stanford-crypto-pbkdf2;164;161;167;164;162;166;162;163;163;165 11:29:49 INFO - PROCESS | 22762 | |13;stanford-crypto-sha256-iterative;70;67;68;70;67;67;67;68;68;67 11:29:49 INFO - PROCESS | 22762 | __end_tp_report 11:29:49 INFO - PROCESS | 22762 | __start_cc_report 11:29:49 INFO - PROCESS | 22762 | _x_x_mozilla_cycle_collect,748 11:29:49 INFO - PROCESS | 22762 | __end_cc_report 11:29:49 INFO - PROCESS | 22762 | __startTimestamp1465237789871__endTimestamp 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | ------- Summary: start ------- 11:29:49 INFO - PROCESS | 22762 | Number of tests: 14 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:4.05 (3.6%) stddev-sans-first:4.24 11:29:49 INFO - PROCESS | 22762 | Values: 112.0 112.0 104.0 113.0 112.0 115.0 102.0 111.0 111.0 110.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:156.00 stddev:17.26 (11.1%) stddev-sans-first:18.29 11:29:49 INFO - PROCESS | 22762 | Values: 154.0 131.0 165.0 175.0 133.0 156.0 156.0 134.0 177.0 138.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.50 stddev:1.29 (0.8%) stddev-sans-first:1.30 11:29:49 INFO - PROCESS | 22762 | Values: 165.0 165.0 164.0 166.0 162.0 163.0 163.0 165.0 163.0 163.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:39.22 (51.6%) stddev-sans-first:40.91 11:29:49 INFO - PROCESS | 22762 | Values: 75.0 80.0 75.0 170.0 78.0 74.0 77.0 80.0 169.0 74.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:95.00 stddev:21.68 (22.8%) stddev-sans-first:22.46 11:29:49 INFO - PROCESS | 22762 | Values: 95.0 96.0 142.0 95.0 95.0 95.0 140.0 94.0 94.0 137.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#5] imaging-gaussian-blur Cycles:10 Average:119.40 Median:119.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:29:49 INFO - PROCESS | 22762 | Values: 120.0 120.0 119.0 119.0 119.0 119.0 120.0 119.0 120.0 119.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 11:29:49 INFO - PROCESS | 22762 | Values: 149.0 149.0 148.0 149.0 149.0 148.0 149.0 151.0 149.0 148.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:96.00 stddev:2.00 (2.1%) stddev-sans-first:2.12 11:29:49 INFO - PROCESS | 22762 | Values: 97.0 101.0 97.0 96.0 96.0 101.0 96.0 96.0 96.0 97.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:56.50 stddev:4.55 (8.1%) stddev-sans-first:4.79 11:29:49 INFO - PROCESS | 22762 | Values: 56.0 56.0 56.0 57.0 56.0 59.0 57.0 70.0 55.0 54.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 11:29:49 INFO - PROCESS | 22762 | Values: 59.0 59.0 60.0 60.0 61.0 61.0 60.0 60.0 59.0 60.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.50 stddev:1.08 (1.4%) stddev-sans-first:1.00 11:29:49 INFO - PROCESS | 22762 | Values: 74.0 75.0 75.0 75.0 75.0 78.0 76.0 75.0 76.0 76.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:123.00 stddev:7.60 (6.2%) stddev-sans-first:5.55 11:29:49 INFO - PROCESS | 22762 | Values: 140.0 120.0 123.0 121.0 118.0 119.0 123.0 116.0 131.0 132.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.00 stddev:1.89 (1.2%) stddev-sans-first:2.00 11:29:49 INFO - PROCESS | 22762 | Values: 164.0 161.0 167.0 164.0 162.0 166.0 162.0 163.0 163.0 165.0 11:29:49 INFO - PROCESS | 22762 | 11:29:49 INFO - PROCESS | 22762 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:1.00 11:29:49 INFO - PROCESS | 22762 | Values: 70.0 67.0 68.0 70.0 67.0 67.0 67.0 68.0 68.0 67.0 11:29:49 INFO - PROCESS | 22762 | -------- Summary: end -------- 11:29:49 INFO - PROCESS | 22762 | 11:29:50 INFO - TEST-INFO | 22762: exit 0 11:29:50 INFO - TEST-OK | kraken | took 58859ms 11:29:50 INFO - SUITE-END | took 1166s 11:29:51 INFO - Completed test suite (00:19:26) 11:29:51 INFO - javascript benchmark 11:29:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3289.9013029609114, 3316.618588862281, 3331.034000139958, 3350.6816852399043, 3393.6097348804897, 5448.8365349039495, 5497.8075767348155, 5507.366652834925, 5507.4767897049815, 5542.806001789938, 5474.698891560963, 5500.0, 5503.642263252886, 5530.557555395569, 5537.390887002437, 4935.136351138554, 4994.300797888299, 5078.5175408336145, 5090.287359769617, 5127.692338459686, 4846.878828029292, 4925.7537123143875, 4945.604351651878, 5130.563902068328, 5189.42916279209, 5042.445331013586, 5080.0, 5127.948720512803, 5150.613703972217, 5154.201098829669, 5074.999999999982, 5084.669496482717, 5106.259592359106, 5111.0, 5131.1277082895995, 4786.329913812069, 4861.829835955725, 4993.151164302078, 5019.14674505335, 5048.318477005594, 5203.505666961632, 5243.659162154448, 5245.26566280721, 5279.944011197737, 5328.280682107905, 5679.772809087632, 5755.856103597402, 5769.0192667246665, 5778.942210577925, 5793.391693872167, 5837.153612726131, 5843.795467158629, 5971.910421343683, 6066.514678825683, 6071.028635418356, 5432.837014889559, 5453.590980676426, 5483.7806487740445, 5491.121420572729, 5514.779408823602, 5928.903152916724, 5931.377205393458, 5933.080372542263, 5934.495567876779, 5936.762529498858, 5036.345275114285, 5464.480874316933, 5760.74076666551, 5830.067189249699, 5881.264841894763, 5787.2476578045425, 5879.470847623735, 5898.292204935436, 5899.46904778572, 5905.40945905406, 5845.678487683218, 5848.181254624356, 5883.735231914574, 5887.8233652990475, 5896.0, 5865.648061116347, 5873.119032145212, 5900.793472228452, 5912.970435147797, 5918.822435326947, 4449.154660614473, 4512.909741805145, 4518.525554816762, 4526.366308716782, 4540.750258735801, 3952.8418863245724, 3981.5819338969573, 4010.939835902464, 4017.0961533654695, 4092.0, 5561.944380556142, 5712.428757124254, 5713.457221563945, 5733.741981610838, 5741.971290143522, 5875.941240587625, 5899.646021238739, 5902.61632993854, 5911.9113213301835, 5913.319968203712, 5403.243545903577, 5534.75093620788, 5597.216389705444, 5615.0, 5615.578831587565, 4964.379452568429, 4964.478729733398, 5023.648344615842, 5029.06962211992, 5045.217991211368, 5932.3474417814, 6010.038393856962, 6010.879782404328, 6031.668258245751, 6046.667433291123, 5804.361520232856, 5825.271841019872, 5880.411958804086, 5964.343922168471, 5983.760649574142, 6087.391260873877, 6091.177691011834, 6123.14276001369, 6149.877002459836, 6156.661383623944, 5821.563382746226, 5838.970805145947, 5885.94114058871, 5887.793927212699, 5913.940860591339, 5760.798372057126, 5807.303123625192, 5817.505512031525, 5863.706814659336, 5868.2664666916635, 5802.071668533014, 5808.07070868659, 5845.912311315419, 5851.21008663825, 5869.735861886311, 5613.438656134354, 5781.017227071324, 5806.390329015561, 5806.738696758572, 5815.621984570989, 5725.799597014085, 5730.942690573041, 5746.138079287973, 5763.366029736641, 5764.654120752768, 5686.175504551734, 5723.0, 5771.826845194651, 5788.131780232999, 5790.218320526675, 5515.283013208257, 5696.458836410535, 5706.915686019643, 5710.600257982068, 5711.571632127524], "value": 5425.975335515922, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.4432605513842, 649.2533586375667, 650.5283669339732, 662.7978466567698, 665.663839760921, 39414.40878386827, 40351.59648403515, 40385.7980710096, 40444.19111617766, 40478.59521404785, 42354.57645423545, 42829.357559636555, 43028.354574681405, 43102.491412800555, 43193.7840310798, 8663.48019118855, 8764.43031202973, 8776.60505277264, 8777.2100510954, 8787.340949428786, 8593.0, 8694.434861733998, 8707.390482666184, 8712.172343627377, 8772.03507614162, 8852.5573721314, 8958.776030599221, 9015.549222538879, 9022.954885225598, 9045.954770226139, 8888.0, 8956.507392093432, 8958.507282099481, 8980.191782739552, 9011.098890111001, 8867.379283450096, 8920.420172688755, 8954.910450895539, 8961.641534338618, 8988.011318754932, 41848.58151418477, 42235.36646950298, 42353.364699529535, 42547.78726106381, 42752.3587146193, 3576.2311103112697, 3724.1062145085257, 3771.9057023574355, 3808.1622043150464, 4172.332426811726, 32217.51673724896, 32473.0, 32620.673793262238, 32622.347553048807, 33303.66696333054, 4489.0, 4534.31985202219, 4541.682082254243, 4553.567411095941, 4564.1328147652175, 219995.0, 220767.0, 221876.0, 221893.89053054794, 222592.0, 38627.22745545073, 59216.70391648014, 60052.09921851176, 60234.0, 60338.0, 37029.629703703155, 37140.44289335662, 37238.8138059308, 37384.0, 37392.25215495675, 16813.327466901188, 16886.74669879953, 16899.493015209562, 17044.744328835077, 17057.402990895258, 14011.369488373048, 14066.507672231422, 14096.295185240697, 14110.85889141116, 14133.293335333192, 8969.282457403391, 8999.280057595377, 9013.504257265782, 9056.818863622691, 9083.091690830865, 3572.696320812708, 3577.94633080504, 3587.192881601619, 3609.9458508122398, 3628.129248980226, 1125.876153623101, 1146.8623765148068, 1204.3978010994504, 1220.9145359824904, 1267.3916520070418, 32166.0, 32602.673973260436, 32628.347433051207, 33363.332733345196, 33666.0, 1198.820176973461, 1212.805951047828, 1229.932353720554, 1270.964164206169, 1386.8058471813954, 16877.40929067477, 16978.660426791394, 17227.3970411035, 17265.309387624606, 17302.394416195624, 503180.0, 520906.0, 560487.0, 570672.0, 609332.0, 56460.435395645516, 57012.42987570071, 57227.42772572304, 57309.71345143248, 57695.42304576984, 1514.5986313626897, 1527.3585094260438, 1529.587011506887, 1531.089002043782, 1572.701186774509, 29611.555826662185, 30683.693163068085, 30811.691883080883, 31292.0, 33106.83446582752, 52542.474575255284, 52830.735846320524, 53285.7335713319, 53420.4657953431, 53454.73272633767, 448936.0, 450390.0, 452217.0, 452456.0, 453980.0, 29395.85302073476, 29727.405451891274, 30079.398412032075, 30139.69860301369, 30350.696493034786, 46922.29616555686, 47332.05335893332, 47792.0, 48303.516964829905, 48901.0, 40722.59277407306, 40922.59077409188, 40982.59017409788, 41822.163556729305, 42530.57469425266, 40570.59429405668, 41010.17979640331, 41703.58296416997, 42370.364444533974, 43416.56583434125, 37836.24327513379, 38482.230355393294, 38956.0, 39140.60859391483, 39435.40846887356, 33297.0, 33821.32357352888, 33935.83032084824, 34283.828580856934, 34572.13569660779, 27790.305242369104, 28566.714332856405, 28608.856955715088, 28696.569551456327, 28846.278843029093], "value": 19165.36291531116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.44257686296254, 434.7652267775401, 435.2929668394795, 438.05598934296603, 449.68971409727305, 18151.909240453795, 18322.175502102404, 18441.893486390825, 18868.716969245474, 18917.52706182346, 18270.269189232447, 18653.440396788083, 18735.62528749424, 19608.803911960877, 19622.117004734784, 5290.788368465257, 5295.4704529546925, 5446.264754258164, 5454.699991500466, 5461.808836690717, 5399.406065332811, 5423.891522169554, 5445.319335083114, 5469.972650136744, 5472.20653005314, 5273.288106105684, 5481.725913704299, 5494.203340515623, 5509.944900550983, 5534.0592099343, 5479.260299859528, 5513.5864810139, 5529.723513824333, 5545.611807173499, 5549.223108764776, 5347.82347883465, 5412.512873841373, 5418.91871621926, 5439.728013599304, 5446.1558458439, 14218.28908554568, 14505.0, 14669.70660586793, 14700.191489468076, 16274.593135171597, 2464.938376540583, 2530.9493810123695, 2534.9873250633814, 2551.285640020797, 2620.3842097107163, 10225.181985441146, 10275.845862312071, 10759.193060520493, 13476.93261533686, 14485.985980981335, 2071.3475255294534, 2117.68234764785, 2167.7398712154486, 2171.5873983943, 2172.945676358088, 78853.21146788573, 82533.17466825375, 83082.0, 83130.0, 84261.57869210615, 11214.775704486028, 11919.165658404001, 12028.63914082579, 12156.209846359958, 12687.238765674088, 16247.67504649924, 16405.933614315032, 16407.507774766775, 16432.178391080397, 16486.917565412336, 8903.06517815633, 8975.820483590292, 8985.146411090936, 8988.820223595492, 9103.089691030844, 8846.203841654282, 8873.73378798624, 8897.421667591585, 8952.462852228888, 8979.0, 5043.697378157322, 5108.463611320833, 5109.08036553424, 5129.358830146231, 5165.767540460688, 2090.916363345449, 2114.418534902883, 2175.738911330619, 2179.6294629912954, 2187.9453013674784, 986.2849434160177, 1018.8624535687587, 1097.8353247013013, 1183.1599564309436, 1184.9526018959318, 18404.35584754527, 19177.904110479638, 19265.614687706166, 19386.0, 19584.902075489532, 1060.7083052160563, 1073.9624113156, 1078.9244752867223, 1101.2566517600749, 1111.222144498854, 10903.400312982862, 11125.0, 11216.66350009501, 11221.158413118885, 11243.269187502787, 500860.0, 519098.0, 519158.0, 522824.0, 533912.0, 86081.0, 87452.5627371859, 89730.55134724284, 101038.0, 103260.48369758253, 1072.9409882456384, 1102.0962810495316, 1102.399192440122, 1105.1379923659558, 1123.2867129373071, 16817.495475135765, 18273.908630457296, 18304.633907321513, 18351.908240458713, 18503.35238266654, 37753.81123094367, 39071.218575628896, 40594.67809099187, 40637.390439142844, 41149.79425102975, 53655.19517207323, 57640.135397968224, 58095.41904581069, 58180.70909645594, 58628.0, 9144.63421463134, 9214.901201161965, 9275.814483710154, 9323.86014209801, 9507.382020168943, 13643.249621270925, 14011.08927919682, 14135.222562759147, 14283.71432571322, 14374.640633984234, 11639.941800290944, 11672.241304315192, 11868.287902725864, 12272.938635306766, 12284.324362160167, 12290.770922907637, 12416.813747793609, 12422.813657794959, 12556.748865022832, 12657.050721195763, 11565.653030409101, 11750.94124529372, 11899.76200476003, 12011.81982270284, 12478.126531143096, 9165.220956218796, 9213.815723685355, 9230.492322922304, 9372.34393592442, 9433.764155896157, 8857.468551886908, 10855.891441085803, 10983.340999540053, 11315.20793544444, 11342.20604557673], "value": 9449.802192589963, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.0887932886642, 1364.7202323523675, 1452.527928423262, 1841.0058568373088, 1849.6763066463366, 7273.418126549876, 7686.308232259095, 7904.367650587954, 8098.271155596002, 8130.796730081751, 7962.960185199066, 8013.0, 8040.155783642721, 8041.035075790899, 8060.0, 2306.2504685977, 2340.871252081135, 2341.016772955354, 2341.4146463384154, 2342.0397636968846, 2278.4076140203583, 2316.8494047886916, 2347.6947996760396, 2369.8104151667826, 2374.76252374762, 2308.411355104446, 2333.3349995251356, 2344.0272287000876, 2365.2076554354226, 2371.6323969784626, 2325.6046472099615, 2329.406001469623, 2334.369720175543, 2343.7773411525877, 2368.585497537941, 2338.4270853640796, 2340.6723058771786, 2353.1058197884695, 2364.066193853418, 2370.7510711375403, 8196.54918979456, 8213.753587392388, 8223.671053157866, 8227.465214761021, 8245.83508329836, 5099.4900509949075, 5142.357205349332, 5185.585153187736, 5201.869953251161, 5236.947630523722, 3436.3127374524943, 3471.2363280078594, 3489.6510348965153, 3539.4159963605975, 3554.59122200945, 1096.8903109689047, 1203.2900588652737, 1234.3026190202506, 1237.189640785287, 1242.9502819887193, 11175.0, 11218.831717524243, 11252.49363778632, 11269.436528173559, 11529.538818447252, 4479.260921947907, 4519.909601807945, 4585.243434833282, 4589.908201836011, 4593.793279302439, 9747.0, 9761.463119528353, 9770.511474426392, 9778.31551791382, 9814.950925245328, 5314.73426328682, 5324.4675532446445, 5328.49379308965, 5338.252644629755, 5360.731963401892, 4502.482214545304, 4553.772311384418, 4664.113818374566, 4696.0, 4850.054239423349, 3735.3836616957897, 3782.981085094557, 3784.7729136251914, 3823.770573765583, 3837.5394952605866, 1127.2391135983178, 1127.9887201128047, 1137.70988397958, 1162.7965106106396, 1162.8720840707515, 947.7820101376584, 1038.1539045677748, 1046.5133712823574, 1055.6516349604613, 1059.8357254625546, 5904.7933322334375, 6023.45788879003, 6097.0, 6157.291911430153, 6278.6860656966965, 993.1409330928694, 1008.8991100889853, 1013.1945103642622, 1018.9847152292722, 1086.6522712732008, 4121.835126594902, 4162.791860406967, 4214.199302132585, 4229.238737027365, 4277.700560960765, 9852.655157069468, 10030.949845250727, 10151.543180556893, 10183.33808302458, 10189.9810018999, 9831.115199631924, 9950.751231219278, 9962.750931226632, 10002.749931251632, 10032.69901902944, 7331.450141239322, 7596.582187979714, 7619.4285428593075, 7686.961565192139, 7754.92245077542, 5791.768329266951, 5860.501857342174, 5956.225690660186, 5986.491148252448, 6057.697115144313, 8607.784805379915, 8620.396572239883, 8636.740897773077, 8760.649574016968, 8868.600912959062, 8577.742667719978, 8641.438306510057, 8738.91261087381, 8771.16673915977, 9050.637974480947, 6761.661916904037, 7312.268773122645, 7539.962300188464, 7670.654820532978, 7755.2632499912415, 7655.157932627518, 7659.4255430841795, 7687.769366919001, 7704.26809453101, 7737.690492380467, 6923.238443771081, 7070.964645176741, 7097.964510177416, 7137.393321567725, 7154.0, 6760.797176084725, 6788.694508747217, 6837.487188460786, 6877.484188685969, 6973.721051157897, 6549.214094308523, 6596.835079122869, 6651.43462805667, 6745.5952642841585, 6774.491913106635, 4972.428170760264, 4999.475055119306, 5023.7739301732245, 5037.949620503748, 5151.0, 4941.6293777966075, 4977.328060711758, 4992.550670439678, 5007.749612519432, 5058.696478211319], "value": 4484.133688663927, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.9757117001809, 349.1707195410899, 356.39057212167194, 360.2165290493177, 365.51751687772145, 6545.5418120731565, 6589.0, 6597.670116494174, 6624.933750662492, 6753.628550429725, 6533.934660653392, 6535.11775910252, 6535.575187612813, 6557.082008518812, 6566.080748695174, 4650.000249946261, 4784.138855006097, 4879.804807807684, 4906.460289368167, 4921.163402221631, 4887.095887260851, 4890.095332363507, 4890.902181956359, 4906.681065730716, 4920.065187614359, 4854.0, 4856.05306965142, 4857.538533839297, 4858.368412106422, 4860.927086093711, 4853.660243782919, 4865.586425153866, 4867.659263851532, 4867.805287788502, 4869.488703686097, 4248.086661367821, 4251.107267473834, 4262.829486820523, 4264.616184543375, 4276.973526353684, 6138.685516290982, 6148.477379422754, 6248.0, 6252.218472690914, 6278.937210627881, 5702.686352250625, 5721.226419809872, 5733.455321744469, 5733.541316694655, 5751.942480575224, 6787.947868080455, 6811.386975172209, 6813.3527314905, 6814.284500127515, 6829.692663830139, 4731.219348807443, 4733.431988161408, 4741.502142275046, 4746.4541577718655, 4769.475357710649, 7130.786076417716, 7157.6063316517575, 7166.498345115844, 7177.605231712254, 7182.569045857265, 4591.081783643284, 4684.976575117103, 4688.765561721969, 4690.929636055462, 4928.6303527235605, 4714.972561798391, 4762.97596016858, 4773.7374444405195, 4775.737334446639, 4779.426468823764, 5566.526845218121, 5600.803971860965, 5603.047481928082, 5604.719764011783, 5614.859628509238, 6924.826879328057, 6936.306369363023, 6955.339242771928, 6956.165260168711, 6962.721491140399, 1684.0485125903824, 1710.0167403742898, 1712.8458438740572, 1713.6144367517209, 1730.8009578898336, 1095.6001059613343, 1103.2167161315394, 1122.7698321844002, 1128.0693427921997, 1139.7948369293606, 6741.157355330583, 6742.056112144303, 6745.2242992056545, 6746.460283177432, 6767.763128290486, 7086.50394472382, 7193.964030179815, 7211.062561866924, 7221.855562888818, 7277.090363704537, 6818.556793808486, 6830.077939478107, 6887.414569761526, 6887.586744795329, 6908.723651054002, 3886.1644746379666, 3927.4108883667677, 3938.8621398250925, 3946.7829269389886, 3946.881593552198, 7670.27132422419, 7693.923060769433, 7722.189170137167, 7765.883511747328, 7779.611019449118, 7284.453665975073, 7377.852442951111, 7413.851722965511, 7436.628168591549, 7449.14334851499, 7463.552186868806, 7466.290702383265, 7473.813154671177, 7509.324160825552, 7715.189905060112, 7333.816654583465, 7337.192908780136, 7337.229590892879, 7340.67867783804, 7345.412367010733, 7132.144142702701, 7145.356917877416, 7157.997880296867, 7181.317774811385, 7190.71237150529, 7449.739259125905, 7531.849363012819, 7538.509996850187, 7580.507267027626, 7587.62061896914, 4805.183118869871, 4807.351007613927, 4822.987172693774, 4823.5658790709, 4837.927431088607, 7293.781186564412, 7295.598742069024, 7307.1231452226075, 7314.597697126709, 7322.633868306457, 6954.860902781815, 6974.825629359307, 6997.160340759141, 7042.190148132825, 7051.083359163276, 6821.147356580427, 6956.95645653156, 7017.578945263096, 7046.154461464657, 7059.788206353817, 6855.383015528626, 6857.108575885302, 6860.211075726355, 6860.4168645663685, 6896.137982752156, 6982.546134501241, 7030.718771249298, 7033.296670332926, 7035.437165026683, 7035.964820175866, 6809.89785153233, 6819.522633415613, 6822.181338239443, 6834.829129271808, 6860.588364698134], "value": 5210.231328832104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.4835856693153, 794.7854079398562, 842.2546046748625, 873.9774463877263, 939.2861425316759, 14667.559973200809, 15367.769483457758, 15572.065676059445, 15644.687106257868, 15701.136437495934, 14138.858611413883, 14244.643883902907, 14280.000399972007, 14391.136531808099, 14398.208098554602, 893.5219657483248, 909.790748127931, 912.32943786317, 913.4427998920653, 933.7432206143297, 920.9915142918494, 932.1889955738517, 932.3100905330041, 933.351320832022, 939.2908354192609, 943.3349488610513, 948.3172116076414, 955.7180631713626, 960.865478832964, 961.7307153996892, 935.2985261054209, 935.822193783179, 940.5626383731563, 945.985810212844, 948.4356807699407, 698.4272896225098, 699.7935608995358, 699.9720011199546, 702.0382076555101, 702.3292755418563, 14219.004669673128, 14257.85742142586, 14259.928700356535, 14289.428422863073, 14325.426982920671, 14359.353829077716, 14626.999999999893, 14724.926375368163, 14759.0, 14774.26128693561, 11417.724781190807, 11498.367589782558, 11661.358625275607, 11704.707382315424, 12060.216085954473, 3968.1666849961543, 4001.2597669431248, 4046.8785936421955, 4060.4518390017265, 4061.776602286873, 58031.41968580303, 58567.414325856626, 60163.0, 60175.69912150455, 60593.394066058776, 11207.0, 11233.775324493465, 11266.380349080715, 11318.717032074264, 11442.599509017144, 20438.79561204369, 20481.89759051195, 20533.0, 20575.176992920115, 20656.896715516326, 8615.91384086151, 8664.8700269496, 8666.523341216167, 8692.478451292942, 8847.51338676379, 4938.506149385104, 5029.119904016782, 5040.8658051938755, 5069.518395752471, 5092.592592592584, 3517.8592856285463, 3587.497750314958, 3614.2410093880053, 3622.529071220777, 3637.1998160405196, 690.0718533572438, 690.975815846453, 691.5263044814318, 699.5383047188831, 706.2372637551432, 712.6294326949957, 716.4304378019488, 753.5365750063671, 793.0523024985088, 816.808050108224, 9055.637774488947, 9289.72130836076, 10021.849672254923, 10331.571120936123, 10351.585936562453, 627.802242293676, 693.874726947441, 722.0757430488983, 740.6185814305637, 809.9190080991972, 4485.327200919823, 4548.295014272793, 4787.784549695202, 4976.1757610797285, 4991.67554108989, 64805.0, 66618.66690666613, 66869.6656516724, 66873.33126668769, 66950.33049669539, 52564.47435525672, 53751.0, 56547.71726141343, 58305.70847145737, 60260.69869650624, 51530.48469515332, 52212.47787522152, 52424.21363679548, 52652.47347526476, 53049.73475132677, 9713.271504637321, 9941.801163976825, 10195.0, 10235.894468526512, 10289.794204115726, 37372.2525549482, 37482.812585936896, 37653.435198471496, 38217.0, 39225.411618826314, 46328.76835615935, 48959.510404895496, 49111.75444122899, 49352.25971610501, 50862.23706644477, 12764.079706084845, 12795.232286062866, 12796.296203708886, 12886.90461310799, 13092.214467132002, 14190.716185676436, 14345.64135896611, 14433.134011959317, 14473.348699308346, 14509.637259068608, 13389.397477113358, 13424.194548327132, 13466.461341546228, 13656.317184140555, 13688.65778355549, 13331.533396331082, 13859.514916977858, 13904.51334203298, 13911.304434778423, 13968.58094257174, 13147.474101035852, 13197.274149921846, 13275.66810829737, 13360.732785344433, 13486.12340197884, 11137.610183643534, 11274.323540587591, 11294.49174787153, 11370.886291136983, 11507.482163302839, 11149.832752508557, 11410.0, 11520.94239528797, 11611.825822612498, 11659.067274618179], "value": 7225.894318129695, "unit": "score"}], "name": "dromaeo_css", "value": 7412.767226799445, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 104.0, 113.0, 112.0, 115.0, 102.0, 111.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 165.0, 175.0, 133.0, 156.0, 156.0, 134.0, 177.0, 138.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 166.0, 162.0, 163.0, 163.0, 165.0, 163.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 75.0, 170.0, 78.0, 74.0, 77.0, 80.0, 169.0, 74.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 142.0, 95.0, 95.0, 95.0, 140.0, 94.0, 94.0, 137.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 119.0, 119.0, 119.0, 119.0, 120.0, 119.0, 120.0, 119.0], "value": 119.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 149.0, 149.0, 148.0, 149.0, 151.0, 149.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 101.0, 97.0, 96.0, 96.0, 101.0, 96.0, 96.0, 96.0, 97.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 56.0, 59.0, 57.0, 70.0, 55.0, 54.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 60.0, 61.0, 61.0, 60.0, 60.0, 59.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 75.0, 75.0, 78.0, 76.0, 75.0, 76.0, 76.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 120.0, 123.0, 121.0, 118.0, 119.0, 123.0, 116.0, 131.0, 132.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 167.0, 164.0, 162.0, 166.0, 162.0, 163.0, 163.0, 165.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 70.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1544.0, "alertThreshold": 2.0}]} 11:29:51 INFO - Return code: 0 11:29:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:29:51 ERROR - # TBPL SUCCESS # 11:29:51 INFO - Running post-action listener: _resource_record_post_action 11:29:51 INFO - Running post-run listener: _resource_record_post_run 11:29:52 INFO - Total resource usage - Wall time: 1183s; CPU: 25.0%; Read bytes: 266240; Write bytes: 509579264; Read time: 32; Write time: 413264 11:29:52 INFO - install - Wall time: 16s; CPU: 27.0%; Read bytes: 0; Write bytes: 248745984; Read time: 0; Write time: 273540 11:29:52 INFO - run-tests - Wall time: 1168s; CPU: 25.0%; Read bytes: 266240; Write bytes: 242421760; Read time: 32; Write time: 129048 11:29:52 INFO - Running post-run listener: _upload_blobber_files 11:29:52 INFO - Blob upload gear active. 11:29:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:29:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:29:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:29:52 INFO - (blobuploader) - INFO - Open directory for files ... 11:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:29:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:53 INFO - (blobuploader) - INFO - Done attempting. 11:29:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:29:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:29:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:54 INFO - (blobuploader) - INFO - Done attempting. 11:29:54 INFO - (blobuploader) - INFO - Iteration through files over. 11:29:54 INFO - Return code: 0 11:29:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:29:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:29:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e561f2e38d116b9c178cbd40fd7871abcf261a8ba82f378b01c7118bbb5f91b56a49b2addf9f62293baadc5d4e975e393aacbd466b7dbe952e49c64e249bbca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e709d8e07fc4368ba4ed9b965e467bb1dd2295afd7bbcfec6e9674636601204f6fa7996e8afc1178f59898de954fecfcbf27687d4e7f614829134a09196e824"} 11:29:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:29:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:29:54 INFO - Contents: 11:29:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e561f2e38d116b9c178cbd40fd7871abcf261a8ba82f378b01c7118bbb5f91b56a49b2addf9f62293baadc5d4e975e393aacbd466b7dbe952e49c64e249bbca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e709d8e07fc4368ba4ed9b965e467bb1dd2295afd7bbcfec6e9674636601204f6fa7996e8afc1178f59898de954fecfcbf27687d4e7f614829134a09196e824"} 11:29:54 INFO - Running post-run listener: copy_logs_to_upload_dir 11:29:54 INFO - Copying logs to upload dir... 11:29:54 INFO - mkdir: /builds/slave/test/build/upload/logs 11:29:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.098184 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-06-06 11:29:53.991631) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 11:29:53.995813) ========= 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=523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843 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-Aurora/sha512/9e561f2e38d116b9c178cbd40fd7871abcf261a8ba82f378b01c7118bbb5f91b56a49b2addf9f62293baadc5d4e975e393aacbd466b7dbe952e49c64e249bbca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e709d8e07fc4368ba4ed9b965e467bb1dd2295afd7bbcfec6e9674636601204f6fa7996e8afc1178f59898de954fecfcbf27687d4e7f614829134a09196e824"} build_url:https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005361 build_url: 'https://queue.taskcluster.net/v1/task/C13SNNZOQrKwXHqcdpogNg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e561f2e38d116b9c178cbd40fd7871abcf261a8ba82f378b01c7118bbb5f91b56a49b2addf9f62293baadc5d4e975e393aacbd466b7dbe952e49c64e249bbca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e709d8e07fc4368ba4ed9b965e467bb1dd2295afd7bbcfec6e9674636601204f6fa7996e8afc1178f59898de954fecfcbf27687d4e7f614829134a09196e824"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 11:29:54.088917) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:29:54.089283) ========= 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=523ca41ca1e0623de333ad52000001bf-1465236571.602312-1763755843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002124 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:29:54.165496) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 11:29:54.165847) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 11:29:54.166150) ========= ========= Total master_lag: 0.23 =========