builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1461422255.58 results: success (0) buildid: 20160423050248 builduid: 7dea74687f704e61be54fffc88399692 revision: 32e9b18217afb665d570621b11363854b1da0a54 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:35.577673) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:35.578073) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:35.578414) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:35.610313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:35.610556) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 07:37:37-- 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% 71.0M=0s 2016-04-23 07:37:37 (71.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175596 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:35.815506) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:35.815803) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018345 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:35.867102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 07:37:35.867405) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 32e9b18217afb665d570621b11363854b1da0a54 --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 32e9b18217afb665d570621b11363854b1da0a54 --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=82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 07:37:37,415 truncating revision to first 12 chars 2016-04-23 07:37:37,415 Setting DEBUG logging. 2016-04-23 07:37:37,415 attempt 1/10 2016-04-23 07:37:37,415 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/32e9b18217af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 07:37:38,539 unpacking tar archive at: mozilla-aurora-32e9b18217af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.438927 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 07:37:37.319054) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:37.319367) ========= script_repo_revision: 32e9b18217afb665d570621b11363854b1da0a54 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:37.319765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:37.320038) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 07:37:37.329457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-23 07:37:37.329757) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:37:38 INFO - MultiFileLogger online at 20160423 07:37:38 in /builds/slave/test 07:37:38 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 07:37:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:38 INFO - {'append_to_log': False, 07:37:38 INFO - 'base_work_dir': '/builds/slave/test', 07:37:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:37:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:38 INFO - 'branch': 'Mozilla-Aurora', 07:37:38 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:38 INFO - 'config_files': ('talos/linux_config.py',), 07:37:38 INFO - 'default_actions': ('clobber', 07:37:38 INFO - 'read-buildbot-config', 07:37:38 INFO - 'download-and-extract', 07:37:38 INFO - 'populate-webroot', 07:37:38 INFO - 'create-virtualenv', 07:37:38 INFO - 'install', 07:37:38 INFO - 'run-tests'), 07:37:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:38 INFO - 'download_minidump_stackwalk': True, 07:37:38 INFO - 'download_symbols': 'ondemand', 07:37:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:38 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:38 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:38 INFO - 'installer_path': 'installer.exe', 07:37:38 INFO - 'log_level': 'info', 07:37:38 INFO - 'log_name': 'talos', 07:37:38 INFO - 'log_to_console': True, 07:37:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:37:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:37:38 INFO - 'opt_config_files': (), 07:37:38 INFO - 'pip_index': False, 07:37:38 INFO - 'sps_profile': False, 07:37:38 INFO - 'sps_profile_interval': 0, 07:37:38 INFO - 'suite': 'dromaeojs-e10s', 07:37:38 INFO - 'system_bits': '32', 07:37:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:38 INFO - 'title': 'talos-linux64-ix-066', 07:37:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:38 INFO - 'use_talos_json': True, 07:37:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:38 INFO - 'work_dir': 'build'} 07:37:38 INFO - ##### 07:37:38 INFO - ##### Running clobber step. 07:37:38 INFO - ##### 07:37:38 INFO - Running pre-action listener: _resource_record_pre_action 07:37:38 INFO - Running main action method: clobber 07:37:38 INFO - rmtree: /builds/slave/test/build 07:37:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:39 INFO - Running post-action listener: _resource_record_post_action 07:37:39 INFO - ##### 07:37:39 INFO - ##### Running read-buildbot-config step. 07:37:39 INFO - ##### 07:37:39 INFO - Running pre-action listener: _resource_record_pre_action 07:37:39 INFO - Running main action method: read_buildbot_config 07:37:39 INFO - Using buildbot properties: 07:37:39 INFO - { 07:37:39 INFO - "project": "", 07:37:39 INFO - "product": "firefox", 07:37:39 INFO - "script_repo_revision": "production", 07:37:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:37:39 INFO - "repository": "", 07:37:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:37:39 INFO - "buildid": "20160423050248", 07:37:39 INFO - "pgo_build": "True", 07:37:39 INFO - "basedir": "/builds/slave/test", 07:37:39 INFO - "buildnumber": 312, 07:37:39 INFO - "slavename": "talos-linux64-ix-066", 07:37:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:37:39 INFO - "platform": "ubuntu64_hw", 07:37:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:37:39 INFO - "branch": "mozilla-aurora", 07:37:39 INFO - "repo_path": "releases/mozilla-aurora", 07:37:39 INFO - "revision": "32e9b18217afb665d570621b11363854b1da0a54", 07:37:39 INFO - "stage_platform": "linux64-pgo", 07:37:39 INFO - "builduid": "7dea74687f704e61be54fffc88399692", 07:37:39 INFO - "slavebuilddir": "test" 07:37:39 INFO - } 07:37:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 07:37:39 INFO - Running post-action listener: _resource_record_post_action 07:37:39 INFO - ##### 07:37:39 INFO - ##### Running download-and-extract step. 07:37:39 INFO - ##### 07:37:39 INFO - Running pre-action listener: _resource_record_pre_action 07:37:39 INFO - Running main action method: download_and_extract 07:37:39 INFO - mkdir: /builds/slave/test/build/tests 07:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:39 INFO - https://queue.taskcluster.net/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:37:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 07:37:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 07:37:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 07:37:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:37:42 INFO - Downloaded 1448 bytes. 07:37:42 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 07:37:42 INFO - Using the following test package requirements: 07:37:42 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 07:37:42 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 07:37:42 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:37:42 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 07:37:42 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:37:42 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 07:37:42 INFO - u'jsshell-linux-x86_64.zip'], 07:37:42 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 07:37:42 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:37:42 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 07:37:42 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 07:37:42 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:37:42 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 07:37:42 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:37:42 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 07:37:42 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:37:42 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 07:37:42 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 07:37:42 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:37:42 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:37:42 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')]} 07:37:42 INFO - https://queue.taskcluster.net/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 07:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 07:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 07:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:43 INFO - Downloaded 23358625 bytes. 07:37:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:37:44 INFO - Return code: 0 07:37:44 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:44 INFO - https://queue.taskcluster.net/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:37:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 07:37:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 07:37:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 07:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:51 INFO - Downloaded 23358625 bytes. 07:37:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:37:52 INFO - Return code: 0 07:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:52 INFO - https://queue.taskcluster.net/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:37:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 07:37:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 07:37:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 07:37:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:37:54 INFO - Downloaded 10845194 bytes. 07:37:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:37:54 INFO - Return code: 0 07:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:54 INFO - https://queue.taskcluster.net/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:37:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 07:37:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 07:37:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 07:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:37:55 INFO - Downloaded 60837714 bytes. 07:37:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 07:37:55 INFO - mkdir: /builds/slave/test/properties 07:37:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:55 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:55 INFO - Contents: 07:37:55 INFO - build_url:https://queue.taskcluster.net/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 07:37:56 INFO - Running post-action listener: _resource_record_post_action 07:37:56 INFO - Running post-action listener: set_extra_try_arguments 07:37:56 INFO - ##### 07:37:56 INFO - ##### Running populate-webroot step. 07:37:56 INFO - ##### 07:37:56 INFO - Running pre-action listener: _resource_record_pre_action 07:37:56 INFO - Running main action method: populate_webroot 07:37:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:56 INFO - '--tppagecycles', 07:37:56 INFO - '7'], 07:37:56 INFO - 'tests': ['tsvgm']}}, 07:37:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:37:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:37:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:37:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:37:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:56 INFO - 'talos_options': ['--e10s'], 07:37:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:56 INFO - 'tests': ['damp', 'tps']}, 07:37:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:56 INFO - 'talos_options': ['--e10s'], 07:37:56 INFO - 'tests': ['damp', 'tps']}, 07:37:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:37:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:56 INFO - 'other': {'tests': ['a11yr', 07:37:56 INFO - 'ts_paint', 07:37:56 INFO - 'tpaint', 07:37:56 INFO - 'sessionrestore', 07:37:56 INFO - 'sessionrestore_no_auto_restore', 07:37:56 INFO - 'tabpaint']}, 07:37:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:37:56 INFO - 'tests': ['a11yr', 07:37:56 INFO - 'ts_paint', 07:37:56 INFO - 'tpaint', 07:37:56 INFO - 'sessionrestore', 07:37:56 INFO - 'sessionrestore_no_auto_restore', 07:37:56 INFO - 'tabpaint']}, 07:37:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:37:56 INFO - 'tests': ['a11yr', 07:37:56 INFO - 'ts_paint', 07:37:56 INFO - 'tpaint', 07:37:56 INFO - 'sessionrestore', 07:37:56 INFO - 'sessionrestore_no_auto_restore', 07:37:56 INFO - 'tabpaint']}, 07:37:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:37:56 INFO - 'tests': ['a11yr', 07:37:56 INFO - 'ts_paint', 07:37:56 INFO - 'tpaint', 07:37:56 INFO - 'sessionrestore', 07:37:56 INFO - 'sessionrestore_no_auto_restore', 07:37:56 INFO - 'tabpaint']}, 07:37:56 INFO - 'other_l64': {'tests': ['a11yr', 07:37:56 INFO - 'ts_paint', 07:37:56 INFO - 'tpaint', 07:37:56 INFO - 'sessionrestore', 07:37:56 INFO - 'sessionrestore_no_auto_restore', 07:37:56 INFO - 'tabpaint']}, 07:37:56 INFO - 'other_nol64': {'tests': ['a11yr', 07:37:56 INFO - 'ts_paint', 07:37:56 INFO - 'tpaint', 07:37:56 INFO - 'sessionrestore', 07:37:56 INFO - 'sessionrestore_no_auto_restore', 07:37:56 INFO - 'tabpaint']}, 07:37:56 INFO - 'svgr': {'tests': ['tsvgx', 07:37:56 INFO - 'tsvgr_opacity', 07:37:56 INFO - 'tart', 07:37:56 INFO - 'tscrollx', 07:37:56 INFO - 'cart']}, 07:37:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:37:56 INFO - 'tests': ['tsvgx', 07:37:56 INFO - 'tsvgr_opacity', 07:37:56 INFO - 'tart', 07:37:56 INFO - 'tscrollx', 07:37:56 INFO - 'cart']}, 07:37:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:56 INFO - 'tests': ['tp5o']}, 07:37:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:56 INFO - 'talos_options': ['--e10s'], 07:37:56 INFO - 'tests': ['tp5o']}, 07:37:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:56 INFO - 'talos_options': ['--xperf_path', 07:37:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:56 INFO - 'tests': ['tp5n']}, 07:37:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:56 INFO - 'talos_options': ['--e10s', 07:37:56 INFO - '--xperf_path', 07:37:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:56 INFO - 'tests': ['tp5n']}}, 07:37:56 INFO - 'talos.zip': {'path': '', 07:37:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:56 INFO - Running post-action listener: _resource_record_post_action 07:37:56 INFO - ##### 07:37:56 INFO - ##### Running create-virtualenv step. 07:37:56 INFO - ##### 07:37:56 INFO - Running pre-action listener: _resource_record_pre_action 07:37:56 INFO - Running main action method: create_virtualenv 07:37:56 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:56 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 07:37:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:56 INFO - Using real prefix '/usr' 07:37:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:57 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:59 INFO - Installing pip.................done. 07:37:59 INFO - Return code: 0 07:37:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dfdc06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ec160>, '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 0x17ed060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ed4f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', '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 07:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:37:59 INFO - Using env: {'DISPLAY': ':0', 07:37:59 INFO - 'HOME': '/home/cltbld', 07:37:59 INFO - 'LANG': 'en_US.UTF-8', 07:37:59 INFO - 'LANGUAGE': 'en_US:en', 07:37:59 INFO - 'LOGNAME': 'cltbld', 07:37:59 INFO - 'MAIL': '/var/mail/cltbld', 07:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:59 INFO - 'MOZ_NO_REMOTE': '1', 07:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:59 INFO - 'NO_EM_RESTART': '1', 07:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:59 INFO - 'PWD': '/builds/slave/test', 07:37:59 INFO - 'SHELL': '/bin/bash', 07:37:59 INFO - 'SHLVL': '1', 07:37:59 INFO - 'TERM': 'linux', 07:37:59 INFO - 'TMOUT': '86400', 07:37:59 INFO - 'USER': 'cltbld', 07:37:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', 07:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:59 INFO - '_': '/tools/buildbot/bin/python'} 07:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:59 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 07:37:59 INFO - Cleaning up... 07:37:59 INFO - Return code: 0 07:37:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5dfdc06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ec160>, '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 0x17ed060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ed4f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', '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 07:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:37:59 INFO - Using env: {'DISPLAY': ':0', 07:37:59 INFO - 'HOME': '/home/cltbld', 07:37:59 INFO - 'LANG': 'en_US.UTF-8', 07:37:59 INFO - 'LANGUAGE': 'en_US:en', 07:37:59 INFO - 'LOGNAME': 'cltbld', 07:37:59 INFO - 'MAIL': '/var/mail/cltbld', 07:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:59 INFO - 'MOZ_NO_REMOTE': '1', 07:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:59 INFO - 'NO_EM_RESTART': '1', 07:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:59 INFO - 'PWD': '/builds/slave/test', 07:37:59 INFO - 'SHELL': '/bin/bash', 07:37:59 INFO - 'SHLVL': '1', 07:37:59 INFO - 'TERM': 'linux', 07:37:59 INFO - 'TMOUT': '86400', 07:37:59 INFO - 'USER': 'cltbld', 07:37:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', 07:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:59 INFO - '_': '/tools/buildbot/bin/python'} 07:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:59 INFO - Downloading/unpacking psutil>=0.7.1 07:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:01 INFO - Installing collected packages: psutil 07:38:01 INFO - Running setup.py install for psutil 07:38:01 INFO - building 'psutil._psutil_linux' extension 07:38:01 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 07:38:02 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 07:38:02 INFO - building 'psutil._psutil_posix' extension 07:38:02 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 07:38:02 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 07:38:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:02 INFO - Successfully installed psutil 07:38:02 INFO - Cleaning up... 07:38:02 INFO - Return code: 0 07:38:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:38:02 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')]} 07:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:02 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')]} 07:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:02 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 0x7f5dfdc06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ec160>, '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 0x17ed060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ed4f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', '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 07:38:02 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 07:38:02 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 07:38:02 INFO - Using env: {'DISPLAY': ':0', 07:38:02 INFO - 'HOME': '/home/cltbld', 07:38:02 INFO - 'LANG': 'en_US.UTF-8', 07:38:02 INFO - 'LANGUAGE': 'en_US:en', 07:38:02 INFO - 'LOGNAME': 'cltbld', 07:38:02 INFO - 'MAIL': '/var/mail/cltbld', 07:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:02 INFO - 'MOZ_NO_REMOTE': '1', 07:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:02 INFO - 'NO_EM_RESTART': '1', 07:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:02 INFO - 'PWD': '/builds/slave/test', 07:38:02 INFO - 'SHELL': '/bin/bash', 07:38:02 INFO - 'SHLVL': '1', 07:38:02 INFO - 'TERM': 'linux', 07:38:02 INFO - 'TMOUT': '86400', 07:38:02 INFO - 'USER': 'cltbld', 07:38:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', 07:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:02 INFO - '_': '/tools/buildbot/bin/python'} 07:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:38:04 INFO - Installing collected packages: mozsystemmonitor 07:38:04 INFO - Running setup.py install for mozsystemmonitor 07:38:04 INFO - Successfully installed mozsystemmonitor 07:38:04 INFO - Cleaning up... 07:38:04 INFO - Return code: 0 07:38:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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', '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 0x7f5dfdc06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ec160>, '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 0x17ed060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ed4f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', '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 07:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:38: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 blobuploader==1.2.4 07:38:04 INFO - Using env: {'DISPLAY': ':0', 07:38:04 INFO - 'HOME': '/home/cltbld', 07:38:04 INFO - 'LANG': 'en_US.UTF-8', 07:38:04 INFO - 'LANGUAGE': 'en_US:en', 07:38:04 INFO - 'LOGNAME': 'cltbld', 07:38:04 INFO - 'MAIL': '/var/mail/cltbld', 07:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:04 INFO - 'MOZ_NO_REMOTE': '1', 07:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:04 INFO - 'NO_EM_RESTART': '1', 07:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:04 INFO - 'PWD': '/builds/slave/test', 07:38:04 INFO - 'SHELL': '/bin/bash', 07:38:04 INFO - 'SHLVL': '1', 07:38:04 INFO - 'TERM': 'linux', 07:38:04 INFO - 'TMOUT': '86400', 07:38:04 INFO - 'USER': 'cltbld', 07:38:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', 07:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:04 INFO - '_': '/tools/buildbot/bin/python'} 07:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:04 INFO - Downloading/unpacking blobuploader==1.2.4 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:06 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:07 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 07:38:07 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 07:38:07 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 07:38:07 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 07:38:07 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 07:38:07 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 07:38:07 INFO - Downloading docopt-0.6.1.tar.gz 07:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:07 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:07 INFO - Running setup.py install for blobuploader 07:38:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:07 INFO - Running setup.py install for requests 07:38:07 INFO - Running setup.py install for docopt 07:38:08 INFO - Successfully installed blobuploader requests docopt 07:38:08 INFO - Cleaning up... 07:38:08 INFO - Return code: 0 07:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:08 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')]} 07:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:08 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')]} 07:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:08 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 0x7f5dfdc06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ec160>, '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 0x17ed060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ed4f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', '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 07:38:08 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 07:38:08 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 07:38:08 INFO - Using env: {'DISPLAY': ':0', 07:38:08 INFO - 'HOME': '/home/cltbld', 07:38:08 INFO - 'LANG': 'en_US.UTF-8', 07:38:08 INFO - 'LANGUAGE': 'en_US:en', 07:38:08 INFO - 'LOGNAME': 'cltbld', 07:38:08 INFO - 'MAIL': '/var/mail/cltbld', 07:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:08 INFO - 'MOZ_NO_REMOTE': '1', 07:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:08 INFO - 'NO_EM_RESTART': '1', 07:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:08 INFO - 'PWD': '/builds/slave/test', 07:38:08 INFO - 'SHELL': '/bin/bash', 07:38:08 INFO - 'SHLVL': '1', 07:38:08 INFO - 'TERM': 'linux', 07:38:08 INFO - 'TMOUT': '86400', 07:38:08 INFO - 'USER': 'cltbld', 07:38:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', 07:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:08 INFO - '_': '/tools/buildbot/bin/python'} 07:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:08 INFO - Running setup.py (path:/tmp/pip-46lgHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:08 INFO - Running setup.py (path:/tmp/pip-Tw61Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:08 INFO - Running setup.py (path:/tmp/pip-uElaWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:08 INFO - Running setup.py (path:/tmp/pip-lfeiQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:08 INFO - Running setup.py (path:/tmp/pip-T2IzAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:08 INFO - Running setup.py (path:/tmp/pip-_dePXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:08 INFO - Running setup.py (path:/tmp/pip-KcdBQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:08 INFO - Running setup.py (path:/tmp/pip-uedzKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:08 INFO - Running setup.py (path:/tmp/pip-8DUxVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:08 INFO - Running setup.py (path:/tmp/pip-WNp6Le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:09 INFO - Running setup.py (path:/tmp/pip-uKHF4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:09 INFO - Running setup.py (path:/tmp/pip-Sz_fct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:09 INFO - Running setup.py (path:/tmp/pip-WDqK1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:09 INFO - Running setup.py (path:/tmp/pip-DAxU3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:09 INFO - Running setup.py (path:/tmp/pip-ZeVWSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:09 INFO - Running setup.py (path:/tmp/pip-4xRTdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:09 INFO - Running setup.py (path:/tmp/pip-3H3jRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:09 INFO - Running setup.py install for manifestparser 07:38:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Running setup.py install for mozcrash 07:38:09 INFO - Running setup.py install for mozdebug 07:38:09 INFO - Running setup.py install for mozdevice 07:38:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Running setup.py install for mozfile 07:38:10 INFO - Running setup.py install for mozhttpd 07:38:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Running setup.py install for mozinfo 07:38:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Running setup.py install for mozInstall 07:38:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Running setup.py install for mozleak 07:38:10 INFO - Running setup.py install for mozlog 07:38:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Running setup.py install for moznetwork 07:38:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Running setup.py install for mozprocess 07:38:10 INFO - Running setup.py install for mozprofile 07:38:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Running setup.py install for mozrunner 07:38:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:11 INFO - Running setup.py install for mozscreenshot 07:38:11 INFO - Running setup.py install for moztest 07:38:11 INFO - Running setup.py install for mozversion 07:38:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:11 INFO - Cleaning up... 07:38:11 INFO - Return code: 0 07:38:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:11 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')]} 07:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:11 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')]} 07:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:11 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 0x7f5dfdc06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ec160>, '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 0x17ed060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ed4f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', '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 07:38:11 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 07:38:11 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 07:38:11 INFO - Using env: {'DISPLAY': ':0', 07:38:11 INFO - 'HOME': '/home/cltbld', 07:38:11 INFO - 'LANG': 'en_US.UTF-8', 07:38:11 INFO - 'LANGUAGE': 'en_US:en', 07:38:11 INFO - 'LOGNAME': 'cltbld', 07:38:11 INFO - 'MAIL': '/var/mail/cltbld', 07:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:11 INFO - 'MOZ_NO_REMOTE': '1', 07:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:11 INFO - 'NO_EM_RESTART': '1', 07:38:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:11 INFO - 'PWD': '/builds/slave/test', 07:38:11 INFO - 'SHELL': '/bin/bash', 07:38:11 INFO - 'SHLVL': '1', 07:38:11 INFO - 'TERM': 'linux', 07:38:11 INFO - 'TMOUT': '86400', 07:38:11 INFO - 'USER': 'cltbld', 07:38:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', 07:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:11 INFO - '_': '/tools/buildbot/bin/python'} 07:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:11 INFO - Running setup.py (path:/tmp/pip-uI_TMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:11 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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:11 INFO - Running setup.py (path:/tmp/pip-kP38Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:11 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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:11 INFO - Running setup.py (path:/tmp/pip-0jjRvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:11 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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:11 INFO - Running setup.py (path:/tmp/pip-XgdK8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:11 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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:11 INFO - Running setup.py (path:/tmp/pip-3Jq2RQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:11 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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:11 INFO - Running setup.py (path:/tmp/pip-dSV6LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:11 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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:12 INFO - Running setup.py (path:/tmp/pip-GX20DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:12 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)) 07:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:12 INFO - Running setup.py (path:/tmp/pip-aJZ4Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:12 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)) 07:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:12 INFO - Running setup.py (path:/tmp/pip-Hwo6RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:12 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)) 07:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:12 INFO - Running setup.py (path:/tmp/pip-iT9EId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:12 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)) 07:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:12 INFO - Running setup.py (path:/tmp/pip-UWJQEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:12 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)) 07:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:12 INFO - Running setup.py (path:/tmp/pip-zNXv49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:12 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)) 07:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:12 INFO - Running setup.py (path:/tmp/pip-VxQNwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:12 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)) 07:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:12 INFO - Running setup.py (path:/tmp/pip-ZuQLcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:12 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)) 07:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:12 INFO - Running setup.py (path:/tmp/pip-jAYmNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:12 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)) 07:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:12 INFO - Running setup.py (path:/tmp/pip-UEWbCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:12 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)) 07:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:12 INFO - Running setup.py (path:/tmp/pip-GxVXWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:12 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)) 07:38:12 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)) 07:38:12 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)) 07:38:12 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)) 07:38:12 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)) 07:38:12 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)) 07:38:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:14 INFO - Downloading blessings-1.6.tar.gz 07:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:14 INFO - Installing collected packages: blessings 07:38:14 INFO - Running setup.py install for blessings 07:38:15 INFO - Successfully installed blessings 07:38:15 INFO - Cleaning up... 07:38:15 INFO - Return code: 0 07:38:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:15 INFO - Reading from file tmpfile_stdout 07:38:15 INFO - Current package versions: 07:38:15 INFO - argparse == 1.2.1 07:38:15 INFO - blessings == 1.6 07:38:15 INFO - blobuploader == 1.2.4 07:38:15 INFO - docopt == 0.6.1 07:38:15 INFO - manifestparser == 1.1 07:38:15 INFO - mozInstall == 1.12 07:38:15 INFO - mozcrash == 0.17 07:38:15 INFO - mozdebug == 0.1 07:38:15 INFO - mozdevice == 0.48 07:38:15 INFO - mozfile == 1.2 07:38:15 INFO - mozhttpd == 0.7 07:38:15 INFO - mozinfo == 0.9 07:38:15 INFO - mozleak == 0.1 07:38:15 INFO - mozlog == 3.1 07:38:15 INFO - moznetwork == 0.27 07:38:15 INFO - mozprocess == 0.22 07:38:15 INFO - mozprofile == 0.28 07:38:15 INFO - mozrunner == 6.11 07:38:15 INFO - mozscreenshot == 0.1 07:38:15 INFO - mozsystemmonitor == 0.0 07:38:15 INFO - moztest == 0.7 07:38:15 INFO - mozversion == 1.4 07:38:15 INFO - psutil == 3.1.1 07:38:15 INFO - requests == 1.2.3 07:38:15 INFO - wsgiref == 0.1.2 07:38:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:15 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 0x7f5dfdc06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ec160>, '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 0x17ed060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ed4f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', '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 07:38:15 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 07:38:15 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 07:38:15 INFO - Using env: {'DISPLAY': ':0', 07:38:15 INFO - 'HOME': '/home/cltbld', 07:38:15 INFO - 'LANG': 'en_US.UTF-8', 07:38:15 INFO - 'LANGUAGE': 'en_US:en', 07:38:15 INFO - 'LOGNAME': 'cltbld', 07:38:15 INFO - 'MAIL': '/var/mail/cltbld', 07:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:15 INFO - 'MOZ_NO_REMOTE': '1', 07:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:15 INFO - 'NO_EM_RESTART': '1', 07:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:15 INFO - 'PWD': '/builds/slave/test', 07:38:15 INFO - 'SHELL': '/bin/bash', 07:38:15 INFO - 'SHLVL': '1', 07:38:15 INFO - 'TERM': 'linux', 07:38:15 INFO - 'TMOUT': '86400', 07:38:15 INFO - 'USER': 'cltbld', 07:38:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', 07:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:15 INFO - '_': '/tools/buildbot/bin/python'} 07:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:15 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)) 07:38:15 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)) 07:38:15 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)) 07:38:15 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)) 07:38:15 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)) 07:38:15 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)) 07:38:15 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)) 07:38:15 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)) 07:38:15 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)) 07:38:15 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)) 07:38:15 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)) 07:38:15 INFO - Cleaning up... 07:38:15 INFO - Return code: 0 07:38:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:15 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 0x7f5dfdc06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ec160>, '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 0x17ed060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ed4f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', '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 07:38:15 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 07:38:15 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 07:38:15 INFO - Using env: {'DISPLAY': ':0', 07:38:15 INFO - 'HOME': '/home/cltbld', 07:38:15 INFO - 'LANG': 'en_US.UTF-8', 07:38:15 INFO - 'LANGUAGE': 'en_US:en', 07:38:15 INFO - 'LOGNAME': 'cltbld', 07:38:15 INFO - 'MAIL': '/var/mail/cltbld', 07:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:15 INFO - 'MOZ_NO_REMOTE': '1', 07:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:15 INFO - 'NO_EM_RESTART': '1', 07:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:15 INFO - 'PWD': '/builds/slave/test', 07:38:15 INFO - 'SHELL': '/bin/bash', 07:38:15 INFO - 'SHLVL': '1', 07:38:15 INFO - 'TERM': 'linux', 07:38:15 INFO - 'TMOUT': '86400', 07:38:15 INFO - 'USER': 'cltbld', 07:38:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', 07:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:15 INFO - '_': '/tools/buildbot/bin/python'} 07:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:15 INFO - Downloading/unpacking jsonschema 07:38:15 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 07:38:15 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 07:38:15 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 07:38:15 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 07:38:15 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 07:38:15 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 07:38:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:17 INFO - Downloading/unpacking functools32 (from jsonschema) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:17 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:17 INFO - warning: no files found matching '*.txt' 07:38:17 INFO - no previously-included directories found matching 'build' 07:38:17 INFO - no previously-included directories found matching 'dist' 07:38:17 INFO - no previously-included directories found matching '.git*' 07:38:17 INFO - Installing collected packages: jsonschema, functools32 07:38:17 INFO - Running setup.py install for functools32 07:38:18 INFO - warning: no files found matching '*.txt' 07:38:18 INFO - no previously-included directories found matching 'build' 07:38:18 INFO - no previously-included directories found matching 'dist' 07:38:18 INFO - no previously-included directories found matching '.git*' 07:38:18 INFO - Successfully installed jsonschema functools32 07:38:18 INFO - Cleaning up... 07:38:18 INFO - Return code: 0 07:38:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dfdc06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ec160>, '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 0x17ed060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ed4f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', '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 07:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:38:18 INFO - Using env: {'DISPLAY': ':0', 07:38:18 INFO - 'HOME': '/home/cltbld', 07:38:18 INFO - 'LANG': 'en_US.UTF-8', 07:38:18 INFO - 'LANGUAGE': 'en_US:en', 07:38:18 INFO - 'LOGNAME': 'cltbld', 07:38:18 INFO - 'MAIL': '/var/mail/cltbld', 07:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:18 INFO - 'MOZ_NO_REMOTE': '1', 07:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:18 INFO - 'NO_EM_RESTART': '1', 07:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:18 INFO - 'PWD': '/builds/slave/test', 07:38:18 INFO - 'SHELL': '/bin/bash', 07:38:18 INFO - 'SHLVL': '1', 07:38:18 INFO - 'TERM': 'linux', 07:38:18 INFO - 'TMOUT': '86400', 07:38:18 INFO - 'USER': 'cltbld', 07:38:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', 07:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:18 INFO - '_': '/tools/buildbot/bin/python'} 07:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:18 INFO - Downloading/unpacking flake8 07:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:38:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:38:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:20 INFO - no previously-included directories found matching 'docs/_build' 07:38:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:38:20 INFO - Running setup.py install for pep8 07:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:20 INFO - no previously-included directories found matching 'docs/_build' 07:38:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:38:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:38:21 INFO - Cleaning up... 07:38:21 INFO - Return code: 0 07:38:21 INFO - Running post-action listener: _resource_record_post_action 07:38:21 INFO - Running post-action listener: _start_resource_monitoring 07:38:21 INFO - Starting resource monitoring. 07:38:21 INFO - ##### 07:38:21 INFO - ##### Running install step. 07:38:21 INFO - ##### 07:38:21 INFO - Running pre-action listener: _resource_record_pre_action 07:38:21 INFO - Running main action method: install 07:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:21 INFO - Reading from file tmpfile_stdout 07:38:21 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:21 INFO - Reading from file tmpfile_stdout 07:38:21 INFO - Output received: 07:38:21 INFO - Usage: mozinstall [options] installer 07:38:21 INFO - Options: 07:38:21 INFO - -h, --help show this help message and exit 07:38:21 INFO - -d DEST, --destination=DEST 07:38:21 INFO - Directory to install application into. [default: 07:38:21 INFO - "/builds/slave/test"] 07:38:21 INFO - --app=APP Application being installed. [default: firefox] 07:38:21 INFO - mkdir: /builds/slave/test/build/application 07:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:38:36 INFO - Reading from file tmpfile_stdout 07:38:36 INFO - Output received: 07:38:36 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:36 INFO - Running post-action listener: _resource_record_post_action 07:38:36 INFO - ##### 07:38:36 INFO - ##### Running run-tests step. 07:38:36 INFO - ##### 07:38:36 INFO - Running pre-action listener: _resource_record_pre_action 07:38:36 INFO - Running main action method: run_tests 07:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:36 INFO - Python 2.7.3 07:38:36 INFO - Return code: 0 07:38:36 INFO - grabbing minidump binary from tooltool 07:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:36 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 0x17ec160>, '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 0x17ed060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ed4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:36 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 07:38:36 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 07:38:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:36 INFO - Return code: 0 07:38:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:38:37 INFO - Return code: 0 07:38:37 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/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 07:38:37 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/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 07:38:37 INFO - Using env: {'DISPLAY': ':0', 07:38:37 INFO - 'HOME': '/home/cltbld', 07:38:37 INFO - 'LANG': 'en_US.UTF-8', 07:38:37 INFO - 'LANGUAGE': 'en_US:en', 07:38:37 INFO - 'LOGNAME': 'cltbld', 07:38:37 INFO - 'MAIL': '/var/mail/cltbld', 07:38:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:37 INFO - 'MOZ_NO_REMOTE': '1', 07:38:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:37 INFO - 'NO_EM_RESTART': '1', 07:38:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:37 INFO - 'PWD': '/builds/slave/test', 07:38:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:37 INFO - 'SHELL': '/bin/bash', 07:38:37 INFO - 'SHLVL': '1', 07:38:37 INFO - 'TERM': 'linux', 07:38:37 INFO - 'TMOUT': '86400', 07:38:37 INFO - 'USER': 'cltbld', 07:38:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006', 07:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:37 INFO - '_': '/tools/buildbot/bin/python'} 07:38:37 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/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 07:38:37 INFO - mozversion application_buildid: 20160423050248 07:38:37 INFO - mozversion application_changeset: 32e9b18217afb665d570621b11363854b1da0a54 07:38:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:38:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:37 INFO - mozversion application_name: Firefox 07:38:37 INFO - mozversion application_remotingname: firefox-dev 07:38:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:38:37 INFO - mozversion application_vendor: Mozilla 07:38:37 INFO - mozversion application_version: 47.0a2 07:38:37 INFO - mozversion platform_buildid: 20160423050248 07:38:37 INFO - mozversion platform_changeset: 32e9b18217afb665d570621b11363854b1da0a54 07:38:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:38:37 INFO - mozversion platform_version: 47.0a2 07:38:37 INFO - using testdate: 1461422317 07:38:37 INFO - actual date: 1461422317 07:38:37 INFO - starting webserver on 'localhost:36848' 07:38:37 INFO - SUITE-START | Running 2 tests 07:38:37 INFO - TEST-START | dromaeo_css 07:38:37 INFO - operating with platform_type : linux_ 07:38:37 INFO - Initialising browser for dromaeo_css test... 07:38:37 INFO - TEST-INFO | started process 6311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp25OXPW/profile http://localhost:36848/getInfo.html) 07:38:41 INFO - PROCESS | 6311 | 07:38:41 INFO - PROCESS | 6311 | (process:6388): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:38:42 INFO - PROCESS | 6311 | __metrics Screen width/height:1600/1200 07:38:42 INFO - PROCESS | 6311 | colorDepth:24 07:38:42 INFO - PROCESS | 6311 | Browser inner width/height: 1024/697 07:38:42 INFO - PROCESS | 6311 | __metrics 07:38:43 ERROR - PROCESS | 6311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 07:38:44 INFO - TEST-INFO | 6311: exit 0 07:38:44 INFO - Browser initialized. 07:38:44 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:44 INFO - TEST-INFO | started process 6439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp25OXPW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:46 INFO - PROCESS | 6439 | 07:38:46 INFO - PROCESS | 6439 | (process:6508): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:38:56 INFO - PROCESS | 6439 | RSS: Main: 151199744 07:38:56 INFO - PROCESS | 6439 | 07:39:45 INFO - PROCESS | 6439 | 1461422385978 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] 07:41:53 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:36848/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36848/tests/dromaeo/cssquery-ext.html) 07:41:54 INFO - PROCESS | 6439 | RSS: Main: 155480064 07:41:54 INFO - PROCESS | 6439 | 07:44:56 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:36848/tests/dromaeo/cssquery-ext.html (next: http://localhost:36848/tests/dromaeo/cssquery-jquery.html) 07:44:57 INFO - PROCESS | 6439 | RSS: Main: 153350144 07:44:57 INFO - PROCESS | 6439 | 07:47:59 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:36848/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36848/tests/dromaeo/cssquery-mootools.html) 07:47:59 INFO - PROCESS | 6439 | RSS: Main: 153571328 07:47:59 INFO - PROCESS | 6439 | 07:51:01 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:36848/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36848/tests/dromaeo/cssquery-prototype.html) 07:51:01 INFO - PROCESS | 6439 | RSS: Main: 152834048 07:51:01 INFO - PROCESS | 6439 | 07:54:04 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:36848/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36848/tests/dromaeo/cssquery-yui.html) 07:54:04 INFO - PROCESS | 6439 | RSS: Main: 154484736 07:54:04 INFO - PROCESS | 6439 | 07:57:07 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:36848/tests/dromaeo/cssquery-yui.html (next: http://localhost:36848/tests/dromaeo/cssquery-dojo.html) 07:57:07 INFO - PROCESS | 6439 | RSS: Main: 155402240 07:57:07 INFO - PROCESS | 6439 | 07:57:07 INFO - PROCESS | 6439 | __start_tp_report 07:57:07 INFO - PROCESS | 6439 | _x_x_mozilla_page_load 07:57:07 INFO - PROCESS | 6439 | _x_x_mozilla_page_load_details 07:57:07 INFO - PROCESS | 6439 | |i|pagename|runs| 07:57:07 INFO - PROCESS | 6439 | |0;dojo.html;3327.8502467388967;3363.4114030044734;3369.1408690783846;3387.0008347537473;3416.060583339581;5477.315335583052;5478.178273259013;5481.534069604083;5493;5516.558675305981;5463.754131064102;5476.7535460904255;5501.339839219289;5511.641743286694;5523.530499907512;5015.19756838905;5043.949560504385;5087.135187018216;5128.8461346159675;5142.434332223453;5018.673786203904;5087.56755675768;5122.564582010534;5139.768710408022;5192.792288308463;5117.488251174871;5178.326817513718;5183.585313174937;5205.739713014353;5235.973820130894;5138.792383789806;5148.794048238066;5159.484051594811;5173.741312934357;5222.660527065728;4879.316895634614;5083.237514372837;5094.337736094321;5140.357455318085;5165.974170129163;5358.169483729989;5395.325584301962;5408.4591540845995;5408.621396502246;5409.486098820606;5933.406659334032;5949.613275137102;5956.37458066901;5963.075723262901;5989.730462129215;5864.70676466175;5988.940110598882;6022.939770602282;6024.156618073429;6037.245344331958;5578.191162281487;5657.773689052392;5673.063944449161;5676.68778217202;5702.201691763156;6106.358832322631;6112.083187521907;6116.449519543263;6121;6133.570650054543;5765.4811067004175;5846.736896839652;5856.560757943172;5905.970470147622;5964.642121472725;6010.819675409744;6031.366706495843;6035.879282414415;6040.184575082308;6070.908936365958;5928.318243401977;5954.434328738763;5959.523238140939;5978.8206353809455;5990.490808281258;5851.444112809277;5890.087036509348;5968.552358573038;5979.282486101695;5982.551308651869;4475.351074094303;4514.435695538058;4524.23088075028;4535.002299494106;4544.954550454519;4069.1251380953236;4088.3867419887256;4091.284025295561;4094.0992981544014;4112.609302116294;5550.639208451437;5619.4099619540175;5691.402402747734;5710.543156547549;5714.428557144252;6042.486388656926;6095.05526643371;6099.451049405575;6125.295591007002;6129.877402452015;5578.888422231533;5582.413846546055;5599.636023658449;5649.983003059407;5652.830415087554;4969.850904472872;5062.848114556569;5109.105906466353;5171.844844654666;5211.1662134059125;6021.494626343414;6046.546509011841;6065.969670151621;6074.3925607438905;6091.299500557493;5932.851678708067;5937.821865344046;5941.970290148522;5951.315598706205;5957.136215248678;5891.1752354671235;6117.938820611737;6122.825106970096;6123.7550497981365;6170.382961703794;5826.970865145647;5829.59192856496;5850.473457388855;5855.765769369177;5905.084711869667;5931.792387266425;5974.701264936823;5975.731092100953;5976.043832986875;5979.760809567569;5845.590808643524;5905.852353691021;5910.52715782745;5922.348541660328;5945.702714864326;5768.538516918553;5793.131030345482;5797.043487824461;5819.76720931158;5820.243368362086;5620.887582248414;5662.915056274242;5679.77280908759;5680.346760122638;5684.090545512699;5891.381404952418;5900.468957793819;5915.733791979457;5957.702114894151;5968.582199246185;5787.652740835563;5817.9127313091185;5826.329972053099;5831;5832.387599302182 07:57:07 INFO - PROCESS | 6439 | |1;ext.html;526.1502673182811;551.9089350257206;576.6280748916948;592.3454582686134;608.9847753806155;37609.81195094024;37856;37859.810700946524;37932.431013534784;38081.809590952005;40884;41678.791606042;41682;41740.16519669605;41805.37291940623;8735.563221838898;8887.111288871125;8924;8942.329325300596;8944.955275223614;8754.430961987482;8817.250533704611;8847.380683352168;8850.468971861708;8865.556722163898;9035.096490350945;9093.454392736458;9115.908840911572;9122.08779122089;9127.95436022819;9065;9087.818243635156;9127.817443651124;9127.863082053775;9135.862962055608;9108.726738197865;9223.123803238681;9245.815083698288;9253.444793312423;9274.48990305533;42016.1596768066;42078.57921420777;42563.7871810642;42575.7871210645;42759.78620106911;3638.163222458823;3655.4334078217917;3833.9616603833883;4264.850730224458;4483.730976141442;31699;31716;31973;32186.839065804754;32385.676143238503;3924.6271604197555;3927.56796752357;4022.4971878515184;4054.837806487737;4081.122558649875;279983;280277;280303;280547;281094;45265.54734452679;46074.30888536674;61462.69268653718;62012.68993655003;62120;43696.12607747891;43816.78091609522;43969.560304397186;44007;44034.77982610131;16709.91645041767;16846;16861;16989.23548440323;16989.40537081196;13273.137246078973;13329.200247984958;13345.266010369523;13358.666033349244;13401.664958375924;15486.690266194613;15511;15652.921735391477;15663;15704.921475392779;6094.329623741385;6096.695165241809;6272.968635156795;6285.465735412449;6326.620402775849;1031.6750223679517;1100.2463312630873;1173.3018853781987;1196.7905616517075;1218.805570540875;29454.705452945196;29454.852725736233;29852.552211716407;30671.846640766653;30767.2308192297;1141.6403832792644;1143.4454289669504;1149.0807354116673;1158.820382840661;1173.1318824070127;15257.847421525643;15413.614659633598;15424.82095477497;15754.527364179094;15832.604184895239;175949;329454;544944;547668;551879;57044;57631.13553296704;57818.421815782145;58358.708206458694;58400.41599584035;1481.5703446000539;1513.7729340598999;1525.794017807604;1527.5722797616686;1537.7385844406253;28886.566701499072;29323.70676293295;29739;29886.103416897527;30170.396592068475;50435.74782126066;50818.491815081376;51064.74467627638;51231.74384128056;51254.487455124974;308229;312234;312524;313177;315171;34699.13252168615;34710.65289347074;35353;35450.29099417946;35565.82217088898;46287.305690413996;46925;47091.529084710084;47242.74930472839;47560.2865957004;38471;38867.80566097265;39672.60327396689;39672.60327396689;40059.39910901397;38502;38672.613273868024;38688.41967370548;41645;42168;36058.63941360658;36783.44824827683;36953.260934780614;37102.25795484129;37105.25789484249;31122.533162002135;31482.37035259328;31784.205394865312;32809.671903280665;34767;26299.605505917043;27236;27412.58881116745;27425.58861617117;27621.64188429339 07:57:07 INFO - PROCESS | 6439 | |2;jquery.html;373.42306137018306;394.64284822235885;394.84798352634226;395.97030222733287;406.1774905815721;17294.481165565023;19654.705179422286;20080.799192008075;20200.59598808023;20203.191872325107;18246.63506729868;18606.34877779278;18689;19003.714944275845;19026.524336891584;5393.514583687467;5650;5650.5479561634975;5660.2075709400715;5666.490015898568;4161.3549899765585;5789.768409263625;6027.156198132265;6029.849253768647;6045.697715114248;5816.4474374934525;5936.050231962887;5969.850753731148;5980.671063091529;5983.940160598404;5915.112733090028;5923.466887980103;5938.554608404365;5953.761849526057;5961.284645842505;5197.714125723083;5218.03466358721;5258.8159414420315;5262;5283.365996080495;22155.556888862295;22412.775872241233;22465.32604021882;22593.77406225933;22678.433039174153;2401.615741481372;2410.3130607776698;2438.9634155487684;2557.961630575543;2935.882564697431;13593.456261749518;13991.720165596733;14172.645683857883;14260.85739142616;14322.95538572855;1789.329001624391;1790.8656850736118;1819.1631849349183;1915.817997290255;1977.1103003648273;63570;65082;65430;65699;66522;10094.242931780145;10455.320404173704;10486.265961382782;10548.41983690889;10593.52329145175;14594.781078283835;14640.633984150481;14759.966802323948;14820;14822.184779836996;7732.6906923723545;8005.119436861941;8011.399145064027;8166.959165204136;8414;8137.715179968673;8158.306543943712;8164.959175204086;8196.34429245659;8204.056533498604;4730.810767569259;4778.235482322882;4790.952090479051;4842.927356089662;4891.559759621651;1891.4514790710814;1983.2562788954142;2022.6157030164222;2065.607534568427;2094.078605413644;930.7300882744064;994.557421947241;1030.1861529391847;1055.2929537210089;1057.6985559115615;15862.841371586368;17359.913200433915;17426.827078470134;17639.73540396895;18095.72856407155;1020.5407566595062;1035.1304903880775;1045.487711021594;1096.2435919215716;1098.5386137822134;9991.450470224063;10412;10448.487013824788;10449;10528.947355263175;450978;460638;460917;465443;466926;79441.20558794454;80599.59700201578;81745;83016.58491707503;83655;1059.2003037706636;1074.6346242277664;1074.8602681651334;1081.0378762901025;1085.1102096280974;15930.442434514736;15931.601709957344;16209.432669856498;16341.264643090852;16413;35457;35788.28423431569;35837.46243806397;36609.26781464409;36972.63027369799;50358.49641503538;50704.74647626886;50790;51000;51425;8099.5545245009735;8153.836923261383;8247.422680412314;8352;8464.407491475538;9471.573779180091;11751.177417580688;11841;11851.881481185077;12163.209391389531;10675.09261712732;10716.464176790972;10722.463876806285;10724.302920310154;10856.674299771019;10563.524641391003;10706.250562460864;10754.40850753216;10822.51298691545;10992.780144396907;10226.795464090528;10844.566217351217;10926.562937482411;11091.5563377464;11289.491972861077;8141.348692104499;8182.468139571147;8269.95865020671;8297.460665056751;8372.455790373606;8738.69414570487;10851.077658398808;11100.61147859821;11120.499577519193;11142.721431964266 07:57:07 INFO - PROCESS | 6439 | |3;mootools.html;1555.9144247066413;1568.3412966554047;1797.7662903822502;1918.5203699075232;1976.0317444452223;7292.343689067983;7949.205079492048;7962.4028197885245;8078.757637270884;8092.676292948275;8230.2592766651;8365.163483651631;8443.324534037278;8456.408051436401;8470.661173553066;2372.881355932205;2379.1672914479923;2393.808495320379;2395.6047252203366;2411.05968672218;2353.8587684738886;2385.7733515316104;2391.0674836813655;2396.101461951768;2410.529946660402;2392.258399896029;2392.497575509145;2401.639754036891;2433.4403087289934;2446.2049833803994;2397.496525729599;2405.7473965233576;2406.6750988616486;2408.843425177358;2450.5588993981078;2354.7527509611587;2372.7627237276306;2379.3694670912223;2383.2731017039796;2386.749391313904;8365.58172091393;8376.958115209385;8395.664173433055;8412.537310447922;8461.66153353865;5027.622928280393;5151.6136289778415;5183.403908550527;5183.922241166386;5185.2999845021195;3168.1287645897332;3184.4427225235722;3238.951415728766;3248.9350212995846;3266.4447044002577;973.2262851033374;983.4345251480356;1005.3063386263455;1015.1523477895965;1035.4667346316653;11287.548498060069;11306.208565400426;11347.26242794224;11348.375839328834;11362.034227090624;4356.172327257811;4423.756693381831;4522.932156017662;4531.8413855515555;4581.862544123682;9696.127348538665;9721.076497732704;9808.36245644045;9834.60661573529;9881.802363952824;5147.176451767699;5169.172932330809;5184.196449550326;5194.8961020780125;5201.29782479368;4061.3501839706096;4531.43357080365;4549.431321084864;4600.723956562617;4644.9767751161025;3791.3933770596573;3804.1821008483307;3818;3867.45855580219;3879.84480620772;1250.424804589899;1251.5056552661829;1254.172246317426;1257.4718618180202;1269.930153841529;1426.0231741257064;1440.0927415728024;1455.8180227471566;1476.7932489451484;1501.797257370263;7892.210778922062;7952.681892724342;7977.760667179994;7990.9200907991335;7995.200479952075;516.9896602068013;527.3276572370258;535.8874636326415;538.1658429434361;547.3623228938243;5905.940940590625;5928.555358348141;5946.524278057745;5957.672328022;6039.637621742621;9681.128698417177;10114.443705596115;10143.340682855738;10243.129334006693;10265.589376425009;9733.513324333755;9902.306838521234;10044.949775251076;10081.344712593658;10115.342502737298;7863.095743989515;7885;7908.209179082046;7921.049474063034;7923.801904952307;7378.926210737824;7414.369778568666;7419.591922444318;7430.7399241026305;7643.464957452925;8814.823703526023;8853.203211710977;8908;9023.77440563965;9032.36773425854;9073.228775553887;9095.863562046443;9112.589933453142;9129.269658427444;9348.392354496937;6572.901406478811;6980.301969802979;7145.214026456982;7445.181030086578;7517.097948246027;7683.692652294069;7684.6157692116285;7691.50005249657;7716.729914453192;7721.884171737316;6922.723091076301;7030.894536581853;7034.648267586703;7053.823654408681;7202.2797720229655;7090.822729431806;7118.60847653384;7152.928470715435;7183.425325974014;7209.747658831916;7231.385332246818;7315.195328513752;7442.404607631484;7462.701491940262;7510.474266801271;6692.263850976291;6704.966475167788;6717.2946840581035;6721.1598550181225;6748.920172772333;6941.201761797458;6995.965020174866;7041.788746337618;7042.436605071684;7052.400545953446 07:57:07 INFO - PROCESS | 6439 | |4;prototype.html;364.2223852075818;370.8090333478259;370.96290370962896;374.33555439095585;380.735388904711;6351.079093531435;6372.872542549152;6375.521835862317;6396.360363963601;6447.742090316394;6273.623582585048;6294.6223226606435;6312.779052733155;6314.621122732628;6339.302676705559;4729.78715957781;4810.807567697288;4859.951400486003;4862.586680132193;4939.851804445863;4852.927206091894;4870.196417591093;4873.34209881665;4876.390451193601;4892.9510704892855;4762.857114286577;4791.904161916759;4810.7835147418455;4811.08589368019;4821.252705830602;4834.4923783002805;4838.201696720037;4844.12805694973;4846.9515304846855;4850.296706977504;4197.433346498215;4199.118185181115;4202.579742025803;4205.97897010516;4217.198732240895;5922.496587790043;6032.66820324882;6043.335233124353;6067.696615169224;6069.332373438918;5598.916016259759;5600.719964001824;5602.299712535933;5602.7758889644365;5609.775608975636;6677.465802735769;6692.966535167342;6695.564788288794;6696.096027036385;6725.327467253284;4588.655850811169;4597.931031034537;4601.930971035437;4603.539646035403;4616.953830461686;6966.477514186457;7048.788536343918;7058.929410705879;7074.717011319541;7075.363217310415;4717.787699553528;4840.080384726891;4843.346148270009;4846.854594362175;4853.514648535118;4858.65989380747;4878.536539028786;4889.2910527973245;4891.902161956812;4903.264510323409;5628.2683251177905;5646.774129034875;5651.717414129277;5653.349864765604;5668.716564171775;6719.731210751613;6747.527673062937;6748.898766518506;6763.391294783395;6778.186617605918;1726.5683579105223;1750.7899052113828;1753.438899552131;1756.1745979389666;1758.085795386392;1102.074257623584;1129.3336931210624;1135.0408904475705;1145.8052131137727;1148.2823235477827;6493.22081350241;6522.934770652233;6531.020346947996;6545.050967609765;6548.083268342436;6927.7228910844005;6984.126984126984;7025.754098606524;7026.578405295699;7040.894386584206;6470.676466176672;6507.3167317431935;6580.86838263232;6608.900866487006;6627.701753421107;3832.5784163741964;3854.325493038763;3862.671672907778;3864.130570621644;3869.090763670535;7246.384057355184;7251.782446526613;7254.854902901912;7296.562206267535;7296.598687072262;7190.676419561132;7197.856042879113;7199.640017999184;7203.783886483414;7224.096987876515;7096.680649370791;7286.96356518214;7317.963410182915;7322.231165727629;7328.780136595804;7023.964880175567;7084;7104.857902842017;7106.253843346581;7143.4999550031;6911.101556797584;6933.37599616037;6945.0971373721095;6948.652567371712;6968.303169683194;7252.129744430491;7272.272772722686;7273.745418910313;7287.854242915006;7304.123505179413;4686.554777296152;4757.143714131351;4847.394075740533;4851.490593487774;4873.6832105913;7014.684339204646;7036.261192574706;7041.119860017498;7063.540869843444;7072.080629518336;6810.795676129724;6813.3527314905;6824.2152152503095;6830.975353696986;6835.7949261522235;6801.965990170215;6837.487188460786;6846.418054465227;6856.828579285558;6860.348266914635;6518.641474718936;6686.06395104676;6732.663366831541;6753.358430949052;6753.662316884234;6936.572199730256;6957.652117394009;6987.196472405739;6989.231184569795;7002.124734408199;6723.092382528296;6736.898946515904;6740.595564266159;6744.7976560703255;6753.3246675332075 07:57:07 INFO - PROCESS | 6439 | |5;yui.html;786.5123623353521;906.8141031088624;915.9313051521129;922.1930810540777;942.7077605942159;14900.478483253088;14982.475613353536;15175.317110730017;15299.541013769576;15315.770263446044;12661.683457913558;14242.786358204608;14299.642508937255;14312.21282829444;14337;909.1908201700492;931.0317270039151;931.1526510875105;935.6865450074199;942.7171848445473;927.9628814847398;928.0394791390912;933.6545478173085;934.6448349627132;936.2790651198573;978.6721448314823;989.915857152143;991.8710567626199;992.0674565908059;994.5275993902875;967.2358836519142;973.4013581647272;974.2206235011962;976.4775844922932;982.341830973246;715.1132595581441;722.4220623501178;724.8550289942033;725.0429433148247;726.7274771960515;14264;14286.714265714627;14319.355628996616;14368.568942931728;14425.495107671286;14649.12105273687;14702.4854130106;14747;14818.925905370405;14824.407023719039;10753.892461075367;10780.46097695112;10824.67525974222;10876.945615271952;10890.945545272301;3840.558335791364;3895.590962948878;3907.609239076098;3916;3956.6439020488006;50639.24041139386;51415.48584514144;51423;51572.74213628908;51650.2252466217;11480.59817906386;11559.595414160463;11772.234804737836;12091;12210.75578488443;20889.37331880046;20979.790202097785;21002.894985524974;21023.26418575373;21275.829829359223;7759.090341122079;7862.803429914184;7884.960575197088;8106.108328083906;8243.95878020618;4391.385206071152;4392.978035109868;4430.734155950653;4455.6658250631335;4535.387722657399;3468.7745296555645;3478.617352091268;3482.9477557836653;3507.105688049531;3509.0350153707936;601.5368166511848;602.5631417222567;606.8167074205318;612.6354818882758;626.4393367935763;577.9739911703983;628.5788521690479;679.3546131175403;697.2469732688684;715.345458905096;8713.956430217808;8790.340724445565;8906;9048.819023619622;9231.630734770533;524.318386098071;606.6845240474928;633.1831936801567;641.7144370754969;642.4667525953447;4060.6954478414236;4094.0992981544014;4095.3037983542868;4165.437665915123;4203.957960420356;57679.423205768246;58195.127073093936;59563;59970;60244;50646.74676626667;50750;50960;52348.73825630924;52545.211821822704;47637.28544071842;47787.28319075217;48245.27632085521;48538.27192592184;48708;9053.275737940818;9089.136532029446;9142.268618510636;9232.676856309998;9327.020662830577;36632.633673663986;36635.63364366322;37162.62837371592;37511;38077.61922380851;43716.56283437125;46814;46931.76534117308;47440;47880.76059619679;11452.599159029394;11494.827577586175;11545.711357216136;11645.59240426581;11789.233699809485;12177.208481448677;12285.1400401971;12824.166429182073;12869.485220591072;12881.162724422882;11409.942950285196;11507;11606.071514278668;11886;11983.28100313984;11311.490982905625;11971.580994665144;12100.092493062879;12160.452779625115;12581.559645412366;11706.88293117058;12034.398280086136;12052.819207711716;12070.215435996632;12091.697707557381;9770.31607787448;9972.950135249277;10037.146842518468;10059.09468147841;10188.541515631667;9779.462129582942;10163;10229.897701022894;10254.846177307496;10361.4301213434 07:57:07 INFO - PROCESS | 6439 | __end_tp_report 07:57:07 INFO - PROCESS | 6439 | __start_cc_report 07:57:07 INFO - PROCESS | 6439 | _x_x_mozilla_cycle_collect,329 07:57:07 INFO - PROCESS | 6439 | __end_cc_report 07:57:07 INFO - PROCESS | 6439 | __startTimestamp1461423427360__endTimestamp 07:57:07 INFO - PROCESS | 6439 | 07:57:07 INFO - PROCESS | 6439 | ------- Summary: start ------- 07:57:07 INFO - PROCESS | 6439 | Number of tests: 6 07:57:07 INFO - PROCESS | 6439 | 07:57:07 INFO - PROCESS | 6439 | [#0] dojo.html Cycles:165 Average:5545.75 Median:5787.65 stddev:609.64 (10.5%) stddev-sans-first:586.16 07:57:07 INFO - PROCESS | 6439 | Values: 3327.9 3363.4 3369.1 3387.0 3416.1 5477.3 5478.2 5481.5 5493.0 5516.6 5463.8 5476.8 5501.3 5511.6 5523.5 5015.2 5043.9 5087.1 5128.8 5142.4 5018.7 5087.6 5122.6 5139.8 5192.8 5117.5 5178.3 5183.6 5205.7 5236.0 5138.8 5148.8 5159.5 5173.7 5222.7 4879.3 5083.2 5094.3 5140.4 5166.0 5358.2 5395.3 5408.5 5408.6 5409.5 5933.4 5949.6 5956.4 5963.1 5989.7 5864.7 5988.9 6022.9 6024.2 6037.2 5578.2 5657.8 5673.1 5676.7 5702.2 6106.4 6112.1 6116.4 6121.0 6133.6 5765.5 5846.7 5856.6 5906.0 5964.6 6010.8 6031.4 6035.9 6040.2 6070.9 5928.3 5954.4 5959.5 5978.8 5990.5 5851.4 5890.1 5968.6 5979.3 5982.6 4475.4 4514.4 4524.2 4535.0 4545.0 4069.1 4088.4 4091.3 4094.1 4112.6 5550.6 5619.4 5691.4 5710.5 5714.4 6042.5 6095.1 6099.5 6125.3 6129.9 5578.9 5582.4 5599.6 5650.0 5652.8 4969.9 5062.8 5109.1 5171.8 5211.2 6021.5 6046.5 6066.0 6074.4 6091.3 5932.9 5937.8 5942.0 5951.3 5957.1 5891.2 6117.9 6122.8 6123.8 6170.4 5827.0 5829.6 5850.5 5855.8 5905.1 5931.8 5974.7 5975.7 5976.0 5979.8 5845.6 5905.9 5910.5 5922.3 5945.7 5768.5 5793.1 5797.0 5819.8 5820.2 5620.9 5662.9 5679.8 5680.3 5684.1 5891.4 5900.5 5915.7 5957.7 5968.6 5787.7 5817.9 5826.3 5831.0 5832.4 07:57:07 INFO - PROCESS | 6439 | 07:57:07 INFO - PROCESS | 6439 | [#1] ext.html Cycles:180 Average:50755.13 Median:38486.50 stddev:94773.02 (246.3%) stddev-sans-first:94963.85 07:57:07 INFO - PROCESS | 6439 | Values: 526.2 551.9 576.6 592.3 609.0 37609.8 37856.0 37859.8 37932.4 38081.8 40884.0 41678.8 41682.0 41740.2 41805.4 8735.6 8887.1 8924.0 8942.3 8945.0 8754.4 8817.3 8847.4 8850.5 8865.6 9035.1 9093.5 9115.9 9122.1 9128.0 9065.0 9087.8 9127.8 9127.9 9135.9 9108.7 9223.1 9245.8 9253.4 9274.5 42016.2 42078.6 42563.8 42575.8 42759.8 3638.2 3655.4 3834.0 4264.9 4483.7 31699.0 31716.0 31973.0 32186.8 32385.7 3924.6 3927.6 4022.5 4054.8 4081.1 279983.0 280277.0 280303.0 280547.0 281094.0 45265.5 46074.3 61462.7 62012.7 62120.0 43696.1 43816.8 43969.6 44007.0 44034.8 16709.9 16846.0 16861.0 16989.2 16989.4 13273.1 13329.2 13345.3 13358.7 13401.7 15486.7 15511.0 15652.9 15663.0 15704.9 6094.3 6096.7 6273.0 6285.5 6326.6 1031.7 1100.2 1173.3 1196.8 1218.8 29454.7 29454.9 29852.6 30671.8 30767.2 1141.6 1143.4 1149.1 1158.8 1173.1 15257.8 15413.6 15424.8 15754.5 15832.6 175949.0 329454.0 544944.0 547668.0 551879.0 57044.0 57631.1 57818.4 58358.7 58400.4 1481.6 1513.8 1525.8 1527.6 1537.7 28886.6 29323.7 29739.0 29886.1 30170.4 50435.7 50818.5 51064.7 51231.7 51254.5 308229.0 312234.0 312524.0 313177.0 315171.0 34699.1 34710.7 35353.0 35450.3 35565.8 46287.3 46925.0 47091.5 47242.7 47560.3 38471.0 38867.8 39672.6 39672.6 40059.4 38502.0 38672.6 38688.4 41645.0 42168.0 36058.6 36783.4 36953.3 37102.3 37105.3 31122.5 31482.4 31784.2 32809.7 34767.0 26299.6 27236.0 27412.6 27425.6 27621.6 07:57:07 INFO - PROCESS | 6439 | 07:57:07 INFO - PROCESS | 6439 | [#2] jquery.html Cycles:180 Average:26913.00 Median:2405.96 stddev:75631.22 (3143.5%) stddev-sans-first:75817.14 07:57:07 INFO - PROCESS | 6439 | Values: 373.4 394.6 394.8 396.0 406.2 17294.5 19654.7 20080.8 20200.6 20203.2 18246.6 18606.3 18689.0 19003.7 19026.5 5393.5 5650.0 5650.5 5660.2 5666.5 4161.4 5789.8 6027.2 6029.8 6045.7 5816.4 5936.1 5969.9 5980.7 5983.9 5915.1 5923.5 5938.6 5953.8 5961.3 5197.7 5218.0 5258.8 5262.0 5283.4 22155.6 22412.8 22465.3 22593.8 22678.4 2401.6 2410.3 2439.0 2558.0 2935.9 13593.5 13991.7 14172.6 14260.9 14323.0 1789.3 1790.9 1819.2 1915.8 1977.1 63570.0 65082.0 65430.0 65699.0 66522.0 10094.2 10455.3 10486.3 10548.4 10593.5 14594.8 14640.6 14760.0 14820.0 14822.2 7732.7 8005.1 8011.4 8167.0 8414.0 8137.7 8158.3 8165.0 8196.3 8204.1 4730.8 4778.2 4791.0 4842.9 4891.6 1891.5 1983.3 2022.6 2065.6 2094.1 930.7 994.6 1030.2 1055.3 1057.7 15862.8 17359.9 17426.8 17639.7 18095.7 1020.5 1035.1 1045.5 1096.2 1098.5 9991.5 10412.0 10448.5 10449.0 10528.9 450978.0 460638.0 460917.0 465443.0 466926.0 79441.2 80599.6 81745.0 83016.6 83655.0 1059.2 1074.6 1074.9 1081.0 1085.1 15930.4 15931.6 16209.4 16341.3 16413.0 35457.0 35788.3 35837.5 36609.3 36972.6 50358.5 50704.7 50790.0 51000.0 51425.0 8099.6 8153.8 8247.4 8352.0 8464.4 9471.6 11751.2 11841.0 11851.9 12163.2 10675.1 10716.5 10722.5 10724.3 10856.7 10563.5 10706.3 10754.4 10822.5 10992.8 10226.8 10844.6 10926.6 11091.6 11289.5 8141.3 8182.5 8270.0 8297.5 8372.5 8738.7 10851.1 11100.6 11120.5 11142.7 07:57:07 INFO - PROCESS | 6439 | 07:57:07 INFO - PROCESS | 6439 | [#3] mootools.html Cycles:180 Average:5769.45 Median:5917.25 stddev:3018.97 (51.0%) stddev-sans-first:3010.83 07:57:07 INFO - PROCESS | 6439 | Values: 1555.9 1568.3 1797.8 1918.5 1976.0 7292.3 7949.2 7962.4 8078.8 8092.7 8230.3 8365.2 8443.3 8456.4 8470.7 2372.9 2379.2 2393.8 2395.6 2411.1 2353.9 2385.8 2391.1 2396.1 2410.5 2392.3 2392.5 2401.6 2433.4 2446.2 2397.5 2405.7 2406.7 2408.8 2450.6 2354.8 2372.8 2379.4 2383.3 2386.7 8365.6 8377.0 8395.7 8412.5 8461.7 5027.6 5151.6 5183.4 5183.9 5185.3 3168.1 3184.4 3239.0 3248.9 3266.4 973.2 983.4 1005.3 1015.2 1035.5 11287.5 11306.2 11347.3 11348.4 11362.0 4356.2 4423.8 4522.9 4531.8 4581.9 9696.1 9721.1 9808.4 9834.6 9881.8 5147.2 5169.2 5184.2 5194.9 5201.3 4061.4 4531.4 4549.4 4600.7 4645.0 3791.4 3804.2 3818.0 3867.5 3879.8 1250.4 1251.5 1254.2 1257.5 1269.9 1426.0 1440.1 1455.8 1476.8 1501.8 7892.2 7952.7 7977.8 7990.9 7995.2 517.0 527.3 535.9 538.2 547.4 5905.9 5928.6 5946.5 5957.7 6039.6 9681.1 10114.4 10143.3 10243.1 10265.6 9733.5 9902.3 10044.9 10081.3 10115.3 7863.1 7885.0 7908.2 7921.0 7923.8 7378.9 7414.4 7419.6 7430.7 7643.5 8814.8 8853.2 8908.0 9023.8 9032.4 9073.2 9095.9 9112.6 9129.3 9348.4 6572.9 6980.3 7145.2 7445.2 7517.1 7683.7 7684.6 7691.5 7716.7 7721.9 6922.7 7030.9 7034.6 7053.8 7202.3 7090.8 7118.6 7152.9 7183.4 7209.7 7231.4 7315.2 7442.4 7462.7 7510.5 6692.3 6705.0 6717.3 6721.2 6748.9 6941.2 6996.0 7041.8 7042.4 7052.4 07:57:07 INFO - PROCESS | 6439 | 07:57:07 INFO - PROCESS | 6439 | [#4] prototype.html Cycles:180 Average:5680.69 Median:6481.95 stddev:1721.93 (26.6%) stddev-sans-first:1679.89 07:57:07 INFO - PROCESS | 6439 | Values: 364.2 370.8 371.0 374.3 380.7 6351.1 6372.9 6375.5 6396.4 6447.7 6273.6 6294.6 6312.8 6314.6 6339.3 4729.8 4810.8 4860.0 4862.6 4939.9 4852.9 4870.2 4873.3 4876.4 4893.0 4762.9 4791.9 4810.8 4811.1 4821.3 4834.5 4838.2 4844.1 4847.0 4850.3 4197.4 4199.1 4202.6 4206.0 4217.2 5922.5 6032.7 6043.3 6067.7 6069.3 5598.9 5600.7 5602.3 5602.8 5609.8 6677.5 6693.0 6695.6 6696.1 6725.3 4588.7 4597.9 4601.9 4603.5 4617.0 6966.5 7048.8 7058.9 7074.7 7075.4 4717.8 4840.1 4843.3 4846.9 4853.5 4858.7 4878.5 4889.3 4891.9 4903.3 5628.3 5646.8 5651.7 5653.3 5668.7 6719.7 6747.5 6748.9 6763.4 6778.2 1726.6 1750.8 1753.4 1756.2 1758.1 1102.1 1129.3 1135.0 1145.8 1148.3 6493.2 6522.9 6531.0 6545.1 6548.1 6927.7 6984.1 7025.8 7026.6 7040.9 6470.7 6507.3 6580.9 6608.9 6627.7 3832.6 3854.3 3862.7 3864.1 3869.1 7246.4 7251.8 7254.9 7296.6 7296.6 7190.7 7197.9 7199.6 7203.8 7224.1 7096.7 7287.0 7318.0 7322.2 7328.8 7024.0 7084.0 7104.9 7106.3 7143.5 6911.1 6933.4 6945.1 6948.7 6968.3 7252.1 7272.3 7273.7 7287.9 7304.1 4686.6 4757.1 4847.4 4851.5 4873.7 7014.7 7036.3 7041.1 7063.5 7072.1 6810.8 6813.4 6824.2 6831.0 6835.8 6802.0 6837.5 6846.4 6856.8 6860.3 6518.6 6686.1 6732.7 6753.4 6753.7 6936.6 6957.7 6987.2 6989.2 7002.1 6723.1 6736.9 6740.6 6744.8 6753.3 07:57:07 INFO - PROCESS | 6439 | 07:57:07 INFO - PROCESS | 6439 | [#5] yui.html Cycles:180 Average:14587.33 Median:4443.20 stddev:16514.19 (371.7%) stddev-sans-first:16527.99 07:57:07 INFO - PROCESS | 6439 | Values: 786.5 906.8 915.9 922.2 942.7 14900.5 14982.5 15175.3 15299.5 15315.8 12661.7 14242.8 14299.6 14312.2 14337.0 909.2 931.0 931.2 935.7 942.7 928.0 928.0 933.7 934.6 936.3 978.7 989.9 991.9 992.1 994.5 967.2 973.4 974.2 976.5 982.3 715.1 722.4 724.9 725.0 726.7 14264.0 14286.7 14319.4 14368.6 14425.5 14649.1 14702.5 14747.0 14818.9 14824.4 10753.9 10780.5 10824.7 10876.9 10890.9 3840.6 3895.6 3907.6 3916.0 3956.6 50639.2 51415.5 51423.0 51572.7 51650.2 11480.6 11559.6 11772.2 12091.0 12210.8 20889.4 20979.8 21002.9 21023.3 21275.8 7759.1 7862.8 7885.0 8106.1 8244.0 4391.4 4393.0 4430.7 4455.7 4535.4 3468.8 3478.6 3482.9 3507.1 3509.0 601.5 602.6 606.8 612.6 626.4 578.0 628.6 679.4 697.2 715.3 8714.0 8790.3 8906.0 9048.8 9231.6 524.3 606.7 633.2 641.7 642.5 4060.7 4094.1 4095.3 4165.4 4204.0 57679.4 58195.1 59563.0 59970.0 60244.0 50646.7 50750.0 50960.0 52348.7 52545.2 47637.3 47787.3 48245.3 48538.3 48708.0 9053.3 9089.1 9142.3 9232.7 9327.0 36632.6 36635.6 37162.6 37511.0 38077.6 43716.6 46814.0 46931.8 47440.0 47880.8 11452.6 11494.8 11545.7 11645.6 11789.2 12177.2 12285.1 12824.2 12869.5 12881.2 11409.9 11507.0 11606.1 11886.0 11983.3 11311.5 11971.6 12100.1 12160.5 12581.6 11706.9 12034.4 12052.8 12070.2 12091.7 9770.3 9973.0 10037.1 10059.1 10188.5 9779.5 10163.0 10229.9 10254.8 10361.4 07:57:07 INFO - PROCESS | 6439 | -------- Summary: end -------- 07:57:07 INFO - PROCESS | 6439 | 07:57:08 INFO - TEST-INFO | 6439: exit 0 07:57:08 INFO - TEST-OK | dromaeo_css | took 1110154ms 07:57:08 INFO - TEST-START | kraken 07:57:08 INFO - operating with platform_type : linux_ 07:57:08 INFO - Initialising browser for kraken test... 07:57:08 INFO - TEST-INFO | started process 6684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuypNt1/profile http://localhost:36848/getInfo.html) 07:57:11 INFO - PROCESS | 6684 | 07:57:11 INFO - PROCESS | 6684 | (process:6763): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:57:12 INFO - PROCESS | 6684 | __metrics Screen width/height:1600/1200 07:57:12 INFO - PROCESS | 6684 | colorDepth:24 07:57:12 INFO - PROCESS | 6684 | Browser inner width/height: 1024/697 07:57:12 INFO - PROCESS | 6684 | __metrics 07:57:13 ERROR - PROCESS | 6684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 07:57:14 INFO - TEST-INFO | 6684: exit 0 07:57:14 INFO - Browser initialized. 07:57:14 INFO - Running cycle 1/1 for kraken test... 07:57:14 INFO - TEST-INFO | started process 6814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuypNt1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:16 INFO - PROCESS | 6814 | 07:57:16 INFO - PROCESS | 6814 | (process:6883): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:57:26 INFO - PROCESS | 6814 | RSS: Main: 151482368 07:57:26 INFO - PROCESS | 6814 | 07:57:28 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36848/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:29 INFO - PROCESS | 6814 | RSS: Main: 155881472 07:57:29 INFO - PROCESS | 6814 | 07:57:32 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36848/tests/kraken/driver.html?testName=audio-dft) 07:57:32 INFO - PROCESS | 6814 | RSS: Main: 156356608 07:57:32 INFO - PROCESS | 6814 | 07:57:35 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36848/tests/kraken/driver.html?testName=audio-fft) 07:57:36 INFO - PROCESS | 6814 | RSS: Main: 156704768 07:57:36 INFO - PROCESS | 6814 | 07:57:38 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36848/tests/kraken/driver.html?testName=audio-oscillator) 07:57:38 INFO - PROCESS | 6814 | RSS: Main: 156512256 07:57:38 INFO - PROCESS | 6814 | 07:57:41 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36848/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:41 INFO - PROCESS | 6814 | RSS: Main: 156835840 07:57:41 INFO - PROCESS | 6814 | 07:57:44 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36848/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:45 INFO - PROCESS | 6814 | RSS: Main: 157032448 07:57:45 INFO - PROCESS | 6814 | 07:57:48 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36848/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:49 INFO - PROCESS | 6814 | RSS: Main: 157417472 07:57:49 INFO - PROCESS | 6814 | 07:57:52 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36848/tests/kraken/driver.html?testName=json-parse-financial) 07:57:52 INFO - PROCESS | 6814 | RSS: Main: 157323264 07:57:52 INFO - PROCESS | 6814 | 07:57:54 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36848/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:54 INFO - PROCESS | 6814 | RSS: Main: 157167616 07:57:54 INFO - PROCESS | 6814 | 07:57:56 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36848/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:57 INFO - PROCESS | 6814 | RSS: Main: 156766208 07:57:57 INFO - PROCESS | 6814 | 07:57:59 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36848/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:59 INFO - PROCESS | 6814 | RSS: Main: 157216768 07:57:59 INFO - PROCESS | 6814 | 07:58:02 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:02 INFO - PROCESS | 6814 | RSS: Main: 157937664 07:58:02 INFO - PROCESS | 6814 | 07:58:05 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:05 INFO - PROCESS | 6814 | RSS: Main: 157323264 07:58:05 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:36848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36848/tests/kraken/driver.html?testName=ai-astar) 07:58:07 INFO - PROCESS | 6814 | RSS: Main: 159248384 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | __start_tp_report 07:58:07 INFO - PROCESS | 6814 | _x_x_mozilla_page_load 07:58:07 INFO - PROCESS | 6814 | _x_x_mozilla_page_load_details 07:58:07 INFO - PROCESS | 6814 | |i|pagename|runs| 07:58:07 INFO - PROCESS | 6814 | |0;ai-astar;113;104;111;111;113;123;111;111;112;111 07:58:07 INFO - PROCESS | 6814 | |1;audio-beat-detection;159;126;162;168;137;164;160;134;172;128 07:58:07 INFO - PROCESS | 6814 | |2;audio-dft;163;164;162;165;162;163;162;164;166;162 07:58:07 INFO - PROCESS | 6814 | |3;audio-fft;74;75;76;159;74;76;74;76;159;75 07:58:07 INFO - PROCESS | 6814 | |4;audio-oscillator;92;92;136;100;93;94;141;93;93;138 07:58:07 INFO - PROCESS | 6814 | |5;imaging-gaussian-blur;117;119;119;117;118;117;117;118;117;118 07:58:07 INFO - PROCESS | 6814 | |6;imaging-darkroom;146;147;146;147;147;147;148;147;147;146 07:58:07 INFO - PROCESS | 6814 | |7;imaging-desaturate;96;97;97;96;97;96;96;95;96;97 07:58:07 INFO - PROCESS | 6814 | |8;json-parse-financial;59;58;57;58;58;65;58;64;56;55 07:58:07 INFO - PROCESS | 6814 | |9;json-stringify-tinderbox;68;67;65;65;66;71;66;66;65;65 07:58:07 INFO - PROCESS | 6814 | |10;stanford-crypto-aes;81;81;81;81;80;79;80;81;82;79 07:58:07 INFO - PROCESS | 6814 | |11;stanford-crypto-ccm;125;125;114;124;117;115;119;114;116;121 07:58:07 INFO - PROCESS | 6814 | |12;stanford-crypto-pbkdf2;139;153;138;151;147;135;153;148;150;136 07:58:07 INFO - PROCESS | 6814 | |13;stanford-crypto-sha256-iterative;68;67;67;67;70;67;69;67;71;67 07:58:07 INFO - PROCESS | 6814 | __end_tp_report 07:58:07 INFO - PROCESS | 6814 | __start_cc_report 07:58:07 INFO - PROCESS | 6814 | _x_x_mozilla_cycle_collect,838 07:58:07 INFO - PROCESS | 6814 | __end_cc_report 07:58:07 INFO - PROCESS | 6814 | __startTimestamp1461423487909__endTimestamp 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | ------- Summary: start ------- 07:58:07 INFO - PROCESS | 6814 | Number of tests: 14 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#0] ai-astar Cycles:10 Average:112.00 Median:111.50 stddev:4.62 (4.1%) stddev-sans-first:4.88 07:58:07 INFO - PROCESS | 6814 | Values: 113.0 104.0 111.0 111.0 113.0 123.0 111.0 111.0 112.0 111.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:161.00 stddev:17.65 (11.0%) stddev-sans-first:18.48 07:58:07 INFO - PROCESS | 6814 | Values: 159.0 126.0 162.0 168.0 137.0 164.0 160.0 134.0 172.0 128.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:1.42 (0.9%) stddev-sans-first:1.50 07:58:07 INFO - PROCESS | 6814 | Values: 163.0 164.0 162.0 165.0 162.0 163.0 162.0 164.0 166.0 162.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#3] audio-fft Cycles:10 Average:91.80 Median:75.00 stddev:35.43 (47.2%) stddev-sans-first:36.99 07:58:07 INFO - PROCESS | 6814 | Values: 74.0 75.0 76.0 159.0 74.0 76.0 74.0 76.0 159.0 75.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:92.50 stddev:21.64 (23.4%) stddev-sans-first:22.24 07:58:07 INFO - PROCESS | 6814 | Values: 92.0 92.0 136.0 100.0 93.0 94.0 141.0 93.0 93.0 138.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 07:58:07 INFO - PROCESS | 6814 | Values: 117.0 119.0 119.0 117.0 118.0 117.0 117.0 118.0 117.0 118.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 07:58:07 INFO - PROCESS | 6814 | Values: 146.0 147.0 146.0 147.0 147.0 147.0 148.0 147.0 147.0 146.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 07:58:07 INFO - PROCESS | 6814 | Values: 96.0 97.0 97.0 96.0 97.0 96.0 96.0 95.0 96.0 97.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.00 stddev:3.22 (5.6%) stddev-sans-first:3.42 07:58:07 INFO - PROCESS | 6814 | Values: 59.0 58.0 57.0 58.0 58.0 65.0 58.0 64.0 56.0 55.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:1.90 (2.9%) stddev-sans-first:1.92 07:58:07 INFO - PROCESS | 6814 | Values: 68.0 67.0 65.0 65.0 66.0 71.0 66.0 66.0 65.0 65.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 07:58:07 INFO - PROCESS | 6814 | Values: 81.0 81.0 81.0 81.0 80.0 79.0 80.0 81.0 82.0 79.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:120.00 stddev:4.47 (3.7%) stddev-sans-first:4.18 07:58:07 INFO - PROCESS | 6814 | Values: 125.0 125.0 114.0 124.0 117.0 115.0 119.0 114.0 116.0 121.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:149.00 stddev:7.21 (4.8%) stddev-sans-first:7.31 07:58:07 INFO - PROCESS | 6814 | Values: 139.0 153.0 138.0 151.0 147.0 135.0 153.0 148.0 150.0 136.0 07:58:07 INFO - PROCESS | 6814 | 07:58:07 INFO - PROCESS | 6814 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:67.50 stddev:1.49 (2.2%) stddev-sans-first:1.58 07:58:07 INFO - PROCESS | 6814 | Values: 68.0 67.0 67.0 67.0 70.0 67.0 69.0 67.0 71.0 67.0 07:58:07 INFO - PROCESS | 6814 | -------- Summary: end -------- 07:58:07 INFO - PROCESS | 6814 | 07:58:08 INFO - TEST-INFO | 6814: exit 0 07:58:08 INFO - TEST-OK | kraken | took 60779ms 07:58:08 INFO - SUITE-END | took 1170s 07:58:09 INFO - Completed test suite (00:19:31) 07:58:09 INFO - javascript benchmark 07:58:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3327.8502467388967, 3363.4114030044734, 3369.1408690783846, 3387.0008347537473, 3416.060583339581, 5477.315335583052, 5478.178273259013, 5481.534069604083, 5493.0, 5516.558675305981, 5463.754131064102, 5476.7535460904255, 5501.339839219289, 5511.641743286694, 5523.530499907512, 5015.19756838905, 5043.949560504385, 5087.135187018216, 5128.8461346159675, 5142.434332223453, 5018.673786203904, 5087.56755675768, 5122.564582010534, 5139.768710408022, 5192.792288308463, 5117.488251174871, 5178.326817513718, 5183.585313174937, 5205.739713014353, 5235.973820130894, 5138.792383789806, 5148.794048238066, 5159.484051594811, 5173.741312934357, 5222.660527065728, 4879.316895634614, 5083.237514372837, 5094.337736094321, 5140.357455318085, 5165.974170129163, 5358.169483729989, 5395.325584301962, 5408.4591540845995, 5408.621396502246, 5409.486098820606, 5933.406659334032, 5949.613275137102, 5956.37458066901, 5963.075723262901, 5989.730462129215, 5864.70676466175, 5988.940110598882, 6022.939770602282, 6024.156618073429, 6037.245344331958, 5578.191162281487, 5657.773689052392, 5673.063944449161, 5676.68778217202, 5702.201691763156, 6106.358832322631, 6112.083187521907, 6116.449519543263, 6121.0, 6133.570650054543, 5765.4811067004175, 5846.736896839652, 5856.560757943172, 5905.970470147622, 5964.642121472725, 6010.819675409744, 6031.366706495843, 6035.879282414415, 6040.184575082308, 6070.908936365958, 5928.318243401977, 5954.434328738763, 5959.523238140939, 5978.8206353809455, 5990.490808281258, 5851.444112809277, 5890.087036509348, 5968.552358573038, 5979.282486101695, 5982.551308651869, 4475.351074094303, 4514.435695538058, 4524.23088075028, 4535.002299494106, 4544.954550454519, 4069.1251380953236, 4088.3867419887256, 4091.284025295561, 4094.0992981544014, 4112.609302116294, 5550.639208451437, 5619.4099619540175, 5691.402402747734, 5710.543156547549, 5714.428557144252, 6042.486388656926, 6095.05526643371, 6099.451049405575, 6125.295591007002, 6129.877402452015, 5578.888422231533, 5582.413846546055, 5599.636023658449, 5649.983003059407, 5652.830415087554, 4969.850904472872, 5062.848114556569, 5109.105906466353, 5171.844844654666, 5211.1662134059125, 6021.494626343414, 6046.546509011841, 6065.969670151621, 6074.3925607438905, 6091.299500557493, 5932.851678708067, 5937.821865344046, 5941.970290148522, 5951.315598706205, 5957.136215248678, 5891.1752354671235, 6117.938820611737, 6122.825106970096, 6123.7550497981365, 6170.382961703794, 5826.970865145647, 5829.59192856496, 5850.473457388855, 5855.765769369177, 5905.084711869667, 5931.792387266425, 5974.701264936823, 5975.731092100953, 5976.043832986875, 5979.760809567569, 5845.590808643524, 5905.852353691021, 5910.52715782745, 5922.348541660328, 5945.702714864326, 5768.538516918553, 5793.131030345482, 5797.043487824461, 5819.76720931158, 5820.243368362086, 5620.887582248414, 5662.915056274242, 5679.77280908759, 5680.346760122638, 5684.090545512699, 5891.381404952418, 5900.468957793819, 5915.733791979457, 5957.702114894151, 5968.582199246185, 5787.652740835563, 5817.9127313091185, 5826.329972053099, 5831.0, 5832.387599302182], "unit": "score", "name": "dojo.html", "value": 5506.53048318075}, {"lowerIsBetter": false, "replicates": [526.1502673182811, 551.9089350257206, 576.6280748916948, 592.3454582686134, 608.9847753806155, 37609.81195094024, 37856.0, 37859.810700946524, 37932.431013534784, 38081.809590952005, 40884.0, 41678.791606042, 41682.0, 41740.16519669605, 41805.37291940623, 8735.563221838898, 8887.111288871125, 8924.0, 8942.329325300596, 8944.955275223614, 8754.430961987482, 8817.250533704611, 8847.380683352168, 8850.468971861708, 8865.556722163898, 9035.096490350945, 9093.454392736458, 9115.908840911572, 9122.08779122089, 9127.95436022819, 9065.0, 9087.818243635156, 9127.817443651124, 9127.863082053775, 9135.862962055608, 9108.726738197865, 9223.123803238681, 9245.815083698288, 9253.444793312423, 9274.48990305533, 42016.1596768066, 42078.57921420777, 42563.7871810642, 42575.7871210645, 42759.78620106911, 3638.163222458823, 3655.4334078217917, 3833.9616603833883, 4264.850730224458, 4483.730976141442, 31699.0, 31716.0, 31973.0, 32186.839065804754, 32385.676143238503, 3924.6271604197555, 3927.56796752357, 4022.4971878515184, 4054.837806487737, 4081.122558649875, 279983.0, 280277.0, 280303.0, 280547.0, 281094.0, 45265.54734452679, 46074.30888536674, 61462.69268653718, 62012.68993655003, 62120.0, 43696.12607747891, 43816.78091609522, 43969.560304397186, 44007.0, 44034.77982610131, 16709.91645041767, 16846.0, 16861.0, 16989.23548440323, 16989.40537081196, 13273.137246078973, 13329.200247984958, 13345.266010369523, 13358.666033349244, 13401.664958375924, 15486.690266194613, 15511.0, 15652.921735391477, 15663.0, 15704.921475392779, 6094.329623741385, 6096.695165241809, 6272.968635156795, 6285.465735412449, 6326.620402775849, 1031.6750223679517, 1100.2463312630873, 1173.3018853781987, 1196.7905616517075, 1218.805570540875, 29454.705452945196, 29454.852725736233, 29852.552211716407, 30671.846640766653, 30767.2308192297, 1141.6403832792644, 1143.4454289669504, 1149.0807354116673, 1158.820382840661, 1173.1318824070127, 15257.847421525643, 15413.614659633598, 15424.82095477497, 15754.527364179094, 15832.604184895239, 175949.0, 329454.0, 544944.0, 547668.0, 551879.0, 57044.0, 57631.13553296704, 57818.421815782145, 58358.708206458694, 58400.41599584035, 1481.5703446000539, 1513.7729340598999, 1525.794017807604, 1527.5722797616686, 1537.7385844406253, 28886.566701499072, 29323.70676293295, 29739.0, 29886.103416897527, 30170.396592068475, 50435.74782126066, 50818.491815081376, 51064.74467627638, 51231.74384128056, 51254.487455124974, 308229.0, 312234.0, 312524.0, 313177.0, 315171.0, 34699.13252168615, 34710.65289347074, 35353.0, 35450.29099417946, 35565.82217088898, 46287.305690413996, 46925.0, 47091.529084710084, 47242.74930472839, 47560.2865957004, 38471.0, 38867.80566097265, 39672.60327396689, 39672.60327396689, 40059.39910901397, 38502.0, 38672.613273868024, 38688.41967370548, 41645.0, 42168.0, 36058.63941360658, 36783.44824827683, 36953.260934780614, 37102.25795484129, 37105.25789484249, 31122.533162002135, 31482.37035259328, 31784.205394865312, 32809.671903280665, 34767.0, 26299.605505917043, 27236.0, 27412.58881116745, 27425.58861617117, 27621.64188429339], "unit": "score", "name": "ext.html", "value": 19207.7996352277}, {"lowerIsBetter": false, "replicates": [373.42306137018306, 394.64284822235885, 394.84798352634226, 395.97030222733287, 406.1774905815721, 17294.481165565023, 19654.705179422286, 20080.799192008075, 20200.59598808023, 20203.191872325107, 18246.63506729868, 18606.34877779278, 18689.0, 19003.714944275845, 19026.524336891584, 5393.514583687467, 5650.0, 5650.5479561634975, 5660.2075709400715, 5666.490015898568, 4161.3549899765585, 5789.768409263625, 6027.156198132265, 6029.849253768647, 6045.697715114248, 5816.4474374934525, 5936.050231962887, 5969.850753731148, 5980.671063091529, 5983.940160598404, 5915.112733090028, 5923.466887980103, 5938.554608404365, 5953.761849526057, 5961.284645842505, 5197.714125723083, 5218.03466358721, 5258.8159414420315, 5262.0, 5283.365996080495, 22155.556888862295, 22412.775872241233, 22465.32604021882, 22593.77406225933, 22678.433039174153, 2401.615741481372, 2410.3130607776698, 2438.9634155487684, 2557.961630575543, 2935.882564697431, 13593.456261749518, 13991.720165596733, 14172.645683857883, 14260.85739142616, 14322.95538572855, 1789.329001624391, 1790.8656850736118, 1819.1631849349183, 1915.817997290255, 1977.1103003648273, 63570.0, 65082.0, 65430.0, 65699.0, 66522.0, 10094.242931780145, 10455.320404173704, 10486.265961382782, 10548.41983690889, 10593.52329145175, 14594.781078283835, 14640.633984150481, 14759.966802323948, 14820.0, 14822.184779836996, 7732.6906923723545, 8005.119436861941, 8011.399145064027, 8166.959165204136, 8414.0, 8137.715179968673, 8158.306543943712, 8164.959175204086, 8196.34429245659, 8204.056533498604, 4730.810767569259, 4778.235482322882, 4790.952090479051, 4842.927356089662, 4891.559759621651, 1891.4514790710814, 1983.2562788954142, 2022.6157030164222, 2065.607534568427, 2094.078605413644, 930.7300882744064, 994.557421947241, 1030.1861529391847, 1055.2929537210089, 1057.6985559115615, 15862.841371586368, 17359.913200433915, 17426.827078470134, 17639.73540396895, 18095.72856407155, 1020.5407566595062, 1035.1304903880775, 1045.487711021594, 1096.2435919215716, 1098.5386137822134, 9991.450470224063, 10412.0, 10448.487013824788, 10449.0, 10528.947355263175, 450978.0, 460638.0, 460917.0, 465443.0, 466926.0, 79441.20558794454, 80599.59700201578, 81745.0, 83016.58491707503, 83655.0, 1059.2003037706636, 1074.6346242277664, 1074.8602681651334, 1081.0378762901025, 1085.1102096280974, 15930.442434514736, 15931.601709957344, 16209.432669856498, 16341.264643090852, 16413.0, 35457.0, 35788.28423431569, 35837.46243806397, 36609.26781464409, 36972.63027369799, 50358.49641503538, 50704.74647626886, 50790.0, 51000.0, 51425.0, 8099.5545245009735, 8153.836923261383, 8247.422680412314, 8352.0, 8464.407491475538, 9471.573779180091, 11751.177417580688, 11841.0, 11851.881481185077, 12163.209391389531, 10675.09261712732, 10716.464176790972, 10722.463876806285, 10724.302920310154, 10856.674299771019, 10563.524641391003, 10706.250562460864, 10754.40850753216, 10822.51298691545, 10992.780144396907, 10226.795464090528, 10844.566217351217, 10926.562937482411, 11091.5563377464, 11289.491972861077, 8141.348692104499, 8182.468139571147, 8269.95865020671, 8297.460665056751, 8372.455790373606, 8738.69414570487, 10851.077658398808, 11100.61147859821, 11120.499577519193, 11142.721431964266], "unit": "score", "name": "jquery.html", "value": 8960.417607087147}, {"lowerIsBetter": false, "replicates": [1555.9144247066413, 1568.3412966554047, 1797.7662903822502, 1918.5203699075232, 1976.0317444452223, 7292.343689067983, 7949.205079492048, 7962.4028197885245, 8078.757637270884, 8092.676292948275, 8230.2592766651, 8365.163483651631, 8443.324534037278, 8456.408051436401, 8470.661173553066, 2372.881355932205, 2379.1672914479923, 2393.808495320379, 2395.6047252203366, 2411.05968672218, 2353.8587684738886, 2385.7733515316104, 2391.0674836813655, 2396.101461951768, 2410.529946660402, 2392.258399896029, 2392.497575509145, 2401.639754036891, 2433.4403087289934, 2446.2049833803994, 2397.496525729599, 2405.7473965233576, 2406.6750988616486, 2408.843425177358, 2450.5588993981078, 2354.7527509611587, 2372.7627237276306, 2379.3694670912223, 2383.2731017039796, 2386.749391313904, 8365.58172091393, 8376.958115209385, 8395.664173433055, 8412.537310447922, 8461.66153353865, 5027.622928280393, 5151.6136289778415, 5183.403908550527, 5183.922241166386, 5185.2999845021195, 3168.1287645897332, 3184.4427225235722, 3238.951415728766, 3248.9350212995846, 3266.4447044002577, 973.2262851033374, 983.4345251480356, 1005.3063386263455, 1015.1523477895965, 1035.4667346316653, 11287.548498060069, 11306.208565400426, 11347.26242794224, 11348.375839328834, 11362.034227090624, 4356.172327257811, 4423.756693381831, 4522.932156017662, 4531.8413855515555, 4581.862544123682, 9696.127348538665, 9721.076497732704, 9808.36245644045, 9834.60661573529, 9881.802363952824, 5147.176451767699, 5169.172932330809, 5184.196449550326, 5194.8961020780125, 5201.29782479368, 4061.3501839706096, 4531.43357080365, 4549.431321084864, 4600.723956562617, 4644.9767751161025, 3791.3933770596573, 3804.1821008483307, 3818.0, 3867.45855580219, 3879.84480620772, 1250.424804589899, 1251.5056552661829, 1254.172246317426, 1257.4718618180202, 1269.930153841529, 1426.0231741257064, 1440.0927415728024, 1455.8180227471566, 1476.7932489451484, 1501.797257370263, 7892.210778922062, 7952.681892724342, 7977.760667179994, 7990.9200907991335, 7995.200479952075, 516.9896602068013, 527.3276572370258, 535.8874636326415, 538.1658429434361, 547.3623228938243, 5905.940940590625, 5928.555358348141, 5946.524278057745, 5957.672328022, 6039.637621742621, 9681.128698417177, 10114.443705596115, 10143.340682855738, 10243.129334006693, 10265.589376425009, 9733.513324333755, 9902.306838521234, 10044.949775251076, 10081.344712593658, 10115.342502737298, 7863.095743989515, 7885.0, 7908.209179082046, 7921.049474063034, 7923.801904952307, 7378.926210737824, 7414.369778568666, 7419.591922444318, 7430.7399241026305, 7643.464957452925, 8814.823703526023, 8853.203211710977, 8908.0, 9023.77440563965, 9032.36773425854, 9073.228775553887, 9095.863562046443, 9112.589933453142, 9129.269658427444, 9348.392354496937, 6572.901406478811, 6980.301969802979, 7145.214026456982, 7445.181030086578, 7517.097948246027, 7683.692652294069, 7684.6157692116285, 7691.50005249657, 7716.729914453192, 7721.884171737316, 6922.723091076301, 7030.894536581853, 7034.648267586703, 7053.823654408681, 7202.2797720229655, 7090.822729431806, 7118.60847653384, 7152.928470715435, 7183.425325974014, 7209.747658831916, 7231.385332246818, 7315.195328513752, 7442.404607631484, 7462.701491940262, 7510.474266801271, 6692.263850976291, 6704.966475167788, 6717.2946840581035, 6721.1598550181225, 6748.920172772333, 6941.201761797458, 6995.965020174866, 7041.788746337618, 7042.436605071684, 7052.400545953446], "unit": "score", "name": "mootools.html", "value": 4668.835497426898}, {"lowerIsBetter": false, "replicates": [364.2223852075818, 370.8090333478259, 370.96290370962896, 374.33555439095585, 380.735388904711, 6351.079093531435, 6372.872542549152, 6375.521835862317, 6396.360363963601, 6447.742090316394, 6273.623582585048, 6294.6223226606435, 6312.779052733155, 6314.621122732628, 6339.302676705559, 4729.78715957781, 4810.807567697288, 4859.951400486003, 4862.586680132193, 4939.851804445863, 4852.927206091894, 4870.196417591093, 4873.34209881665, 4876.390451193601, 4892.9510704892855, 4762.857114286577, 4791.904161916759, 4810.7835147418455, 4811.08589368019, 4821.252705830602, 4834.4923783002805, 4838.201696720037, 4844.12805694973, 4846.9515304846855, 4850.296706977504, 4197.433346498215, 4199.118185181115, 4202.579742025803, 4205.97897010516, 4217.198732240895, 5922.496587790043, 6032.66820324882, 6043.335233124353, 6067.696615169224, 6069.332373438918, 5598.916016259759, 5600.719964001824, 5602.299712535933, 5602.7758889644365, 5609.775608975636, 6677.465802735769, 6692.966535167342, 6695.564788288794, 6696.096027036385, 6725.327467253284, 4588.655850811169, 4597.931031034537, 4601.930971035437, 4603.539646035403, 4616.953830461686, 6966.477514186457, 7048.788536343918, 7058.929410705879, 7074.717011319541, 7075.363217310415, 4717.787699553528, 4840.080384726891, 4843.346148270009, 4846.854594362175, 4853.514648535118, 4858.65989380747, 4878.536539028786, 4889.2910527973245, 4891.902161956812, 4903.264510323409, 5628.2683251177905, 5646.774129034875, 5651.717414129277, 5653.349864765604, 5668.716564171775, 6719.731210751613, 6747.527673062937, 6748.898766518506, 6763.391294783395, 6778.186617605918, 1726.5683579105223, 1750.7899052113828, 1753.438899552131, 1756.1745979389666, 1758.085795386392, 1102.074257623584, 1129.3336931210624, 1135.0408904475705, 1145.8052131137727, 1148.2823235477827, 6493.22081350241, 6522.934770652233, 6531.020346947996, 6545.050967609765, 6548.083268342436, 6927.7228910844005, 6984.126984126984, 7025.754098606524, 7026.578405295699, 7040.894386584206, 6470.676466176672, 6507.3167317431935, 6580.86838263232, 6608.900866487006, 6627.701753421107, 3832.5784163741964, 3854.325493038763, 3862.671672907778, 3864.130570621644, 3869.090763670535, 7246.384057355184, 7251.782446526613, 7254.854902901912, 7296.562206267535, 7296.598687072262, 7190.676419561132, 7197.856042879113, 7199.640017999184, 7203.783886483414, 7224.096987876515, 7096.680649370791, 7286.96356518214, 7317.963410182915, 7322.231165727629, 7328.780136595804, 7023.964880175567, 7084.0, 7104.857902842017, 7106.253843346581, 7143.4999550031, 6911.101556797584, 6933.37599616037, 6945.0971373721095, 6948.652567371712, 6968.303169683194, 7252.129744430491, 7272.272772722686, 7273.745418910313, 7287.854242915006, 7304.123505179413, 4686.554777296152, 4757.143714131351, 4847.394075740533, 4851.490593487774, 4873.6832105913, 7014.684339204646, 7036.261192574706, 7041.119860017498, 7063.540869843444, 7072.080629518336, 6810.795676129724, 6813.3527314905, 6824.2152152503095, 6830.975353696986, 6835.7949261522235, 6801.965990170215, 6837.487188460786, 6846.418054465227, 6856.828579285558, 6860.348266914635, 6518.641474718936, 6686.06395104676, 6732.663366831541, 6753.358430949052, 6753.662316884234, 6936.572199730256, 6957.652117394009, 6987.196472405739, 6989.231184569795, 7002.124734408199, 6723.092382528296, 6736.898946515904, 6740.595564266159, 6744.7976560703255, 6753.3246675332075], "unit": "score", "name": "prototype.html", "value": 5125.010974209167}, {"lowerIsBetter": false, "replicates": [786.5123623353521, 906.8141031088624, 915.9313051521129, 922.1930810540777, 942.7077605942159, 14900.478483253088, 14982.475613353536, 15175.317110730017, 15299.541013769576, 15315.770263446044, 12661.683457913558, 14242.786358204608, 14299.642508937255, 14312.21282829444, 14337.0, 909.1908201700492, 931.0317270039151, 931.1526510875105, 935.6865450074199, 942.7171848445473, 927.9628814847398, 928.0394791390912, 933.6545478173085, 934.6448349627132, 936.2790651198573, 978.6721448314823, 989.915857152143, 991.8710567626199, 992.0674565908059, 994.5275993902875, 967.2358836519142, 973.4013581647272, 974.2206235011962, 976.4775844922932, 982.341830973246, 715.1132595581441, 722.4220623501178, 724.8550289942033, 725.0429433148247, 726.7274771960515, 14264.0, 14286.714265714627, 14319.355628996616, 14368.568942931728, 14425.495107671286, 14649.12105273687, 14702.4854130106, 14747.0, 14818.925905370405, 14824.407023719039, 10753.892461075367, 10780.46097695112, 10824.67525974222, 10876.945615271952, 10890.945545272301, 3840.558335791364, 3895.590962948878, 3907.609239076098, 3916.0, 3956.6439020488006, 50639.24041139386, 51415.48584514144, 51423.0, 51572.74213628908, 51650.2252466217, 11480.59817906386, 11559.595414160463, 11772.234804737836, 12091.0, 12210.75578488443, 20889.37331880046, 20979.790202097785, 21002.894985524974, 21023.26418575373, 21275.829829359223, 7759.090341122079, 7862.803429914184, 7884.960575197088, 8106.108328083906, 8243.95878020618, 4391.385206071152, 4392.978035109868, 4430.734155950653, 4455.6658250631335, 4535.387722657399, 3468.7745296555645, 3478.617352091268, 3482.9477557836653, 3507.105688049531, 3509.0350153707936, 601.5368166511848, 602.5631417222567, 606.8167074205318, 612.6354818882758, 626.4393367935763, 577.9739911703983, 628.5788521690479, 679.3546131175403, 697.2469732688684, 715.345458905096, 8713.956430217808, 8790.340724445565, 8906.0, 9048.819023619622, 9231.630734770533, 524.318386098071, 606.6845240474928, 633.1831936801567, 641.7144370754969, 642.4667525953447, 4060.6954478414236, 4094.0992981544014, 4095.3037983542868, 4165.437665915123, 4203.957960420356, 57679.423205768246, 58195.127073093936, 59563.0, 59970.0, 60244.0, 50646.74676626667, 50750.0, 50960.0, 52348.73825630924, 52545.211821822704, 47637.28544071842, 47787.28319075217, 48245.27632085521, 48538.27192592184, 48708.0, 9053.275737940818, 9089.136532029446, 9142.268618510636, 9232.676856309998, 9327.020662830577, 36632.633673663986, 36635.63364366322, 37162.62837371592, 37511.0, 38077.61922380851, 43716.56283437125, 46814.0, 46931.76534117308, 47440.0, 47880.76059619679, 11452.599159029394, 11494.827577586175, 11545.711357216136, 11645.59240426581, 11789.233699809485, 12177.208481448677, 12285.1400401971, 12824.166429182073, 12869.485220591072, 12881.162724422882, 11409.942950285196, 11507.0, 11606.071514278668, 11886.0, 11983.28100313984, 11311.490982905625, 11971.580994665144, 12100.092493062879, 12160.452779625115, 12581.559645412366, 11706.88293117058, 12034.398280086136, 12052.819207711716, 12070.215435996632, 12091.697707557381, 9770.31607787448, 9972.950135249277, 10037.146842518468, 10059.09468147841, 10188.541515631667, 9779.462129582942, 10163.0, 10229.897701022894, 10254.846177307496, 10361.4301213434], "unit": "score", "name": "yui.html", "value": 6783.365649456794}], "name": "dromaeo_css", "value": 7320.004976820083}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 104.0, 111.0, 111.0, 113.0, 123.0, 111.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [159.0, 126.0, 162.0, 168.0, 137.0, 164.0, 160.0, 134.0, 172.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 162.0, 165.0, 162.0, 163.0, 162.0, 164.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 76.0, 159.0, 74.0, 76.0, 74.0, 76.0, 159.0, 75.0], "unit": "score", "name": "audio-fft", "value": 91.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 136.0, 100.0, 93.0, 94.0, 141.0, 93.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [117.0, 119.0, 119.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 57.0, 58.0, 58.0, 65.0, 58.0, 64.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 65.0, 65.0, 66.0, 71.0, 66.0, 66.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 81.0, 80.0, 79.0, 80.0, 81.0, 82.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.5}, {"lowerIsBetter": true, "replicates": [125.0, 125.0, 114.0, 124.0, 117.0, 115.0, 119.0, 114.0, 116.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [139.0, 153.0, 138.0, 151.0, 147.0, 135.0, 153.0, 148.0, 150.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 70.0, 67.0, 69.0, 67.0, 71.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1523.8000000000002}]} 07:58:09 INFO - Return code: 0 07:58:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:58:09 ERROR - # TBPL SUCCESS # 07:58:09 INFO - Running post-action listener: _resource_record_post_action 07:58:09 INFO - Running post-run listener: _resource_record_post_run 07:58:10 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 496685056; Read time: 0; Write time: 531216 07:58:10 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 235638784; Read time: 0; Write time: 322612 07:58:10 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 251478016; Read time: 0; Write time: 207308 07:58:10 INFO - Running post-run listener: _upload_blobber_files 07:58:10 INFO - Blob upload gear active. 07:58:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:10 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 07:58:10 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'] 07:58:10 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 07:58:10 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:58:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:58:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:11 INFO - (blobuploader) - INFO - Done attempting. 07:58:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:58:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:58:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:12 INFO - (blobuploader) - INFO - Done attempting. 07:58:12 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:12 INFO - Return code: 0 07:58:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9195db35a480b5d8ad2f71b9e889aa8a9fa05ec3272db33b19e9eb544ea3502e78c993c18b3577d80275231cf1a173196b32525492e1f9d655acef2d463894d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/980ab91bdbc1ede77f33443d612a5036034b4e0ee7286806708f2bb589685f2f4993fac747ce4dbc52533bc2aad623bd413854b5ef98be9f1b3d2184efc2e1db"} 07:58:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:12 INFO - Contents: 07:58:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9195db35a480b5d8ad2f71b9e889aa8a9fa05ec3272db33b19e9eb544ea3502e78c993c18b3577d80275231cf1a173196b32525492e1f9d655acef2d463894d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/980ab91bdbc1ede77f33443d612a5036034b4e0ee7286806708f2bb589685f2f4993fac747ce4dbc52533bc2aad623bd413854b5ef98be9f1b3d2184efc2e1db"} 07:58:12 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:12 INFO - Copying logs to upload dir... 07:58:12 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.483604 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-23 07:58:10.809494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 07:58:10.813095) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006 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/9195db35a480b5d8ad2f71b9e889aa8a9fa05ec3272db33b19e9eb544ea3502e78c993c18b3577d80275231cf1a173196b32525492e1f9d655acef2d463894d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/980ab91bdbc1ede77f33443d612a5036034b4e0ee7286806708f2bb589685f2f4993fac747ce4dbc52533bc2aad623bd413854b5ef98be9f1b3d2184efc2e1db"} build_url:https://queue.taskcluster.net/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/ayEDP08iQPuyU_76YxBWzA/artifacts/public/build/firefox-47.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/9195db35a480b5d8ad2f71b9e889aa8a9fa05ec3272db33b19e9eb544ea3502e78c993c18b3577d80275231cf1a173196b32525492e1f9d655acef2d463894d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/980ab91bdbc1ede77f33443d612a5036034b4e0ee7286806708f2bb589685f2f4993fac747ce4dbc52533bc2aad623bd413854b5ef98be9f1b3d2184efc2e1db"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 07:58:10.837450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:58:10.837780) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461421716.920896-1940362006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:58:10.922230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 07:58:10.922513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 07:58:10.922809) ========= ========= Total master_lag: 0.16 =========