builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1463036201.06 results: success (0) buildid: 20160511211918 builduid: b5b007d81d4a4000989fa67bcd6e7e31 revision: 2fb177e17d81e069a02797c6234e8ed085cbc55c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:41.058430) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:41.058825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:41.059110) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:41.080247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:41.080730) ========= 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=fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 23:56:41-- 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% 19.3M=0.001s 2016-05-11 23:56:42 (19.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.392217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:41.489671) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:41.490063) ========= 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=fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020872 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:41.539652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:41.540038) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2fb177e17d81e069a02797c6234e8ed085cbc55c --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 2fb177e17d81e069a02797c6234e8ed085cbc55c --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=fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 23:56:42,214 truncating revision to first 12 chars 2016-05-11 23:56:42,214 Setting DEBUG logging. 2016-05-11 23:56:42,214 attempt 1/10 2016-05-11 23:56:42,214 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2fb177e17d81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 23:56:42,474 unpacking tar archive at: mozilla-aurora-2fb177e17d81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551715 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:42.104846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:42.105186) ========= script_repo_revision: 2fb177e17d81e069a02797c6234e8ed085cbc55c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:42.105640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:42.105979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:42.115137) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-11 23:56:42.115454) ========= /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=fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:56:42 INFO - MultiFileLogger online at 20160511 23:56:42 in /builds/slave/test 23:56:42 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 23:56:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:56:42 INFO - {'append_to_log': False, 23:56:42 INFO - 'base_work_dir': '/builds/slave/test', 23:56:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:56:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:56:42 INFO - 'branch': 'Mozilla-Aurora', 23:56:42 INFO - 'buildbot_json_path': 'buildprops.json', 23:56:42 INFO - 'config_files': ('talos/linux_config.py',), 23:56:42 INFO - 'default_actions': ('clobber', 23:56:42 INFO - 'read-buildbot-config', 23:56:42 INFO - 'download-and-extract', 23:56:42 INFO - 'populate-webroot', 23:56:42 INFO - 'create-virtualenv', 23:56:42 INFO - 'install', 23:56:42 INFO - 'run-tests'), 23:56:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:56:42 INFO - 'download_minidump_stackwalk': True, 23:56:42 INFO - 'download_symbols': 'ondemand', 23:56:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:56:42 INFO - 'tooltool.py': '/tools/tooltool.py', 23:56:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:56:42 INFO - '/tools/misc-python/virtualenv.py')}, 23:56:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:56:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:56:42 INFO - 'installer_path': 'installer.exe', 23:56:42 INFO - 'log_level': 'info', 23:56:42 INFO - 'log_name': 'talos', 23:56:42 INFO - 'log_to_console': True, 23:56:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:56:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:56:42 INFO - 'opt_config_files': (), 23:56:42 INFO - 'pip_index': False, 23:56:42 INFO - 'sps_profile': False, 23:56:42 INFO - 'sps_profile_interval': 0, 23:56:42 INFO - 'suite': 'dromaeojs-e10s', 23:56:42 INFO - 'system_bits': '32', 23:56:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:56:42 INFO - 'title': 'talos-linux64-ix-048', 23:56:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:56:42 INFO - 'use_talos_json': True, 23:56:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:56:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:56:42 INFO - 'work_dir': 'build'} 23:56:42 INFO - ##### 23:56:42 INFO - ##### Running clobber step. 23:56:42 INFO - ##### 23:56:42 INFO - Running pre-action listener: _resource_record_pre_action 23:56:42 INFO - Running main action method: clobber 23:56:42 INFO - rmtree: /builds/slave/test/build 23:56:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:56:43 INFO - Running post-action listener: _resource_record_post_action 23:56:43 INFO - ##### 23:56:43 INFO - ##### Running read-buildbot-config step. 23:56:43 INFO - ##### 23:56:43 INFO - Running pre-action listener: _resource_record_pre_action 23:56:43 INFO - Running main action method: read_buildbot_config 23:56:43 INFO - Using buildbot properties: 23:56:43 INFO - { 23:56:43 INFO - "project": "", 23:56:43 INFO - "product": "firefox", 23:56:43 INFO - "script_repo_revision": "production", 23:56:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 23:56:43 INFO - "repository": "", 23:56:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 23:56:43 INFO - "buildid": "20160511211918", 23:56:43 INFO - "pgo_build": "True", 23:56:43 INFO - "basedir": "/builds/slave/test", 23:56:43 INFO - "buildnumber": 352, 23:56:43 INFO - "slavename": "talos-linux64-ix-048", 23:56:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:56:43 INFO - "platform": "ubuntu64_hw", 23:56:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:56:43 INFO - "branch": "mozilla-aurora", 23:56:43 INFO - "repo_path": "releases/mozilla-aurora", 23:56:43 INFO - "revision": "2fb177e17d81e069a02797c6234e8ed085cbc55c", 23:56:43 INFO - "stage_platform": "linux64-pgo", 23:56:43 INFO - "builduid": "b5b007d81d4a4000989fa67bcd6e7e31", 23:56:43 INFO - "slavebuilddir": "test" 23:56:43 INFO - } 23:56:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 23:56:43 INFO - Running post-action listener: _resource_record_post_action 23:56:43 INFO - ##### 23:56:43 INFO - ##### Running download-and-extract step. 23:56:43 INFO - ##### 23:56:43 INFO - Running pre-action listener: _resource_record_pre_action 23:56:43 INFO - Running main action method: download_and_extract 23:56:43 INFO - mkdir: /builds/slave/test/build/tests 23:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:43 INFO - https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 23:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 23:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:45 INFO - Downloaded 1361 bytes. 23:56:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 23:56:45 INFO - Using the following test package requirements: 23:56:45 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 23:56:45 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:56:45 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:56:45 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:45 INFO - u'jsshell-linux-x86_64.zip'], 23:56:45 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:56:45 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 23:56:45 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:56:45 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:56:45 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:56:45 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:56:45 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:45 INFO - https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:56:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:56:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:56:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:46 INFO - Downloaded 23800103 bytes. 23:56:46 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'] 23:56:46 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 23:56:47 INFO - Return code: 0 23:56:47 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 23:56: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')]} 23:56:47 INFO - https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:56:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:56:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:56:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:53 INFO - Downloaded 23800103 bytes. 23:56:53 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'] 23:56:53 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 23:56:55 INFO - Return code: 0 23:56: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')]} 23:56:55 INFO - https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:56:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 23:56:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 23:56:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:56 INFO - Downloaded 10840145 bytes. 23:56:56 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'] 23:56:56 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 23:56:56 INFO - Return code: 0 23:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:56 INFO - https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:56:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:56:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:56:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:57 INFO - Downloaded 62692424 bytes. 23:56:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:56:57 INFO - mkdir: /builds/slave/test/properties 23:56:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:56:57 INFO - Writing to file /builds/slave/test/properties/build_url 23:56:57 INFO - Contents: 23:56:57 INFO - build_url:https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:56:58 INFO - Running post-action listener: _resource_record_post_action 23:56:58 INFO - Running post-action listener: set_extra_try_arguments 23:56:58 INFO - ##### 23:56:58 INFO - ##### Running populate-webroot step. 23:56:58 INFO - ##### 23:56:58 INFO - Running pre-action listener: _resource_record_pre_action 23:56:58 INFO - Running main action method: populate_webroot 23:56:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:56:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:56:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:56:58 INFO - '--tppagecycles', 23:56:58 INFO - '7'], 23:56:58 INFO - 'tests': ['tsvgm']}}, 23:56:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:56:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:56:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:56:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:56:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:56:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:56:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:58 INFO - 'talos_options': ['--disable-e10s'], 23:56:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:56:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:56:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:58 INFO - 'talos_options': ['--disable-e10s'], 23:56:58 INFO - 'tests': ['damp', 'tps']}, 23:56:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:58 INFO - 'tests': ['damp', 'tps']}, 23:56:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:56:58 INFO - 'tests': ['dromaeo_dom']}, 23:56:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:56:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:56:58 INFO - 'tests': ['a11yr', 23:56:58 INFO - 'ts_paint', 23:56:58 INFO - 'tpaint', 23:56:58 INFO - 'sessionrestore', 23:56:58 INFO - 'sessionrestore_no_auto_restore', 23:56:58 INFO - 'tabpaint']}, 23:56:58 INFO - 'other-e10s': {'tests': ['a11yr', 23:56:58 INFO - 'ts_paint', 23:56:58 INFO - 'tpaint', 23:56:58 INFO - 'sessionrestore', 23:56:58 INFO - 'sessionrestore_no_auto_restore', 23:56:58 INFO - 'tabpaint']}, 23:56:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:56:58 INFO - 'ts_paint', 23:56:58 INFO - 'tpaint', 23:56:58 INFO - 'sessionrestore', 23:56:58 INFO - 'sessionrestore_no_auto_restore', 23:56:58 INFO - 'tabpaint']}, 23:56:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:56:58 INFO - 'ts_paint', 23:56:58 INFO - 'tpaint', 23:56:58 INFO - 'sessionrestore', 23:56:58 INFO - 'sessionrestore_no_auto_restore', 23:56:58 INFO - 'tabpaint']}, 23:56:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:56:58 INFO - 'tests': ['a11yr', 23:56:58 INFO - 'ts_paint', 23:56:58 INFO - 'tpaint', 23:56:58 INFO - 'sessionrestore', 23:56:58 INFO - 'sessionrestore_no_auto_restore', 23:56:58 INFO - 'tabpaint']}, 23:56:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:56:58 INFO - 'tests': ['a11yr', 23:56:58 INFO - 'ts_paint', 23:56:58 INFO - 'tpaint', 23:56:58 INFO - 'sessionrestore', 23:56:58 INFO - 'sessionrestore_no_auto_restore', 23:56:58 INFO - 'tabpaint']}, 23:56:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:56:58 INFO - 'tests': ['tsvgx', 23:56:58 INFO - 'tsvgr_opacity', 23:56:58 INFO - 'tart', 23:56:58 INFO - 'tscrollx', 23:56:58 INFO - 'cart']}, 23:56:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:56:58 INFO - 'tsvgr_opacity', 23:56:58 INFO - 'tart', 23:56:58 INFO - 'tscrollx', 23:56:58 INFO - 'cart']}, 23:56:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:58 INFO - 'talos_options': ['--disable-e10s'], 23:56:58 INFO - 'tests': ['tp5o']}, 23:56:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:58 INFO - 'tests': ['tp5o']}, 23:56:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:58 INFO - 'talos_options': ['--disable-e10s', 23:56:58 INFO - '--xperf_path', 23:56:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:56:58 INFO - 'tests': ['tp5n']}, 23:56:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:58 INFO - 'talos_options': ['--xperf_path', 23:56:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:56:58 INFO - 'tests': ['tp5n']}}, 23:56:58 INFO - 'talos.zip': {'path': '', 23:56:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:56:58 INFO - Running post-action listener: _resource_record_post_action 23:56:58 INFO - ##### 23:56:58 INFO - ##### Running create-virtualenv step. 23:56:58 INFO - ##### 23:56:58 INFO - Running pre-action listener: _resource_record_pre_action 23:56:58 INFO - Running main action method: create_virtualenv 23:56:58 INFO - Creating virtualenv /builds/slave/test/build/venv 23:56:58 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 23:56:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:56:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:56:58 INFO - Using real prefix '/usr' 23:56:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:56:59 INFO - Installing distribute.............................................................................................................................................................................................done. 23:57:01 INFO - Installing pip.................done. 23:57:01 INFO - Return code: 0 23:57:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:57: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')]} 23:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57: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')]} 23:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc587b65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314410>, '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 0x1315310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', '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 23:57: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', 'pip>=1.5'] in /builds/slave/test/build 23:57: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 pip>=1.5 23:57:01 INFO - Using env: {'DISPLAY': ':0', 23:57:01 INFO - 'HOME': '/home/cltbld', 23:57:01 INFO - 'LANG': 'en_US.UTF-8', 23:57:01 INFO - 'LANGUAGE': 'en_US:en', 23:57:01 INFO - 'LOGNAME': 'cltbld', 23:57:01 INFO - 'MAIL': '/var/mail/cltbld', 23:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:01 INFO - 'MOZ_NO_REMOTE': '1', 23:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:01 INFO - 'NO_EM_RESTART': '1', 23:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:01 INFO - 'PWD': '/builds/slave/test', 23:57:01 INFO - 'SHELL': '/bin/bash', 23:57:01 INFO - 'SHLVL': '1', 23:57:01 INFO - 'TERM': 'linux', 23:57:01 INFO - 'TMOUT': '86400', 23:57:01 INFO - 'USER': 'cltbld', 23:57:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', 23:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:01 INFO - '_': '/tools/buildbot/bin/python'} 23:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:01 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 23:57:01 INFO - Cleaning up... 23:57:01 INFO - Return code: 0 23:57:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:57: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')]} 23:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57: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')]} 23:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57: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', '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 0x7fc587b65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314410>, '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 0x1315310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', '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 23:57: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', 'psutil>=0.7.1'] in /builds/slave/test/build 23:57: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 psutil>=0.7.1 23:57:01 INFO - Using env: {'DISPLAY': ':0', 23:57:01 INFO - 'HOME': '/home/cltbld', 23:57:01 INFO - 'LANG': 'en_US.UTF-8', 23:57:01 INFO - 'LANGUAGE': 'en_US:en', 23:57:01 INFO - 'LOGNAME': 'cltbld', 23:57:01 INFO - 'MAIL': '/var/mail/cltbld', 23:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:01 INFO - 'MOZ_NO_REMOTE': '1', 23:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:01 INFO - 'NO_EM_RESTART': '1', 23:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:01 INFO - 'PWD': '/builds/slave/test', 23:57:01 INFO - 'SHELL': '/bin/bash', 23:57:01 INFO - 'SHLVL': '1', 23:57:01 INFO - 'TERM': 'linux', 23:57:01 INFO - 'TMOUT': '86400', 23:57:01 INFO - 'USER': 'cltbld', 23:57:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', 23:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:01 INFO - '_': '/tools/buildbot/bin/python'} 23:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:01 INFO - Downloading/unpacking psutil>=0.7.1 23:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:57:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:57:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:57:03 INFO - Installing collected packages: psutil 23:57:03 INFO - Running setup.py install for psutil 23:57:03 INFO - building 'psutil._psutil_linux' extension 23:57:03 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 23:57:04 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 23:57:04 INFO - building 'psutil._psutil_posix' extension 23:57:04 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 23:57:04 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 23:57:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:57:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:57:04 INFO - Successfully installed psutil 23:57:04 INFO - Cleaning up... 23:57:04 INFO - Return code: 0 23:57:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:57: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')]} 23:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57: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')]} 23:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57: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', '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 0x7fc587b65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314410>, '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 0x1315310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', '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 23:57: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:57: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 mozsystemmonitor==0.0.0 23:57:04 INFO - Using env: {'DISPLAY': ':0', 23:57:04 INFO - 'HOME': '/home/cltbld', 23:57:04 INFO - 'LANG': 'en_US.UTF-8', 23:57:04 INFO - 'LANGUAGE': 'en_US:en', 23:57:04 INFO - 'LOGNAME': 'cltbld', 23:57:04 INFO - 'MAIL': '/var/mail/cltbld', 23:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:04 INFO - 'MOZ_NO_REMOTE': '1', 23:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:04 INFO - 'NO_EM_RESTART': '1', 23:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:04 INFO - 'PWD': '/builds/slave/test', 23:57:04 INFO - 'SHELL': '/bin/bash', 23:57:04 INFO - 'SHLVL': '1', 23:57:04 INFO - 'TERM': 'linux', 23:57:04 INFO - 'TMOUT': '86400', 23:57:04 INFO - 'USER': 'cltbld', 23:57:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', 23:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:04 INFO - '_': '/tools/buildbot/bin/python'} 23:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:57: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 23:57: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 23:57: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 23:57: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 23:57: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 23:57: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 23:57:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:57:06 INFO - Installing collected packages: mozsystemmonitor 23:57:06 INFO - Running setup.py install for mozsystemmonitor 23:57:06 INFO - Successfully installed mozsystemmonitor 23:57:06 INFO - Cleaning up... 23:57:06 INFO - Return code: 0 23:57:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:57:06 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')]} 23:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:06 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')]} 23:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:06 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 0x7fc587b65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314410>, '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 0x1315310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', '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 23:57:06 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 23:57:06 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 23:57:06 INFO - Using env: {'DISPLAY': ':0', 23:57:06 INFO - 'HOME': '/home/cltbld', 23:57:06 INFO - 'LANG': 'en_US.UTF-8', 23:57:06 INFO - 'LANGUAGE': 'en_US:en', 23:57:06 INFO - 'LOGNAME': 'cltbld', 23:57:06 INFO - 'MAIL': '/var/mail/cltbld', 23:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:06 INFO - 'MOZ_NO_REMOTE': '1', 23:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:06 INFO - 'NO_EM_RESTART': '1', 23:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:06 INFO - 'PWD': '/builds/slave/test', 23:57:06 INFO - 'SHELL': '/bin/bash', 23:57:06 INFO - 'SHLVL': '1', 23:57:06 INFO - 'TERM': 'linux', 23:57:06 INFO - 'TMOUT': '86400', 23:57:06 INFO - 'USER': 'cltbld', 23:57:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', 23:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:06 INFO - '_': '/tools/buildbot/bin/python'} 23:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:06 INFO - Downloading/unpacking blobuploader==1.2.4 23:57: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 23:57: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 23:57: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 23:57: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 23:57: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 23:57: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 23:57:08 INFO - Downloading blobuploader-1.2.4.tar.gz 23:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:57:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:57:08 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 23:57:08 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 23:57:08 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 23:57:08 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 23:57:08 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 23:57:08 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 23:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:57:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:57:09 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 23:57:09 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 23:57:09 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 23:57:09 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 23:57:09 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 23:57:09 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 23:57:09 INFO - Downloading docopt-0.6.1.tar.gz 23:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:57:09 INFO - Installing collected packages: blobuploader, requests, docopt 23:57:09 INFO - Running setup.py install for blobuploader 23:57:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:57:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:57:09 INFO - Running setup.py install for requests 23:57:09 INFO - Running setup.py install for docopt 23:57:10 INFO - Successfully installed blobuploader requests docopt 23:57:10 INFO - Cleaning up... 23:57:10 INFO - Return code: 0 23:57:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:10 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 0x7fc587b65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314410>, '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 0x1315310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', '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 23:57:10 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 23:57:10 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 23:57:10 INFO - Using env: {'DISPLAY': ':0', 23:57:10 INFO - 'HOME': '/home/cltbld', 23:57:10 INFO - 'LANG': 'en_US.UTF-8', 23:57:10 INFO - 'LANGUAGE': 'en_US:en', 23:57:10 INFO - 'LOGNAME': 'cltbld', 23:57:10 INFO - 'MAIL': '/var/mail/cltbld', 23:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:10 INFO - 'MOZ_NO_REMOTE': '1', 23:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:10 INFO - 'NO_EM_RESTART': '1', 23:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:10 INFO - 'PWD': '/builds/slave/test', 23:57:10 INFO - 'SHELL': '/bin/bash', 23:57:10 INFO - 'SHLVL': '1', 23:57:10 INFO - 'TERM': 'linux', 23:57:10 INFO - 'TMOUT': '86400', 23:57:10 INFO - 'USER': 'cltbld', 23:57:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', 23:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:10 INFO - '_': '/tools/buildbot/bin/python'} 23:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:57:10 INFO - Running setup.py (path:/tmp/pip-F3Lmtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:57:10 INFO - Running setup.py (path:/tmp/pip-VhSBLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:57:10 INFO - Running setup.py (path:/tmp/pip-f5suLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:57:10 INFO - Running setup.py (path:/tmp/pip-eUz34f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:57:10 INFO - Running setup.py (path:/tmp/pip-yKhjeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:57:10 INFO - Running setup.py (path:/tmp/pip-Xsmwtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:57:10 INFO - Running setup.py (path:/tmp/pip-40YHdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:57:10 INFO - Running setup.py (path:/tmp/pip-qRm58y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:57:10 INFO - Running setup.py (path:/tmp/pip-opEgLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:57:10 INFO - Running setup.py (path:/tmp/pip-JFMBij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:57:11 INFO - Running setup.py (path:/tmp/pip-JsCXzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:57:11 INFO - Running setup.py (path:/tmp/pip-f7eRTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:57:11 INFO - Running setup.py (path:/tmp/pip-AS3AzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:57:11 INFO - Running setup.py (path:/tmp/pip-hoWp6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:11 INFO - Running setup.py (path:/tmp/pip-7GqPFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:57:11 INFO - Running setup.py (path:/tmp/pip-UaThET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:57:11 INFO - Running setup.py (path:/tmp/pip-m7NVw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:57:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:57:11 INFO - Running setup.py install for manifestparser 23:57:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:57:11 INFO - Running setup.py install for mozcrash 23:57:11 INFO - Running setup.py install for mozdebug 23:57:11 INFO - Running setup.py install for mozdevice 23:57:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:57:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:57:11 INFO - Running setup.py install for mozfile 23:57:12 INFO - Running setup.py install for mozhttpd 23:57:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:57:12 INFO - Running setup.py install for mozinfo 23:57:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:57:12 INFO - Running setup.py install for mozInstall 23:57:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:57:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:57:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:57:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:57:12 INFO - Running setup.py install for mozleak 23:57:12 INFO - Running setup.py install for mozlog 23:57:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:57:12 INFO - Running setup.py install for moznetwork 23:57:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:57:12 INFO - Running setup.py install for mozprocess 23:57:12 INFO - Running setup.py install for mozprofile 23:57:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:57:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:57:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:57:12 INFO - Running setup.py install for mozrunner 23:57:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:57:13 INFO - Running setup.py install for mozscreenshot 23:57:13 INFO - Running setup.py install for moztest 23:57:13 INFO - Running setup.py install for mozversion 23:57:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:57:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:57:13 INFO - Cleaning up... 23:57:13 INFO - Return code: 0 23:57:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:13 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 0x7fc587b65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314410>, '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 0x1315310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', '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 23:57:13 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 23:57:13 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 23:57:13 INFO - Using env: {'DISPLAY': ':0', 23:57:13 INFO - 'HOME': '/home/cltbld', 23:57:13 INFO - 'LANG': 'en_US.UTF-8', 23:57:13 INFO - 'LANGUAGE': 'en_US:en', 23:57:13 INFO - 'LOGNAME': 'cltbld', 23:57:13 INFO - 'MAIL': '/var/mail/cltbld', 23:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:13 INFO - 'MOZ_NO_REMOTE': '1', 23:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:13 INFO - 'NO_EM_RESTART': '1', 23:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:13 INFO - 'PWD': '/builds/slave/test', 23:57:13 INFO - 'SHELL': '/bin/bash', 23:57:13 INFO - 'SHLVL': '1', 23:57:13 INFO - 'TERM': 'linux', 23:57:13 INFO - 'TMOUT': '86400', 23:57:13 INFO - 'USER': 'cltbld', 23:57:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', 23:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:13 INFO - '_': '/tools/buildbot/bin/python'} 23:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:57:13 INFO - Running setup.py (path:/tmp/pip-H_8Q48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:57:13 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)) 23:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:57:13 INFO - Running setup.py (path:/tmp/pip-udT8jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:57:13 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)) 23:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:57:13 INFO - Running setup.py (path:/tmp/pip-l6VQE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:57:13 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)) 23:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:57:13 INFO - Running setup.py (path:/tmp/pip-MhPDa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:57:13 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)) 23:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:57:13 INFO - Running setup.py (path:/tmp/pip-NqtPCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:57:13 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)) 23:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:57:13 INFO - Running setup.py (path:/tmp/pip-VsKJaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:57:13 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)) 23:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:57:13 INFO - Running setup.py (path:/tmp/pip-hsZM50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:57:14 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)) 23:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:57:14 INFO - Running setup.py (path:/tmp/pip-DWJjOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:57:14 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)) 23:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:57:14 INFO - Running setup.py (path:/tmp/pip-kg6zzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:57:14 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)) 23:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:57:14 INFO - Running setup.py (path:/tmp/pip-jiXsy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:57:14 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)) 23:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:57:14 INFO - Running setup.py (path:/tmp/pip-Eo8NSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:57:14 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)) 23:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:57:14 INFO - Running setup.py (path:/tmp/pip-5oR9MD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:57:14 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)) 23:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:57:14 INFO - Running setup.py (path:/tmp/pip-fliP8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:57:14 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)) 23:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:57:14 INFO - Running setup.py (path:/tmp/pip-9_Qz4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:57:14 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)) 23:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:14 INFO - Running setup.py (path:/tmp/pip-L3rJT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:14 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)) 23:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:57:14 INFO - Running setup.py (path:/tmp/pip-NzUXzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:57:14 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)) 23:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:57:14 INFO - Running setup.py (path:/tmp/pip-IqrxXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:57:14 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)) 23:57:14 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)) 23:57:14 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)) 23:57:14 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)) 23:57:14 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)) 23:57:14 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)) 23:57:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:57:14 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 23:57:14 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 23:57:14 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 23:57:14 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 23:57:14 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 23:57:14 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 23:57:16 INFO - Downloading blessings-1.6.tar.gz 23:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:57:16 INFO - Installing collected packages: blessings 23:57:16 INFO - Running setup.py install for blessings 23:57:16 INFO - Successfully installed blessings 23:57:16 INFO - Cleaning up... 23:57:16 INFO - Return code: 0 23:57:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:57:17 INFO - Reading from file tmpfile_stdout 23:57:17 INFO - Current package versions: 23:57:17 INFO - argparse == 1.2.1 23:57:17 INFO - blessings == 1.6 23:57:17 INFO - blobuploader == 1.2.4 23:57:17 INFO - docopt == 0.6.1 23:57:17 INFO - manifestparser == 1.1 23:57:17 INFO - mozInstall == 1.12 23:57:17 INFO - mozcrash == 0.17 23:57:17 INFO - mozdebug == 0.1 23:57:17 INFO - mozdevice == 0.48 23:57:17 INFO - mozfile == 1.2 23:57:17 INFO - mozhttpd == 0.7 23:57:17 INFO - mozinfo == 0.9 23:57:17 INFO - mozleak == 0.1 23:57:17 INFO - mozlog == 3.1 23:57:17 INFO - moznetwork == 0.27 23:57:17 INFO - mozprocess == 0.22 23:57:17 INFO - mozprofile == 0.28 23:57:17 INFO - mozrunner == 6.11 23:57:17 INFO - mozscreenshot == 0.1 23:57:17 INFO - mozsystemmonitor == 0.0 23:57:17 INFO - moztest == 0.7 23:57:17 INFO - mozversion == 1.4 23:57:17 INFO - psutil == 3.1.1 23:57:17 INFO - requests == 1.2.3 23:57:17 INFO - wsgiref == 0.1.2 23:57:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:57:17 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')]} 23:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:17 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')]} 23:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:17 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 0x7fc587b65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314410>, '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 0x1315310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', '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 23:57:17 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 23:57:17 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 23:57:17 INFO - Using env: {'DISPLAY': ':0', 23:57:17 INFO - 'HOME': '/home/cltbld', 23:57:17 INFO - 'LANG': 'en_US.UTF-8', 23:57:17 INFO - 'LANGUAGE': 'en_US:en', 23:57:17 INFO - 'LOGNAME': 'cltbld', 23:57:17 INFO - 'MAIL': '/var/mail/cltbld', 23:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:17 INFO - 'MOZ_NO_REMOTE': '1', 23:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:17 INFO - 'NO_EM_RESTART': '1', 23:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:17 INFO - 'PWD': '/builds/slave/test', 23:57:17 INFO - 'SHELL': '/bin/bash', 23:57:17 INFO - 'SHLVL': '1', 23:57:17 INFO - 'TERM': 'linux', 23:57:17 INFO - 'TMOUT': '86400', 23:57:17 INFO - 'USER': 'cltbld', 23:57:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', 23:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:17 INFO - '_': '/tools/buildbot/bin/python'} 23:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:17 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)) 23:57:17 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)) 23:57:17 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)) 23:57:17 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)) 23:57:17 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)) 23:57:17 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)) 23:57:17 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)) 23:57:17 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)) 23:57:17 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)) 23:57:17 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)) 23:57:17 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)) 23:57:17 INFO - Cleaning up... 23:57:17 INFO - Return code: 0 23:57:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:57:17 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')]} 23:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:17 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')]} 23:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:17 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 0x7fc587b65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314410>, '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 0x1315310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', '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 23:57:17 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 23:57:17 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 23:57:17 INFO - Using env: {'DISPLAY': ':0', 23:57:17 INFO - 'HOME': '/home/cltbld', 23:57:17 INFO - 'LANG': 'en_US.UTF-8', 23:57:17 INFO - 'LANGUAGE': 'en_US:en', 23:57:17 INFO - 'LOGNAME': 'cltbld', 23:57:17 INFO - 'MAIL': '/var/mail/cltbld', 23:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:17 INFO - 'MOZ_NO_REMOTE': '1', 23:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:17 INFO - 'NO_EM_RESTART': '1', 23:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:17 INFO - 'PWD': '/builds/slave/test', 23:57:17 INFO - 'SHELL': '/bin/bash', 23:57:17 INFO - 'SHLVL': '1', 23:57:17 INFO - 'TERM': 'linux', 23:57:17 INFO - 'TMOUT': '86400', 23:57:17 INFO - 'USER': 'cltbld', 23:57:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', 23:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:17 INFO - '_': '/tools/buildbot/bin/python'} 23:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:17 INFO - Downloading/unpacking jsonschema 23:57:17 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 23:57:17 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 23:57:17 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 23:57:17 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 23:57:17 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 23:57:17 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 23:57:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:57:19 INFO - Downloading/unpacking functools32 (from jsonschema) 23:57:19 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 23:57:19 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 23:57:19 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 23:57:19 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 23:57:19 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 23:57:19 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 23:57:19 INFO - Downloading functools32-3.2.3-2.tar.gz 23:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:57:19 INFO - warning: no files found matching '*.txt' 23:57:19 INFO - no previously-included directories found matching 'build' 23:57:19 INFO - no previously-included directories found matching 'dist' 23:57:19 INFO - no previously-included directories found matching '.git*' 23:57:19 INFO - Installing collected packages: jsonschema, functools32 23:57:19 INFO - Running setup.py install for functools32 23:57:19 INFO - warning: no files found matching '*.txt' 23:57:19 INFO - no previously-included directories found matching 'build' 23:57:19 INFO - no previously-included directories found matching 'dist' 23:57:19 INFO - no previously-included directories found matching '.git*' 23:57:19 INFO - Successfully installed jsonschema functools32 23:57:19 INFO - Cleaning up... 23:57:19 INFO - Return code: 0 23:57:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:57:19 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')]} 23:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:19 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')]} 23:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:19 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 0x7fc587b65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314410>, '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 0x1315310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', '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 23:57:19 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 23:57:19 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 23:57:19 INFO - Using env: {'DISPLAY': ':0', 23:57:19 INFO - 'HOME': '/home/cltbld', 23:57:19 INFO - 'LANG': 'en_US.UTF-8', 23:57:19 INFO - 'LANGUAGE': 'en_US:en', 23:57:19 INFO - 'LOGNAME': 'cltbld', 23:57:19 INFO - 'MAIL': '/var/mail/cltbld', 23:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:19 INFO - 'MOZ_NO_REMOTE': '1', 23:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:19 INFO - 'NO_EM_RESTART': '1', 23:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:19 INFO - 'PWD': '/builds/slave/test', 23:57:19 INFO - 'SHELL': '/bin/bash', 23:57:19 INFO - 'SHLVL': '1', 23:57:19 INFO - 'TERM': 'linux', 23:57:19 INFO - 'TMOUT': '86400', 23:57:19 INFO - 'USER': 'cltbld', 23:57:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', 23:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:19 INFO - '_': '/tools/buildbot/bin/python'} 23:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:20 INFO - Downloading/unpacking flake8 23:57:20 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 23:57:20 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 23:57:20 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 23:57:20 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 23:57:20 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 23:57:20 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 23:57:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:57:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:57:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:57:22 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 23:57:22 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 23:57:22 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 23:57:22 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 23:57:22 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 23:57:22 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 23:57:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:57:22 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 23:57:22 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 23:57:22 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 23:57:22 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 23:57:22 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 23:57:22 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 23:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:57:22 INFO - no previously-included directories found matching 'docs/_build' 23:57:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:57:22 INFO - Running setup.py install for pep8 23:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:57:22 INFO - no previously-included directories found matching 'docs/_build' 23:57:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:57:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:57:22 INFO - Cleaning up... 23:57:22 INFO - Return code: 0 23:57:22 INFO - Running post-action listener: _resource_record_post_action 23:57:22 INFO - Running post-action listener: _start_resource_monitoring 23:57:22 INFO - Starting resource monitoring. 23:57:22 INFO - ##### 23:57:22 INFO - ##### Running install step. 23:57:22 INFO - ##### 23:57:22 INFO - Running pre-action listener: _resource_record_pre_action 23:57:22 INFO - Running main action method: install 23:57:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:57:23 INFO - Reading from file tmpfile_stdout 23:57:23 INFO - Detecting whether we're running mozinstall >=1.0... 23:57:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:57:23 INFO - Reading from file tmpfile_stdout 23:57:23 INFO - Output received: 23:57:23 INFO - Usage: mozinstall [options] installer 23:57:23 INFO - Options: 23:57:23 INFO - -h, --help show this help message and exit 23:57:23 INFO - -d DEST, --destination=DEST 23:57:23 INFO - Directory to install application into. [default: 23:57:23 INFO - "/builds/slave/test"] 23:57:23 INFO - --app=APP Application being installed. [default: firefox] 23:57:23 INFO - mkdir: /builds/slave/test/build/application 23:57:23 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'] 23:57:23 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 23:57:38 INFO - Reading from file tmpfile_stdout 23:57:38 INFO - Output received: 23:57:38 INFO - /builds/slave/test/build/application/firefox/firefox 23:57:38 INFO - Running post-action listener: _resource_record_post_action 23:57:38 INFO - ##### 23:57:38 INFO - ##### Running run-tests step. 23:57:38 INFO - ##### 23:57:38 INFO - Running pre-action listener: _resource_record_pre_action 23:57:38 INFO - Running main action method: run_tests 23:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:57:38 INFO - Python 2.7.3 23:57:38 INFO - Return code: 0 23:57:38 INFO - grabbing minidump binary from tooltool 23:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:38 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 0x1314410>, '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 0x1315310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:57:38 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 23:57:38 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 23:57:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:57:38 INFO - Return code: 0 23:57:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:57:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:57:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:57:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:57:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:57:39 INFO - Return code: 0 23:57:39 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/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 23:57:39 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/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 23:57:39 INFO - Using env: {'DISPLAY': ':0', 23:57:39 INFO - 'HOME': '/home/cltbld', 23:57:39 INFO - 'LANG': 'en_US.UTF-8', 23:57:39 INFO - 'LANGUAGE': 'en_US:en', 23:57:39 INFO - 'LOGNAME': 'cltbld', 23:57:39 INFO - 'MAIL': '/var/mail/cltbld', 23:57:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:57:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:39 INFO - 'MOZ_NO_REMOTE': '1', 23:57:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:39 INFO - 'NO_EM_RESTART': '1', 23:57:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:39 INFO - 'PWD': '/builds/slave/test', 23:57:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:57:39 INFO - 'SHELL': '/bin/bash', 23:57:39 INFO - 'SHLVL': '1', 23:57:39 INFO - 'TERM': 'linux', 23:57:39 INFO - 'TMOUT': '86400', 23:57:39 INFO - 'USER': 'cltbld', 23:57:39 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044', 23:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:39 INFO - '_': '/tools/buildbot/bin/python'} 23:57:39 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/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 23:57:40 INFO - mozversion application_buildid: 20160511211918 23:57:40 INFO - mozversion application_changeset: 2fb177e17d81e069a02797c6234e8ed085cbc55c 23:57:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:57:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:57:40 INFO - mozversion application_name: Firefox 23:57:40 INFO - mozversion application_remotingname: firefox-dev 23:57:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:57:40 INFO - mozversion application_vendor: Mozilla 23:57:40 INFO - mozversion application_version: 48.0a2 23:57:40 INFO - mozversion platform_buildid: 20160511211918 23:57:40 INFO - mozversion platform_changeset: 2fb177e17d81e069a02797c6234e8ed085cbc55c 23:57:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:57:40 INFO - mozversion platform_version: 48.0a2 23:57:40 INFO - using testdate: 1463036260 23:57:40 INFO - actual date: 1463036260 23:57:40 INFO - starting webserver on 'localhost:60735' 23:57:40 INFO - SUITE-START | Running 2 tests 23:57:40 INFO - TEST-START | dromaeo_css 23:57:40 INFO - operating with platform_type : linux_ 23:57:40 INFO - Initialising browser for dromaeo_css test... 23:57:40 INFO - TEST-INFO | started process 21316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHcRPAa/profile http://localhost:60735/getInfo.html) 23:57:44 INFO - PROCESS | 21316 | 23:57:44 INFO - PROCESS | 21316 | (process:21399): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:57:44 INFO - PROCESS | 21316 | __metrics Screen width/height:1600/1200 23:57:44 INFO - PROCESS | 21316 | colorDepth:24 23:57:44 INFO - PROCESS | 21316 | Browser inner width/height: 1024/697 23:57:44 INFO - PROCESS | 21316 | __metrics 23:57:45 ERROR - PROCESS | 21316 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:57:46 INFO - TEST-INFO | 21316: exit 0 23:57:46 INFO - Browser initialized. 23:57:46 INFO - Running cycle 1/1 for dromaeo_css test... 23:57:46 INFO - TEST-INFO | started process 21450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHcRPAa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:57:48 INFO - PROCESS | 21450 | 23:57:48 INFO - PROCESS | 21450 | (process:21518): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:57:58 INFO - PROCESS | 21450 | RSS: Main: 151666688 23:57:58 INFO - PROCESS | 21450 | 23:58:47 INFO - PROCESS | 21450 | 1463036327856 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] 00:00:55 INFO - PROCESS | 21450 | Cycle 1(1): loaded http://localhost:60735/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60735/tests/dromaeo/cssquery-ext.html) 00:00:56 INFO - PROCESS | 21450 | RSS: Main: 154554368 00:00:56 INFO - PROCESS | 21450 | 00:03:58 INFO - PROCESS | 21450 | Cycle 1(1): loaded http://localhost:60735/tests/dromaeo/cssquery-ext.html (next: http://localhost:60735/tests/dromaeo/cssquery-jquery.html) 00:03:59 INFO - PROCESS | 21450 | RSS: Main: 152604672 00:03:59 INFO - PROCESS | 21450 | 00:07:00 INFO - PROCESS | 21450 | Cycle 1(1): loaded http://localhost:60735/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60735/tests/dromaeo/cssquery-mootools.html) 00:07:01 INFO - PROCESS | 21450 | RSS: Main: 152207360 00:07:01 INFO - PROCESS | 21450 | 00:10:02 INFO - PROCESS | 21450 | Cycle 1(1): loaded http://localhost:60735/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60735/tests/dromaeo/cssquery-prototype.html) 00:10:03 INFO - PROCESS | 21450 | RSS: Main: 153403392 00:10:03 INFO - PROCESS | 21450 | 00:13:05 INFO - PROCESS | 21450 | Cycle 1(1): loaded http://localhost:60735/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60735/tests/dromaeo/cssquery-yui.html) 00:13:06 INFO - PROCESS | 21450 | RSS: Main: 152899584 00:13:06 INFO - PROCESS | 21450 | 00:16:08 INFO - PROCESS | 21450 | Cycle 1(1): loaded http://localhost:60735/tests/dromaeo/cssquery-yui.html (next: http://localhost:60735/tests/dromaeo/cssquery-dojo.html) 00:16:09 INFO - PROCESS | 21450 | RSS: Main: 155467776 00:16:09 INFO - PROCESS | 21450 | 00:16:09 INFO - PROCESS | 21450 | __start_tp_report 00:16:09 INFO - PROCESS | 21450 | _x_x_mozilla_page_load 00:16:09 INFO - PROCESS | 21450 | _x_x_mozilla_page_load_details 00:16:09 INFO - PROCESS | 21450 | |i|pagename|runs| 00:16:09 INFO - PROCESS | 21450 | |0;dojo.html;3359.2273777031282;3404.6765557272065;3420.315936812638;3436.570428696413;3442.535257740206;5614.157876318554;5646.153077038442;5666.376698563155;5673.404292549285;5713.800016999406;5560.527355174815;5598.832035038945;5620.775168993246;5643.717814109288;5643.915341269884;5103.821366252191;5122.948770512303;5166.199239117943;5174.896502069956;5196.844094677166;5058.671186372892;5176.818811341604;5192.948070519285;5265.552428043621;5273.815416460425;5109.923351149736;5134.332536770234;5137.845864624067;5162.148245539482;5254.054270231357;5187.714675692835;5194.584433245332;5195.376554813447;5204.9219261711105;5208.140656791625;5090.440051594322;5121.129408000649;5121.513456221653;5168.8966220675375;5199.064168449678;5429.375621803503;5485.204645326406;5485.4788795064405;5506.889862202774;5585.162225666142;6103.216304434332;6115.936978868489;6124.351350138838;6126.090206827809;6131.858919339687;6137.162486020161;6178.443940045418;6185.721642526052;6191.9690401547705;6195.7521699131985;5497.587680923907;5520.254765606672;5582.972085139549;5769.5672824537905;5796.478316951452;6105.32841387447;6171.444569988723;6247.344028876993;6290.49676025926;6348.523860710465;5987.1318658794235;6000.369961154103;6002.969985150134;6016.488598469179;6045.183900173508;5810.796622118206;5923;6063;6077.513798896078;6086.6348019119;5972.671503067373;5979.1928089707335;5980.102984552352;5980.55145864062;6020.217371741734;5935.762569497172;5990.221271234712;5996.640201587918;5997.070454079538;5999.070144127667;4503.527129651405;4551.52209018055;4564.475085365159;4564.748938808331;4588.518205588432;4099.487564054493;4102.077032667686;4112.177564487115;4112.239235741397;4120.711550191518;5800.767969281266;5831.3877042910735;5834.737436815353;5843.853903652443;5862.765489380377;5933.673647949404;6015.0676645120075;6095.6952152392205;6130.2030736004035;6155.446009859134;5896.027155519377;5910.379410161957;5910.940890591125;5922.407759224129;5930.584859059911;5257.579393648575;5257.605679574047;5263.578913686896;5265.815696450606;5275.736213189325;6168.9691551541955;6274.623522588659;6292.370762923671;6298.842528936813;6304.495640348853;6187.659678717624;6203.751849925952;6204.5967012144065;6213.5339849510565;6218.751249949952;6113.4152177380265;6117.3402608778015;6368.044793281045;6378.553501254868;6385.616862988236;6051.939480605138;6055.969720151371;6060.2424696912885;6073.423024812636;6095.817125486243;6109.694515274307;6127.662978536223;6132.938670613236;6144.986077297374;6148.815535533941;5753.654780713171;5902.822915312548;5961.225040744675;5991.161237426677;6009.609375390585;5943.821685349273;5948.196993406008;5951.761929522944;5955.702214889325;5964.343922168645;5831.562632802472;5845.678487683218;5854.765809367577;5879.882402352015;5880.882382352243;5830.300363956352;5899.764009439575;5959.433853783884;5992.910106348321;6012.669303188367;5799.130130480462;5862.208601838868;5864.765409383577;5872.882542349214;5879 00:16:09 INFO - PROCESS | 21450 | |1;ext.html;623.2489849731074;654.1822721598002;663.8340414896275;664.7772996046324;697.7069630755083;42766.0755266013;44251.3362299565;44296;44340.55659443405;44483;44606;44916.3262551062;44995.325070123894;45222.773886130606;45354;8884.822303553925;9033.728988130366;9069.637214511411;9075.228605568534;9082.273418126568;8966.327525435585;9012.27901767857;9034.774130646754;9045.959714632836;9073.773155671128;9010.729678109667;9061.773455663595;9076.954615226914;9083.591238394289;9085.54572271387;8992.910070899305;9003.729888103302;9012.369134160612;9016.233620142262;9049.095090490964;8970.820583588356;9018.549072546411;9041.276697864156;9093.227075698573;9093.59078841447;40709.185816283505;41386.37920431196;41393.79303103465;41494.792526037476;41690.58309416897;3802.5627052888995;3821.8662346817728;4001.6198461146437;4035.899102522431;4562.406887104688;33722.662773372445;34085.48871766926;34370.48444273338;34410.82794586036;34463.48304775431;4509.098180363908;4515.390422292981;4586.977065114686;4659.324397962277;4671.229247174212;319309.4379809086;321039;322138;323700;325779;58277;58527.12209316863;58635.413645863846;64450;64666;71229;71770;71787.64106179436;71956;72099.27900721031;19906.701399479018;20003.699944500844;20170.193192272145;20185.59628807445;20234.190632374834;15118;15153.318100685496;15192.164430956404;15317.157556334509;15414.691706165813;21351.25270615552;21385;21403.250886218906;21559.24542641;21589.892050539645;7585.848283034419;7594.962025189839;7625.466217364731;7894.960525197337;7919.485233459806;1109.3343993603773;1153.7692461507731;1160.3270103340042;1163.4066626020622;1243.7947738623027;33354;33447;33524.16189595231;33526.83236583802;34411.4838277426;1205.879412058787;1243.6766440725476;1247.6756043428775;1255.3974092435683;1295.4947570447343;16975.830241697673;17434.389796357067;17563.73654395185;17573.113781072967;17620.735688964676;485518;545018;552883;556330;860029;56444.71777641168;56892.71553642205;57279.71360143173;57418.712906436034;57759.71120144457;1557.6806754615504;1565.5146904459655;1572.6776010917733;1577.242923396776;1581.7785510028605;32582.83708581442;33934.490982635776;34019.65980340165;34066.95598264112;34510.30979380449;55504;56131;56209;56232.71883640719;56346.43653563412;428460;431112;432230;433450;434227;31431.842840785648;31804.204894877814;32383.51424728584;32425;32438.675613243566;51147.74426127846;51345.743271283405;51474;52359.73820130875;52690.736546318556;42459;42920.35619465648;43036.78481607572;43932.78033609811;44406.3339049908;41225.587744122175;41678.583214168684;41896.581034189265;42367.78816106023;42778;42468;42650.78674606607;43185.56814431941;43666;43667.344989824545;36044.27911441704;36509.26981460409;36530.08674783152;36535.45196821997;36618.26763464769;28916.42167156687;28975.900904278587;29061.418771624027;30687;30759.53860692136 00:16:09 INFO - PROCESS | 21450 | |2;jquery.html;410.673514555928;412.4143715923387;420.6844866350238;425.09242766693103;436.7816091954023;18926.337578184768;19553.804461955377;19559.315423960164;20847.583048339064;21160;18532;19272.710909336372;19323;20376.083076261566;20393.796062039375;5298.258243845855;5430.3755068167075;5468.890622187574;5752.395998420168;5927.555433342495;5775.711214439282;5847.502962248214;5850.093235548476;5869.060950247961;5878;5422.511973922346;5425.810096646618;5762.02045652238;5772.365039845614;5781.739821708013;5416.566674666017;5418.512333889949;5439.347278326606;5444.91832622511;5466.01611709894;5227.3465816772905;5284.709340986245;5308.5487733542695;5344.545713614348;5356.4375740547075;14123.152610843383;14389.568312950523;14508.492202772957;14545.34545945435;16658.83341166597;2448.094205144108;2474.925752227436;2495.8502489850666;2496.8252222344445;2553.1319351420607;10354.844677329771;10988.835167472495;11359.402241594022;13683;14022.439102435992;2036.7046778217223;2041.6427125253022;2090.1743811194647;2146.441925099485;2148.1514801653416;79734;81882;82631;82874.58562707208;83849;11270.436478176221;11454.54181832734;11528.481218345194;11530.827037594443;11658.475368608433;15726.842731572538;15746.448874289574;15796.763048554281;15944.521664350088;15988.360465581247;8712.085231050649;8735.694250701323;8828.823423531494;8899.777903931068;8969.686060987835;8634.22291993711;8745;8773.912260877309;8787.472751634923;8836.955815220883;4899.485554016848;4905.068037073016;4922.753862306942;4964.230544265644;5060.038592667382;1929.8263156316;1993.3322337017262;2020.3736841579157;2033.3086750504604;2035.5013021809752;962.0908241711516;1053.4153544782719;1170.8946194842506;1181.8490347567345;1183.9408029598485;18595.34916277924;21090.47273818136;21115.049822758014;21159.04784284711;21177.68233476499;1087.2606627493221;1094.9726256843642;1109.2290857853875;1171.8945294923499;1205.9698507537207;10868.967448092419;11160.944195278971;11216.943915280372;11219;11235.325880447199;620693;622578;624191;648140;657889;101170.49414752879;102506.48746756368;103349.48325258326;103701.48149259205;103813.48093259486;1164.9708757280966;1167.772284404533;1180.2741314091772;1198.5565340823778;1213.1932265043647;17277.39529116475;17511.912440437718;17854.642907142043;18047;18175.363862264756;26754.59868102019;29916.401671966873;31741.68258317387;42082.579174207865;43033.784831075645;62076.689616553434;62334;62561.68719156375;62817.37182628115;62853.37146628658;8861.33539984491;8869.113088691338;9109;9174.954125229331;9265.53672316395;12567.120301578801;13224.669383265495;13518.526851560147;13716.245606491739;13930.930345348208;11618.593349232737;11718.472668729757;11931.806819318346;12234.938825306173;12289.324087175291;11327.603533876605;11728.824067639163;11753.412329383325;12007.75984480323;12120;11800.70498237551;12584.30786306762;12920.741585168056;13062.412191451218;13195.802062969255;9054.954725226331;9170.495622740813;9178.954105229432;9257.981622021438;9271.238464691956;9281.67514137002;11879.34663593476;12306;12401.689957750768;12455.439505222468 00:16:09 INFO - PROCESS | 21450 | |3;mootools.html;1524.138861543228;1524.1921781455826;1716.6652502761967;1886.556659185092;1907.9904600476996;6780.627065511395;7979.92020079799;8149.062857771358;8181.672733090677;8206.261436470717;8015.7194498192575;8051.838963220746;8082.95958520208;8108.878366824488;8117.9594102029405;2404.759524047599;2418.129473389587;2421.987890060547;2432.74456182101;2436.671049408325;2352.6000579901374;2359;2382.0471811275456;2384.606539920911;2396.9640455393182;2364.160722943356;2385.3917251101034;2395.2933884504114;2406.470576473173;2411.6141417373224;2384.880755962195;2396.197273913241;2404.1945948107405;2407.566638005167;2422.63660450932;2358.563665721847;2404.747501512351;2432.659427680126;2434.403571125086;2438.4879175373017;8149.918500815034;8162.877556836652;8166.836663266701;8182.67269309227;8220;5167.638265321429;5256.684598924038;5277.736113194325;5296.814611488618;5311.575073994071;3432.8671538392273;3473.235888104613;3489.5114683944266;3496.807675577842;3541.8583256669704;1135.642272684102;1138.430784607696;1143.1940481960198;1143.8627364716288;1154.757500924807;10999.450027498593;11144.665660030212;11178;11259.605913792979;11289;4501.549845015472;4538.251188553918;4578.633709303248;4584.5186255442695;4591.885202869955;9843.114119729116;9849.359791613522;9856.112949834549;9867.901320986843;9918.008199180169;5228.294180285613;5273.393559740679;5279.709615971082;5279.709615971158;5282.286891269706;4190.874273771792;4735.21868891629;4809.206480930678;4857.052874689472;4918.409790825124;3961.801909904551;3968.3650615901893;4000.8399664013114;4051.4327994080854;4071.9796401017807;1295.941682624284;1302.8241187439764;1303.88916942061;1304.1392680830795;1308.9018323625767;1000.1798525209404;1008.4100801031332;1019.3832731197667;1020.8009438159488;1033.0289527843802;5430.266913966643;5456.863578410572;5499.835004949858;5504.339479262514;5522.006038912954;1096.88666004006;1116.5198964445367;1152.746395792941;1152.8501294831617;1177.240679761549;3756.3426400379826;3877.263319969197;3934.86227982025;3953.2686453006286;3958.7030972677167;9750.707478775648;9981.251406144569;10167.847482287772;10273.332233404804;10313.84529232062;9112.95443522778;9416.858747118798;9443.669471568463;9477.052294770469;10048.879959216685;7783.571903545359;7790.649420776079;7800.1419843816;7872.921270787333;7876.448648594658;5479.780808767605;5503.669779813224;5574.888502229852;5619.606627536196;5627.8593035174445;8764.649414023368;8781.868271975798;8807.075257097913;8840.823183536422;8854.070322616033;8615.655373785228;8709.259712924473;8724.214820666171;8811.823763524822;8971.865422018544;5961.493273071837;6978.860422791618;7135.464840137114;7355.926440735524;7686.57723825195;7617.961910190414;7631.656575454229;7643.541387516767;7659.808504787202;7664.770056898302;6830.180378354629;6885.345892140239;6908.067410899464;6936.375726184668;7009.719611215494;6735.158105236846;6746.257911629815;6779.491538134561;6822.692978816064;6867.656617169221;6531.444827189742;6558.80323590293;6615.106960560262;6628.07206991012;6634.270230274762;4895.192293271571;4897.559219670246;4923.778429970588;4936.43231028422;4987;4963.875903102306;4980.750962451935;5044.571211447068;5071.315372424676;5104.0812653721205 00:16:09 INFO - PROCESS | 21450 | |4;prototype.html;343.39048189463716;357.313957202172;358.2923725641856;358.8743939621133;359.2330374650122;6390.201224846883;6549.508786840982;6567.573107747993;6623.867522649544;6642.734290628375;6349.1746073010445;6447;6488.513361497895;6541.869162616745;6551.4431273341825;4925.556699897017;4926.433460152075;4954.975225123887;4956.975215123937;4970.453250142499;4941.085899108676;4948.084604348189;4959.107360675077;4971.27916452116;4978.153713868651;4927.2609108633815;4933;4937.975310123445;4942.555170034696;4948.851534453954;4774.188387974053;4927.236278376858;4938.3086367908345;4941.308216849626;4944.901101977958;4324.762138082404;4350.651947844165;4352.216601011816;4357.629601483878;4357.803898824561;6279.780207692755;6284.402981716776;6291.8741625167695;6325.810225693236;6329.778457753957;5832.475077243069;5833.095870140135;5838.357780644125;5853.648781073107;5855.795047173328;6880.483963702743;6918.342757438036;6928.16861976566;6934.306569343075;6937;4737.573618374363;4884.658073934826;4892.217245240744;4894.926576101361;4904;7230.132384113887;7275.745348912816;7277.963610181915;7302.890456643155;7316.926830731678;4968.552830245295;4978.850634480971;4979.751012449363;4990.451050384455;4994.175960966472;5045.8738531537;5051.191809310492;5051.823186188466;5053.570446512014;5064.620153488503;5789.247397838254;5801.796937107181;5803.129530570448;5818.7672493100645;5824.068149096124;6761.628110453874;6997;7035.155781306276;7056.858862822714;7057.047298614724;1785.2055835153492;1790.9104544772708;1801.819818018214;1803.666321730484;1804.5127815489743;1128.8306753986967;1173.2549830857297;1191.845060142176;1191.988080119205;1212.9757404851853;6713.865722685617;6741.1236539249585;6794.966025169842;6801.149856267966;6810;7293.927060729431;7312.049433573708;7315.743948961761;7317.707291708379;7326.96336518314;6808.148981377328;6858.177018757681;6860.348266914635;6863.073485079451;6876.381125698711;3879.86420475282;3903.434002069684;3943.171933893857;3944.901377465529;3957.2679054375035;7445.771447711067;7452.962735186397;7492.325690687864;7514.323710866049;7532.322091011835;7305.525140865933;7332;7355.668994895243;7367;7383;7487.2512748725785;7496;7501.624918754041;7504.099508059068;7532.698692052366;7108.466864985044;7230.13238411394;7254.492185546961;7275.890861636974;7289.489735718661;7224.277572242734;7225.855482890418;7231.16841563227;7274.527155734861;7304.379127774198;7523.435742319239;7537.54774713519;7546.169921308542;7546.471746977659;7553.811154721176;4854.660173787801;4899.216125419915;4899.559039686445;4905.950940490549;4907.656464047625;7061.611611361424;7282.817929551804;7290.359669074416;7291.817704557428;7292.088488938883;7057.8473565563;7092.361687448154;7099.112610923635;7105.076340075757;7111.648786730505;6953.582785032914;6980.825479363057;6997.790066298019;7005.929940700732;7028.789136325919;6858.588484690935;6870.862582748417;6887.690053947485;6930.44556435494;6933.82665433348;6962.025316455802;7067.752628657972;7096.787096387116;7105.111861017373;7161.677724502514;6765.9661701691175;6933.514653974174;6949.861002779815;6955.965220173866;6976.651167441506 00:16:09 INFO - PROCESS | 21450 | |5;yui.html;794.9443538952272;799.0411506192567;862.6075135813205;868.9782755431113;873.122511875565;13044.152130111535;13048.804267935977;13160;13160.276184809843;15633.296501657424;15545.766813497778;15644.296006679699;15750.921245393756;15809.288582013809;15834.920825395886;884.5444596033049;894.2935081285776;905.2712566384058;915.1214833759599;922.8754118194058;903.286403741047;904.5612877754317;907.8002839375326;910.7404389748923;911.0843602179833;940.1538615246264;941.0354386753564;944.0842382888587;945.2485274207022;947.3605316411429;935.359278893953;939.1406862720603;939.2439086535336;940.4874343482784;940.5156344482597;695.6069820551372;695.766918082443;695.919969203543;696.2271878215178;698.7868700046483;15555.922220388826;15586.922065389714;15606.219689015505;15610.141442220673;15651.608709782233;12995.220286782824;13021.153625014344;13026.674333141653;13131.606051818366;13139.14595551286;10993.340399576051;11132.777344453065;11227.607033753779;11227.66317010491;11495.252808567417;3994;4002.8398864045403;4006.6193711597352;4008.5590585035625;4078.8572399966156;57799;57870.710646446496;58220;58384.70807645977;58450.707746461;10351.06840384369;10560.366378017343;10563.788724225626;10613.150947924301;10616.681499555025;19888.10503527345;19943.900280498794;19970.20119195245;19988.20047198096;20017.699734503993;8092.190780921861;8182.918170818216;8225;8245.79385515367;8295.8340833183;4530.252508336088;4587.3348364486965;4608.986023074918;4611.169989401873;4639.698419602715;3339.532465454838;3376.544166537486;3391.609964854024;3409.301093275922;3412.744044196695;610.703808652803;611.458858909859;613.0773186354597;628.13003989474;634.0615888485067;703.869784089945;705.9258777828356;713.4969846258375;723.1864152828068;734.353768683555;8946.955265223633;9149.130832570896;9364.484953327496;10045.849312260321;10496.47517624131;775.8836174573859;786.390547325827;803.2931020701861;803.9236272554098;828.1925123005142;4302.44068271129;4377.824887004548;4417.514073451917;4717.3631559739;4745.881352966135;61186.388136118956;61276.69361653163;62778;62826;67912;52437.7378113107;55372.44627553673;59016.40983590195;59115.70442147762;59477.70261148667;53324;53395.73302133542;53420;53853.19220211622;53891;9298.814023719622;9821.165200958;10173.08442240202;10207.183425325808;10313.535890884777;36197.63802361942;38553.80723096366;40084.79957600193;40140.3978940322;40229.39655905222;52368.47631523636;53001;53315.73342133265;53522.464775353306;54181;11510;11514.654560363202;11516.769664606829;11714.23857449263;11808;13229.669258268621;13825.585232443043;14020;14086.859131408964;14403.78394324107;13031.739365212454;13134.146280491737;13452.838752475196;13524;13800.654983625089;12636.494540218288;12923.741525169256;13076.542321018718;13261.07172497916;13554.051216414757;13162.868371316164;13358.465661373437;13431.462741490232;13527.391267392793;13666.794998074838;11553.653390398302;11577.305361678325;11653;11781.587644432404;11898.286102833858;11343.602973895873;11406.885931140583;11460.94269528647;11528.250663706833;11769.646910592695 00:16:09 INFO - PROCESS | 21450 | __end_tp_report 00:16:09 INFO - PROCESS | 21450 | __start_cc_report 00:16:09 INFO - PROCESS | 21450 | _x_x_mozilla_cycle_collect,318 00:16:09 INFO - PROCESS | 21450 | __end_cc_report 00:16:09 INFO - PROCESS | 21450 | __startTimestamp1463037369050__endTimestamp 00:16:09 INFO - PROCESS | 21450 | 00:16:09 INFO - PROCESS | 21450 | ------- Summary: start ------- 00:16:09 INFO - PROCESS | 21450 | Number of tests: 6 00:16:09 INFO - PROCESS | 21450 | 00:16:09 INFO - PROCESS | 21450 | [#0] dojo.html Cycles:165 Average:5648.11 Median:5880.88 stddev:639.58 (10.9%) stddev-sans-first:615.82 00:16:09 INFO - PROCESS | 21450 | Values: 3359.2 3404.7 3420.3 3436.6 3442.5 5614.2 5646.2 5666.4 5673.4 5713.8 5560.5 5598.8 5620.8 5643.7 5643.9 5103.8 5122.9 5166.2 5174.9 5196.8 5058.7 5176.8 5192.9 5265.6 5273.8 5109.9 5134.3 5137.8 5162.1 5254.1 5187.7 5194.6 5195.4 5204.9 5208.1 5090.4 5121.1 5121.5 5168.9 5199.1 5429.4 5485.2 5485.5 5506.9 5585.2 6103.2 6115.9 6124.4 6126.1 6131.9 6137.2 6178.4 6185.7 6192.0 6195.8 5497.6 5520.3 5583.0 5769.6 5796.5 6105.3 6171.4 6247.3 6290.5 6348.5 5987.1 6000.4 6003.0 6016.5 6045.2 5810.8 5923.0 6063.0 6077.5 6086.6 5972.7 5979.2 5980.1 5980.6 6020.2 5935.8 5990.2 5996.6 5997.1 5999.1 4503.5 4551.5 4564.5 4564.7 4588.5 4099.5 4102.1 4112.2 4112.2 4120.7 5800.8 5831.4 5834.7 5843.9 5862.8 5933.7 6015.1 6095.7 6130.2 6155.4 5896.0 5910.4 5910.9 5922.4 5930.6 5257.6 5257.6 5263.6 5265.8 5275.7 6169.0 6274.6 6292.4 6298.8 6304.5 6187.7 6203.8 6204.6 6213.5 6218.8 6113.4 6117.3 6368.0 6378.6 6385.6 6051.9 6056.0 6060.2 6073.4 6095.8 6109.7 6127.7 6132.9 6145.0 6148.8 5753.7 5902.8 5961.2 5991.2 6009.6 5943.8 5948.2 5951.8 5955.7 5964.3 5831.6 5845.7 5854.8 5879.9 5880.9 5830.3 5899.8 5959.4 5992.9 6012.7 5799.1 5862.2 5864.8 5872.9 5879.0 00:16:09 INFO - PROCESS | 21450 | 00:16:09 INFO - PROCESS | 21450 | [#1] ext.html Cycles:180 Average:62531.78 Median:237074.39 stddev:125624.43 (53.0%) stddev-sans-first:125890.85 00:16:09 INFO - PROCESS | 21450 | Values: 623.2 654.2 663.8 664.8 697.7 42766.1 44251.3 44296.0 44340.6 44483.0 44606.0 44916.3 44995.3 45222.8 45354.0 8884.8 9033.7 9069.6 9075.2 9082.3 8966.3 9012.3 9034.8 9046.0 9073.8 9010.7 9061.8 9077.0 9083.6 9085.5 8992.9 9003.7 9012.4 9016.2 9049.1 8970.8 9018.5 9041.3 9093.2 9093.6 40709.2 41386.4 41393.8 41494.8 41690.6 3802.6 3821.9 4001.6 4035.9 4562.4 33722.7 34085.5 34370.5 34410.8 34463.5 4509.1 4515.4 4587.0 4659.3 4671.2 319309.4 321039.0 322138.0 323700.0 325779.0 58277.0 58527.1 58635.4 64450.0 64666.0 71229.0 71770.0 71787.6 71956.0 72099.3 19906.7 20003.7 20170.2 20185.6 20234.2 15118.0 15153.3 15192.2 15317.2 15414.7 21351.3 21385.0 21403.3 21559.2 21589.9 7585.8 7595.0 7625.5 7895.0 7919.5 1109.3 1153.8 1160.3 1163.4 1243.8 33354.0 33447.0 33524.2 33526.8 34411.5 1205.9 1243.7 1247.7 1255.4 1295.5 16975.8 17434.4 17563.7 17573.1 17620.7 485518.0 545018.0 552883.0 556330.0 860029.0 56444.7 56892.7 57279.7 57418.7 57759.7 1557.7 1565.5 1572.7 1577.2 1581.8 32582.8 33934.5 34019.7 34067.0 34510.3 55504.0 56131.0 56209.0 56232.7 56346.4 428460.0 431112.0 432230.0 433450.0 434227.0 31431.8 31804.2 32383.5 32425.0 32438.7 51147.7 51345.7 51474.0 52359.7 52690.7 42459.0 42920.4 43036.8 43932.8 44406.3 41225.6 41678.6 41896.6 42367.8 42778.0 42468.0 42650.8 43185.6 43666.0 43667.3 36044.3 36509.3 36530.1 36535.5 36618.3 28916.4 28975.9 29061.4 30687.0 30759.5 00:16:09 INFO - PROCESS | 21450 | 00:16:09 INFO - PROCESS | 21450 | [#2] jquery.html Cycles:180 Average:33359.64 Median:11590.32 stddev:104267.08 (899.6%) stddev-sans-first:104530.22 00:16:09 INFO - PROCESS | 21450 | Values: 410.7 412.4 420.7 425.1 436.8 18926.3 19553.8 19559.3 20847.6 21160.0 18532.0 19272.7 19323.0 20376.1 20393.8 5298.3 5430.4 5468.9 5752.4 5927.6 5775.7 5847.5 5850.1 5869.1 5878.0 5422.5 5425.8 5762.0 5772.4 5781.7 5416.6 5418.5 5439.3 5444.9 5466.0 5227.3 5284.7 5308.5 5344.5 5356.4 14123.2 14389.6 14508.5 14545.3 16658.8 2448.1 2474.9 2495.9 2496.8 2553.1 10354.8 10988.8 11359.4 13683.0 14022.4 2036.7 2041.6 2090.2 2146.4 2148.2 79734.0 81882.0 82631.0 82874.6 83849.0 11270.4 11454.5 11528.5 11530.8 11658.5 15726.8 15746.4 15796.8 15944.5 15988.4 8712.1 8735.7 8828.8 8899.8 8969.7 8634.2 8745.0 8773.9 8787.5 8837.0 4899.5 4905.1 4922.8 4964.2 5060.0 1929.8 1993.3 2020.4 2033.3 2035.5 962.1 1053.4 1170.9 1181.8 1183.9 18595.3 21090.5 21115.0 21159.0 21177.7 1087.3 1095.0 1109.2 1171.9 1206.0 10869.0 11160.9 11216.9 11219.0 11235.3 620693.0 622578.0 624191.0 648140.0 657889.0 101170.5 102506.5 103349.5 103701.5 103813.5 1165.0 1167.8 1180.3 1198.6 1213.2 17277.4 17511.9 17854.6 18047.0 18175.4 26754.6 29916.4 31741.7 42082.6 43033.8 62076.7 62334.0 62561.7 62817.4 62853.4 8861.3 8869.1 9109.0 9175.0 9265.5 12567.1 13224.7 13518.5 13716.2 13930.9 11618.6 11718.5 11931.8 12234.9 12289.3 11327.6 11728.8 11753.4 12007.8 12120.0 11800.7 12584.3 12920.7 13062.4 13195.8 9055.0 9170.5 9179.0 9258.0 9271.2 9281.7 11879.3 12306.0 12401.7 12455.4 00:16:09 INFO - PROCESS | 21450 | 00:16:09 INFO - PROCESS | 21450 | [#3] mootools.html Cycles:180 Average:5434.09 Median:5015.79 stddev:2877.57 (57.4%) stddev-sans-first:2870.64 00:16:09 INFO - PROCESS | 21450 | Values: 1524.1 1524.2 1716.7 1886.6 1908.0 6780.6 7979.9 8149.1 8181.7 8206.3 8015.7 8051.8 8083.0 8108.9 8118.0 2404.8 2418.1 2422.0 2432.7 2436.7 2352.6 2359.0 2382.0 2384.6 2397.0 2364.2 2385.4 2395.3 2406.5 2411.6 2384.9 2396.2 2404.2 2407.6 2422.6 2358.6 2404.7 2432.7 2434.4 2438.5 8149.9 8162.9 8166.8 8182.7 8220.0 5167.6 5256.7 5277.7 5296.8 5311.6 3432.9 3473.2 3489.5 3496.8 3541.9 1135.6 1138.4 1143.2 1143.9 1154.8 10999.5 11144.7 11178.0 11259.6 11289.0 4501.5 4538.3 4578.6 4584.5 4591.9 9843.1 9849.4 9856.1 9867.9 9918.0 5228.3 5273.4 5279.7 5279.7 5282.3 4190.9 4735.2 4809.2 4857.1 4918.4 3961.8 3968.4 4000.8 4051.4 4072.0 1295.9 1302.8 1303.9 1304.1 1308.9 1000.2 1008.4 1019.4 1020.8 1033.0 5430.3 5456.9 5499.8 5504.3 5522.0 1096.9 1116.5 1152.7 1152.9 1177.2 3756.3 3877.3 3934.9 3953.3 3958.7 9750.7 9981.3 10167.8 10273.3 10313.8 9113.0 9416.9 9443.7 9477.1 10048.9 7783.6 7790.6 7800.1 7872.9 7876.4 5479.8 5503.7 5574.9 5619.6 5627.9 8764.6 8781.9 8807.1 8840.8 8854.1 8615.7 8709.3 8724.2 8811.8 8971.9 5961.5 6978.9 7135.5 7355.9 7686.6 7618.0 7631.7 7643.5 7659.8 7664.8 6830.2 6885.3 6908.1 6936.4 7009.7 6735.2 6746.3 6779.5 6822.7 6867.7 6531.4 6558.8 6615.1 6628.1 6634.3 4895.2 4897.6 4923.8 4936.4 4987.0 4963.9 4980.8 5044.6 5071.3 5104.1 00:16:09 INFO - PROCESS | 21450 | 00:16:09 INFO - PROCESS | 21450 | [#4] prototype.html Cycles:180 Average:5856.64 Median:6727.49 stddev:1781.05 (26.5%) stddev-sans-first:1737.31 00:16:09 INFO - PROCESS | 21450 | Values: 343.4 357.3 358.3 358.9 359.2 6390.2 6549.5 6567.6 6623.9 6642.7 6349.2 6447.0 6488.5 6541.9 6551.4 4925.6 4926.4 4955.0 4957.0 4970.5 4941.1 4948.1 4959.1 4971.3 4978.2 4927.3 4933.0 4938.0 4942.6 4948.9 4774.2 4927.2 4938.3 4941.3 4944.9 4324.8 4350.7 4352.2 4357.6 4357.8 6279.8 6284.4 6291.9 6325.8 6329.8 5832.5 5833.1 5838.4 5853.6 5855.8 6880.5 6918.3 6928.2 6934.3 6937.0 4737.6 4884.7 4892.2 4894.9 4904.0 7230.1 7275.7 7278.0 7302.9 7316.9 4968.6 4978.9 4979.8 4990.5 4994.2 5045.9 5051.2 5051.8 5053.6 5064.6 5789.2 5801.8 5803.1 5818.8 5824.1 6761.6 6997.0 7035.2 7056.9 7057.0 1785.2 1790.9 1801.8 1803.7 1804.5 1128.8 1173.3 1191.8 1192.0 1213.0 6713.9 6741.1 6795.0 6801.1 6810.0 7293.9 7312.0 7315.7 7317.7 7327.0 6808.1 6858.2 6860.3 6863.1 6876.4 3879.9 3903.4 3943.2 3944.9 3957.3 7445.8 7453.0 7492.3 7514.3 7532.3 7305.5 7332.0 7355.7 7367.0 7383.0 7487.3 7496.0 7501.6 7504.1 7532.7 7108.5 7230.1 7254.5 7275.9 7289.5 7224.3 7225.9 7231.2 7274.5 7304.4 7523.4 7537.5 7546.2 7546.5 7553.8 4854.7 4899.2 4899.6 4906.0 4907.7 7061.6 7282.8 7290.4 7291.8 7292.1 7057.8 7092.4 7099.1 7105.1 7111.6 6953.6 6980.8 6997.8 7005.9 7028.8 6858.6 6870.9 6887.7 6930.4 6933.8 6962.0 7067.8 7096.8 7105.1 7161.7 6766.0 6933.5 6949.9 6956.0 6976.7 00:16:09 INFO - PROCESS | 21450 | 00:16:09 INFO - PROCESS | 21450 | [#5] yui.html Cycles:180 Average:15675.23 Median:4340.13 stddev:18295.65 (421.5%) stddev-sans-first:18312.85 00:16:09 INFO - PROCESS | 21450 | Values: 794.9 799.0 862.6 869.0 873.1 13044.2 13048.8 13160.0 13160.3 15633.3 15545.8 15644.3 15750.9 15809.3 15834.9 884.5 894.3 905.3 915.1 922.9 903.3 904.6 907.8 910.7 911.1 940.2 941.0 944.1 945.2 947.4 935.4 939.1 939.2 940.5 940.5 695.6 695.8 695.9 696.2 698.8 15555.9 15586.9 15606.2 15610.1 15651.6 12995.2 13021.2 13026.7 13131.6 13139.1 10993.3 11132.8 11227.6 11227.7 11495.3 3994.0 4002.8 4006.6 4008.6 4078.9 57799.0 57870.7 58220.0 58384.7 58450.7 10351.1 10560.4 10563.8 10613.2 10616.7 19888.1 19943.9 19970.2 19988.2 20017.7 8092.2 8182.9 8225.0 8245.8 8295.8 4530.3 4587.3 4609.0 4611.2 4639.7 3339.5 3376.5 3391.6 3409.3 3412.7 610.7 611.5 613.1 628.1 634.1 703.9 705.9 713.5 723.2 734.4 8947.0 9149.1 9364.5 10045.8 10496.5 775.9 786.4 803.3 803.9 828.2 4302.4 4377.8 4417.5 4717.4 4745.9 61186.4 61276.7 62778.0 62826.0 67912.0 52437.7 55372.4 59016.4 59115.7 59477.7 53324.0 53395.7 53420.0 53853.2 53891.0 9298.8 9821.2 10173.1 10207.2 10313.5 36197.6 38553.8 40084.8 40140.4 40229.4 52368.5 53001.0 53315.7 53522.5 54181.0 11510.0 11514.7 11516.8 11714.2 11808.0 13229.7 13825.6 14020.0 14086.9 14403.8 13031.7 13134.1 13452.8 13524.0 13800.7 12636.5 12923.7 13076.5 13261.1 13554.1 13162.9 13358.5 13431.5 13527.4 13666.8 11553.7 11577.3 11653.0 11781.6 11898.3 11343.6 11406.9 11460.9 11528.3 11769.6 00:16:09 INFO - PROCESS | 21450 | -------- Summary: end -------- 00:16:09 INFO - PROCESS | 21450 | 00:16:09 INFO - TEST-INFO | 21450: exit 0 00:16:09 INFO - TEST-OK | dromaeo_css | took 1109660ms 00:16:09 INFO - TEST-START | kraken 00:16:09 INFO - operating with platform_type : linux_ 00:16:09 INFO - Initialising browser for kraken test... 00:16:09 INFO - TEST-INFO | started process 21689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxe6Dz/profile http://localhost:60735/getInfo.html) 00:16:13 INFO - PROCESS | 21689 | 00:16:13 INFO - PROCESS | 21689 | (process:21766): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:16:14 INFO - PROCESS | 21689 | __metrics Screen width/height:1600/1200 00:16:14 INFO - PROCESS | 21689 | colorDepth:24 00:16:14 INFO - PROCESS | 21689 | Browser inner width/height: 1024/697 00:16:14 INFO - PROCESS | 21689 | __metrics 00:16:15 ERROR - PROCESS | 21689 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 00:16:16 INFO - TEST-INFO | 21689: exit 0 00:16:16 INFO - Browser initialized. 00:16:16 INFO - Running cycle 1/1 for kraken test... 00:16:16 INFO - TEST-INFO | started process 21817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxe6Dz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:16:17 INFO - PROCESS | 21817 | 00:16:17 INFO - PROCESS | 21817 | (process:21887): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:16:27 INFO - PROCESS | 21817 | RSS: Main: 151973888 00:16:27 INFO - PROCESS | 21817 | 00:16:30 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60735/tests/kraken/driver.html?testName=audio-beat-detection) 00:16:31 INFO - PROCESS | 21817 | RSS: Main: 157339648 00:16:31 INFO - PROCESS | 21817 | 00:16:33 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60735/tests/kraken/driver.html?testName=audio-dft) 00:16:34 INFO - PROCESS | 21817 | RSS: Main: 157024256 00:16:34 INFO - PROCESS | 21817 | 00:16:37 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60735/tests/kraken/driver.html?testName=audio-fft) 00:16:37 INFO - PROCESS | 21817 | RSS: Main: 157253632 00:16:37 INFO - PROCESS | 21817 | 00:16:40 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60735/tests/kraken/driver.html?testName=audio-oscillator) 00:16:40 INFO - PROCESS | 21817 | RSS: Main: 157151232 00:16:40 INFO - PROCESS | 21817 | 00:16:42 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60735/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:16:43 INFO - PROCESS | 21817 | RSS: Main: 156938240 00:16:43 INFO - PROCESS | 21817 | 00:16:46 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60735/tests/kraken/driver.html?testName=imaging-darkroom) 00:16:47 INFO - PROCESS | 21817 | RSS: Main: 157499392 00:16:47 INFO - PROCESS | 21817 | 00:16:50 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60735/tests/kraken/driver.html?testName=imaging-desaturate) 00:16:51 INFO - PROCESS | 21817 | RSS: Main: 157294592 00:16:51 INFO - PROCESS | 21817 | 00:16:53 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60735/tests/kraken/driver.html?testName=json-parse-financial) 00:16:54 INFO - PROCESS | 21817 | RSS: Main: 157663232 00:16:54 INFO - PROCESS | 21817 | 00:16:56 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60735/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:16:56 INFO - PROCESS | 21817 | RSS: Main: 157454336 00:16:56 INFO - PROCESS | 21817 | 00:16:58 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60735/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:16:59 INFO - PROCESS | 21817 | RSS: Main: 157380608 00:16:59 INFO - PROCESS | 21817 | 00:17:00 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60735/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:17:01 INFO - PROCESS | 21817 | RSS: Main: 157306880 00:17:01 INFO - PROCESS | 21817 | 00:17:04 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:17:04 INFO - PROCESS | 21817 | RSS: Main: 157904896 00:17:04 INFO - PROCESS | 21817 | 00:17:07 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:17:08 INFO - PROCESS | 21817 | RSS: Main: 157827072 00:17:08 INFO - PROCESS | 21817 | 00:17:09 INFO - PROCESS | 21817 | Cycle 1(1): loaded http://localhost:60735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60735/tests/kraken/driver.html?testName=ai-astar) 00:17:10 INFO - PROCESS | 21817 | RSS: Main: 159072256 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | __start_tp_report 00:17:10 INFO - PROCESS | 21817 | _x_x_mozilla_page_load 00:17:10 INFO - PROCESS | 21817 | _x_x_mozilla_page_load_details 00:17:10 INFO - PROCESS | 21817 | |i|pagename|runs| 00:17:10 INFO - PROCESS | 21817 | |0;ai-astar;109;110;105;111;111;111;101;110;109;109 00:17:10 INFO - PROCESS | 21817 | |1;audio-beat-detection;154;128;160;175;128;157;155;127;188;127 00:17:10 INFO - PROCESS | 21817 | |2;audio-dft;164;162;163;162;162;159;161;161;164;163 00:17:10 INFO - PROCESS | 21817 | |3;audio-fft;73;75;75;166;76;75;74;76;165;76 00:17:10 INFO - PROCESS | 21817 | |4;audio-oscillator;93;93;150;92;94;93;150;92;94;149 00:17:10 INFO - PROCESS | 21817 | |5;imaging-gaussian-blur;119;119;118;117;117;117;117;118;117;118 00:17:10 INFO - PROCESS | 21817 | |6;imaging-darkroom;146;147;147;147;147;146;146;147;146;147 00:17:10 INFO - PROCESS | 21817 | |7;imaging-desaturate;96;96;95;95;95;96;95;96;95;95 00:17:10 INFO - PROCESS | 21817 | |8;json-parse-financial;57;57;56;56;60;57;57;79;57;57 00:17:10 INFO - PROCESS | 21817 | |9;json-stringify-tinderbox;57;63;59;58;58;58;57;57;58;57 00:17:10 INFO - PROCESS | 21817 | |10;stanford-crypto-aes;72;72;74;74;73;75;74;74;74;73 00:17:10 INFO - PROCESS | 21817 | |11;stanford-crypto-ccm;120;121;122;115;112;119;119;116;136;131 00:17:10 INFO - PROCESS | 21817 | |12;stanford-crypto-pbkdf2;162;174;163;160;160;163;158;156;158;159 00:17:10 INFO - PROCESS | 21817 | |13;stanford-crypto-sha256-iterative;65;65;64;67;70;67;67;66;65;67 00:17:10 INFO - PROCESS | 21817 | __end_tp_report 00:17:10 INFO - PROCESS | 21817 | __start_cc_report 00:17:10 INFO - PROCESS | 21817 | _x_x_mozilla_cycle_collect,869 00:17:10 INFO - PROCESS | 21817 | __end_cc_report 00:17:10 INFO - PROCESS | 21817 | __startTimestamp1463037430019__endTimestamp 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | ------- Summary: start ------- 00:17:10 INFO - PROCESS | 21817 | Number of tests: 14 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.20 (2.9%) stddev-sans-first:3.40 00:17:10 INFO - PROCESS | 21817 | Values: 109.0 110.0 105.0 111.0 111.0 111.0 101.0 110.0 109.0 109.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:156.00 stddev:21.82 (14.0%) stddev-sans-first:23.09 00:17:10 INFO - PROCESS | 21817 | Values: 154.0 128.0 160.0 175.0 128.0 157.0 155.0 127.0 188.0 127.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.52 (0.9%) stddev-sans-first:1.45 00:17:10 INFO - PROCESS | 21817 | Values: 164.0 162.0 163.0 162.0 162.0 159.0 161.0 161.0 164.0 163.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.00 stddev:38.17 (50.9%) stddev-sans-first:39.79 00:17:10 INFO - PROCESS | 21817 | Values: 73.0 75.0 75.0 166.0 76.0 75.0 74.0 76.0 165.0 76.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:93.00 stddev:27.38 (29.4%) stddev-sans-first:28.34 00:17:10 INFO - PROCESS | 21817 | Values: 93.0 93.0 150.0 92.0 94.0 93.0 150.0 92.0 94.0 149.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 00:17:10 INFO - PROCESS | 21817 | Values: 119.0 119.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 00:17:10 INFO - PROCESS | 21817 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 00:17:10 INFO - PROCESS | 21817 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:57.00 stddev:7.01 (12.3%) stddev-sans-first:7.38 00:17:10 INFO - PROCESS | 21817 | Values: 57.0 57.0 56.0 56.0 60.0 57.0 57.0 79.0 57.0 57.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:1.81 (3.1%) stddev-sans-first:1.87 00:17:10 INFO - PROCESS | 21817 | Values: 57.0 63.0 59.0 58.0 58.0 58.0 57.0 57.0 58.0 57.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#10] stanford-crypto-aes Cycles:10 Average:73.50 Median:74.00 stddev:0.97 (1.3%) stddev-sans-first:0.87 00:17:10 INFO - PROCESS | 21817 | Values: 72.0 72.0 74.0 74.0 73.0 75.0 74.0 74.0 74.0 73.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:120.50 stddev:7.28 (6.0%) stddev-sans-first:7.71 00:17:10 INFO - PROCESS | 21817 | Values: 120.0 121.0 122.0 115.0 112.0 119.0 119.0 116.0 136.0 131.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.00 stddev:5.01 (3.1%) stddev-sans-first:5.31 00:17:10 INFO - PROCESS | 21817 | Values: 162.0 174.0 163.0 160.0 160.0 163.0 158.0 156.0 158.0 159.0 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - PROCESS | 21817 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.70 (2.5%) stddev-sans-first:1.74 00:17:10 INFO - PROCESS | 21817 | Values: 65.0 65.0 64.0 67.0 70.0 67.0 67.0 66.0 65.0 67.0 00:17:10 INFO - PROCESS | 21817 | -------- Summary: end -------- 00:17:10 INFO - PROCESS | 21817 | 00:17:10 INFO - TEST-INFO | 21817: exit 0 00:17:10 INFO - TEST-OK | kraken | took 61198ms 00:17:10 INFO - SUITE-END | took 1170s 00:17:11 INFO - Completed test suite (00:19:31) 00:17:11 INFO - javascript benchmark 00:17:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3359.2273777031282, 3404.6765557272065, 3420.315936812638, 3436.570428696413, 3442.535257740206, 5614.157876318554, 5646.153077038442, 5666.376698563155, 5673.404292549285, 5713.800016999406, 5560.527355174815, 5598.832035038945, 5620.775168993246, 5643.717814109288, 5643.915341269884, 5103.821366252191, 5122.948770512303, 5166.199239117943, 5174.896502069956, 5196.844094677166, 5058.671186372892, 5176.818811341604, 5192.948070519285, 5265.552428043621, 5273.815416460425, 5109.923351149736, 5134.332536770234, 5137.845864624067, 5162.148245539482, 5254.054270231357, 5187.714675692835, 5194.584433245332, 5195.376554813447, 5204.9219261711105, 5208.140656791625, 5090.440051594322, 5121.129408000649, 5121.513456221653, 5168.8966220675375, 5199.064168449678, 5429.375621803503, 5485.204645326406, 5485.4788795064405, 5506.889862202774, 5585.162225666142, 6103.216304434332, 6115.936978868489, 6124.351350138838, 6126.090206827809, 6131.858919339687, 6137.162486020161, 6178.443940045418, 6185.721642526052, 6191.9690401547705, 6195.7521699131985, 5497.587680923907, 5520.254765606672, 5582.972085139549, 5769.5672824537905, 5796.478316951452, 6105.32841387447, 6171.444569988723, 6247.344028876993, 6290.49676025926, 6348.523860710465, 5987.1318658794235, 6000.369961154103, 6002.969985150134, 6016.488598469179, 6045.183900173508, 5810.796622118206, 5923.0, 6063.0, 6077.513798896078, 6086.6348019119, 5972.671503067373, 5979.1928089707335, 5980.102984552352, 5980.55145864062, 6020.217371741734, 5935.762569497172, 5990.221271234712, 5996.640201587918, 5997.070454079538, 5999.070144127667, 4503.527129651405, 4551.52209018055, 4564.475085365159, 4564.748938808331, 4588.518205588432, 4099.487564054493, 4102.077032667686, 4112.177564487115, 4112.239235741397, 4120.711550191518, 5800.767969281266, 5831.3877042910735, 5834.737436815353, 5843.853903652443, 5862.765489380377, 5933.673647949404, 6015.0676645120075, 6095.6952152392205, 6130.2030736004035, 6155.446009859134, 5896.027155519377, 5910.379410161957, 5910.940890591125, 5922.407759224129, 5930.584859059911, 5257.579393648575, 5257.605679574047, 5263.578913686896, 5265.815696450606, 5275.736213189325, 6168.9691551541955, 6274.623522588659, 6292.370762923671, 6298.842528936813, 6304.495640348853, 6187.659678717624, 6203.751849925952, 6204.5967012144065, 6213.5339849510565, 6218.751249949952, 6113.4152177380265, 6117.3402608778015, 6368.044793281045, 6378.553501254868, 6385.616862988236, 6051.939480605138, 6055.969720151371, 6060.2424696912885, 6073.423024812636, 6095.817125486243, 6109.694515274307, 6127.662978536223, 6132.938670613236, 6144.986077297374, 6148.815535533941, 5753.654780713171, 5902.822915312548, 5961.225040744675, 5991.161237426677, 6009.609375390585, 5943.821685349273, 5948.196993406008, 5951.761929522944, 5955.702214889325, 5964.343922168645, 5831.562632802472, 5845.678487683218, 5854.765809367577, 5879.882402352015, 5880.882382352243, 5830.300363956352, 5899.764009439575, 5959.433853783884, 5992.910106348321, 6012.669303188367, 5799.130130480462, 5862.208601838868, 5864.765409383577, 5872.882542349214, 5879.0], "value": 5605.799334647164, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.2489849731074, 654.1822721598002, 663.8340414896275, 664.7772996046324, 697.7069630755083, 42766.0755266013, 44251.3362299565, 44296.0, 44340.55659443405, 44483.0, 44606.0, 44916.3262551062, 44995.325070123894, 45222.773886130606, 45354.0, 8884.822303553925, 9033.728988130366, 9069.637214511411, 9075.228605568534, 9082.273418126568, 8966.327525435585, 9012.27901767857, 9034.774130646754, 9045.959714632836, 9073.773155671128, 9010.729678109667, 9061.773455663595, 9076.954615226914, 9083.591238394289, 9085.54572271387, 8992.910070899305, 9003.729888103302, 9012.369134160612, 9016.233620142262, 9049.095090490964, 8970.820583588356, 9018.549072546411, 9041.276697864156, 9093.227075698573, 9093.59078841447, 40709.185816283505, 41386.37920431196, 41393.79303103465, 41494.792526037476, 41690.58309416897, 3802.5627052888995, 3821.8662346817728, 4001.6198461146437, 4035.899102522431, 4562.406887104688, 33722.662773372445, 34085.48871766926, 34370.48444273338, 34410.82794586036, 34463.48304775431, 4509.098180363908, 4515.390422292981, 4586.977065114686, 4659.324397962277, 4671.229247174212, 319309.4379809086, 321039.0, 322138.0, 323700.0, 325779.0, 58277.0, 58527.12209316863, 58635.413645863846, 64450.0, 64666.0, 71229.0, 71770.0, 71787.64106179436, 71956.0, 72099.27900721031, 19906.701399479018, 20003.699944500844, 20170.193192272145, 20185.59628807445, 20234.190632374834, 15118.0, 15153.318100685496, 15192.164430956404, 15317.157556334509, 15414.691706165813, 21351.25270615552, 21385.0, 21403.250886218906, 21559.24542641, 21589.892050539645, 7585.848283034419, 7594.962025189839, 7625.466217364731, 7894.960525197337, 7919.485233459806, 1109.3343993603773, 1153.7692461507731, 1160.3270103340042, 1163.4066626020622, 1243.7947738623027, 33354.0, 33447.0, 33524.16189595231, 33526.83236583802, 34411.4838277426, 1205.879412058787, 1243.6766440725476, 1247.6756043428775, 1255.3974092435683, 1295.4947570447343, 16975.830241697673, 17434.389796357067, 17563.73654395185, 17573.113781072967, 17620.735688964676, 485518.0, 545018.0, 552883.0, 556330.0, 860029.0, 56444.71777641168, 56892.71553642205, 57279.71360143173, 57418.712906436034, 57759.71120144457, 1557.6806754615504, 1565.5146904459655, 1572.6776010917733, 1577.242923396776, 1581.7785510028605, 32582.83708581442, 33934.490982635776, 34019.65980340165, 34066.95598264112, 34510.30979380449, 55504.0, 56131.0, 56209.0, 56232.71883640719, 56346.43653563412, 428460.0, 431112.0, 432230.0, 433450.0, 434227.0, 31431.842840785648, 31804.204894877814, 32383.51424728584, 32425.0, 32438.675613243566, 51147.74426127846, 51345.743271283405, 51474.0, 52359.73820130875, 52690.736546318556, 42459.0, 42920.35619465648, 43036.78481607572, 43932.78033609811, 44406.3339049908, 41225.587744122175, 41678.583214168684, 41896.581034189265, 42367.78816106023, 42778.0, 42468.0, 42650.78674606607, 43185.56814431941, 43666.0, 43667.344989824545, 36044.27911441704, 36509.26981460409, 36530.08674783152, 36535.45196821997, 36618.26763464769, 28916.42167156687, 28975.900904278587, 29061.418771624027, 30687.0, 30759.53860692136], "value": 21405.42297118328, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.673514555928, 412.4143715923387, 420.6844866350238, 425.09242766693103, 436.7816091954023, 18926.337578184768, 19553.804461955377, 19559.315423960164, 20847.583048339064, 21160.0, 18532.0, 19272.710909336372, 19323.0, 20376.083076261566, 20393.796062039375, 5298.258243845855, 5430.3755068167075, 5468.890622187574, 5752.395998420168, 5927.555433342495, 5775.711214439282, 5847.502962248214, 5850.093235548476, 5869.060950247961, 5878.0, 5422.511973922346, 5425.810096646618, 5762.02045652238, 5772.365039845614, 5781.739821708013, 5416.566674666017, 5418.512333889949, 5439.347278326606, 5444.91832622511, 5466.01611709894, 5227.3465816772905, 5284.709340986245, 5308.5487733542695, 5344.545713614348, 5356.4375740547075, 14123.152610843383, 14389.568312950523, 14508.492202772957, 14545.34545945435, 16658.83341166597, 2448.094205144108, 2474.925752227436, 2495.8502489850666, 2496.8252222344445, 2553.1319351420607, 10354.844677329771, 10988.835167472495, 11359.402241594022, 13683.0, 14022.439102435992, 2036.7046778217223, 2041.6427125253022, 2090.1743811194647, 2146.441925099485, 2148.1514801653416, 79734.0, 81882.0, 82631.0, 82874.58562707208, 83849.0, 11270.436478176221, 11454.54181832734, 11528.481218345194, 11530.827037594443, 11658.475368608433, 15726.842731572538, 15746.448874289574, 15796.763048554281, 15944.521664350088, 15988.360465581247, 8712.085231050649, 8735.694250701323, 8828.823423531494, 8899.777903931068, 8969.686060987835, 8634.22291993711, 8745.0, 8773.912260877309, 8787.472751634923, 8836.955815220883, 4899.485554016848, 4905.068037073016, 4922.753862306942, 4964.230544265644, 5060.038592667382, 1929.8263156316, 1993.3322337017262, 2020.3736841579157, 2033.3086750504604, 2035.5013021809752, 962.0908241711516, 1053.4153544782719, 1170.8946194842506, 1181.8490347567345, 1183.9408029598485, 18595.34916277924, 21090.47273818136, 21115.049822758014, 21159.04784284711, 21177.68233476499, 1087.2606627493221, 1094.9726256843642, 1109.2290857853875, 1171.8945294923499, 1205.9698507537207, 10868.967448092419, 11160.944195278971, 11216.943915280372, 11219.0, 11235.325880447199, 620693.0, 622578.0, 624191.0, 648140.0, 657889.0, 101170.49414752879, 102506.48746756368, 103349.48325258326, 103701.48149259205, 103813.48093259486, 1164.9708757280966, 1167.772284404533, 1180.2741314091772, 1198.5565340823778, 1213.1932265043647, 17277.39529116475, 17511.912440437718, 17854.642907142043, 18047.0, 18175.363862264756, 26754.59868102019, 29916.401671966873, 31741.68258317387, 42082.579174207865, 43033.784831075645, 62076.689616553434, 62334.0, 62561.68719156375, 62817.37182628115, 62853.37146628658, 8861.33539984491, 8869.113088691338, 9109.0, 9174.954125229331, 9265.53672316395, 12567.120301578801, 13224.669383265495, 13518.526851560147, 13716.245606491739, 13930.930345348208, 11618.593349232737, 11718.472668729757, 11931.806819318346, 12234.938825306173, 12289.324087175291, 11327.603533876605, 11728.824067639163, 11753.412329383325, 12007.75984480323, 12120.0, 11800.70498237551, 12584.30786306762, 12920.741585168056, 13062.412191451218, 13195.802062969255, 9054.954725226331, 9170.495622740813, 9178.954105229432, 9257.981622021438, 9271.238464691956, 9281.67514137002, 11879.34663593476, 12306.0, 12401.689957750768, 12455.439505222468], "value": 9548.396572231162, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.138861543228, 1524.1921781455826, 1716.6652502761967, 1886.556659185092, 1907.9904600476996, 6780.627065511395, 7979.92020079799, 8149.062857771358, 8181.672733090677, 8206.261436470717, 8015.7194498192575, 8051.838963220746, 8082.95958520208, 8108.878366824488, 8117.9594102029405, 2404.759524047599, 2418.129473389587, 2421.987890060547, 2432.74456182101, 2436.671049408325, 2352.6000579901374, 2359.0, 2382.0471811275456, 2384.606539920911, 2396.9640455393182, 2364.160722943356, 2385.3917251101034, 2395.2933884504114, 2406.470576473173, 2411.6141417373224, 2384.880755962195, 2396.197273913241, 2404.1945948107405, 2407.566638005167, 2422.63660450932, 2358.563665721847, 2404.747501512351, 2432.659427680126, 2434.403571125086, 2438.4879175373017, 8149.918500815034, 8162.877556836652, 8166.836663266701, 8182.67269309227, 8220.0, 5167.638265321429, 5256.684598924038, 5277.736113194325, 5296.814611488618, 5311.575073994071, 3432.8671538392273, 3473.235888104613, 3489.5114683944266, 3496.807675577842, 3541.8583256669704, 1135.642272684102, 1138.430784607696, 1143.1940481960198, 1143.8627364716288, 1154.757500924807, 10999.450027498593, 11144.665660030212, 11178.0, 11259.605913792979, 11289.0, 4501.549845015472, 4538.251188553918, 4578.633709303248, 4584.5186255442695, 4591.885202869955, 9843.114119729116, 9849.359791613522, 9856.112949834549, 9867.901320986843, 9918.008199180169, 5228.294180285613, 5273.393559740679, 5279.709615971082, 5279.709615971158, 5282.286891269706, 4190.874273771792, 4735.21868891629, 4809.206480930678, 4857.052874689472, 4918.409790825124, 3961.801909904551, 3968.3650615901893, 4000.8399664013114, 4051.4327994080854, 4071.9796401017807, 1295.941682624284, 1302.8241187439764, 1303.88916942061, 1304.1392680830795, 1308.9018323625767, 1000.1798525209404, 1008.4100801031332, 1019.3832731197667, 1020.8009438159488, 1033.0289527843802, 5430.266913966643, 5456.863578410572, 5499.835004949858, 5504.339479262514, 5522.006038912954, 1096.88666004006, 1116.5198964445367, 1152.746395792941, 1152.8501294831617, 1177.240679761549, 3756.3426400379826, 3877.263319969197, 3934.86227982025, 3953.2686453006286, 3958.7030972677167, 9750.707478775648, 9981.251406144569, 10167.847482287772, 10273.332233404804, 10313.84529232062, 9112.95443522778, 9416.858747118798, 9443.669471568463, 9477.052294770469, 10048.879959216685, 7783.571903545359, 7790.649420776079, 7800.1419843816, 7872.921270787333, 7876.448648594658, 5479.780808767605, 5503.669779813224, 5574.888502229852, 5619.606627536196, 5627.8593035174445, 8764.649414023368, 8781.868271975798, 8807.075257097913, 8840.823183536422, 8854.070322616033, 8615.655373785228, 8709.259712924473, 8724.214820666171, 8811.823763524822, 8971.865422018544, 5961.493273071837, 6978.860422791618, 7135.464840137114, 7355.926440735524, 7686.57723825195, 7617.961910190414, 7631.656575454229, 7643.541387516767, 7659.808504787202, 7664.770056898302, 6830.180378354629, 6885.345892140239, 6908.067410899464, 6936.375726184668, 7009.719611215494, 6735.158105236846, 6746.257911629815, 6779.491538134561, 6822.692978816064, 6867.656617169221, 6531.444827189742, 6558.80323590293, 6615.106960560262, 6628.07206991012, 6634.270230274762, 4895.192293271571, 4897.559219670246, 4923.778429970588, 4936.43231028422, 4987.0, 4963.875903102306, 4980.750962451935, 5044.571211447068, 5071.315372424676, 5104.0812653721205], "value": 4496.616199330323, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.39048189463716, 357.313957202172, 358.2923725641856, 358.8743939621133, 359.2330374650122, 6390.201224846883, 6549.508786840982, 6567.573107747993, 6623.867522649544, 6642.734290628375, 6349.1746073010445, 6447.0, 6488.513361497895, 6541.869162616745, 6551.4431273341825, 4925.556699897017, 4926.433460152075, 4954.975225123887, 4956.975215123937, 4970.453250142499, 4941.085899108676, 4948.084604348189, 4959.107360675077, 4971.27916452116, 4978.153713868651, 4927.2609108633815, 4933.0, 4937.975310123445, 4942.555170034696, 4948.851534453954, 4774.188387974053, 4927.236278376858, 4938.3086367908345, 4941.308216849626, 4944.901101977958, 4324.762138082404, 4350.651947844165, 4352.216601011816, 4357.629601483878, 4357.803898824561, 6279.780207692755, 6284.402981716776, 6291.8741625167695, 6325.810225693236, 6329.778457753957, 5832.475077243069, 5833.095870140135, 5838.357780644125, 5853.648781073107, 5855.795047173328, 6880.483963702743, 6918.342757438036, 6928.16861976566, 6934.306569343075, 6937.0, 4737.573618374363, 4884.658073934826, 4892.217245240744, 4894.926576101361, 4904.0, 7230.132384113887, 7275.745348912816, 7277.963610181915, 7302.890456643155, 7316.926830731678, 4968.552830245295, 4978.850634480971, 4979.751012449363, 4990.451050384455, 4994.175960966472, 5045.8738531537, 5051.191809310492, 5051.823186188466, 5053.570446512014, 5064.620153488503, 5789.247397838254, 5801.796937107181, 5803.129530570448, 5818.7672493100645, 5824.068149096124, 6761.628110453874, 6997.0, 7035.155781306276, 7056.858862822714, 7057.047298614724, 1785.2055835153492, 1790.9104544772708, 1801.819818018214, 1803.666321730484, 1804.5127815489743, 1128.8306753986967, 1173.2549830857297, 1191.845060142176, 1191.988080119205, 1212.9757404851853, 6713.865722685617, 6741.1236539249585, 6794.966025169842, 6801.149856267966, 6810.0, 7293.927060729431, 7312.049433573708, 7315.743948961761, 7317.707291708379, 7326.96336518314, 6808.148981377328, 6858.177018757681, 6860.348266914635, 6863.073485079451, 6876.381125698711, 3879.86420475282, 3903.434002069684, 3943.171933893857, 3944.901377465529, 3957.2679054375035, 7445.771447711067, 7452.962735186397, 7492.325690687864, 7514.323710866049, 7532.322091011835, 7305.525140865933, 7332.0, 7355.668994895243, 7367.0, 7383.0, 7487.2512748725785, 7496.0, 7501.624918754041, 7504.099508059068, 7532.698692052366, 7108.466864985044, 7230.13238411394, 7254.492185546961, 7275.890861636974, 7289.489735718661, 7224.277572242734, 7225.855482890418, 7231.16841563227, 7274.527155734861, 7304.379127774198, 7523.435742319239, 7537.54774713519, 7546.169921308542, 7546.471746977659, 7553.811154721176, 4854.660173787801, 4899.216125419915, 4899.559039686445, 4905.950940490549, 4907.656464047625, 7061.611611361424, 7282.817929551804, 7290.359669074416, 7291.817704557428, 7292.088488938883, 7057.8473565563, 7092.361687448154, 7099.112610923635, 7105.076340075757, 7111.648786730505, 6953.582785032914, 6980.825479363057, 6997.790066298019, 7005.929940700732, 7028.789136325919, 6858.588484690935, 6870.862582748417, 6887.690053947485, 6930.44556435494, 6933.82665433348, 6962.025316455802, 7067.752628657972, 7096.787096387116, 7105.111861017373, 7161.677724502514, 6765.9661701691175, 6933.514653974174, 6949.861002779815, 6955.965220173866, 6976.651167441506], "value": 5272.958630207109, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.9443538952272, 799.0411506192567, 862.6075135813205, 868.9782755431113, 873.122511875565, 13044.152130111535, 13048.804267935977, 13160.0, 13160.276184809843, 15633.296501657424, 15545.766813497778, 15644.296006679699, 15750.921245393756, 15809.288582013809, 15834.920825395886, 884.5444596033049, 894.2935081285776, 905.2712566384058, 915.1214833759599, 922.8754118194058, 903.286403741047, 904.5612877754317, 907.8002839375326, 910.7404389748923, 911.0843602179833, 940.1538615246264, 941.0354386753564, 944.0842382888587, 945.2485274207022, 947.3605316411429, 935.359278893953, 939.1406862720603, 939.2439086535336, 940.4874343482784, 940.5156344482597, 695.6069820551372, 695.766918082443, 695.919969203543, 696.2271878215178, 698.7868700046483, 15555.922220388826, 15586.922065389714, 15606.219689015505, 15610.141442220673, 15651.608709782233, 12995.220286782824, 13021.153625014344, 13026.674333141653, 13131.606051818366, 13139.14595551286, 10993.340399576051, 11132.777344453065, 11227.607033753779, 11227.66317010491, 11495.252808567417, 3994.0, 4002.8398864045403, 4006.6193711597352, 4008.5590585035625, 4078.8572399966156, 57799.0, 57870.710646446496, 58220.0, 58384.70807645977, 58450.707746461, 10351.06840384369, 10560.366378017343, 10563.788724225626, 10613.150947924301, 10616.681499555025, 19888.10503527345, 19943.900280498794, 19970.20119195245, 19988.20047198096, 20017.699734503993, 8092.190780921861, 8182.918170818216, 8225.0, 8245.79385515367, 8295.8340833183, 4530.252508336088, 4587.3348364486965, 4608.986023074918, 4611.169989401873, 4639.698419602715, 3339.532465454838, 3376.544166537486, 3391.609964854024, 3409.301093275922, 3412.744044196695, 610.703808652803, 611.458858909859, 613.0773186354597, 628.13003989474, 634.0615888485067, 703.869784089945, 705.9258777828356, 713.4969846258375, 723.1864152828068, 734.353768683555, 8946.955265223633, 9149.130832570896, 9364.484953327496, 10045.849312260321, 10496.47517624131, 775.8836174573859, 786.390547325827, 803.2931020701861, 803.9236272554098, 828.1925123005142, 4302.44068271129, 4377.824887004548, 4417.514073451917, 4717.3631559739, 4745.881352966135, 61186.388136118956, 61276.69361653163, 62778.0, 62826.0, 67912.0, 52437.7378113107, 55372.44627553673, 59016.40983590195, 59115.70442147762, 59477.70261148667, 53324.0, 53395.73302133542, 53420.0, 53853.19220211622, 53891.0, 9298.814023719622, 9821.165200958, 10173.08442240202, 10207.183425325808, 10313.535890884777, 36197.63802361942, 38553.80723096366, 40084.79957600193, 40140.3978940322, 40229.39655905222, 52368.47631523636, 53001.0, 53315.73342133265, 53522.464775353306, 54181.0, 11510.0, 11514.654560363202, 11516.769664606829, 11714.23857449263, 11808.0, 13229.669258268621, 13825.585232443043, 14020.0, 14086.859131408964, 14403.78394324107, 13031.739365212454, 13134.146280491737, 13452.838752475196, 13524.0, 13800.654983625089, 12636.494540218288, 12923.741525169256, 13076.542321018718, 13261.07172497916, 13554.051216414757, 13162.868371316164, 13358.465661373437, 13431.462741490232, 13527.391267392793, 13666.794998074838, 11553.653390398302, 11577.305361678325, 11653.0, 11781.587644432404, 11898.286102833858, 11343.602973895873, 11406.885931140583, 11460.94269528647, 11528.250663706833, 11769.646910592695], "value": 7087.403554368451, "unit": "score"}], "name": "dromaeo_css", "value": 7599.061357390877, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 105.0, 111.0, 111.0, 111.0, 101.0, 110.0, 109.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 160.0, 175.0, 128.0, 157.0, 155.0, 127.0, 188.0, 127.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 162.0, 162.0, 159.0, 161.0, 161.0, 164.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 166.0, 76.0, 75.0, 74.0, 76.0, 165.0, 76.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 150.0, 92.0, 94.0, 93.0, 150.0, 92.0, 94.0, 149.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 60.0, 57.0, 57.0, 79.0, 57.0, 57.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 59.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 74.0, 74.0, 73.0, 75.0, 74.0, 74.0, 74.0, 73.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 122.0, 115.0, 112.0, 119.0, 119.0, 116.0, 136.0, 131.0], "value": 121.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 174.0, 163.0, 160.0, 160.0, 163.0, 158.0, 156.0, 158.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 67.0, 70.0, 67.0, 67.0, 66.0, 65.0, 67.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1523.1, "alertThreshold": 2.0}]} 00:17:11 INFO - Return code: 0 00:17:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:17:11 ERROR - # TBPL SUCCESS # 00:17:11 INFO - Running post-action listener: _resource_record_post_action 00:17:11 INFO - Running post-run listener: _resource_record_post_run 00:17:12 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 401408; Write bytes: 496529408; Read time: 32; Write time: 391852 00:17:12 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248066048; Read time: 0; Write time: 261060 00:17:12 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 401408; Write bytes: 247865344; Read time: 32; Write time: 130792 00:17:12 INFO - Running post-run listener: _upload_blobber_files 00:17:12 INFO - Blob upload gear active. 00:17:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:17:12 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 00:17:12 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'] 00:17:12 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 00:17:12 INFO - (blobuploader) - INFO - Open directory for files ... 00:17:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:17:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:17:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:17:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:17:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:17:13 INFO - (blobuploader) - INFO - Done attempting. 00:17:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:17:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:17:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:17:14 INFO - (blobuploader) - INFO - Done attempting. 00:17:14 INFO - (blobuploader) - INFO - Iteration through files over. 00:17:14 INFO - Return code: 0 00:17:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:17:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:17:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f20c0cd28175b75643cfaecfc25f6645d169f98ceb21189d835b7d38ac76ab343bfb66c7e156f212e0e82912281588a39ef34157d469a0f18884a3f643908641", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5baba4457766fcba97c4d8157713e54cdf0bae62f784603f784531614bf6584ba53c29291a9220a0a7bc0d85255884ed7b0e508e1d73d0d9a58f4c7db7da845f"} 00:17:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:17:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:17:14 INFO - Contents: 00:17:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f20c0cd28175b75643cfaecfc25f6645d169f98ceb21189d835b7d38ac76ab343bfb66c7e156f212e0e82912281588a39ef34157d469a0f18884a3f643908641", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5baba4457766fcba97c4d8157713e54cdf0bae62f784603f784531614bf6584ba53c29291a9220a0a7bc0d85255884ed7b0e508e1d73d0d9a58f4c7db7da845f"} 00:17:14 INFO - Running post-run listener: copy_logs_to_upload_dir 00:17:14 INFO - Copying logs to upload dir... 00:17:14 INFO - mkdir: /builds/slave/test/build/upload/logs 00:17:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.554594 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-12 00:17:13.675887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 00:17:13.679177) ========= 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=fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044 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/f20c0cd28175b75643cfaecfc25f6645d169f98ceb21189d835b7d38ac76ab343bfb66c7e156f212e0e82912281588a39ef34157d469a0f18884a3f643908641", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5baba4457766fcba97c4d8157713e54cdf0bae62f784603f784531614bf6584ba53c29291a9220a0a7bc0d85255884ed7b0e508e1d73d0d9a58f4c7db7da845f"} build_url:https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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/f20c0cd28175b75643cfaecfc25f6645d169f98ceb21189d835b7d38ac76ab343bfb66c7e156f212e0e82912281588a39ef34157d469a0f18884a3f643908641", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5baba4457766fcba97c4d8157713e54cdf0bae62f784603f784531614bf6584ba53c29291a9220a0a7bc0d85255884ed7b0e508e1d73d0d9a58f4c7db7da845f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 00:17:13.704736) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:17:13.705077) ========= 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=fa44defc139c4ba8574fe040000001db-1463035081.882884-556423044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:17:13.789856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 00:17:13.790231) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 00:17:13.790616) ========= ========= Total master_lag: 0.16 =========