builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1461949713.03 results: success (0) buildid: 20160429092239 builduid: 6da8d858777c444882a4eb8b3b8a26d8 revision: 70443ad6bcc6c58f5e76ed71bf3f2bd075d17be8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:33.033313) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:33.033865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:33.034140) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:33.061237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:33.061486) ========= 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=6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 10:08:33-- 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% 21.9M=0.001s 2016-04-29 10:08:33 (21.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120728 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:33.195125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:33.195398) ========= 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=6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016003 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:33.244021) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:33.244320) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 70443ad6bcc6c58f5e76ed71bf3f2bd075d17be8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 70443ad6bcc6c58f5e76ed71bf3f2bd075d17be8 --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=6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 10:08:33,584 truncating revision to first 12 chars 2016-04-29 10:08:33,584 Setting DEBUG logging. 2016-04-29 10:08:33,585 attempt 1/10 2016-04-29 10:08:33,585 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/70443ad6bcc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 10:08:33,839 unpacking tar archive at: fx-team-70443ad6bcc6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756474 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:34.013052) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:34.013337) ========= script_repo_revision: 70443ad6bcc6c58f5e76ed71bf3f2bd075d17be8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:34.013727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:34.014004) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 10:08:34.023104) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-29 10:08:34.023378) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:08:34 INFO - MultiFileLogger online at 20160429 10:08:34 in /builds/slave/test 10:08:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:08:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:08:34 INFO - {'append_to_log': False, 10:08:34 INFO - 'base_work_dir': '/builds/slave/test', 10:08:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:08:34 INFO - 'branch': 'Fx-Team-Non-PGO', 10:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:08:34 INFO - 'config_files': ('talos/linux_config.py',), 10:08:34 INFO - 'default_actions': ('clobber', 10:08:34 INFO - 'read-buildbot-config', 10:08:34 INFO - 'download-and-extract', 10:08:34 INFO - 'populate-webroot', 10:08:34 INFO - 'create-virtualenv', 10:08:34 INFO - 'install', 10:08:34 INFO - 'run-tests'), 10:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:08:34 INFO - 'download_minidump_stackwalk': True, 10:08:34 INFO - 'download_symbols': 'ondemand', 10:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:08:34 INFO - 'installer_path': 'installer.exe', 10:08:34 INFO - 'log_level': 'info', 10:08:34 INFO - 'log_name': 'talos', 10:08:34 INFO - 'log_to_console': True, 10:08:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:08:34 INFO - 'opt_config_files': (), 10:08:34 INFO - 'pip_index': False, 10:08:34 INFO - 'sps_profile': False, 10:08:34 INFO - 'sps_profile_interval': 0, 10:08:34 INFO - 'suite': 'dromaeojs-e10s', 10:08:34 INFO - 'system_bits': '32', 10:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:08:34 INFO - 'title': 'talos-linux64-ix-050', 10:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:08:34 INFO - 'use_talos_json': True, 10:08:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:08:34 INFO - 'work_dir': 'build'} 10:08:34 INFO - ##### 10:08:34 INFO - ##### Running clobber step. 10:08:34 INFO - ##### 10:08:34 INFO - Running pre-action listener: _resource_record_pre_action 10:08:34 INFO - Running main action method: clobber 10:08:34 INFO - rmtree: /builds/slave/test/build 10:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:08:34 INFO - Running post-action listener: _resource_record_post_action 10:08:34 INFO - ##### 10:08:34 INFO - ##### Running read-buildbot-config step. 10:08:34 INFO - ##### 10:08:34 INFO - Running pre-action listener: _resource_record_pre_action 10:08:34 INFO - Running main action method: read_buildbot_config 10:08:34 INFO - Using buildbot properties: 10:08:34 INFO - { 10:08:34 INFO - "project": "", 10:08:34 INFO - "product": "firefox", 10:08:34 INFO - "script_repo_revision": "production", 10:08:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:08:34 INFO - "repository": "", 10:08:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:08:34 INFO - "buildid": "20160429092239", 10:08:34 INFO - "pgo_build": "False", 10:08:34 INFO - "basedir": "/builds/slave/test", 10:08:34 INFO - "buildnumber": 1219, 10:08:34 INFO - "slavename": "talos-linux64-ix-050", 10:08:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:08:34 INFO - "platform": "ubuntu64_hw", 10:08:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:08:34 INFO - "branch": "fx-team", 10:08:34 INFO - "repo_path": "integration/fx-team", 10:08:34 INFO - "revision": "70443ad6bcc6c58f5e76ed71bf3f2bd075d17be8", 10:08:34 INFO - "stage_platform": "linux64", 10:08:34 INFO - "builduid": "6da8d858777c444882a4eb8b3b8a26d8", 10:08:34 INFO - "slavebuilddir": "test" 10:08:34 INFO - } 10:08:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:08:34 INFO - Running post-action listener: _resource_record_post_action 10:08:34 INFO - ##### 10:08:34 INFO - ##### Running download-and-extract step. 10:08:34 INFO - ##### 10:08:34 INFO - Running pre-action listener: _resource_record_pre_action 10:08:34 INFO - Running main action method: download_and_extract 10:08:34 INFO - mkdir: /builds/slave/test/build/tests 10:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:34 INFO - https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:08:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:08:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:08:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:08:41 INFO - Downloaded 1361 bytes. 10:08:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:08:41 INFO - Using the following test package requirements: 10:08:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:08:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:08:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:08:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:41 INFO - u'jsshell-linux-x86_64.zip'], 10:08:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:08:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:08:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:08:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:08:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:08:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:08:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:41 INFO - https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:08:49 INFO - Downloaded 22301146 bytes. 10:08:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:08:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:08:50 INFO - Return code: 0 10:08:50 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:08:50 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')]} 10:08:50 INFO - https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:08:54 INFO - Downloaded 22301146 bytes. 10:08:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:08:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:08:55 INFO - Return code: 0 10:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:55 INFO - https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:08:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:08:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:08:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:08:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:08:56 INFO - Downloaded 10840145 bytes. 10:08:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:08:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:08:56 INFO - Return code: 0 10:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:56 INFO - https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:08:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:08:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:08:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:08:59 INFO - Downloaded 54854156 bytes. 10:08:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:08:59 INFO - mkdir: /builds/slave/test/properties 10:08:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:08:59 INFO - Writing to file /builds/slave/test/properties/build_url 10:08:59 INFO - Contents: 10:08:59 INFO - build_url:https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:08:59 INFO - Running post-action listener: _resource_record_post_action 10:08:59 INFO - Running post-action listener: set_extra_try_arguments 10:08:59 INFO - ##### 10:08:59 INFO - ##### Running populate-webroot step. 10:08:59 INFO - ##### 10:08:59 INFO - Running pre-action listener: _resource_record_pre_action 10:08:59 INFO - Running main action method: populate_webroot 10:08:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:08:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:08:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:08:59 INFO - '--tppagecycles', 10:08:59 INFO - '7'], 10:08:59 INFO - 'tests': ['tsvgm']}}, 10:08:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:08:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:08:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:08:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:08:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:08:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:08:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:59 INFO - 'talos_options': ['--disable-e10s'], 10:08:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:59 INFO - 'talos_options': ['--disable-e10s'], 10:08:59 INFO - 'tests': ['damp', 'tps']}, 10:08:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:59 INFO - 'tests': ['damp', 'tps']}, 10:08:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:08:59 INFO - 'tests': ['dromaeo_dom']}, 10:08:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:08:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:08:59 INFO - 'tests': ['a11yr', 10:08:59 INFO - 'ts_paint', 10:08:59 INFO - 'tpaint', 10:08:59 INFO - 'sessionrestore', 10:08:59 INFO - 'sessionrestore_no_auto_restore', 10:08:59 INFO - 'tabpaint']}, 10:08:59 INFO - 'other-e10s': {'tests': ['a11yr', 10:08:59 INFO - 'ts_paint', 10:08:59 INFO - 'tpaint', 10:08:59 INFO - 'sessionrestore', 10:08:59 INFO - 'sessionrestore_no_auto_restore', 10:08:59 INFO - 'tabpaint']}, 10:08:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:08:59 INFO - 'ts_paint', 10:08:59 INFO - 'tpaint', 10:08:59 INFO - 'sessionrestore', 10:08:59 INFO - 'sessionrestore_no_auto_restore', 10:08:59 INFO - 'tabpaint']}, 10:08:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:08:59 INFO - 'ts_paint', 10:08:59 INFO - 'tpaint', 10:08:59 INFO - 'sessionrestore', 10:08:59 INFO - 'sessionrestore_no_auto_restore', 10:08:59 INFO - 'tabpaint']}, 10:08:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:08:59 INFO - 'tests': ['a11yr', 10:08:59 INFO - 'ts_paint', 10:08:59 INFO - 'tpaint', 10:08:59 INFO - 'sessionrestore', 10:08:59 INFO - 'sessionrestore_no_auto_restore', 10:08:59 INFO - 'tabpaint']}, 10:08:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:08:59 INFO - 'tests': ['a11yr', 10:08:59 INFO - 'ts_paint', 10:08:59 INFO - 'tpaint', 10:08:59 INFO - 'sessionrestore', 10:08:59 INFO - 'sessionrestore_no_auto_restore', 10:08:59 INFO - 'tabpaint']}, 10:08:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:08:59 INFO - 'tests': ['tsvgx', 10:08:59 INFO - 'tsvgr_opacity', 10:08:59 INFO - 'tart', 10:08:59 INFO - 'tscrollx', 10:08:59 INFO - 'cart']}, 10:08:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:08:59 INFO - 'tsvgr_opacity', 10:08:59 INFO - 'tart', 10:08:59 INFO - 'tscrollx', 10:08:59 INFO - 'cart']}, 10:08:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:59 INFO - 'talos_options': ['--disable-e10s'], 10:08:59 INFO - 'tests': ['tp5o']}, 10:08:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:59 INFO - 'tests': ['tp5o']}, 10:08:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:59 INFO - 'talos_options': ['--disable-e10s', 10:08:59 INFO - '--xperf_path', 10:08:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:59 INFO - 'tests': ['tp5n']}, 10:08:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:59 INFO - 'talos_options': ['--xperf_path', 10:08:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:59 INFO - 'tests': ['tp5n']}}, 10:08:59 INFO - 'talos.zip': {'path': '', 10:08:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:08:59 INFO - Running post-action listener: _resource_record_post_action 10:08:59 INFO - ##### 10:08:59 INFO - ##### Running create-virtualenv step. 10:08:59 INFO - ##### 10:08:59 INFO - Running pre-action listener: _resource_record_pre_action 10:08:59 INFO - Running main action method: create_virtualenv 10:08:59 INFO - Creating virtualenv /builds/slave/test/build/venv 10:08:59 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 10:08:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:08:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:08:59 INFO - Using real prefix '/usr' 10:08:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:09:00 INFO - Installing distribute.............................................................................................................................................................................................done. 10:09:02 INFO - Installing pip.................done. 10:09:02 INFO - Return code: 0 10:09:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff253bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b8410>, '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 0x23b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b97a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', '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 10:09: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', 'pip>=1.5'] in /builds/slave/test/build 10:09: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 pip>=1.5 10:09:02 INFO - Using env: {'DISPLAY': ':0', 10:09:02 INFO - 'HOME': '/home/cltbld', 10:09:02 INFO - 'LANG': 'en_US.UTF-8', 10:09:02 INFO - 'LANGUAGE': 'en_US:en', 10:09:02 INFO - 'LOGNAME': 'cltbld', 10:09:02 INFO - 'MAIL': '/var/mail/cltbld', 10:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:02 INFO - 'MOZ_NO_REMOTE': '1', 10:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:02 INFO - 'NO_EM_RESTART': '1', 10:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:02 INFO - 'PWD': '/builds/slave/test', 10:09:02 INFO - 'SHELL': '/bin/bash', 10:09:02 INFO - 'SHLVL': '1', 10:09:02 INFO - 'TERM': 'linux', 10:09:02 INFO - 'TMOUT': '86400', 10:09:02 INFO - 'USER': 'cltbld', 10:09:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', 10:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:02 INFO - '_': '/tools/buildbot/bin/python'} 10:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:02 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 10:09:02 INFO - Cleaning up... 10:09:02 INFO - Return code: 0 10:09:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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', '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 0x7ff253bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b8410>, '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 0x23b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b97a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', '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 10:09: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', 'psutil>=0.7.1'] in /builds/slave/test/build 10:09: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 psutil>=0.7.1 10:09:02 INFO - Using env: {'DISPLAY': ':0', 10:09:02 INFO - 'HOME': '/home/cltbld', 10:09:02 INFO - 'LANG': 'en_US.UTF-8', 10:09:02 INFO - 'LANGUAGE': 'en_US:en', 10:09:02 INFO - 'LOGNAME': 'cltbld', 10:09:02 INFO - 'MAIL': '/var/mail/cltbld', 10:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:02 INFO - 'MOZ_NO_REMOTE': '1', 10:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:02 INFO - 'NO_EM_RESTART': '1', 10:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:02 INFO - 'PWD': '/builds/slave/test', 10:09:02 INFO - 'SHELL': '/bin/bash', 10:09:02 INFO - 'SHLVL': '1', 10:09:02 INFO - 'TERM': 'linux', 10:09:02 INFO - 'TMOUT': '86400', 10:09:02 INFO - 'USER': 'cltbld', 10:09:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', 10:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:02 INFO - '_': '/tools/buildbot/bin/python'} 10:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:02 INFO - Downloading/unpacking psutil>=0.7.1 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:09:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:04 INFO - Installing collected packages: psutil 10:09:04 INFO - Running setup.py install for psutil 10:09:04 INFO - building 'psutil._psutil_linux' extension 10:09:04 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 10:09:05 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 10:09:05 INFO - building 'psutil._psutil_posix' extension 10:09:05 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 10:09:05 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 10:09:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:05 INFO - Successfully installed psutil 10:09:05 INFO - Cleaning up... 10:09:05 INFO - Return code: 0 10:09:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:09:05 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')]} 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:05 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')]} 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:05 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 0x7ff253bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b8410>, '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 0x23b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b97a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', '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 10:09:05 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 10:09:05 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 10:09:05 INFO - Using env: {'DISPLAY': ':0', 10:09:05 INFO - 'HOME': '/home/cltbld', 10:09:05 INFO - 'LANG': 'en_US.UTF-8', 10:09:05 INFO - 'LANGUAGE': 'en_US:en', 10:09:05 INFO - 'LOGNAME': 'cltbld', 10:09:05 INFO - 'MAIL': '/var/mail/cltbld', 10:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:05 INFO - 'MOZ_NO_REMOTE': '1', 10:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:05 INFO - 'NO_EM_RESTART': '1', 10:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:05 INFO - 'PWD': '/builds/slave/test', 10:09:05 INFO - 'SHELL': '/bin/bash', 10:09:05 INFO - 'SHLVL': '1', 10:09:05 INFO - 'TERM': 'linux', 10:09:05 INFO - 'TMOUT': '86400', 10:09:05 INFO - 'USER': 'cltbld', 10:09:05 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', 10:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:05 INFO - '_': '/tools/buildbot/bin/python'} 10:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:09:05 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 10:09:05 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 10:09:05 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 10:09:05 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 10:09:05 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 10:09:05 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 10:09:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:09:07 INFO - Installing collected packages: mozsystemmonitor 10:09:07 INFO - Running setup.py install for mozsystemmonitor 10:09:07 INFO - Successfully installed mozsystemmonitor 10:09:07 INFO - Cleaning up... 10:09:07 INFO - Return code: 0 10:09:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:09:07 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')]} 10:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:07 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')]} 10:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:07 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 0x7ff253bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b8410>, '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 0x23b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b97a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', '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 10:09:07 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 10:09:07 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 10:09:07 INFO - Using env: {'DISPLAY': ':0', 10:09:07 INFO - 'HOME': '/home/cltbld', 10:09:07 INFO - 'LANG': 'en_US.UTF-8', 10:09:07 INFO - 'LANGUAGE': 'en_US:en', 10:09:07 INFO - 'LOGNAME': 'cltbld', 10:09:07 INFO - 'MAIL': '/var/mail/cltbld', 10:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:07 INFO - 'MOZ_NO_REMOTE': '1', 10:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:07 INFO - 'NO_EM_RESTART': '1', 10:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:07 INFO - 'PWD': '/builds/slave/test', 10:09:07 INFO - 'SHELL': '/bin/bash', 10:09:07 INFO - 'SHLVL': '1', 10:09:07 INFO - 'TERM': 'linux', 10:09:07 INFO - 'TMOUT': '86400', 10:09:07 INFO - 'USER': 'cltbld', 10:09:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', 10:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:07 INFO - '_': '/tools/buildbot/bin/python'} 10:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:07 INFO - Downloading/unpacking blobuploader==1.2.4 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:09 INFO - Downloading blobuploader-1.2.4.tar.gz 10:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:09:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:09:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 INFO - Downloading docopt-0.6.1.tar.gz 10:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:09:10 INFO - Installing collected packages: blobuploader, requests, docopt 10:09:10 INFO - Running setup.py install for blobuploader 10:09:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:09:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:09:10 INFO - Running setup.py install for requests 10:09:10 INFO - Running setup.py install for docopt 10:09:11 INFO - Successfully installed blobuploader requests docopt 10:09:11 INFO - Cleaning up... 10:09:11 INFO - Return code: 0 10:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:11 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 0x7ff253bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b8410>, '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 0x23b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b97a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', '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 10:09:11 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 10:09:11 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 10:09:11 INFO - Using env: {'DISPLAY': ':0', 10:09:11 INFO - 'HOME': '/home/cltbld', 10:09:11 INFO - 'LANG': 'en_US.UTF-8', 10:09:11 INFO - 'LANGUAGE': 'en_US:en', 10:09:11 INFO - 'LOGNAME': 'cltbld', 10:09:11 INFO - 'MAIL': '/var/mail/cltbld', 10:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:11 INFO - 'MOZ_NO_REMOTE': '1', 10:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:11 INFO - 'NO_EM_RESTART': '1', 10:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:11 INFO - 'PWD': '/builds/slave/test', 10:09:11 INFO - 'SHELL': '/bin/bash', 10:09:11 INFO - 'SHLVL': '1', 10:09:11 INFO - 'TERM': 'linux', 10:09:11 INFO - 'TMOUT': '86400', 10:09:11 INFO - 'USER': 'cltbld', 10:09:11 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', 10:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:11 INFO - '_': '/tools/buildbot/bin/python'} 10:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:11 INFO - Running setup.py (path:/tmp/pip-b6bmvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:11 INFO - Running setup.py (path:/tmp/pip-02iv_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:11 INFO - Running setup.py (path:/tmp/pip-Xs7FEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:11 INFO - Running setup.py (path:/tmp/pip-SMN745-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:11 INFO - Running setup.py (path:/tmp/pip-wn0HzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:11 INFO - Running setup.py (path:/tmp/pip-om8kcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:11 INFO - Running setup.py (path:/tmp/pip-iM_VsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:11 INFO - Running setup.py (path:/tmp/pip-CcRSDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:11 INFO - Running setup.py (path:/tmp/pip-C2Mp4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:11 INFO - Running setup.py (path:/tmp/pip-x3keST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:12 INFO - Running setup.py (path:/tmp/pip-ppmiQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:12 INFO - Running setup.py (path:/tmp/pip-Z2Z67g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:12 INFO - Running setup.py (path:/tmp/pip-uFewJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:12 INFO - Running setup.py (path:/tmp/pip-MNfAHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:12 INFO - Running setup.py (path:/tmp/pip-HeT02i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:12 INFO - Running setup.py (path:/tmp/pip-bbG8yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:12 INFO - Running setup.py (path:/tmp/pip-jBc2PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:12 INFO - Running setup.py install for manifestparser 10:09:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:09:12 INFO - Running setup.py install for mozcrash 10:09:12 INFO - Running setup.py install for mozdebug 10:09:12 INFO - Running setup.py install for mozdevice 10:09:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:09:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:09:12 INFO - Running setup.py install for mozfile 10:09:13 INFO - Running setup.py install for mozhttpd 10:09:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for mozinfo 10:09:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for mozInstall 10:09:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for mozleak 10:09:13 INFO - Running setup.py install for mozlog 10:09:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for moznetwork 10:09:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for mozprocess 10:09:13 INFO - Running setup.py install for mozprofile 10:09:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for mozrunner 10:09:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:09:14 INFO - Running setup.py install for mozscreenshot 10:09:14 INFO - Running setup.py install for moztest 10:09:14 INFO - Running setup.py install for mozversion 10:09:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:09:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:14 INFO - Cleaning up... 10:09:14 INFO - Return code: 0 10:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:14 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')]} 10:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:14 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')]} 10:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:14 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 0x7ff253bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b8410>, '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 0x23b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b97a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', '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 10:09:14 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 10:09:14 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 10:09:14 INFO - Using env: {'DISPLAY': ':0', 10:09:14 INFO - 'HOME': '/home/cltbld', 10:09:14 INFO - 'LANG': 'en_US.UTF-8', 10:09:14 INFO - 'LANGUAGE': 'en_US:en', 10:09:14 INFO - 'LOGNAME': 'cltbld', 10:09:14 INFO - 'MAIL': '/var/mail/cltbld', 10:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:14 INFO - 'MOZ_NO_REMOTE': '1', 10:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:14 INFO - 'NO_EM_RESTART': '1', 10:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:14 INFO - 'PWD': '/builds/slave/test', 10:09:14 INFO - 'SHELL': '/bin/bash', 10:09:14 INFO - 'SHLVL': '1', 10:09:14 INFO - 'TERM': 'linux', 10:09:14 INFO - 'TMOUT': '86400', 10:09:14 INFO - 'USER': 'cltbld', 10:09:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', 10:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:14 INFO - '_': '/tools/buildbot/bin/python'} 10:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:14 INFO - Running setup.py (path:/tmp/pip-aomnON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:14 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)) 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:14 INFO - Running setup.py (path:/tmp/pip-tAYLKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:14 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)) 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:14 INFO - Running setup.py (path:/tmp/pip-wAnl1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:14 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)) 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:14 INFO - Running setup.py (path:/tmp/pip-Z2cWSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:14 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)) 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:14 INFO - Running setup.py (path:/tmp/pip-9W2Y6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:14 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)) 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:14 INFO - Running setup.py (path:/tmp/pip-fOpIqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:14 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)) 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:14 INFO - Running setup.py (path:/tmp/pip-zC7cuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:15 INFO - Running setup.py (path:/tmp/pip-QxkE80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:15 INFO - Running setup.py (path:/tmp/pip-zvUnkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:15 INFO - Running setup.py (path:/tmp/pip-73_2f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:15 INFO - Running setup.py (path:/tmp/pip-SdBAay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:15 INFO - Running setup.py (path:/tmp/pip-SK9BHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:15 INFO - Running setup.py (path:/tmp/pip-rRiM3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:15 INFO - Running setup.py (path:/tmp/pip-mx8qSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:15 INFO - Running setup.py (path:/tmp/pip-mYnerN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:15 INFO - Running setup.py (path:/tmp/pip-vpR_N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:15 INFO - Running setup.py (path:/tmp/pip-pMg8Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:15 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)) 10:09:15 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)) 10:09:15 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)) 10:09:15 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)) 10:09:15 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)) 10:09:15 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)) 10:09:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:17 INFO - Downloading blessings-1.6.tar.gz 10:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:17 INFO - Installing collected packages: blessings 10:09:17 INFO - Running setup.py install for blessings 10:09:17 INFO - Successfully installed blessings 10:09:17 INFO - Cleaning up... 10:09:17 INFO - Return code: 0 10:09:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:18 INFO - Reading from file tmpfile_stdout 10:09:18 INFO - Current package versions: 10:09:18 INFO - argparse == 1.2.1 10:09:18 INFO - blessings == 1.6 10:09:18 INFO - blobuploader == 1.2.4 10:09:18 INFO - docopt == 0.6.1 10:09:18 INFO - manifestparser == 1.1 10:09:18 INFO - mozInstall == 1.12 10:09:18 INFO - mozcrash == 0.17 10:09:18 INFO - mozdebug == 0.1 10:09:18 INFO - mozdevice == 0.48 10:09:18 INFO - mozfile == 1.2 10:09:18 INFO - mozhttpd == 0.7 10:09:18 INFO - mozinfo == 0.9 10:09:18 INFO - mozleak == 0.1 10:09:18 INFO - mozlog == 3.1 10:09:18 INFO - moznetwork == 0.27 10:09:18 INFO - mozprocess == 0.22 10:09:18 INFO - mozprofile == 0.28 10:09:18 INFO - mozrunner == 6.11 10:09:18 INFO - mozscreenshot == 0.1 10:09:18 INFO - mozsystemmonitor == 0.0 10:09:18 INFO - moztest == 0.7 10:09:18 INFO - mozversion == 1.4 10:09:18 INFO - psutil == 3.1.1 10:09:18 INFO - requests == 1.2.3 10:09:18 INFO - wsgiref == 0.1.2 10:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:18 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 0x7ff253bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b8410>, '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 0x23b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b97a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', '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 10:09:18 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 10:09:18 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 10:09:18 INFO - Using env: {'DISPLAY': ':0', 10:09:18 INFO - 'HOME': '/home/cltbld', 10:09:18 INFO - 'LANG': 'en_US.UTF-8', 10:09:18 INFO - 'LANGUAGE': 'en_US:en', 10:09:18 INFO - 'LOGNAME': 'cltbld', 10:09:18 INFO - 'MAIL': '/var/mail/cltbld', 10:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:18 INFO - 'MOZ_NO_REMOTE': '1', 10:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:18 INFO - 'NO_EM_RESTART': '1', 10:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:18 INFO - 'PWD': '/builds/slave/test', 10:09:18 INFO - 'SHELL': '/bin/bash', 10:09:18 INFO - 'SHLVL': '1', 10:09:18 INFO - 'TERM': 'linux', 10:09:18 INFO - 'TMOUT': '86400', 10:09:18 INFO - 'USER': 'cltbld', 10:09:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', 10:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:18 INFO - '_': '/tools/buildbot/bin/python'} 10:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 INFO - Cleaning up... 10:09:18 INFO - Return code: 0 10:09:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff253bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b8410>, '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 0x23b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b97a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', '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 10:09: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', 'jsonschema'] in /builds/slave/test/build 10:09: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 jsonschema 10:09:18 INFO - Using env: {'DISPLAY': ':0', 10:09:18 INFO - 'HOME': '/home/cltbld', 10:09:18 INFO - 'LANG': 'en_US.UTF-8', 10:09:18 INFO - 'LANGUAGE': 'en_US:en', 10:09:18 INFO - 'LOGNAME': 'cltbld', 10:09:18 INFO - 'MAIL': '/var/mail/cltbld', 10:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:18 INFO - 'MOZ_NO_REMOTE': '1', 10:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:18 INFO - 'NO_EM_RESTART': '1', 10:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:18 INFO - 'PWD': '/builds/slave/test', 10:09:18 INFO - 'SHELL': '/bin/bash', 10:09:18 INFO - 'SHLVL': '1', 10:09:18 INFO - 'TERM': 'linux', 10:09:18 INFO - 'TMOUT': '86400', 10:09:18 INFO - 'USER': 'cltbld', 10:09:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', 10:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:18 INFO - '_': '/tools/buildbot/bin/python'} 10:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:18 INFO - Downloading/unpacking jsonschema 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:20 INFO - Downloading/unpacking functools32 (from jsonschema) 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:20 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:20 INFO - warning: no files found matching '*.txt' 10:09:20 INFO - no previously-included directories found matching 'build' 10:09:20 INFO - no previously-included directories found matching 'dist' 10:09:20 INFO - no previously-included directories found matching '.git*' 10:09:20 INFO - Installing collected packages: jsonschema, functools32 10:09:20 INFO - Running setup.py install for functools32 10:09:20 INFO - warning: no files found matching '*.txt' 10:09:20 INFO - no previously-included directories found matching 'build' 10:09:20 INFO - no previously-included directories found matching 'dist' 10:09:20 INFO - no previously-included directories found matching '.git*' 10:09:20 INFO - Successfully installed jsonschema functools32 10:09:20 INFO - Cleaning up... 10:09:20 INFO - Return code: 0 10:09:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:20 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 0x7ff253bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b8410>, '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 0x23b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b97a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', '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 10:09:20 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 10:09:20 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 10:09:20 INFO - Using env: {'DISPLAY': ':0', 10:09:20 INFO - 'HOME': '/home/cltbld', 10:09:20 INFO - 'LANG': 'en_US.UTF-8', 10:09:20 INFO - 'LANGUAGE': 'en_US:en', 10:09:20 INFO - 'LOGNAME': 'cltbld', 10:09:20 INFO - 'MAIL': '/var/mail/cltbld', 10:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:20 INFO - 'MOZ_NO_REMOTE': '1', 10:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:20 INFO - 'NO_EM_RESTART': '1', 10:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:20 INFO - 'PWD': '/builds/slave/test', 10:09:20 INFO - 'SHELL': '/bin/bash', 10:09:20 INFO - 'SHLVL': '1', 10:09:20 INFO - 'TERM': 'linux', 10:09:20 INFO - 'TMOUT': '86400', 10:09:20 INFO - 'USER': 'cltbld', 10:09:20 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', 10:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:20 INFO - '_': '/tools/buildbot/bin/python'} 10:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:21 INFO - Downloading/unpacking flake8 10:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:09:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:09:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:09:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:23 INFO - no previously-included directories found matching 'docs/_build' 10:09:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:09:23 INFO - Running setup.py install for pep8 10:09:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:23 INFO - no previously-included directories found matching 'docs/_build' 10:09:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:09:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:09:23 INFO - Cleaning up... 10:09:23 INFO - Return code: 0 10:09:23 INFO - Running post-action listener: _resource_record_post_action 10:09:23 INFO - Running post-action listener: _start_resource_monitoring 10:09:23 INFO - Starting resource monitoring. 10:09:24 INFO - ##### 10:09:24 INFO - ##### Running install step. 10:09:24 INFO - ##### 10:09:24 INFO - Running pre-action listener: _resource_record_pre_action 10:09:24 INFO - Running main action method: install 10:09:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:24 INFO - Reading from file tmpfile_stdout 10:09:24 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:09:24 INFO - Reading from file tmpfile_stdout 10:09:24 INFO - Output received: 10:09:24 INFO - Usage: mozinstall [options] installer 10:09:24 INFO - Options: 10:09:24 INFO - -h, --help show this help message and exit 10:09:24 INFO - -d DEST, --destination=DEST 10:09:24 INFO - Directory to install application into. [default: 10:09:24 INFO - "/builds/slave/test"] 10:09:24 INFO - --app=APP Application being installed. [default: firefox] 10:09:24 INFO - mkdir: /builds/slave/test/build/application 10:09:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:09:40 INFO - Reading from file tmpfile_stdout 10:09:40 INFO - Output received: 10:09:40 INFO - /builds/slave/test/build/application/firefox/firefox 10:09:40 INFO - Running post-action listener: _resource_record_post_action 10:09:40 INFO - ##### 10:09:40 INFO - ##### Running run-tests step. 10:09:40 INFO - ##### 10:09:40 INFO - Running pre-action listener: _resource_record_pre_action 10:09:40 INFO - Running main action method: run_tests 10:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:40 INFO - Python 2.7.3 10:09:40 INFO - Return code: 0 10:09:40 INFO - grabbing minidump binary from tooltool 10:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:40 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 0x23b8410>, '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 0x23b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:40 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 10:09:40 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 10:09:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:40 INFO - Return code: 0 10:09:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:09:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:09:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:09:41 INFO - Return code: 0 10:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 10:09:41 INFO - Using env: {'DISPLAY': ':0', 10:09:41 INFO - 'HOME': '/home/cltbld', 10:09:41 INFO - 'LANG': 'en_US.UTF-8', 10:09:41 INFO - 'LANGUAGE': 'en_US:en', 10:09:41 INFO - 'LOGNAME': 'cltbld', 10:09:41 INFO - 'MAIL': '/var/mail/cltbld', 10:09:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:41 INFO - 'MOZ_NO_REMOTE': '1', 10:09:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:41 INFO - 'NO_EM_RESTART': '1', 10:09:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:41 INFO - 'PWD': '/builds/slave/test', 10:09:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:41 INFO - 'SHELL': '/bin/bash', 10:09:41 INFO - 'SHLVL': '1', 10:09:41 INFO - 'TERM': 'linux', 10:09:41 INFO - 'TMOUT': '86400', 10:09:41 INFO - 'USER': 'cltbld', 10:09:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990', 10:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:41 INFO - '_': '/tools/buildbot/bin/python'} 10:09:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:09:41 INFO - mozversion application_buildid: 20160429092239 10:09:41 INFO - mozversion application_changeset: 70443ad6bcc6c58f5e76ed71bf3f2bd075d17be8 10:09:41 INFO - mozversion application_display_name: Nightly 10:09:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:41 INFO - mozversion application_name: Firefox 10:09:41 INFO - mozversion application_remotingname: firefox 10:09:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:09:41 INFO - mozversion application_vendor: Mozilla 10:09:41 INFO - mozversion application_version: 49.0a1 10:09:41 INFO - mozversion platform_buildid: 20160429092239 10:09:41 INFO - mozversion platform_changeset: 70443ad6bcc6c58f5e76ed71bf3f2bd075d17be8 10:09:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:09:41 INFO - mozversion platform_version: 49.0a1 10:09:41 INFO - using testdate: 1461949781 10:09:41 INFO - actual date: 1461949781 10:09:41 INFO - starting webserver on 'localhost:40815' 10:09:41 INFO - SUITE-START | Running 2 tests 10:09:41 INFO - TEST-START | dromaeo_css 10:09:41 INFO - operating with platform_type : linux_ 10:09:41 INFO - Initialising browser for dromaeo_css test... 10:09:41 INFO - TEST-INFO | started process 11712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYVXA0L/profile http://localhost:40815/getInfo.html) 10:09:45 INFO - PROCESS | 11712 | 10:09:45 INFO - PROCESS | 11712 | (process:11780): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:09:45 INFO - PROCESS | 11712 | __metrics Screen width/height:1600/1200 10:09:45 INFO - PROCESS | 11712 | colorDepth:24 10:09:45 INFO - PROCESS | 11712 | Browser inner width/height: 1024/697 10:09:45 INFO - PROCESS | 11712 | __metrics 10:09:46 ERROR - PROCESS | 11712 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:09:47 INFO - TEST-INFO | 11712: exit 0 10:09:47 INFO - Browser initialized. 10:09:47 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:47 INFO - TEST-INFO | started process 11831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYVXA0L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:49 INFO - PROCESS | 11831 | 10:09:49 INFO - PROCESS | 11831 | (process:11890): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:09:59 INFO - PROCESS | 11831 | RSS: Main: 166604800 10:09:59 INFO - PROCESS | 11831 | 10:10:48 INFO - PROCESS | 11831 | 1461949848980 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] 10:13:02 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:40815/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40815/tests/dromaeo/cssquery-ext.html) 10:13:03 INFO - PROCESS | 11831 | RSS: Main: 166903808 10:13:03 INFO - PROCESS | 11831 | 10:16:05 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:40815/tests/dromaeo/cssquery-ext.html (next: http://localhost:40815/tests/dromaeo/cssquery-jquery.html) 10:16:05 INFO - PROCESS | 11831 | RSS: Main: 167243776 10:16:05 INFO - PROCESS | 11831 | 10:19:07 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:40815/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40815/tests/dromaeo/cssquery-mootools.html) 10:19:08 INFO - PROCESS | 11831 | RSS: Main: 168112128 10:19:08 INFO - PROCESS | 11831 | 10:22:10 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:40815/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40815/tests/dromaeo/cssquery-prototype.html) 10:22:10 INFO - PROCESS | 11831 | RSS: Main: 165974016 10:22:10 INFO - PROCESS | 11831 | 10:25:13 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:40815/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40815/tests/dromaeo/cssquery-yui.html) 10:25:14 INFO - PROCESS | 11831 | RSS: Main: 166977536 10:25:14 INFO - PROCESS | 11831 | 10:28:16 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:40815/tests/dromaeo/cssquery-yui.html (next: http://localhost:40815/tests/dromaeo/cssquery-dojo.html) 10:28:16 INFO - PROCESS | 11831 | RSS: Main: 168837120 10:28:16 INFO - PROCESS | 11831 | 10:28:16 INFO - PROCESS | 11831 | __start_tp_report 10:28:16 INFO - PROCESS | 11831 | _x_x_mozilla_page_load 10:28:16 INFO - PROCESS | 11831 | _x_x_mozilla_page_load_details 10:28:16 INFO - PROCESS | 11831 | |i|pagename|runs| 10:28:16 INFO - PROCESS | 11831 | |0;dojo.html;2609.6085587161924;2671.118530884808;2692.9461410771787;2693.9865300673496;2712.145674112656;4747.28790681398;4751.6673832831675;4780.067886762083;4792.233242681172;4843.176659967805;4631.282151266559;4742.312364707124;4762.904741905159;4815.927761083578;4821.903561928768;4372.147431250907;4391.49497807753;4433.9113217735785;4441.600255976961;4449.42157519522;4379.934300985487;4482.394876691654;4483.4171557697455;4525.615322697575;4531.796069176895;4237.406763053175;4295.312749959991;4362.454693163355;4402.449693788277;4448.088141930896;4394.62645675118;4429.3798868158165;4436.778161091933;4449.688521803475;4488.483824360208;4305.892352691177;4338.891527711801;4339.349097635349;4346.304591265382;4387.254166791653;4553.590176884063;4597.908041839178;4608.400907881987;4626.352310676508;4652.930206046912;5049.621278404097;5055;5078.7968481260705;5100.617453690988;5135.666181698215;4917.852464426037;5082.771275292621;5125.205593133033;5129.589632829365;5154.5103215194495;4715.504871988461;4731.408573928259;4735.360726301905;4777.331173635694;4777.880552986203;5115.079285728604;5174.01288543467;5174.068667639861;5185.792568297301;5239.083160446907;4780.378550788375;4957.380327459067;4974.204127339608;4975.154223781966;5018.397792264952;4861.246506791453;5071.41678706946;5108.693478391234;5112.36095488064;5173.974130129401;4949.282354058641;4989.376327959005;4993.675411098267;5006.1739812930455;5036.11867923112;4800.543948324904;4973.229149481764;4973.751312434364;5001.249812528077;5013.323201367769;4275.273203555403;4286.5284818669925;4294.957050429518;4314.590113939171;4328.523862375137;3697.9091168105474;3714.220013797079;3719.34911390511;3746.587875333711;3756.73702840804;4303.827846886152;4304;4362.847300344472;4363.040131171138;4421.425214722066;5117.769700363493;5119.513646203604;5129;5131.2559678846355;5134.127198376285;4413.492448368414;4416.53626369233;4426.336049592523;4426.579474949875;4467.5532446755715;4435.090806384684;4490.887727806766;4552.6813123081065;4553.863384098482;4597.563231493003;4790.976045119752;4794.400699912511;4794.712317260975;4813.4945830687975;4843.830465933675;5087.669301495391;5094.974525127351;5098.031374038921;5098.796048158032;5102.872428189325;4632.096741135446;4776.23580227162;4839.612830973443;4841.782119804688;4868.513148685103;4899.755012249445;4908.239222920453;4915.410150781929;4931.432885218246;4974.452810190804;4993.450720420678;4999.750012499288;5002.174641184164;5017.899642007213;5047.167217409086;4759.928601071056;4920.901581968412;4945.208766597327;4982.352294201731;4988.077205716954;4862.149123903374;4877.926831097466;4888.65614323821;4910.754462276944;4948;4715.056988602225;4783.995360974095;4795.544423279783;4817.156997525489;4821.927671085006;4914.778834952364;4964.478729733326;4990.176620857663;5016.698998060128;5022.974885125551;4778.665493415428;4805.352798053545;4824;4844.079624871263;4849 10:28:16 INFO - PROCESS | 11831 | |1;ext.html;606.2724730323612;609.0316396928882;618.4063299232737;625.1248252446577;625.8591816841212;32548.511772323403;33002.17494562634;33045;33217;33428.66571334286;33644.15889602761;34202.65797342026;34258.14354641135;34433.82783086087;34504.1373965651;7483.513571617855;7655.923440765577;7665.310122089011;7682.5006374585755;7700.4224683148705;7641.2740789624895;7754.651040703154;7755.6509957051785;7755.806104847367;7765.417593680469;7728.845423091535;7801.258880406353;7802.570858602775;7806.180351063113;7823.608819559027;7694.153643099255;7699.923000769976;7721.266479684421;7749.147593764681;7774.572398518079;7683.57740324282;7764.068311802564;7769.456138070337;7814.452988290822;7819.100803407568;34574.96275111726;34941.47587786185;35072.82463587691;35097.64902350969;35221.47167792485;3342.1644588852787;3346.5147553604834;3735.795313075783;3775.093977445393;3925.2542017016676;26713.19860404191;26818.195454136407;27192.592111118152;27341.453170936667;27652.723472765218;3214.9678503214905;3219.356128774231;3225.306559089807;3330.58367704037;3392.9491057634154;210373;213083;213460;213916.93041534847;214075;29160.56259156114;29898;29933.401331973673;30030;48515.5148448511;31660.683393165775;31848.840755796075;31991;32060.67939320577;32103.197420064218;12540.749185016248;12605.684857878627;12704.55534056322;12714.809277860839;12715.809262861065;10288;10360.274780765425;10370.688879333633;10409.9479502602;10625.46872656364;8205.220504052106;8226.383021273428;8268.710595129141;8271.1728827118;8304.086550479442;3209.7271731902583;3229.111994201566;3235.3044095519103;3275.050235431698;3295.6374798772117;965.232640051147;995.1590905684685;1014.1481155829139;1024.948752562369;1054.599252284127;28119.43761124807;28293.57559636607;28317.209306957116;28387.858060709565;28476.430471390457;1018.8318927376899;1029.613894789454;1036.7149034015706;1076.5101878645198;1097.8956999085074;15064.322105505278;15120.773188402183;15140.621484462976;15191.848081519265;15273.694526109415;396223;397523;399045;403467;404870;50181.49818501841;50699.746501267255;50700.74649626802;50835.237471437955;50965.745171273906;1218.9390530473618;1263.128441375448;1264.6206138158516;1272.3447424576536;1298.195119026191;27133.457330853667;28037.579436308064;28238.435231294847;28618.284542886595;28756.42487150287;42860.35709464423;42904.78547607242;43389;43492;43501.56498434975;250527;250945;251175;251275;252150;25491.617625735256;25912.22263332103;33783.83108084444;34788.30423391569;35023.64976350204;36835.447468288534;37068.814655926544;37532.437013445364;38270.80864595659;38409;32107.357852842346;32146.357072857943;32191.839040804647;32572.185695357806;32642;34912.30175396427;35164.472532912536;35194;35224.82387588046;35752.463713043806;32237.838810805795;33298.500522492664;33513;33744.49383259302;34947;29491.85254073716;31638.683613164496;31852.681473185898;32375;32550;24039.75960240445;24261.878690606434;24405.755942441057;24586;24661.50676986486 10:28:16 INFO - PROCESS | 11831 | |2;jquery.html;369.88163787587973;373.46967306424875;376.28505838906074;376.9076576238822;381.7060863135388;15822.287997040132;16245.593860153487;17356.218970146343;17612;17654.205560749764;16141.83858161418;16339;17067.40264090757;17185.914070429662;17224.655506889856;4990.401151861773;5144.176931690911;5162.277281180638;5164.715940623264;5170.146925757264;3733.4773131761576;5102.234664800272;5583.469570390806;5895.587308888379;5896.380880007602;5786.392428794979;5802.216700745387;5811.883762324751;5853.268341457318;5871.618344807595;5646.971765141168;5868.677222752747;5896.145058966469;5904.350521442638;5911.645301281937;4985.277134815431;5197.818076367347;5242.973785131088;5253.290805741214;5268.60485463588;11719.882801172049;11964.88035119655;12015.579454719043;12035.458404371824;12049.879501204963;1816.4732227653965;1868.5795695968434;1901.239504198318;1965.4202010406964;2022.646036943529;9007.279417646572;9071.863922041175;9214.677486288016;9414.435133891988;9512.857307140399;1762.8325309095744;1784.2595322940963;1864.4406677996546;1896.0804010055112;1902.6004539046817;66239.66880165617;68876.31123688749;69007.30992690109;69040.30959690388;70272.6486367565;9544.665936692183;10039;10081.647142349982;10591.046805787517;10725.678229653124;14022.789658155136;14103.576892693236;14106.365213565414;14115.78826317606;14119.64700882486;6992.3357281058215;7023.92976070243;7127.394171495377;7183.676734546958;7213.098362704662;6600.933990660128;6603.504737144734;6619.536632435779;6735.797926062226;6742.696578653972;4282.850100246476;4336.333155109648;4355.695101342875;4361.781910904506;4457.531959144308;1740.9738853917202;1764.4971183212722;1802.5133214032137;1887.981120188808;1894.8199921007483;921.5898924978454;923.3674932671141;927.0636656976502;950.8193443245762;950.8954015058338;15485.767713484307;15527.689446211012;15600.29798659063;16306.510804675878;16394.344226231056;858.852867830424;877.0922095631119;909.417972497602;916.5554705967601;976.414151509103;9414.340996130206;9429.66996155145;9540.522973851279;9595.808083838285;9737.65918192874;398894;405176;414365;415000.3999840033;419683;78487;78942.6052869732;81128;83875.5806220965;83968;993.9055789699967;995.9850602240972;1023.7850051489271;1024.0834453164375;1025.0723095598496;14976;15253.466128685443;15273.541793746206;15276.541703748906;15624;34854.82572587121;34938;35659.28681426409;35913;35992.100197495274;49874.503764887115;50284.49715502944;51390;51453.48546514487;52216.73891630518;7205.171405288459;7748.845023099394;7756.92243077562;7792.181820908723;7834.608269586612;8091.757247282591;9586.424814511152;11256.268342557707;11407.714807129889;11552.364619945984;9395.15443610051;9718.319717619699;9952.154066904393;10012.899871001197;10160.44117573511;9784.315097943076;9789.853152202864;9972.052654997764;10195.23535734808;10327.48362581883;8720.694775682821;9594.520273986132;9669.468179250209;9925.1067403934;10248.026437488426;7477.446044958425;7647.617619118911;7690.884636730565;7836.216378362346;7886.72396466121;8873.290136788912;9312.997705493352;9472;9520.143187113194;9584.137427631547 10:28:16 INFO - PROCESS | 11831 | |3;mootools.html;1473.4990103364853;1486.450013495007;1633.6405990682047;1751.229459038024;1783.9108044597767;6859.622720750357;7536.095668519779;7587.2792084752;7871.370290376771;7898.723544675945;7665.1951545087795;7678.3473404760525;7761.883571746414;7771.184025677293;7774.727884524043;2181.0512427094186;2224.7219097612797;2225.1544413122992;2229.598672238996;2235.765244649313;2178.6623073423643;2210.3258506155616;2249.977500224993;2254.729432468098;2268.3421807675754;2203.3389983005113;2204.316661834828;2218.8890555472244;2226.2875879718495;2247.202243203664;2159.8380121490795;2167.1548096242477;2174.923877664282;2182.018091858662;2182.0399024429357;2156.762756096828;2182.9563408731897;2186.0599942024924;2194.4513871532117;2201.020545857094;7828.765137045898;7877.212278772135;7917.287444129998;7962.800929976739;7983;4569.565891240327;4650.395448591696;4706.929396059062;4717.646176536773;4721.102990431841;2806.852021110352;2867.612872262239;2900.3039270575123;2901.956470652942;2908.9272768180754;915.803102332995;916.2212119698203;932.5943214701626;935.1957316707626;960.3661583354952;10431.634892778793;10583.788324233472;10593.894061059367;10614.150867930624;10614.469276536141;4327.480702315679;4351.564843515623;4411.735295882258;4418.491873434532;4418.7127836690515;9168.129027742354;9177.954110229539;9188.494632795127;9196.494192819458;9210.677626283183;4634.189016922025;4641.048585040058;4683.180443422388;4785.449673287547;4792.448868380111;3748.194138260287;4050.918981620351;4236.872893813191;4241.109367032957;4324.437823082979;3580.838862251205;3591.299696559146;3642.927141457156;3725.6274372562525;3727.29181455528;1175.8882906123904;1180.3861991764234;1199.8800119988107;1213.1204876464492;1233.9136260461682;732.9230430804795;787.7400457848896;807.11620775251;900.9009009009004;918.3525614441802;5145.288367497929;5308.867278317995;5339.11904535755;5430.755615997289;5501.477359650827;789.6091434739841;821.117298903681;827.6317038917624;827.8261565071282;842.0905422144069;3588.138846676779;3661.6704496594903;3671.3391589514144;3680.011142504663;3691.501647277637;9622.182114520205;9903.306768526134;9925.50372481373;9958.651447199458;10010.299279050541;9858.802823943624;9895.406275623485;9914.950425247827;9952.601895924083;9952.751181220527;7364.189939106694;7561.962190189124;7569.697212111564;7571.3942884569105;7582.886256706154;5276.261323414648;5352.437994010573;5385.542228910586;5404;5641.4358564144895;8950.552472376225;8955.776105597412;8986.775330616787;9110.088991100836;9246.95376523113;9016.2786977043;9198.908010920073;9225.72322830316;9306.208972237435;9310.255179585753;5787.479126878601;6405.807825765234;6443.387878151568;6541.8691626166255;6599.043138744759;7656.540607563564;7670.0795904491815;7687.461877668509;7746.612669366622;7772.45592808498;6737.326267373223;6766.289539598468;6948.235694073749;6994.720211191699;7048.330408611174;6863;6925.995730618932;6933.583984960918;6964.930350696428;7017.859642807218;6354.110424540476;6369.426751592194;6435.485161187187;6468.967655161694;6481.546291759721;4651.3023046543285;4717.716936983792;4744.501827308083;4807.831725889577;4864.732439715708;4841.419029716457;4901.730404827626;4923.138450771029;4931.926021109614;4958.628102892226 10:28:16 INFO - PROCESS | 11831 | |4;prototype.html;289.7160782433214;293.676955349116;300.46367234486434;302.750231059376;311.95164749463834;4979.402471703392;5058.5953123750105;5066.138756411409;5074.832788458648;5075.162598171307;4949.688332591866;4951.851444456663;4969.353983982077;4969.776360063796;4976.87557811054;3724.25514897021;3791.7345785795005;3927.293087244295;3931.8820435386983;3944.4872166618443;3910.432987216852;3932.803359832011;3936.252112098692;3949.545802232737;3958.990457433365;3901.161250331178;3927.3912543555793;3927.960720392802;3943.191645712622;3943.7830919299427;3865.40086286626;3923.058465968176;3928.5874983126787;3943.3099207638693;3946.309395855714;3477.1133360992785;3489.057954352336;3489.232368878868;3489.9825500872334;3522.0314413536225;4770.282698228635;4776;4776.5701086902345;4783.497732738082;4806.327114204014;4374.125174964988;4480.708753930984;4482.125985432842;4485.932711009337;4486.170058539148;5109.259157422191;5143.974280128576;5157.819476318311;5168.3797944246935;5180.43015268324;3717.9070523236865;3742.55089389275;3797.6012518685693;3797.810109494514;3810.771353718758;5382.757775900055;5416.647917885364;5435.565154787647;5439.048166570834;5463.399026107165;3529.99950042467;3716.6655001050035;3717.3272027587695;3730.123420996064;3731.7014638828828;3755.192633583738;3766.4915236443276;3786.2928006475504;3796.449514820391;3796.6013568575454;4324.200022995756;4351.978240108842;4373.409589705413;4380.802863871133;4382.276924307517;5064.898702025939;5179.378474583074;5185.455527169668;5215.16557350822;5228.424873263938;1384.3078460769616;1401.061288936415;1402.2427888940063;1402.5021117503343;1404.368034384531;873.9431936924079;914.8810654614857;925.0379605210641;952.9475878826593;959.9520023998772;4447.3773671685985;4585.257602111243;4586.908261834745;4589.33454649074;4591.357209990604;5383.515483606494;5396.2984811974975;5399.217113518596;5402.648827826179;5404.270423492778;4451.221036318631;4541.477730061019;4584.472785629629;4597.7011494252765;4602.424696912886;3060.586820779211;3089.474789285827;3093.314143791639;3095.7523398128096;3100.0544833825898;5405.135178371442;5407.405185429599;5416.674999499964;5422.539084177889;5423.810166644149;5624.240727501735;5877.177195192677;5893.3222679391565;5903.675297858659;5904.380040095814;5369.4362091980565;5393.8112166074;5396.406395296514;5397.541208997279;5402.91895621566;5677.346265452962;5707.286589176353;5729.3984131665575;5752.511036561939;5759.136129580596;5569.220309156641;5604.775808967595;5630.605857590093;5644.6330988485615;5688.317401911797;5404.594655400782;5436.592255580768;5444.673319600836;5451.127819548853;5451.909618076321;3571.7321200909514;4002.2595819773437;4004.6395824375945;4016.578259282733;4016.879493615196;5365.919511207413;5390.919136212881;5397.703126327932;5403.270558474555;5410.48600382963;5228.451012643618;5236.083685355124;5245.527902488794;5254.65844720092;5263.315768950012;4928.457869634409;5196.194589838581;5206.823837459223;5212.270282160424;5249.868753281198;5107.208382700539;5153.639245252796;5160.767765450489;5171.3018742469285;5186.922196167136;4988.406028865043;5049.520295571915;5152.76812543429;5201.583873290203;5290;5121.539061484335;5140.665856719302;5141.203113517411;5166.8966620668125;5181.611379146654 10:28:16 INFO - PROCESS | 11831 | |5;yui.html;704.098753595398;724.3119036914928;730.9817254568635;731.7475470962517;751.3238085722852;11367.204295699305;11896.583619573317;11896.702582435444;11926.344051077187;11935.343556104412;10991.340519568812;11309;11693.181477296592;11716.121290903195;11754.706132346675;630.8895943209943;787.8188016756164;796.2992566541435;796.5618909599726;798.6845196147518;774.5159275452842;802.7150361621627;802.7712102050916;803.8512875118122;805.0218983934518;823.6540652925786;828.0932379044937;830.5473516933286;831.0401486283353;834.7829564313292;815.9714409995681;818.9959050204741;820.122468958215;823.9794005149889;829.6598394658191;602.2141105856855;603.4146877528834;605.4127496328555;607.3076692570473;611.2298503885092;11279.774404511945;11316.3210207387;11385.772284554345;11389.974902258753;11390.943045284803;11271.436428178558;11537.653870383818;11538.538458461651;11552;11746.412679365998;9392.62429502819;9519.904800951972;9685.757856053584;9699;9713.70858874235;3224.170338030694;3228.1929517620597;3269.558609587699;3278.393497203025;3300.504924261356;45694;45765;46351.07297854058;46355.841103972336;46390;8790.252828509649;8914.86627700585;9037;9051.502167380857;9056.683016094405;16365.099919504304;16416.261268242957;16473.093979831225;16497.83502164963;16546.503604891874;6424.967875160594;6689.1972963244725;6752.662366881636;6900.171979362509;7018.298170182941;3581.910452238663;3719.8512059517857;3754.755940863835;3768.9434658479595;3800.0689830991582;2783.73554512321;2824.915252542427;2839.929001774931;2844.9431011379656;2845.6869744328105;480.75241250755187;485.31085858080905;486.96591238613667;488.57982135363557;502.4297422425573;569.8262030080865;592.9555283353766;594.669958173218;600.6396162302583;603.1284793473476;7130.2869713028285;7357.8160545986775;7493.812654683567;7590.848183036419;7662.846743065107;479.29304276192335;506.30636028641;551.5670198893849;568.2470726287686;596.5615272774508;3466.5666791651042;3538.433850583894;3630.6913912317223;3679.521662183899;3697.6672099511175;55285.44714552884;57470.7126464365;57579.71210144006;57820;57936;46299;46672.766636166605;47819.76090119527;49894;51024.48975510272;47306.76346618245;47467.28799068017;47502.52497474981;47677.046459070625;48502.5149748498;7975.082865470313;8090.271875531231;8191.79520511992;8239.505629662239;8367.58162091905;30171.547426788176;30406.84796576003;30591.54112688356;30757.23106922345;31117.444127793067;40194.387364821196;40877.182456350114;41048.384274235315;41306.38040429456;41529.96175095647;10571.682849514527;10628.309159904582;10787.029167374974;10823.621173258898;11044.392558409365;11886.583969561023;11932.582359617372;11936;12048.096392770753;12219.572314968933;9480;9609.51952402391;9858.993351189589;9951.601935922483;10353;11389.145814063813;11434.94282528582;11524.962753352238;11537.538498460304;11737.765244694887;9943.950280248553;10166.135878450119;10314.174866010851;10595.841062383915;10706.304090234109;9333.346665733605;9592.76018099553;9597;9729.416235025921;9893.307468477138;9279.860802087838;9514.38156519824;9560.28297877648;9564.234861211226;9630.903690963281 10:28:16 INFO - PROCESS | 11831 | __end_tp_report 10:28:16 INFO - PROCESS | 11831 | __start_cc_report 10:28:16 INFO - PROCESS | 11831 | _x_x_mozilla_cycle_collect,384 10:28:16 INFO - PROCESS | 11831 | __end_cc_report 10:28:16 INFO - PROCESS | 11831 | __startTimestamp1461950896657__endTimestamp 10:28:16 INFO - PROCESS | 11831 | 10:28:16 INFO - PROCESS | 11831 | ------- Summary: start ------- 10:28:16 INFO - PROCESS | 11831 | Number of tests: 6 10:28:16 INFO - PROCESS | 11831 | 10:28:16 INFO - PROCESS | 11831 | [#0] dojo.html Cycles:165 Average:4678.69 Median:4795.54 stddev:478.86 (10.0%) stddev-sans-first:451.98 10:28:16 INFO - PROCESS | 11831 | Values: 2609.6 2671.1 2692.9 2694.0 2712.1 4747.3 4751.7 4780.1 4792.2 4843.2 4631.3 4742.3 4762.9 4815.9 4821.9 4372.1 4391.5 4433.9 4441.6 4449.4 4379.9 4482.4 4483.4 4525.6 4531.8 4237.4 4295.3 4362.5 4402.4 4448.1 4394.6 4429.4 4436.8 4449.7 4488.5 4305.9 4338.9 4339.3 4346.3 4387.3 4553.6 4597.9 4608.4 4626.4 4652.9 5049.6 5055.0 5078.8 5100.6 5135.7 4917.9 5082.8 5125.2 5129.6 5154.5 4715.5 4731.4 4735.4 4777.3 4777.9 5115.1 5174.0 5174.1 5185.8 5239.1 4780.4 4957.4 4974.2 4975.2 5018.4 4861.2 5071.4 5108.7 5112.4 5174.0 4949.3 4989.4 4993.7 5006.2 5036.1 4800.5 4973.2 4973.8 5001.2 5013.3 4275.3 4286.5 4295.0 4314.6 4328.5 3697.9 3714.2 3719.3 3746.6 3756.7 4303.8 4304.0 4362.8 4363.0 4421.4 5117.8 5119.5 5129.0 5131.3 5134.1 4413.5 4416.5 4426.3 4426.6 4467.6 4435.1 4490.9 4552.7 4553.9 4597.6 4791.0 4794.4 4794.7 4813.5 4843.8 5087.7 5095.0 5098.0 5098.8 5102.9 4632.1 4776.2 4839.6 4841.8 4868.5 4899.8 4908.2 4915.4 4931.4 4974.5 4993.5 4999.8 5002.2 5017.9 5047.2 4759.9 4920.9 4945.2 4982.4 4988.1 4862.1 4877.9 4888.7 4910.8 4948.0 4715.1 4784.0 4795.5 4817.2 4821.9 4914.8 4964.5 4990.2 5016.7 5023.0 4778.7 4805.4 4824.0 4844.1 4849.0 10:28:16 INFO - PROCESS | 11831 | 10:28:16 INFO - PROCESS | 11831 | [#1] ext.html Cycles:180 Average:42627.45 Median:33131.00 stddev:79102.91 (238.8%) stddev-sans-first:79261.90 10:28:16 INFO - PROCESS | 11831 | Values: 606.3 609.0 618.4 625.1 625.9 32548.5 33002.2 33045.0 33217.0 33428.7 33644.2 34202.7 34258.1 34433.8 34504.1 7483.5 7655.9 7665.3 7682.5 7700.4 7641.3 7754.7 7755.7 7755.8 7765.4 7728.8 7801.3 7802.6 7806.2 7823.6 7694.2 7699.9 7721.3 7749.1 7774.6 7683.6 7764.1 7769.5 7814.5 7819.1 34575.0 34941.5 35072.8 35097.6 35221.5 3342.2 3346.5 3735.8 3775.1 3925.3 26713.2 26818.2 27192.6 27341.5 27652.7 3215.0 3219.4 3225.3 3330.6 3392.9 210373.0 213083.0 213460.0 213916.9 214075.0 29160.6 29898.0 29933.4 30030.0 48515.5 31660.7 31848.8 31991.0 32060.7 32103.2 12540.7 12605.7 12704.6 12714.8 12715.8 10288.0 10360.3 10370.7 10409.9 10625.5 8205.2 8226.4 8268.7 8271.2 8304.1 3209.7 3229.1 3235.3 3275.1 3295.6 965.2 995.2 1014.1 1024.9 1054.6 28119.4 28293.6 28317.2 28387.9 28476.4 1018.8 1029.6 1036.7 1076.5 1097.9 15064.3 15120.8 15140.6 15191.8 15273.7 396223.0 397523.0 399045.0 403467.0 404870.0 50181.5 50699.7 50700.7 50835.2 50965.7 1218.9 1263.1 1264.6 1272.3 1298.2 27133.5 28037.6 28238.4 28618.3 28756.4 42860.4 42904.8 43389.0 43492.0 43501.6 250527.0 250945.0 251175.0 251275.0 252150.0 25491.6 25912.2 33783.8 34788.3 35023.6 36835.4 37068.8 37532.4 38270.8 38409.0 32107.4 32146.4 32191.8 32572.2 32642.0 34912.3 35164.5 35194.0 35224.8 35752.5 32237.8 33298.5 33513.0 33744.5 34947.0 29491.9 31638.7 31852.7 32375.0 32550.0 24039.8 24261.9 24405.8 24586.0 24661.5 10:28:16 INFO - PROCESS | 11831 | 10:28:16 INFO - PROCESS | 11831 | [#2] jquery.html Cycles:180 Average:24604.91 Median:5167.43 stddev:67812.97 (1312.3%) stddev-sans-first:67978.78 10:28:16 INFO - PROCESS | 11831 | Values: 369.9 373.5 376.3 376.9 381.7 15822.3 16245.6 17356.2 17612.0 17654.2 16141.8 16339.0 17067.4 17185.9 17224.7 4990.4 5144.2 5162.3 5164.7 5170.1 3733.5 5102.2 5583.5 5895.6 5896.4 5786.4 5802.2 5811.9 5853.3 5871.6 5647.0 5868.7 5896.1 5904.4 5911.6 4985.3 5197.8 5243.0 5253.3 5268.6 11719.9 11964.9 12015.6 12035.5 12049.9 1816.5 1868.6 1901.2 1965.4 2022.6 9007.3 9071.9 9214.7 9414.4 9512.9 1762.8 1784.3 1864.4 1896.1 1902.6 66239.7 68876.3 69007.3 69040.3 70272.6 9544.7 10039.0 10081.6 10591.0 10725.7 14022.8 14103.6 14106.4 14115.8 14119.6 6992.3 7023.9 7127.4 7183.7 7213.1 6600.9 6603.5 6619.5 6735.8 6742.7 4282.9 4336.3 4355.7 4361.8 4457.5 1741.0 1764.5 1802.5 1888.0 1894.8 921.6 923.4 927.1 950.8 950.9 15485.8 15527.7 15600.3 16306.5 16394.3 858.9 877.1 909.4 916.6 976.4 9414.3 9429.7 9540.5 9595.8 9737.7 398894.0 405176.0 414365.0 415000.4 419683.0 78487.0 78942.6 81128.0 83875.6 83968.0 993.9 996.0 1023.8 1024.1 1025.1 14976.0 15253.5 15273.5 15276.5 15624.0 34854.8 34938.0 35659.3 35913.0 35992.1 49874.5 50284.5 51390.0 51453.5 52216.7 7205.2 7748.8 7756.9 7792.2 7834.6 8091.8 9586.4 11256.3 11407.7 11552.4 9395.2 9718.3 9952.2 10012.9 10160.4 9784.3 9789.9 9972.1 10195.2 10327.5 8720.7 9594.5 9669.5 9925.1 10248.0 7477.4 7647.6 7690.9 7836.2 7886.7 8873.3 9313.0 9472.0 9520.1 9584.1 10:28:16 INFO - PROCESS | 11831 | 10:28:16 INFO - PROCESS | 11831 | [#3] mootools.html Cycles:180 Average:5216.80 Median:5368.99 stddev:2908.85 (54.2%) stddev-sans-first:2903.40 10:28:16 INFO - PROCESS | 11831 | Values: 1473.5 1486.5 1633.6 1751.2 1783.9 6859.6 7536.1 7587.3 7871.4 7898.7 7665.2 7678.3 7761.9 7771.2 7774.7 2181.1 2224.7 2225.2 2229.6 2235.8 2178.7 2210.3 2250.0 2254.7 2268.3 2203.3 2204.3 2218.9 2226.3 2247.2 2159.8 2167.2 2174.9 2182.0 2182.0 2156.8 2183.0 2186.1 2194.5 2201.0 7828.8 7877.2 7917.3 7962.8 7983.0 4569.6 4650.4 4706.9 4717.6 4721.1 2806.9 2867.6 2900.3 2902.0 2908.9 915.8 916.2 932.6 935.2 960.4 10431.6 10583.8 10593.9 10614.2 10614.5 4327.5 4351.6 4411.7 4418.5 4418.7 9168.1 9178.0 9188.5 9196.5 9210.7 4634.2 4641.0 4683.2 4785.4 4792.4 3748.2 4050.9 4236.9 4241.1 4324.4 3580.8 3591.3 3642.9 3725.6 3727.3 1175.9 1180.4 1199.9 1213.1 1233.9 732.9 787.7 807.1 900.9 918.4 5145.3 5308.9 5339.1 5430.8 5501.5 789.6 821.1 827.6 827.8 842.1 3588.1 3661.7 3671.3 3680.0 3691.5 9622.2 9903.3 9925.5 9958.7 10010.3 9858.8 9895.4 9915.0 9952.6 9952.8 7364.2 7562.0 7569.7 7571.4 7582.9 5276.3 5352.4 5385.5 5404.0 5641.4 8950.6 8955.8 8986.8 9110.1 9247.0 9016.3 9198.9 9225.7 9306.2 9310.3 5787.5 6405.8 6443.4 6541.9 6599.0 7656.5 7670.1 7687.5 7746.6 7772.5 6737.3 6766.3 6948.2 6994.7 7048.3 6863.0 6926.0 6933.6 6964.9 7017.9 6354.1 6369.4 6435.5 6469.0 6481.5 4651.3 4717.7 4744.5 4807.8 4864.7 4841.4 4901.7 4923.1 4931.9 4958.6 10:28:16 INFO - PROCESS | 11831 | 10:28:16 INFO - PROCESS | 11831 | [#4] prototype.html Cycles:180 Average:4405.14 Median:4978.14 stddev:1289.75 (25.9%) stddev-sans-first:1255.83 10:28:16 INFO - PROCESS | 11831 | Values: 289.7 293.7 300.5 302.8 312.0 4979.4 5058.6 5066.1 5074.8 5075.2 4949.7 4951.9 4969.4 4969.8 4976.9 3724.3 3791.7 3927.3 3931.9 3944.5 3910.4 3932.8 3936.3 3949.5 3959.0 3901.2 3927.4 3928.0 3943.2 3943.8 3865.4 3923.1 3928.6 3943.3 3946.3 3477.1 3489.1 3489.2 3490.0 3522.0 4770.3 4776.0 4776.6 4783.5 4806.3 4374.1 4480.7 4482.1 4485.9 4486.2 5109.3 5144.0 5157.8 5168.4 5180.4 3717.9 3742.6 3797.6 3797.8 3810.8 5382.8 5416.6 5435.6 5439.0 5463.4 3530.0 3716.7 3717.3 3730.1 3731.7 3755.2 3766.5 3786.3 3796.4 3796.6 4324.2 4352.0 4373.4 4380.8 4382.3 5064.9 5179.4 5185.5 5215.2 5228.4 1384.3 1401.1 1402.2 1402.5 1404.4 873.9 914.9 925.0 952.9 960.0 4447.4 4585.3 4586.9 4589.3 4591.4 5383.5 5396.3 5399.2 5402.6 5404.3 4451.2 4541.5 4584.5 4597.7 4602.4 3060.6 3089.5 3093.3 3095.8 3100.1 5405.1 5407.4 5416.7 5422.5 5423.8 5624.2 5877.2 5893.3 5903.7 5904.4 5369.4 5393.8 5396.4 5397.5 5402.9 5677.3 5707.3 5729.4 5752.5 5759.1 5569.2 5604.8 5630.6 5644.6 5688.3 5404.6 5436.6 5444.7 5451.1 5451.9 3571.7 4002.3 4004.6 4016.6 4016.9 5365.9 5390.9 5397.7 5403.3 5410.5 5228.5 5236.1 5245.5 5254.7 5263.3 4928.5 5196.2 5206.8 5212.3 5249.9 5107.2 5153.6 5160.8 5171.3 5186.9 4988.4 5049.5 5152.8 5201.6 5290.0 5121.5 5140.7 5141.2 5166.9 5181.6 10:28:16 INFO - PROCESS | 11831 | 10:28:16 INFO - PROCESS | 11831 | [#5] yui.html Cycles:180 Average:12993.59 Median:24494.74 stddev:15436.85 (63.0%) stddev-sans-first:15452.57 10:28:16 INFO - PROCESS | 11831 | Values: 704.1 724.3 731.0 731.7 751.3 11367.2 11896.6 11896.7 11926.3 11935.3 10991.3 11309.0 11693.2 11716.1 11754.7 630.9 787.8 796.3 796.6 798.7 774.5 802.7 802.8 803.9 805.0 823.7 828.1 830.5 831.0 834.8 816.0 819.0 820.1 824.0 829.7 602.2 603.4 605.4 607.3 611.2 11279.8 11316.3 11385.8 11390.0 11390.9 11271.4 11537.7 11538.5 11552.0 11746.4 9392.6 9519.9 9685.8 9699.0 9713.7 3224.2 3228.2 3269.6 3278.4 3300.5 45694.0 45765.0 46351.1 46355.8 46390.0 8790.3 8914.9 9037.0 9051.5 9056.7 16365.1 16416.3 16473.1 16497.8 16546.5 6425.0 6689.2 6752.7 6900.2 7018.3 3581.9 3719.9 3754.8 3768.9 3800.1 2783.7 2824.9 2839.9 2844.9 2845.7 480.8 485.3 487.0 488.6 502.4 569.8 593.0 594.7 600.6 603.1 7130.3 7357.8 7493.8 7590.8 7662.8 479.3 506.3 551.6 568.2 596.6 3466.6 3538.4 3630.7 3679.5 3697.7 55285.4 57470.7 57579.7 57820.0 57936.0 46299.0 46672.8 47819.8 49894.0 51024.5 47306.8 47467.3 47502.5 47677.0 48502.5 7975.1 8090.3 8191.8 8239.5 8367.6 30171.5 30406.8 30591.5 30757.2 31117.4 40194.4 40877.2 41048.4 41306.4 41530.0 10571.7 10628.3 10787.0 10823.6 11044.4 11886.6 11932.6 11936.0 12048.1 12219.6 9480.0 9609.5 9859.0 9951.6 10353.0 11389.1 11434.9 11525.0 11537.5 11737.8 9944.0 10166.1 10314.2 10595.8 10706.3 9333.3 9592.8 9597.0 9729.4 9893.3 9279.9 9514.4 9560.3 9564.2 9630.9 10:28:16 INFO - PROCESS | 11831 | -------- Summary: end -------- 10:28:16 INFO - PROCESS | 11831 | 10:28:17 INFO - TEST-INFO | 11831: exit 0 10:28:17 INFO - TEST-OK | dromaeo_css | took 1116140ms 10:28:17 INFO - TEST-START | kraken 10:28:17 INFO - operating with platform_type : linux_ 10:28:17 INFO - Initialising browser for kraken test... 10:28:17 INFO - TEST-INFO | started process 12066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZNzrnM/profile http://localhost:40815/getInfo.html) 10:28:21 INFO - PROCESS | 12066 | 10:28:21 INFO - PROCESS | 12066 | (process:12135): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:28:21 INFO - PROCESS | 12066 | __metrics Screen width/height:1600/1200 10:28:21 INFO - PROCESS | 12066 | colorDepth:24 10:28:21 INFO - PROCESS | 12066 | Browser inner width/height: 1024/697 10:28:21 INFO - PROCESS | 12066 | __metrics 10:28:22 ERROR - PROCESS | 12066 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:28:23 INFO - TEST-INFO | 12066: exit 0 10:28:23 INFO - Browser initialized. 10:28:23 INFO - Running cycle 1/1 for kraken test... 10:28:23 INFO - TEST-INFO | started process 12186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZNzrnM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:25 INFO - PROCESS | 12186 | 10:28:25 INFO - PROCESS | 12186 | (process:12248): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:28:35 INFO - PROCESS | 12186 | RSS: Main: 166039552 10:28:35 INFO - PROCESS | 12186 | 10:28:37 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40815/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:38 INFO - PROCESS | 12186 | RSS: Main: 170389504 10:28:38 INFO - PROCESS | 12186 | 10:28:41 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40815/tests/kraken/driver.html?testName=audio-dft) 10:28:42 INFO - PROCESS | 12186 | RSS: Main: 174305280 10:28:42 INFO - PROCESS | 12186 | 10:28:45 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40815/tests/kraken/driver.html?testName=audio-fft) 10:28:45 INFO - PROCESS | 12186 | RSS: Main: 164868096 10:28:45 INFO - PROCESS | 12186 | 10:28:47 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40815/tests/kraken/driver.html?testName=audio-oscillator) 10:28:48 INFO - PROCESS | 12186 | RSS: Main: 165597184 10:28:48 INFO - PROCESS | 12186 | 10:28:50 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40815/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:51 INFO - PROCESS | 12186 | RSS: Main: 165797888 10:28:51 INFO - PROCESS | 12186 | 10:28:54 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40815/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:55 INFO - PROCESS | 12186 | RSS: Main: 166391808 10:28:55 INFO - PROCESS | 12186 | 10:28:58 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40815/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:59 INFO - PROCESS | 12186 | RSS: Main: 166088704 10:28:59 INFO - PROCESS | 12186 | 10:29:02 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40815/tests/kraken/driver.html?testName=json-parse-financial) 10:29:02 INFO - PROCESS | 12186 | RSS: Main: 166227968 10:29:02 INFO - PROCESS | 12186 | 10:29:04 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40815/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:29:05 INFO - PROCESS | 12186 | RSS: Main: 166559744 10:29:05 INFO - PROCESS | 12186 | 10:29:07 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40815/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:07 INFO - PROCESS | 12186 | RSS: Main: 166260736 10:29:07 INFO - PROCESS | 12186 | 10:29:09 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40815/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:29:10 INFO - PROCESS | 12186 | RSS: Main: 166498304 10:29:10 INFO - PROCESS | 12186 | 10:29:13 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:29:14 INFO - PROCESS | 12186 | RSS: Main: 167010304 10:29:14 INFO - PROCESS | 12186 | 10:29:17 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:17 INFO - PROCESS | 12186 | RSS: Main: 166707200 10:29:17 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:40815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40815/tests/kraken/driver.html?testName=ai-astar) 10:29:19 INFO - PROCESS | 12186 | RSS: Main: 168230912 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | __start_tp_report 10:29:19 INFO - PROCESS | 12186 | _x_x_mozilla_page_load 10:29:19 INFO - PROCESS | 12186 | _x_x_mozilla_page_load_details 10:29:19 INFO - PROCESS | 12186 | |i|pagename|runs| 10:29:19 INFO - PROCESS | 12186 | |0;ai-astar;115;108;116;114;114;126;115;112;113;112 10:29:19 INFO - PROCESS | 12186 | |1;audio-beat-detection;155;134;153;186;135;161;157;134;193;142 10:29:19 INFO - PROCESS | 12186 | |2;audio-dft;162;163;165;165;176;164;162;162;166;164 10:29:19 INFO - PROCESS | 12186 | |3;audio-fft;78;74;75;159;80;75;74;74;166;82 10:29:19 INFO - PROCESS | 12186 | |4;audio-oscillator;95;93;146;94;94;94;137;95;93;139 10:29:19 INFO - PROCESS | 12186 | |5;imaging-gaussian-blur;118;118;118;118;117;117;120;119;118;118 10:29:19 INFO - PROCESS | 12186 | |6;imaging-darkroom;147;148;148;149;148;147;148;148;148;147 10:29:19 INFO - PROCESS | 12186 | |7;imaging-desaturate;96;96;96;95;95;95;95;97;96;95 10:29:19 INFO - PROCESS | 12186 | |8;json-parse-financial;66;65;66;65;65;65;66;84;63;65 10:29:19 INFO - PROCESS | 12186 | |9;json-stringify-tinderbox;65;66;67;66;66;66;65;66;67;66 10:29:19 INFO - PROCESS | 12186 | |10;stanford-crypto-aes;81;78;79;81;81;80;81;83;81;83 10:29:19 INFO - PROCESS | 12186 | |11;stanford-crypto-ccm;134;136;152;132;137;138;138;150;164;132 10:29:19 INFO - PROCESS | 12186 | |12;stanford-crypto-pbkdf2;178;181;175;173;175;173;176;173;174;178 10:29:19 INFO - PROCESS | 12186 | |13;stanford-crypto-sha256-iterative;72;72;71;74;73;73;72;72;71;73 10:29:19 INFO - PROCESS | 12186 | __end_tp_report 10:29:19 INFO - PROCESS | 12186 | __start_cc_report 10:29:19 INFO - PROCESS | 12186 | _x_x_mozilla_cycle_collect,914 10:29:19 INFO - PROCESS | 12186 | __end_cc_report 10:29:19 INFO - PROCESS | 12186 | __startTimestamp1461950959742__endTimestamp 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | ------- Summary: start ------- 10:29:19 INFO - PROCESS | 12186 | Number of tests: 14 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.50 stddev:4.62 (4.0%) stddev-sans-first:4.90 10:29:19 INFO - PROCESS | 12186 | Values: 115.0 108.0 116.0 114.0 114.0 126.0 115.0 112.0 113.0 112.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:156.00 stddev:20.82 (13.3%) stddev-sans-first:22.08 10:29:19 INFO - PROCESS | 12186 | Values: 155.0 134.0 153.0 186.0 135.0 161.0 157.0 134.0 193.0 142.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:4.15 (2.5%) stddev-sans-first:4.27 10:29:19 INFO - PROCESS | 12186 | Values: 162.0 163.0 165.0 165.0 176.0 164.0 162.0 162.0 166.0 164.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:36.40 (48.5%) stddev-sans-first:38.16 10:29:19 INFO - PROCESS | 12186 | Values: 78.0 74.0 75.0 159.0 80.0 75.0 74.0 74.0 166.0 82.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:94.00 stddev:22.66 (24.1%) stddev-sans-first:23.54 10:29:19 INFO - PROCESS | 12186 | Values: 95.0 93.0 146.0 94.0 94.0 94.0 137.0 95.0 93.0 139.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 10:29:19 INFO - PROCESS | 12186 | Values: 118.0 118.0 118.0 118.0 117.0 117.0 120.0 119.0 118.0 118.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 10:29:19 INFO - PROCESS | 12186 | Values: 147.0 148.0 148.0 149.0 148.0 147.0 148.0 148.0 148.0 147.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 10:29:19 INFO - PROCESS | 12186 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 97.0 96.0 95.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:65.50 stddev:6.04 (9.2%) stddev-sans-first:6.39 10:29:19 INFO - PROCESS | 12186 | Values: 66.0 65.0 66.0 65.0 65.0 65.0 66.0 84.0 63.0 65.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 10:29:19 INFO - PROCESS | 12186 | Values: 65.0 66.0 67.0 66.0 66.0 66.0 65.0 66.0 67.0 66.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:1.55 (1.9%) stddev-sans-first:1.64 10:29:19 INFO - PROCESS | 12186 | Values: 81.0 78.0 79.0 81.0 81.0 80.0 81.0 83.0 81.0 83.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:138.00 stddev:10.54 (7.6%) stddev-sans-first:10.84 10:29:19 INFO - PROCESS | 12186 | Values: 134.0 136.0 152.0 132.0 137.0 138.0 138.0 150.0 164.0 132.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:175.50 stddev:2.67 (1.5%) stddev-sans-first:2.69 10:29:19 INFO - PROCESS | 12186 | Values: 178.0 181.0 175.0 173.0 175.0 173.0 176.0 173.0 174.0 178.0 10:29:19 INFO - PROCESS | 12186 | 10:29:19 INFO - PROCESS | 12186 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:0.95 (1.3%) stddev-sans-first:1.00 10:29:19 INFO - PROCESS | 12186 | Values: 72.0 72.0 71.0 74.0 73.0 73.0 72.0 72.0 71.0 73.0 10:29:19 INFO - PROCESS | 12186 | -------- Summary: end -------- 10:29:19 INFO - PROCESS | 12186 | 10:29:20 INFO - TEST-INFO | 12186: exit 0 10:29:20 INFO - TEST-OK | kraken | took 63418ms 10:29:20 INFO - SUITE-END | took 1179s 10:29:20 INFO - Completed test suite (00:19:39) 10:29:20 INFO - javascript benchmark 10:29:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.6085587161924, 2671.118530884808, 2692.9461410771787, 2693.9865300673496, 2712.145674112656, 4747.28790681398, 4751.6673832831675, 4780.067886762083, 4792.233242681172, 4843.176659967805, 4631.282151266559, 4742.312364707124, 4762.904741905159, 4815.927761083578, 4821.903561928768, 4372.147431250907, 4391.49497807753, 4433.9113217735785, 4441.600255976961, 4449.42157519522, 4379.934300985487, 4482.394876691654, 4483.4171557697455, 4525.615322697575, 4531.796069176895, 4237.406763053175, 4295.312749959991, 4362.454693163355, 4402.449693788277, 4448.088141930896, 4394.62645675118, 4429.3798868158165, 4436.778161091933, 4449.688521803475, 4488.483824360208, 4305.892352691177, 4338.891527711801, 4339.349097635349, 4346.304591265382, 4387.254166791653, 4553.590176884063, 4597.908041839178, 4608.400907881987, 4626.352310676508, 4652.930206046912, 5049.621278404097, 5055.0, 5078.7968481260705, 5100.617453690988, 5135.666181698215, 4917.852464426037, 5082.771275292621, 5125.205593133033, 5129.589632829365, 5154.5103215194495, 4715.504871988461, 4731.408573928259, 4735.360726301905, 4777.331173635694, 4777.880552986203, 5115.079285728604, 5174.01288543467, 5174.068667639861, 5185.792568297301, 5239.083160446907, 4780.378550788375, 4957.380327459067, 4974.204127339608, 4975.154223781966, 5018.397792264952, 4861.246506791453, 5071.41678706946, 5108.693478391234, 5112.36095488064, 5173.974130129401, 4949.282354058641, 4989.376327959005, 4993.675411098267, 5006.1739812930455, 5036.11867923112, 4800.543948324904, 4973.229149481764, 4973.751312434364, 5001.249812528077, 5013.323201367769, 4275.273203555403, 4286.5284818669925, 4294.957050429518, 4314.590113939171, 4328.523862375137, 3697.9091168105474, 3714.220013797079, 3719.34911390511, 3746.587875333711, 3756.73702840804, 4303.827846886152, 4304.0, 4362.847300344472, 4363.040131171138, 4421.425214722066, 5117.769700363493, 5119.513646203604, 5129.0, 5131.2559678846355, 5134.127198376285, 4413.492448368414, 4416.53626369233, 4426.336049592523, 4426.579474949875, 4467.5532446755715, 4435.090806384684, 4490.887727806766, 4552.6813123081065, 4553.863384098482, 4597.563231493003, 4790.976045119752, 4794.400699912511, 4794.712317260975, 4813.4945830687975, 4843.830465933675, 5087.669301495391, 5094.974525127351, 5098.031374038921, 5098.796048158032, 5102.872428189325, 4632.096741135446, 4776.23580227162, 4839.612830973443, 4841.782119804688, 4868.513148685103, 4899.755012249445, 4908.239222920453, 4915.410150781929, 4931.432885218246, 4974.452810190804, 4993.450720420678, 4999.750012499288, 5002.174641184164, 5017.899642007213, 5047.167217409086, 4759.928601071056, 4920.901581968412, 4945.208766597327, 4982.352294201731, 4988.077205716954, 4862.149123903374, 4877.926831097466, 4888.65614323821, 4910.754462276944, 4948.0, 4715.056988602225, 4783.995360974095, 4795.544423279783, 4817.156997525489, 4821.927671085006, 4914.778834952364, 4964.478729733326, 4990.176620857663, 5016.698998060128, 5022.974885125551, 4778.665493415428, 4805.352798053545, 4824.0, 4844.079624871263, 4849.0], "value": 4648.879690137629, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.2724730323612, 609.0316396928882, 618.4063299232737, 625.1248252446577, 625.8591816841212, 32548.511772323403, 33002.17494562634, 33045.0, 33217.0, 33428.66571334286, 33644.15889602761, 34202.65797342026, 34258.14354641135, 34433.82783086087, 34504.1373965651, 7483.513571617855, 7655.923440765577, 7665.310122089011, 7682.5006374585755, 7700.4224683148705, 7641.2740789624895, 7754.651040703154, 7755.6509957051785, 7755.806104847367, 7765.417593680469, 7728.845423091535, 7801.258880406353, 7802.570858602775, 7806.180351063113, 7823.608819559027, 7694.153643099255, 7699.923000769976, 7721.266479684421, 7749.147593764681, 7774.572398518079, 7683.57740324282, 7764.068311802564, 7769.456138070337, 7814.452988290822, 7819.100803407568, 34574.96275111726, 34941.47587786185, 35072.82463587691, 35097.64902350969, 35221.47167792485, 3342.1644588852787, 3346.5147553604834, 3735.795313075783, 3775.093977445393, 3925.2542017016676, 26713.19860404191, 26818.195454136407, 27192.592111118152, 27341.453170936667, 27652.723472765218, 3214.9678503214905, 3219.356128774231, 3225.306559089807, 3330.58367704037, 3392.9491057634154, 210373.0, 213083.0, 213460.0, 213916.93041534847, 214075.0, 29160.56259156114, 29898.0, 29933.401331973673, 30030.0, 48515.5148448511, 31660.683393165775, 31848.840755796075, 31991.0, 32060.67939320577, 32103.197420064218, 12540.749185016248, 12605.684857878627, 12704.55534056322, 12714.809277860839, 12715.809262861065, 10288.0, 10360.274780765425, 10370.688879333633, 10409.9479502602, 10625.46872656364, 8205.220504052106, 8226.383021273428, 8268.710595129141, 8271.1728827118, 8304.086550479442, 3209.7271731902583, 3229.111994201566, 3235.3044095519103, 3275.050235431698, 3295.6374798772117, 965.232640051147, 995.1590905684685, 1014.1481155829139, 1024.948752562369, 1054.599252284127, 28119.43761124807, 28293.57559636607, 28317.209306957116, 28387.858060709565, 28476.430471390457, 1018.8318927376899, 1029.613894789454, 1036.7149034015706, 1076.5101878645198, 1097.8956999085074, 15064.322105505278, 15120.773188402183, 15140.621484462976, 15191.848081519265, 15273.694526109415, 396223.0, 397523.0, 399045.0, 403467.0, 404870.0, 50181.49818501841, 50699.746501267255, 50700.74649626802, 50835.237471437955, 50965.745171273906, 1218.9390530473618, 1263.128441375448, 1264.6206138158516, 1272.3447424576536, 1298.195119026191, 27133.457330853667, 28037.579436308064, 28238.435231294847, 28618.284542886595, 28756.42487150287, 42860.35709464423, 42904.78547607242, 43389.0, 43492.0, 43501.56498434975, 250527.0, 250945.0, 251175.0, 251275.0, 252150.0, 25491.617625735256, 25912.22263332103, 33783.83108084444, 34788.30423391569, 35023.64976350204, 36835.447468288534, 37068.814655926544, 37532.437013445364, 38270.80864595659, 38409.0, 32107.357852842346, 32146.357072857943, 32191.839040804647, 32572.185695357806, 32642.0, 34912.30175396427, 35164.472532912536, 35194.0, 35224.82387588046, 35752.463713043806, 32237.838810805795, 33298.500522492664, 33513.0, 33744.49383259302, 34947.0, 29491.85254073716, 31638.683613164496, 31852.681473185898, 32375.0, 32550.0, 24039.75960240445, 24261.878690606434, 24405.755942441057, 24586.0, 24661.50676986486], "value": 15986.027589278328, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.88163787587973, 373.46967306424875, 376.28505838906074, 376.9076576238822, 381.7060863135388, 15822.287997040132, 16245.593860153487, 17356.218970146343, 17612.0, 17654.205560749764, 16141.83858161418, 16339.0, 17067.40264090757, 17185.914070429662, 17224.655506889856, 4990.401151861773, 5144.176931690911, 5162.277281180638, 5164.715940623264, 5170.146925757264, 3733.4773131761576, 5102.234664800272, 5583.469570390806, 5895.587308888379, 5896.380880007602, 5786.392428794979, 5802.216700745387, 5811.883762324751, 5853.268341457318, 5871.618344807595, 5646.971765141168, 5868.677222752747, 5896.145058966469, 5904.350521442638, 5911.645301281937, 4985.277134815431, 5197.818076367347, 5242.973785131088, 5253.290805741214, 5268.60485463588, 11719.882801172049, 11964.88035119655, 12015.579454719043, 12035.458404371824, 12049.879501204963, 1816.4732227653965, 1868.5795695968434, 1901.239504198318, 1965.4202010406964, 2022.646036943529, 9007.279417646572, 9071.863922041175, 9214.677486288016, 9414.435133891988, 9512.857307140399, 1762.8325309095744, 1784.2595322940963, 1864.4406677996546, 1896.0804010055112, 1902.6004539046817, 66239.66880165617, 68876.31123688749, 69007.30992690109, 69040.30959690388, 70272.6486367565, 9544.665936692183, 10039.0, 10081.647142349982, 10591.046805787517, 10725.678229653124, 14022.789658155136, 14103.576892693236, 14106.365213565414, 14115.78826317606, 14119.64700882486, 6992.3357281058215, 7023.92976070243, 7127.394171495377, 7183.676734546958, 7213.098362704662, 6600.933990660128, 6603.504737144734, 6619.536632435779, 6735.797926062226, 6742.696578653972, 4282.850100246476, 4336.333155109648, 4355.695101342875, 4361.781910904506, 4457.531959144308, 1740.9738853917202, 1764.4971183212722, 1802.5133214032137, 1887.981120188808, 1894.8199921007483, 921.5898924978454, 923.3674932671141, 927.0636656976502, 950.8193443245762, 950.8954015058338, 15485.767713484307, 15527.689446211012, 15600.29798659063, 16306.510804675878, 16394.344226231056, 858.852867830424, 877.0922095631119, 909.417972497602, 916.5554705967601, 976.414151509103, 9414.340996130206, 9429.66996155145, 9540.522973851279, 9595.808083838285, 9737.65918192874, 398894.0, 405176.0, 414365.0, 415000.3999840033, 419683.0, 78487.0, 78942.6052869732, 81128.0, 83875.5806220965, 83968.0, 993.9055789699967, 995.9850602240972, 1023.7850051489271, 1024.0834453164375, 1025.0723095598496, 14976.0, 15253.466128685443, 15273.541793746206, 15276.541703748906, 15624.0, 34854.82572587121, 34938.0, 35659.28681426409, 35913.0, 35992.100197495274, 49874.503764887115, 50284.49715502944, 51390.0, 51453.48546514487, 52216.73891630518, 7205.171405288459, 7748.845023099394, 7756.92243077562, 7792.181820908723, 7834.608269586612, 8091.757247282591, 9586.424814511152, 11256.268342557707, 11407.714807129889, 11552.364619945984, 9395.15443610051, 9718.319717619699, 9952.154066904393, 10012.899871001197, 10160.44117573511, 9784.315097943076, 9789.853152202864, 9972.052654997764, 10195.23535734808, 10327.48362581883, 8720.694775682821, 9594.520273986132, 9669.468179250209, 9925.1067403934, 10248.026437488426, 7477.446044958425, 7647.617619118911, 7690.884636730565, 7836.216378362346, 7886.72396466121, 8873.290136788912, 9312.997705493352, 9472.0, 9520.143187113194, 9584.137427631547], "value": 8088.5288278206, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.4990103364853, 1486.450013495007, 1633.6405990682047, 1751.229459038024, 1783.9108044597767, 6859.622720750357, 7536.095668519779, 7587.2792084752, 7871.370290376771, 7898.723544675945, 7665.1951545087795, 7678.3473404760525, 7761.883571746414, 7771.184025677293, 7774.727884524043, 2181.0512427094186, 2224.7219097612797, 2225.1544413122992, 2229.598672238996, 2235.765244649313, 2178.6623073423643, 2210.3258506155616, 2249.977500224993, 2254.729432468098, 2268.3421807675754, 2203.3389983005113, 2204.316661834828, 2218.8890555472244, 2226.2875879718495, 2247.202243203664, 2159.8380121490795, 2167.1548096242477, 2174.923877664282, 2182.018091858662, 2182.0399024429357, 2156.762756096828, 2182.9563408731897, 2186.0599942024924, 2194.4513871532117, 2201.020545857094, 7828.765137045898, 7877.212278772135, 7917.287444129998, 7962.800929976739, 7983.0, 4569.565891240327, 4650.395448591696, 4706.929396059062, 4717.646176536773, 4721.102990431841, 2806.852021110352, 2867.612872262239, 2900.3039270575123, 2901.956470652942, 2908.9272768180754, 915.803102332995, 916.2212119698203, 932.5943214701626, 935.1957316707626, 960.3661583354952, 10431.634892778793, 10583.788324233472, 10593.894061059367, 10614.150867930624, 10614.469276536141, 4327.480702315679, 4351.564843515623, 4411.735295882258, 4418.491873434532, 4418.7127836690515, 9168.129027742354, 9177.954110229539, 9188.494632795127, 9196.494192819458, 9210.677626283183, 4634.189016922025, 4641.048585040058, 4683.180443422388, 4785.449673287547, 4792.448868380111, 3748.194138260287, 4050.918981620351, 4236.872893813191, 4241.109367032957, 4324.437823082979, 3580.838862251205, 3591.299696559146, 3642.927141457156, 3725.6274372562525, 3727.29181455528, 1175.8882906123904, 1180.3861991764234, 1199.8800119988107, 1213.1204876464492, 1233.9136260461682, 732.9230430804795, 787.7400457848896, 807.11620775251, 900.9009009009004, 918.3525614441802, 5145.288367497929, 5308.867278317995, 5339.11904535755, 5430.755615997289, 5501.477359650827, 789.6091434739841, 821.117298903681, 827.6317038917624, 827.8261565071282, 842.0905422144069, 3588.138846676779, 3661.6704496594903, 3671.3391589514144, 3680.011142504663, 3691.501647277637, 9622.182114520205, 9903.306768526134, 9925.50372481373, 9958.651447199458, 10010.299279050541, 9858.802823943624, 9895.406275623485, 9914.950425247827, 9952.601895924083, 9952.751181220527, 7364.189939106694, 7561.962190189124, 7569.697212111564, 7571.3942884569105, 7582.886256706154, 5276.261323414648, 5352.437994010573, 5385.542228910586, 5404.0, 5641.4358564144895, 8950.552472376225, 8955.776105597412, 8986.775330616787, 9110.088991100836, 9246.95376523113, 9016.2786977043, 9198.908010920073, 9225.72322830316, 9306.208972237435, 9310.255179585753, 5787.479126878601, 6405.807825765234, 6443.387878151568, 6541.8691626166255, 6599.043138744759, 7656.540607563564, 7670.0795904491815, 7687.461877668509, 7746.612669366622, 7772.45592808498, 6737.326267373223, 6766.289539598468, 6948.235694073749, 6994.720211191699, 7048.330408611174, 6863.0, 6925.995730618932, 6933.583984960918, 6964.930350696428, 7017.859642807218, 6354.110424540476, 6369.426751592194, 6435.485161187187, 6468.967655161694, 6481.546291759721, 4651.3023046543285, 4717.716936983792, 4744.501827308083, 4807.831725889577, 4864.732439715708, 4841.419029716457, 4901.730404827626, 4923.138450771029, 4931.926021109614, 4958.628102892226], "value": 4202.23304494784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.7160782433214, 293.676955349116, 300.46367234486434, 302.750231059376, 311.95164749463834, 4979.402471703392, 5058.5953123750105, 5066.138756411409, 5074.832788458648, 5075.162598171307, 4949.688332591866, 4951.851444456663, 4969.353983982077, 4969.776360063796, 4976.87557811054, 3724.25514897021, 3791.7345785795005, 3927.293087244295, 3931.8820435386983, 3944.4872166618443, 3910.432987216852, 3932.803359832011, 3936.252112098692, 3949.545802232737, 3958.990457433365, 3901.161250331178, 3927.3912543555793, 3927.960720392802, 3943.191645712622, 3943.7830919299427, 3865.40086286626, 3923.058465968176, 3928.5874983126787, 3943.3099207638693, 3946.309395855714, 3477.1133360992785, 3489.057954352336, 3489.232368878868, 3489.9825500872334, 3522.0314413536225, 4770.282698228635, 4776.0, 4776.5701086902345, 4783.497732738082, 4806.327114204014, 4374.125174964988, 4480.708753930984, 4482.125985432842, 4485.932711009337, 4486.170058539148, 5109.259157422191, 5143.974280128576, 5157.819476318311, 5168.3797944246935, 5180.43015268324, 3717.9070523236865, 3742.55089389275, 3797.6012518685693, 3797.810109494514, 3810.771353718758, 5382.757775900055, 5416.647917885364, 5435.565154787647, 5439.048166570834, 5463.399026107165, 3529.99950042467, 3716.6655001050035, 3717.3272027587695, 3730.123420996064, 3731.7014638828828, 3755.192633583738, 3766.4915236443276, 3786.2928006475504, 3796.449514820391, 3796.6013568575454, 4324.200022995756, 4351.978240108842, 4373.409589705413, 4380.802863871133, 4382.276924307517, 5064.898702025939, 5179.378474583074, 5185.455527169668, 5215.16557350822, 5228.424873263938, 1384.3078460769616, 1401.061288936415, 1402.2427888940063, 1402.5021117503343, 1404.368034384531, 873.9431936924079, 914.8810654614857, 925.0379605210641, 952.9475878826593, 959.9520023998772, 4447.3773671685985, 4585.257602111243, 4586.908261834745, 4589.33454649074, 4591.357209990604, 5383.515483606494, 5396.2984811974975, 5399.217113518596, 5402.648827826179, 5404.270423492778, 4451.221036318631, 4541.477730061019, 4584.472785629629, 4597.7011494252765, 4602.424696912886, 3060.586820779211, 3089.474789285827, 3093.314143791639, 3095.7523398128096, 3100.0544833825898, 5405.135178371442, 5407.405185429599, 5416.674999499964, 5422.539084177889, 5423.810166644149, 5624.240727501735, 5877.177195192677, 5893.3222679391565, 5903.675297858659, 5904.380040095814, 5369.4362091980565, 5393.8112166074, 5396.406395296514, 5397.541208997279, 5402.91895621566, 5677.346265452962, 5707.286589176353, 5729.3984131665575, 5752.511036561939, 5759.136129580596, 5569.220309156641, 5604.775808967595, 5630.605857590093, 5644.6330988485615, 5688.317401911797, 5404.594655400782, 5436.592255580768, 5444.673319600836, 5451.127819548853, 5451.909618076321, 3571.7321200909514, 4002.2595819773437, 4004.6395824375945, 4016.578259282733, 4016.879493615196, 5365.919511207413, 5390.919136212881, 5397.703126327932, 5403.270558474555, 5410.48600382963, 5228.451012643618, 5236.083685355124, 5245.527902488794, 5254.65844720092, 5263.315768950012, 4928.457869634409, 5196.194589838581, 5206.823837459223, 5212.270282160424, 5249.868753281198, 5107.208382700539, 5153.639245252796, 5160.767765450489, 5171.3018742469285, 5186.922196167136, 4988.406028865043, 5049.520295571915, 5152.76812543429, 5201.583873290203, 5290.0, 5121.539061484335, 5140.665856719302, 5141.203113517411, 5166.8966620668125, 5181.611379146654], "value": 3996.350759270805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.098753595398, 724.3119036914928, 730.9817254568635, 731.7475470962517, 751.3238085722852, 11367.204295699305, 11896.583619573317, 11896.702582435444, 11926.344051077187, 11935.343556104412, 10991.340519568812, 11309.0, 11693.181477296592, 11716.121290903195, 11754.706132346675, 630.8895943209943, 787.8188016756164, 796.2992566541435, 796.5618909599726, 798.6845196147518, 774.5159275452842, 802.7150361621627, 802.7712102050916, 803.8512875118122, 805.0218983934518, 823.6540652925786, 828.0932379044937, 830.5473516933286, 831.0401486283353, 834.7829564313292, 815.9714409995681, 818.9959050204741, 820.122468958215, 823.9794005149889, 829.6598394658191, 602.2141105856855, 603.4146877528834, 605.4127496328555, 607.3076692570473, 611.2298503885092, 11279.774404511945, 11316.3210207387, 11385.772284554345, 11389.974902258753, 11390.943045284803, 11271.436428178558, 11537.653870383818, 11538.538458461651, 11552.0, 11746.412679365998, 9392.62429502819, 9519.904800951972, 9685.757856053584, 9699.0, 9713.70858874235, 3224.170338030694, 3228.1929517620597, 3269.558609587699, 3278.393497203025, 3300.504924261356, 45694.0, 45765.0, 46351.07297854058, 46355.841103972336, 46390.0, 8790.252828509649, 8914.86627700585, 9037.0, 9051.502167380857, 9056.683016094405, 16365.099919504304, 16416.261268242957, 16473.093979831225, 16497.83502164963, 16546.503604891874, 6424.967875160594, 6689.1972963244725, 6752.662366881636, 6900.171979362509, 7018.298170182941, 3581.910452238663, 3719.8512059517857, 3754.755940863835, 3768.9434658479595, 3800.0689830991582, 2783.73554512321, 2824.915252542427, 2839.929001774931, 2844.9431011379656, 2845.6869744328105, 480.75241250755187, 485.31085858080905, 486.96591238613667, 488.57982135363557, 502.4297422425573, 569.8262030080865, 592.9555283353766, 594.669958173218, 600.6396162302583, 603.1284793473476, 7130.2869713028285, 7357.8160545986775, 7493.812654683567, 7590.848183036419, 7662.846743065107, 479.29304276192335, 506.30636028641, 551.5670198893849, 568.2470726287686, 596.5615272774508, 3466.5666791651042, 3538.433850583894, 3630.6913912317223, 3679.521662183899, 3697.6672099511175, 55285.44714552884, 57470.7126464365, 57579.71210144006, 57820.0, 57936.0, 46299.0, 46672.766636166605, 47819.76090119527, 49894.0, 51024.48975510272, 47306.76346618245, 47467.28799068017, 47502.52497474981, 47677.046459070625, 48502.5149748498, 7975.082865470313, 8090.271875531231, 8191.79520511992, 8239.505629662239, 8367.58162091905, 30171.547426788176, 30406.84796576003, 30591.54112688356, 30757.23106922345, 31117.444127793067, 40194.387364821196, 40877.182456350114, 41048.384274235315, 41306.38040429456, 41529.96175095647, 10571.682849514527, 10628.309159904582, 10787.029167374974, 10823.621173258898, 11044.392558409365, 11886.583969561023, 11932.582359617372, 11936.0, 12048.096392770753, 12219.572314968933, 9480.0, 9609.51952402391, 9858.993351189589, 9951.601935922483, 10353.0, 11389.145814063813, 11434.94282528582, 11524.962753352238, 11537.538498460304, 11737.765244694887, 9943.950280248553, 10166.135878450119, 10314.174866010851, 10595.841062383915, 10706.304090234109, 9333.346665733605, 9592.76018099553, 9597.0, 9729.416235025921, 9893.307468477138, 9279.860802087838, 9514.38156519824, 9560.28297877648, 9564.234861211226, 9630.903690963281], "value": 5841.393592863686, "unit": "score"}], "name": "dromaeo_css", "value": 6238.9321566089475, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 116.0, 114.0, 114.0, 126.0, 115.0, 112.0, 113.0, 112.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 134.0, 153.0, 186.0, 135.0, 161.0, 157.0, 134.0, 193.0, 142.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 165.0, 165.0, 176.0, 164.0, 162.0, 162.0, 166.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 75.0, 159.0, 80.0, 75.0, 74.0, 74.0, 166.0, 82.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 146.0, 94.0, 94.0, 94.0, 137.0, 95.0, 93.0, 139.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 120.0, 119.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 149.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 84.0, 63.0, 65.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 79.0, 81.0, 81.0, 80.0, 81.0, 83.0, 81.0, 83.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 152.0, 132.0, 137.0, 138.0, 138.0, 150.0, 164.0, 132.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 181.0, 175.0, 173.0, 175.0, 173.0, 176.0, 173.0, 174.0, 178.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 74.0, 73.0, 73.0, 72.0, 72.0, 71.0, 73.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1600.5999999999997, "alertThreshold": 2.0}]} 10:29:20 INFO - Return code: 0 10:29:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:29:21 ERROR - # TBPL SUCCESS # 10:29:21 INFO - Running post-action listener: _resource_record_post_action 10:29:21 INFO - Running post-run listener: _resource_record_post_run 10:29:22 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519913472; Read time: 20; Write time: 346560 10:29:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 241176576; Read time: 0; Write time: 205976 10:29:22 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278736896; Read time: 20; Write time: 140584 10:29:22 INFO - Running post-run listener: _upload_blobber_files 10:29:22 INFO - Blob upload gear active. 10:29:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:29:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:29:22 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:29:22 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:29:22 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:29:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:29:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:23 INFO - (blobuploader) - INFO - Done attempting. 10:29:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:29:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:29:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:24 INFO - (blobuploader) - INFO - Done attempting. 10:29:24 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:24 INFO - Return code: 0 10:29:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:29:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1afcdda2b489a4091b9c85ce51a9440348d6dadfc1029e64d0f91a0c1eb723cb8e6719f572934cb97ba24354c52d9df939b7de78981d00633b15d68a42e1f85e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92ee3b4663849a75aab209addd52b9cad6c79f5666f1719092e1371d38a81c613d8f2f999fa58fee793dd92b2aaf05da1ca66265c535c71631b20a67c5c5f73b"} 10:29:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:29:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:29:24 INFO - Contents: 10:29:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1afcdda2b489a4091b9c85ce51a9440348d6dadfc1029e64d0f91a0c1eb723cb8e6719f572934cb97ba24354c52d9df939b7de78981d00633b15d68a42e1f85e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92ee3b4663849a75aab209addd52b9cad6c79f5666f1719092e1371d38a81c613d8f2f999fa58fee793dd92b2aaf05da1ca66265c535c71631b20a67c5c5f73b"} 10:29:24 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:24 INFO - Copying logs to upload dir... 10:29:24 INFO - mkdir: /builds/slave/test/build/upload/logs 10:29:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.814001 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-29 10:29:23.859124) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 10:29:23.863350) ========= 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=6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990 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/Fx-Team-Non-PGO/sha512/1afcdda2b489a4091b9c85ce51a9440348d6dadfc1029e64d0f91a0c1eb723cb8e6719f572934cb97ba24354c52d9df939b7de78981d00633b15d68a42e1f85e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92ee3b4663849a75aab209addd52b9cad6c79f5666f1719092e1371d38a81c613d8f2f999fa58fee793dd92b2aaf05da1ca66265c535c71631b20a67c5c5f73b"} build_url:https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/ZFQfehl6Re2G5iYXmiMChg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1afcdda2b489a4091b9c85ce51a9440348d6dadfc1029e64d0f91a0c1eb723cb8e6719f572934cb97ba24354c52d9df939b7de78981d00633b15d68a42e1f85e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92ee3b4663849a75aab209addd52b9cad6c79f5666f1719092e1371d38a81c613d8f2f999fa58fee793dd92b2aaf05da1ca66265c535c71631b20a67c5c5f73b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 10:29:23.894481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:29:23.895046) ========= 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=6dbc10da6d83fee962c624be000001a8-1461949695.496520-808193990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:29:23.978481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 10:29:23.979066) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 10:29:23.979638) ========= ========= Total master_lag: 0.18 =========