builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1462551819.77 results: success (0) buildid: 20160506090722 builduid: 4936efb8919448dea1ac9d3f31163d2c revision: 8c4044b1f2c9ece4b8f83e5646fb267b8fc13e77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:39.767292) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:39.767769) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:39.768054) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:39.785394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:39.785809) ========= 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=1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 09:23:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.1M=0s 2016-05-06 09:23:40 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085326 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:39.885152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:39.885497) ========= 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=1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019831 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:39.934624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:39.935091) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8c4044b1f2c9ece4b8f83e5646fb267b8fc13e77 --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 8c4044b1f2c9ece4b8f83e5646fb267b8fc13e77 --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=1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 09:23:40,644 truncating revision to first 12 chars 2016-05-06 09:23:40,644 Setting DEBUG logging. 2016-05-06 09:23:40,644 attempt 1/10 2016-05-06 09:23:40,645 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8c4044b1f2c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 09:23:40,920 unpacking tar archive at: fx-team-8c4044b1f2c9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.593368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:40.541702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:40.542056) ========= script_repo_revision: 8c4044b1f2c9ece4b8f83e5646fb267b8fc13e77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:40.542555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:40.542862) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:23:40.551251) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-06 09:23:40.551566) ========= /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=1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:23:41 INFO - MultiFileLogger online at 20160506 09:23:41 in /builds/slave/test 09:23:41 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 09:23:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:41 INFO - {'append_to_log': False, 09:23:41 INFO - 'base_work_dir': '/builds/slave/test', 09:23:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:23:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:41 INFO - 'branch': 'Fx-Team-Non-PGO', 09:23:41 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:41 INFO - 'config_files': ('talos/linux_config.py',), 09:23:41 INFO - 'default_actions': ('clobber', 09:23:41 INFO - 'read-buildbot-config', 09:23:41 INFO - 'download-and-extract', 09:23:41 INFO - 'populate-webroot', 09:23:41 INFO - 'create-virtualenv', 09:23:41 INFO - 'install', 09:23:41 INFO - 'run-tests'), 09:23:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:41 INFO - 'download_minidump_stackwalk': True, 09:23:41 INFO - 'download_symbols': 'ondemand', 09:23:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:41 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:41 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:41 INFO - 'installer_path': 'installer.exe', 09:23:41 INFO - 'log_level': 'info', 09:23:41 INFO - 'log_name': 'talos', 09:23:41 INFO - 'log_to_console': True, 09:23:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:23:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:23:41 INFO - 'opt_config_files': (), 09:23:41 INFO - 'pip_index': False, 09:23:41 INFO - 'sps_profile': False, 09:23:41 INFO - 'sps_profile_interval': 0, 09:23:41 INFO - 'suite': 'dromaeojs-e10s', 09:23:41 INFO - 'system_bits': '32', 09:23:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:41 INFO - 'title': 'talos-linux64-ix-027', 09:23:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:41 INFO - 'use_talos_json': True, 09:23:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:41 INFO - 'work_dir': 'build'} 09:23:41 INFO - ##### 09:23:41 INFO - ##### Running clobber step. 09:23:41 INFO - ##### 09:23:41 INFO - Running pre-action listener: _resource_record_pre_action 09:23:41 INFO - Running main action method: clobber 09:23:41 INFO - rmtree: /builds/slave/test/build 09:23:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:41 INFO - Running post-action listener: _resource_record_post_action 09:23:41 INFO - ##### 09:23:41 INFO - ##### Finished clobber step (success) 09:23:41 INFO - ##### 09:23:41 INFO - ##### 09:23:41 INFO - ##### Running read-buildbot-config step. 09:23:41 INFO - ##### 09:23:41 INFO - Running pre-action listener: _resource_record_pre_action 09:23:41 INFO - Running main action method: read_buildbot_config 09:23:41 INFO - Using buildbot properties: 09:23:41 INFO - { 09:23:41 INFO - "project": "", 09:23:41 INFO - "product": "firefox", 09:23:41 INFO - "script_repo_revision": "production", 09:23:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:23:41 INFO - "repository": "", 09:23:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:23:41 INFO - "buildid": "20160506090722", 09:23:41 INFO - "pgo_build": "False", 09:23:41 INFO - "basedir": "/builds/slave/test", 09:23:41 INFO - "buildnumber": 1485, 09:23:41 INFO - "slavename": "talos-linux64-ix-027", 09:23:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:23:41 INFO - "platform": "ubuntu64_hw", 09:23:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:23:41 INFO - "branch": "fx-team", 09:23:41 INFO - "repo_path": "integration/fx-team", 09:23:41 INFO - "revision": "8c4044b1f2c9ece4b8f83e5646fb267b8fc13e77", 09:23:41 INFO - "stage_platform": "linux64", 09:23:41 INFO - "builduid": "4936efb8919448dea1ac9d3f31163d2c", 09:23:41 INFO - "slavebuilddir": "test" 09:23:41 INFO - } 09:23:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:23:41 INFO - Running post-action listener: _resource_record_post_action 09:23:41 INFO - ##### 09:23:41 INFO - ##### Finished read-buildbot-config step (success) 09:23:41 INFO - ##### 09:23:41 INFO - ##### 09:23:41 INFO - ##### Running download-and-extract step. 09:23:41 INFO - ##### 09:23:41 INFO - Running pre-action listener: _resource_record_pre_action 09:23:41 INFO - Running main action method: download_and_extract 09:23:41 INFO - mkdir: /builds/slave/test/build/tests 09:23: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')]} 09:23:41 INFO - https://queue.taskcluster.net/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:23:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:23:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:23:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/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 09:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/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 09:23:42 INFO - Downloaded 1361 bytes. 09:23:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:23:42 INFO - Using the following test package requirements: 09:23:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:23:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:23:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:42 INFO - u'jsshell-linux-x86_64.zip'], 09:23:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:23:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:23:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:23:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:23:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:23:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:42 INFO - https://queue.taskcluster.net/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:23:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:23:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:23:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/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 09:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/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 09:23:48 INFO - Downloaded 22321850 bytes. 09:23:48 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'] 09:23:48 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 09:23:49 INFO - Return code: 0 09:23:49 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 09:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:49 INFO - https://queue.taskcluster.net/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:23:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:23:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:23:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/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 09:23:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/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 09:23:51 INFO - Downloaded 22321850 bytes. 09:23:51 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'] 09:23:51 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 09:23:52 INFO - Return code: 0 09:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:52 INFO - https://queue.taskcluster.net/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:23:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/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 09:23:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/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 09:23:53 INFO - Downloaded 10840152 bytes. 09:23:53 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'] 09:23:53 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 09:23:54 INFO - Return code: 0 09:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:54 INFO - https://queue.taskcluster.net/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:23:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:23:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:23:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/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 09:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUos7TwrTh-hLjFWMo7fFA/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 09:23:55 INFO - Downloaded 54841074 bytes. 09:23:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:23:55 INFO - mkdir: /builds/slave/test/properties 09:23:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:55 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:55 INFO - Contents: 09:23:55 INFO - build_url:https://queue.taskcluster.net/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:23:56 INFO - Running post-action listener: _resource_record_post_action 09:23:56 INFO - Running post-action listener: set_extra_try_arguments 09:23:56 INFO - ##### 09:23:56 INFO - ##### Finished download-and-extract step (success) 09:23:56 INFO - ##### 09:23:56 INFO - ##### 09:23:56 INFO - ##### Running populate-webroot step. 09:23:56 INFO - ##### 09:23:56 INFO - Running pre-action listener: _resource_record_pre_action 09:23:56 INFO - Running main action method: populate_webroot 09:23:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:56 INFO - '--tppagecycles', 09:23:56 INFO - '7'], 09:23:56 INFO - 'tests': ['tsvgm']}}, 09:23:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:23:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:56 INFO - 'talos_options': ['--disable-e10s'], 09:23:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:56 INFO - 'talos_options': ['--disable-e10s'], 09:23:56 INFO - 'tests': ['damp', 'tps']}, 09:23:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:56 INFO - 'tests': ['damp', 'tps']}, 09:23:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:56 INFO - 'tests': ['dromaeo_dom']}, 09:23:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:56 INFO - 'tests': ['a11yr', 09:23:56 INFO - 'ts_paint', 09:23:56 INFO - 'tpaint', 09:23:56 INFO - 'sessionrestore', 09:23:56 INFO - 'sessionrestore_no_auto_restore', 09:23:56 INFO - 'tabpaint']}, 09:23:56 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:56 INFO - 'ts_paint', 09:23:56 INFO - 'tpaint', 09:23:56 INFO - 'sessionrestore', 09:23:56 INFO - 'sessionrestore_no_auto_restore', 09:23:56 INFO - 'tabpaint']}, 09:23:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:56 INFO - 'ts_paint', 09:23:56 INFO - 'tpaint', 09:23:56 INFO - 'sessionrestore', 09:23:56 INFO - 'sessionrestore_no_auto_restore', 09:23:56 INFO - 'tabpaint']}, 09:23:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:56 INFO - 'ts_paint', 09:23:56 INFO - 'tpaint', 09:23:56 INFO - 'sessionrestore', 09:23:56 INFO - 'sessionrestore_no_auto_restore', 09:23:56 INFO - 'tabpaint']}, 09:23:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:56 INFO - 'tests': ['a11yr', 09:23:56 INFO - 'ts_paint', 09:23:56 INFO - 'tpaint', 09:23:56 INFO - 'sessionrestore', 09:23:56 INFO - 'sessionrestore_no_auto_restore', 09:23:56 INFO - 'tabpaint']}, 09:23:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:56 INFO - 'tests': ['a11yr', 09:23:56 INFO - 'ts_paint', 09:23:56 INFO - 'tpaint', 09:23:56 INFO - 'sessionrestore', 09:23:56 INFO - 'sessionrestore_no_auto_restore', 09:23:56 INFO - 'tabpaint']}, 09:23:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:56 INFO - 'tests': ['tsvgx', 09:23:56 INFO - 'tsvgr_opacity', 09:23:56 INFO - 'tart', 09:23:56 INFO - 'tscrollx', 09:23:56 INFO - 'cart']}, 09:23:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:56 INFO - 'tsvgr_opacity', 09:23:56 INFO - 'tart', 09:23:56 INFO - 'tscrollx', 09:23:56 INFO - 'cart']}, 09:23:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:56 INFO - 'talos_options': ['--disable-e10s'], 09:23:56 INFO - 'tests': ['tp5o']}, 09:23:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:56 INFO - 'tests': ['tp5o']}, 09:23:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:56 INFO - 'talos_options': ['--disable-e10s', 09:23:56 INFO - '--xperf_path', 09:23:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:56 INFO - 'tests': ['tp5n']}, 09:23:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:56 INFO - 'talos_options': ['--xperf_path', 09:23:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:56 INFO - 'tests': ['tp5n']}}, 09:23:56 INFO - 'talos.zip': {'path': '', 09:23:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:56 INFO - Running post-action listener: _resource_record_post_action 09:23:56 INFO - ##### 09:23:56 INFO - ##### Finished populate-webroot step (success) 09:23:56 INFO - ##### 09:23:56 INFO - ##### 09:23:56 INFO - ##### Running create-virtualenv step. 09:23:56 INFO - ##### 09:23:56 INFO - Running pre-action listener: _resource_record_pre_action 09:23:56 INFO - Running main action method: create_virtualenv 09:23:56 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:23:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:56 INFO - Using real prefix '/usr' 09:23:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:57 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:59 INFO - Installing pip.................done. 09:23:59 INFO - Return code: 0 09:23:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72af9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24410>, '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 0x1b25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b257a0>, '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': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:23:59 INFO - Using env: {'DISPLAY': ':0', 09:23:59 INFO - 'HOME': '/home/cltbld', 09:23:59 INFO - 'LANG': 'en_US.UTF-8', 09:23:59 INFO - 'LANGUAGE': 'en_US:en', 09:23:59 INFO - 'LOGNAME': 'cltbld', 09:23:59 INFO - 'MAIL': '/var/mail/cltbld', 09:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:59 INFO - 'MOZ_NO_REMOTE': '1', 09:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:59 INFO - 'NO_EM_RESTART': '1', 09:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:59 INFO - 'PWD': '/builds/slave/test', 09:23:59 INFO - 'SHELL': '/bin/bash', 09:23:59 INFO - 'SHLVL': '1', 09:23:59 INFO - 'TERM': 'linux', 09:23:59 INFO - 'TMOUT': '86400', 09:23:59 INFO - 'USER': 'cltbld', 09:23:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 09:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:59 INFO - '_': '/tools/buildbot/bin/python'} 09:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:23:59 INFO - Cleaning up... 09:23:59 INFO - Return code: 0 09:23:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72af9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24410>, '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 0x1b25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b257a0>, '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': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:23:59 INFO - Using env: {'DISPLAY': ':0', 09:23:59 INFO - 'HOME': '/home/cltbld', 09:23:59 INFO - 'LANG': 'en_US.UTF-8', 09:23:59 INFO - 'LANGUAGE': 'en_US:en', 09:23:59 INFO - 'LOGNAME': 'cltbld', 09:23:59 INFO - 'MAIL': '/var/mail/cltbld', 09:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:59 INFO - 'MOZ_NO_REMOTE': '1', 09:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:59 INFO - 'NO_EM_RESTART': '1', 09:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:59 INFO - 'PWD': '/builds/slave/test', 09:23:59 INFO - 'SHELL': '/bin/bash', 09:23:59 INFO - 'SHLVL': '1', 09:23:59 INFO - 'TERM': 'linux', 09:23:59 INFO - 'TMOUT': '86400', 09:23:59 INFO - 'USER': 'cltbld', 09:23:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 09:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:59 INFO - '_': '/tools/buildbot/bin/python'} 09:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:59 INFO - Downloading/unpacking psutil>=0.7.1 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:01 INFO - Installing collected packages: psutil 09:24:01 INFO - Running setup.py install for psutil 09:24:01 INFO - building 'psutil._psutil_linux' extension 09:24:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:24:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:24:01 INFO - building 'psutil._psutil_posix' extension 09:24:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:24:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:24:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:02 INFO - Successfully installed psutil 09:24:02 INFO - Cleaning up... 09:24:02 INFO - Return code: 0 09:24:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72af9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24410>, '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 0x1b25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b257a0>, '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': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:24:02 INFO - Using env: {'DISPLAY': ':0', 09:24:02 INFO - 'HOME': '/home/cltbld', 09:24:02 INFO - 'LANG': 'en_US.UTF-8', 09:24:02 INFO - 'LANGUAGE': 'en_US:en', 09:24:02 INFO - 'LOGNAME': 'cltbld', 09:24:02 INFO - 'MAIL': '/var/mail/cltbld', 09:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:02 INFO - 'MOZ_NO_REMOTE': '1', 09:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:02 INFO - 'NO_EM_RESTART': '1', 09:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:02 INFO - 'PWD': '/builds/slave/test', 09:24:02 INFO - 'SHELL': '/bin/bash', 09:24:02 INFO - 'SHLVL': '1', 09:24:02 INFO - 'TERM': 'linux', 09:24:02 INFO - 'TMOUT': '86400', 09:24:02 INFO - 'USER': 'cltbld', 09:24:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 09:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:02 INFO - '_': '/tools/buildbot/bin/python'} 09:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:24:04 INFO - Installing collected packages: mozsystemmonitor 09:24:04 INFO - Running setup.py install for mozsystemmonitor 09:24:04 INFO - Successfully installed mozsystemmonitor 09:24:04 INFO - Cleaning up... 09:24:04 INFO - Return code: 0 09:24:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72af9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24410>, '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 0x1b25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b257a0>, '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': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:24:04 INFO - Using env: {'DISPLAY': ':0', 09:24:04 INFO - 'HOME': '/home/cltbld', 09:24:04 INFO - 'LANG': 'en_US.UTF-8', 09:24:04 INFO - 'LANGUAGE': 'en_US:en', 09:24:04 INFO - 'LOGNAME': 'cltbld', 09:24:04 INFO - 'MAIL': '/var/mail/cltbld', 09:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:04 INFO - 'MOZ_NO_REMOTE': '1', 09:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:04 INFO - 'NO_EM_RESTART': '1', 09:24:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:04 INFO - 'PWD': '/builds/slave/test', 09:24:04 INFO - 'SHELL': '/bin/bash', 09:24:04 INFO - 'SHLVL': '1', 09:24:04 INFO - 'TERM': 'linux', 09:24:04 INFO - 'TMOUT': '86400', 09:24:04 INFO - 'USER': 'cltbld', 09:24:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 09:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:04 INFO - '_': '/tools/buildbot/bin/python'} 09:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:06 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:07 INFO - Downloading docopt-0.6.1.tar.gz 09:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:07 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:07 INFO - Running setup.py install for blobuploader 09:24:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:07 INFO - Running setup.py install for requests 09:24:07 INFO - Running setup.py install for docopt 09:24:07 INFO - Successfully installed blobuploader requests docopt 09:24:07 INFO - Cleaning up... 09:24:08 INFO - Return code: 0 09:24:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72af9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24410>, '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 0x1b25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b257a0>, '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': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:08 INFO - Using env: {'DISPLAY': ':0', 09:24:08 INFO - 'HOME': '/home/cltbld', 09:24:08 INFO - 'LANG': 'en_US.UTF-8', 09:24:08 INFO - 'LANGUAGE': 'en_US:en', 09:24:08 INFO - 'LOGNAME': 'cltbld', 09:24:08 INFO - 'MAIL': '/var/mail/cltbld', 09:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:08 INFO - 'MOZ_NO_REMOTE': '1', 09:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:08 INFO - 'NO_EM_RESTART': '1', 09:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:08 INFO - 'PWD': '/builds/slave/test', 09:24:08 INFO - 'SHELL': '/bin/bash', 09:24:08 INFO - 'SHLVL': '1', 09:24:08 INFO - 'TERM': 'linux', 09:24:08 INFO - 'TMOUT': '86400', 09:24:08 INFO - 'USER': 'cltbld', 09:24:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 09:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:08 INFO - '_': '/tools/buildbot/bin/python'} 09:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:08 INFO - Running setup.py (path:/tmp/pip-r9PnXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:08 INFO - Running setup.py (path:/tmp/pip-Gg8_11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:08 INFO - Running setup.py (path:/tmp/pip-QUU3mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:08 INFO - Running setup.py (path:/tmp/pip-btTmaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:08 INFO - Running setup.py (path:/tmp/pip-YjoYEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:08 INFO - Running setup.py (path:/tmp/pip-hVGSup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:08 INFO - Running setup.py (path:/tmp/pip-DF4J0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:08 INFO - Running setup.py (path:/tmp/pip-XM6KLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:08 INFO - Running setup.py (path:/tmp/pip-nMpWSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:08 INFO - Running setup.py (path:/tmp/pip-w4MU3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:08 INFO - Running setup.py (path:/tmp/pip-gM5IMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:09 INFO - Running setup.py (path:/tmp/pip-D_sKtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:09 INFO - Running setup.py (path:/tmp/pip-bgeJ4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:09 INFO - Running setup.py (path:/tmp/pip-fO3KZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:09 INFO - Running setup.py (path:/tmp/pip-2KVr1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:09 INFO - Running setup.py (path:/tmp/pip-ECWgvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:09 INFO - Running setup.py (path:/tmp/pip-LNFyn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:09 INFO - Running setup.py install for manifestparser 09:24:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:09 INFO - Running setup.py install for mozcrash 09:24:09 INFO - Running setup.py install for mozdebug 09:24:09 INFO - Running setup.py install for mozdevice 09:24:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:24:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:09 INFO - Running setup.py install for mozfile 09:24:09 INFO - Running setup.py install for mozhttpd 09:24:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Running setup.py install for mozinfo 09:24:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Running setup.py install for mozInstall 09:24:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Running setup.py install for mozleak 09:24:10 INFO - Running setup.py install for mozlog 09:24:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Running setup.py install for moznetwork 09:24:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Running setup.py install for mozprocess 09:24:10 INFO - Running setup.py install for mozprofile 09:24:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Running setup.py install for mozrunner 09:24:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:10 INFO - Running setup.py install for mozscreenshot 09:24:11 INFO - Running setup.py install for moztest 09:24:11 INFO - Running setup.py install for mozversion 09:24:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:11 INFO - Cleaning up... 09:24:11 INFO - Return code: 0 09:24:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72af9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24410>, '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 0x1b25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b257a0>, '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': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:24:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:11 INFO - Using env: {'DISPLAY': ':0', 09:24:11 INFO - 'HOME': '/home/cltbld', 09:24:11 INFO - 'LANG': 'en_US.UTF-8', 09:24:11 INFO - 'LANGUAGE': 'en_US:en', 09:24:11 INFO - 'LOGNAME': 'cltbld', 09:24:11 INFO - 'MAIL': '/var/mail/cltbld', 09:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:11 INFO - 'MOZ_NO_REMOTE': '1', 09:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:11 INFO - 'NO_EM_RESTART': '1', 09:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:11 INFO - 'PWD': '/builds/slave/test', 09:24:11 INFO - 'SHELL': '/bin/bash', 09:24:11 INFO - 'SHLVL': '1', 09:24:11 INFO - 'TERM': 'linux', 09:24:11 INFO - 'TMOUT': '86400', 09:24:11 INFO - 'USER': 'cltbld', 09:24:11 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 09:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:11 INFO - '_': '/tools/buildbot/bin/python'} 09:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:11 INFO - Running setup.py (path:/tmp/pip-jIGfNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:11 INFO - Running setup.py (path:/tmp/pip-YlcCc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:11 INFO - Running setup.py (path:/tmp/pip-U7JnUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:11 INFO - Running setup.py (path:/tmp/pip-lSljQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:11 INFO - Running setup.py (path:/tmp/pip-K_tFQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:11 INFO - Running setup.py (path:/tmp/pip-rmybPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:11 INFO - Running setup.py (path:/tmp/pip-NrWSTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:11 INFO - Running setup.py (path:/tmp/pip-lVJDpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:12 INFO - Running setup.py (path:/tmp/pip-y4Cras-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:12 INFO - Running setup.py (path:/tmp/pip-DAcORL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:12 INFO - Running setup.py (path:/tmp/pip-VAyHPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:12 INFO - Running setup.py (path:/tmp/pip-1s74Qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:12 INFO - Running setup.py (path:/tmp/pip-7X7n_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:12 INFO - Running setup.py (path:/tmp/pip-TC52Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:12 INFO - Running setup.py (path:/tmp/pip-gqKuBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:12 INFO - Running setup.py (path:/tmp/pip-5BAN0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:12 INFO - Running setup.py (path:/tmp/pip-MI2rQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:14 INFO - Downloading blessings-1.6.tar.gz 09:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:14 INFO - Installing collected packages: blessings 09:24:14 INFO - Running setup.py install for blessings 09:24:14 INFO - Successfully installed blessings 09:24:14 INFO - Cleaning up... 09:24:14 INFO - Return code: 0 09:24:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:15 INFO - Reading from file tmpfile_stdout 09:24:15 INFO - Current package versions: 09:24:15 INFO - argparse == 1.2.1 09:24:15 INFO - blessings == 1.6 09:24:15 INFO - blobuploader == 1.2.4 09:24:15 INFO - docopt == 0.6.1 09:24:15 INFO - manifestparser == 1.1 09:24:15 INFO - mozInstall == 1.12 09:24:15 INFO - mozcrash == 0.17 09:24:15 INFO - mozdebug == 0.1 09:24:15 INFO - mozdevice == 0.48 09:24:15 INFO - mozfile == 1.2 09:24:15 INFO - mozhttpd == 0.7 09:24:15 INFO - mozinfo == 0.9 09:24:15 INFO - mozleak == 0.1 09:24:15 INFO - mozlog == 3.1 09:24:15 INFO - moznetwork == 0.27 09:24:15 INFO - mozprocess == 0.22 09:24:15 INFO - mozprofile == 0.28 09:24:15 INFO - mozrunner == 6.11 09:24:15 INFO - mozscreenshot == 0.1 09:24:15 INFO - mozsystemmonitor == 0.0 09:24:15 INFO - moztest == 0.7 09:24:15 INFO - mozversion == 1.4 09:24:15 INFO - psutil == 3.1.1 09:24:15 INFO - requests == 1.2.3 09:24:15 INFO - wsgiref == 0.1.2 09:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72af9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24410>, '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 0x1b25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b257a0>, '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': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:15 INFO - Using env: {'DISPLAY': ':0', 09:24:15 INFO - 'HOME': '/home/cltbld', 09:24:15 INFO - 'LANG': 'en_US.UTF-8', 09:24:15 INFO - 'LANGUAGE': 'en_US:en', 09:24:15 INFO - 'LOGNAME': 'cltbld', 09:24:15 INFO - 'MAIL': '/var/mail/cltbld', 09:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:15 INFO - 'MOZ_NO_REMOTE': '1', 09:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:15 INFO - 'NO_EM_RESTART': '1', 09:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:15 INFO - 'PWD': '/builds/slave/test', 09:24:15 INFO - 'SHELL': '/bin/bash', 09:24:15 INFO - 'SHLVL': '1', 09:24:15 INFO - 'TERM': 'linux', 09:24:15 INFO - 'TMOUT': '86400', 09:24:15 INFO - 'USER': 'cltbld', 09:24:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 09:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:15 INFO - '_': '/tools/buildbot/bin/python'} 09:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:24:15 INFO - Cleaning up... 09:24:15 INFO - Return code: 0 09:24:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72af9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24410>, '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 0x1b25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b257a0>, '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': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:24:15 INFO - Using env: {'DISPLAY': ':0', 09:24:15 INFO - 'HOME': '/home/cltbld', 09:24:15 INFO - 'LANG': 'en_US.UTF-8', 09:24:15 INFO - 'LANGUAGE': 'en_US:en', 09:24:15 INFO - 'LOGNAME': 'cltbld', 09:24:15 INFO - 'MAIL': '/var/mail/cltbld', 09:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:15 INFO - 'MOZ_NO_REMOTE': '1', 09:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:15 INFO - 'NO_EM_RESTART': '1', 09:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:15 INFO - 'PWD': '/builds/slave/test', 09:24:15 INFO - 'SHELL': '/bin/bash', 09:24:15 INFO - 'SHLVL': '1', 09:24:15 INFO - 'TERM': 'linux', 09:24:15 INFO - 'TMOUT': '86400', 09:24:15 INFO - 'USER': 'cltbld', 09:24:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 09:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:15 INFO - '_': '/tools/buildbot/bin/python'} 09:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:15 INFO - Downloading/unpacking jsonschema 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:17 INFO - Downloading/unpacking functools32 (from jsonschema) 09:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:17 INFO - warning: no files found matching '*.txt' 09:24:17 INFO - no previously-included directories found matching 'build' 09:24:17 INFO - no previously-included directories found matching 'dist' 09:24:17 INFO - no previously-included directories found matching '.git*' 09:24:17 INFO - Installing collected packages: jsonschema, functools32 09:24:17 INFO - Running setup.py install for functools32 09:24:17 INFO - warning: no files found matching '*.txt' 09:24:17 INFO - no previously-included directories found matching 'build' 09:24:17 INFO - no previously-included directories found matching 'dist' 09:24:17 INFO - no previously-included directories found matching '.git*' 09:24:17 INFO - Successfully installed jsonschema functools32 09:24:17 INFO - Cleaning up... 09:24:17 INFO - Return code: 0 09:24:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72af9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24410>, '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 0x1b25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b257a0>, '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': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:24:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:24:17 INFO - Using env: {'DISPLAY': ':0', 09:24:17 INFO - 'HOME': '/home/cltbld', 09:24:17 INFO - 'LANG': 'en_US.UTF-8', 09:24:17 INFO - 'LANGUAGE': 'en_US:en', 09:24:17 INFO - 'LOGNAME': 'cltbld', 09:24:17 INFO - 'MAIL': '/var/mail/cltbld', 09:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:17 INFO - 'MOZ_NO_REMOTE': '1', 09:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:17 INFO - 'NO_EM_RESTART': '1', 09:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:17 INFO - 'PWD': '/builds/slave/test', 09:24:17 INFO - 'SHELL': '/bin/bash', 09:24:17 INFO - 'SHLVL': '1', 09:24:17 INFO - 'TERM': 'linux', 09:24:17 INFO - 'TMOUT': '86400', 09:24:17 INFO - 'USER': 'cltbld', 09:24:17 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 09:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:17 INFO - '_': '/tools/buildbot/bin/python'} 09:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:18 INFO - Downloading/unpacking flake8 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:24:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:24:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:24:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:24:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:24:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:24:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:24:20 INFO - no previously-included directories found matching 'docs/_build' 09:24:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:24:20 INFO - Running setup.py install for pep8 09:24:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:24:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:24:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:24:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:24:20 INFO - no previously-included directories found matching 'docs/_build' 09:24:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:24:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:24:20 INFO - Cleaning up... 09:24:20 INFO - Return code: 0 09:24:20 INFO - Running post-action listener: _resource_record_post_action 09:24:20 INFO - Running post-action listener: _start_resource_monitoring 09:24:21 INFO - Starting resource monitoring. 09:24:21 INFO - ##### 09:24:21 INFO - ##### Finished create-virtualenv step (success) 09:24:21 INFO - ##### 09:24:21 INFO - ##### 09:24:21 INFO - ##### Running install step. 09:24:21 INFO - ##### 09:24:21 INFO - Running pre-action listener: _resource_record_pre_action 09:24:21 INFO - Running main action method: install 09:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:21 INFO - Reading from file tmpfile_stdout 09:24:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:21 INFO - Reading from file tmpfile_stdout 09:24:21 INFO - Output received: 09:24:21 INFO - Usage: mozinstall [options] installer 09:24:21 INFO - Options: 09:24:21 INFO - -h, --help show this help message and exit 09:24:21 INFO - -d DEST, --destination=DEST 09:24:21 INFO - Directory to install application into. [default: 09:24:21 INFO - "/builds/slave/test"] 09:24:21 INFO - --app=APP Application being installed. [default: firefox] 09:24:21 INFO - mkdir: /builds/slave/test/build/application 09:24:21 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'] 09:24:21 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 09:24:37 INFO - Reading from file tmpfile_stdout 09:24:37 INFO - Output received: 09:24:37 INFO - /builds/slave/test/build/application/firefox/firefox 09:24:37 INFO - Running post-action listener: _resource_record_post_action 09:24:37 INFO - ##### 09:24:37 INFO - ##### Finished install step (success) 09:24:37 INFO - ##### 09:24:37 INFO - ##### 09:24:37 INFO - ##### Running run-tests step. 09:24:37 INFO - ##### 09:24:37 INFO - Running pre-action listener: _resource_record_pre_action 09:24:37 INFO - Running main action method: run_tests 09:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:24:37 INFO - Python 2.7.3 09:24:37 INFO - Return code: 0 09:24:37 INFO - grabbing minidump binary from tooltool 09:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:37 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 0x1b24410>, '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 0x1b25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b257a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:24:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:24:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:24:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:37 INFO - Return code: 0 09:24:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:24:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:24:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:24:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:24:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:24:38 INFO - Return code: 0 09:24:38 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/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:24:38 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/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:24:38 INFO - Using env: {'DISPLAY': ':0', 09:24:38 INFO - 'HOME': '/home/cltbld', 09:24:38 INFO - 'LANG': 'en_US.UTF-8', 09:24:38 INFO - 'LANGUAGE': 'en_US:en', 09:24:38 INFO - 'LOGNAME': 'cltbld', 09:24:38 INFO - 'MAIL': '/var/mail/cltbld', 09:24:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:38 INFO - 'MOZ_NO_REMOTE': '1', 09:24:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:38 INFO - 'NO_EM_RESTART': '1', 09:24:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:38 INFO - 'PWD': '/builds/slave/test', 09:24:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:38 INFO - 'SHELL': '/bin/bash', 09:24:38 INFO - 'SHLVL': '1', 09:24:38 INFO - 'TERM': 'linux', 09:24:38 INFO - 'TMOUT': '86400', 09:24:38 INFO - 'USER': 'cltbld', 09:24:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742', 09:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:38 INFO - '_': '/tools/buildbot/bin/python'} 09:24:38 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/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:24:38 INFO - mozversion application_buildid: 20160506090722 09:24:38 INFO - mozversion application_changeset: 8c4044b1f2c9ece4b8f83e5646fb267b8fc13e77 09:24:38 INFO - mozversion application_display_name: Nightly 09:24:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:38 INFO - mozversion application_name: Firefox 09:24:38 INFO - mozversion application_remotingname: firefox 09:24:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:24:38 INFO - mozversion application_vendor: Mozilla 09:24:38 INFO - mozversion application_version: 49.0a1 09:24:38 INFO - mozversion platform_buildid: 20160506090722 09:24:38 INFO - mozversion platform_changeset: 8c4044b1f2c9ece4b8f83e5646fb267b8fc13e77 09:24:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:24:38 INFO - mozversion platform_version: 49.0a1 09:24:38 INFO - using testdate: 1462551878 09:24:38 INFO - actual date: 1462551878 09:24:38 INFO - starting webserver on 'localhost:50534' 09:24:38 INFO - SUITE-START | Running 2 tests 09:24:38 INFO - TEST-START | dromaeo_css 09:24:38 INFO - operating with platform_type : linux_ 09:24:38 INFO - Initialising browser for dromaeo_css test... 09:24:38 INFO - TEST-INFO | started process 22621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPfkgu/profile http://localhost:50534/getInfo.html) 09:24:42 INFO - PROCESS | 22621 | 09:24:42 INFO - PROCESS | 22621 | (process:22689): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:24:43 INFO - PROCESS | 22621 | __metrics Screen width/height:1600/1200 09:24:43 INFO - PROCESS | 22621 | colorDepth:24 09:24:43 INFO - PROCESS | 22621 | Browser inner width/height: 1024/697 09:24:43 INFO - PROCESS | 22621 | __metrics 09:24:43 ERROR - PROCESS | 22621 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 09:24:44 INFO - TEST-INFO | 22621: exit 0 09:24:44 INFO - Browser initialized. 09:24:44 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:44 INFO - TEST-INFO | started process 22740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPfkgu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:46 INFO - PROCESS | 22740 | 09:24:46 INFO - PROCESS | 22740 | (process:22799): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:24:56 INFO - PROCESS | 22740 | RSS: Main: 164204544 09:24:56 INFO - PROCESS | 22740 | 09:25:46 INFO - PROCESS | 22740 | 1462551946212 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:27:57 INFO - PROCESS | 22740 | Cycle 1(1): loaded http://localhost:50534/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50534/tests/dromaeo/cssquery-ext.html) 09:27:59 INFO - PROCESS | 22740 | RSS: Main: 167088128 09:27:59 INFO - PROCESS | 22740 | 09:31:01 INFO - PROCESS | 22740 | Cycle 1(1): loaded http://localhost:50534/tests/dromaeo/cssquery-ext.html (next: http://localhost:50534/tests/dromaeo/cssquery-jquery.html) 09:31:01 INFO - PROCESS | 22740 | RSS: Main: 166719488 09:31:01 INFO - PROCESS | 22740 | 09:34:03 INFO - PROCESS | 22740 | Cycle 1(1): loaded http://localhost:50534/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50534/tests/dromaeo/cssquery-mootools.html) 09:34:04 INFO - PROCESS | 22740 | RSS: Main: 168042496 09:34:04 INFO - PROCESS | 22740 | 09:37:06 INFO - PROCESS | 22740 | Cycle 1(1): loaded http://localhost:50534/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50534/tests/dromaeo/cssquery-prototype.html) 09:37:06 INFO - PROCESS | 22740 | RSS: Main: 165609472 09:37:06 INFO - PROCESS | 22740 | 09:40:09 INFO - PROCESS | 22740 | Cycle 1(1): loaded http://localhost:50534/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50534/tests/dromaeo/cssquery-yui.html) 09:40:10 INFO - PROCESS | 22740 | RSS: Main: 167411712 09:40:10 INFO - PROCESS | 22740 | 09:43:12 INFO - PROCESS | 22740 | Cycle 1(1): loaded http://localhost:50534/tests/dromaeo/cssquery-yui.html (next: http://localhost:50534/tests/dromaeo/cssquery-dojo.html) 09:43:13 INFO - PROCESS | 22740 | RSS: Main: 169005056 09:43:13 INFO - PROCESS | 22740 | 09:43:13 INFO - PROCESS | 22740 | __start_tp_report 09:43:13 INFO - PROCESS | 22740 | _x_x_mozilla_page_load 09:43:13 INFO - PROCESS | 22740 | _x_x_mozilla_page_load_details 09:43:13 INFO - PROCESS | 22740 | |i|pagename|runs| 09:43:13 INFO - PROCESS | 22740 | |0;dojo.html;2638.564636834922;2655.760981511665;2662.094887738171;2663.4273631169294;2673;4654.837080702172;4677.555632214942;4696.436427628685;4776.020915712279;4832.661713680044;4711.764411779406;4773.594244489213;4791.616670666347;4816.7350795706225;4840.709557426557;4357.368181613656;4396.384506169139;4471.150481408538;4490.146872094291;4500.34744961982;4414.668899832509;4607.3549703041435;4618.399608050949;4650.162970665279;4657.301404789275;4342.174986752507;4347.69566130371;4368.978155109204;4432.667549933768;4509.887252818673;4422.292433210703;4422.867313980586;4431.135928493945;4446.977765111186;4488.079943611585;4463;4464.397306363632;4466.82132714691;4468.396766436522;4515.683902126852;4717.95282047182;4774.236122220428;4774.976125119387;4795.712257264575;4807.11068452334;5224.164133738622;5230.320058392384;5249.291345668324;5251.133562962106;5276.630635855492;5054.1660625996665;5267.183586544092;5277.920831187535;5281.841544753664;5283.181106928432;4866.58634016109;4894.99652571222;4915;4924.43369012561;4941.975290123598;5369.40936496985;5411.188321751769;5419.701916394557;5427.891442171213;5474.343078830566;4926.211806111005;4960.70235785854;5173.275741396207;5175.715335656575;5178.585713142939;5059.671121377172;5085.593152547787;5106.361704786902;5119.795208191631;5172;5013.674111182761;5089.211172268304;5105.2597373381395;5160.251763494272;5189.325387699575;4979.30289759434;5167.250748641426;5168.586513078944;5180.171172612364;5187.221916712523;4375.518692943773;4402.779861006937;4422.557744225552;4426.734395936254;4432.268675668479;3851.9229615407535;3857.8263978121054;3882.8446862125766;3884.4561761353434;3907.023244188953;4413.051193993307;4466;4485.506594274627;4518.548145185455;4522.954770452319;5204.7918083277;5247.973760131251;5264.6314757966575;5271.156614941591;5301.3373328333955;4410.29435290352;4504.189245935698;4510.0979804039325;4518.051209246095;4554.772261386917;4573.47405048417;4687.437507499122;4688.226442636927;4745.786439610226;4786.305985632064;4844.781984810622;4867.853964381075;4869.488703686133;4904.926426103682;4925.335079764258;5232.686038837682;5239.24031015493;5239.554637855673;5254;5259.47405259471;4677.041206552581;4752.239641657318;4778.163821331323;4786.425628924551;4839.564439200489;5100.69395836251;5125.2568377585785;5125.513076257749;5131.153359695758;5183.352080989876;5142.485751424828;5142.820001299937;5146.948530514647;5162.586993040472;5162.612804039637;4855.635827313036;4875.390576177978;4959.70241785494;4996.650234483552;5015.473375295542;4985.501449855131;5028.296038554532;5039.042581909425;5044.571211447068;5070.8225212117395;4992.201247800334;5001.399832020035;5028.773705183348;5044.772985215747;5072.594192464668;4897.289892965571;5024.0956627807345;5028.069807085701;5057.367829021372;5110.642255042111;4902.950970490249;4943.975280123576;4956.603471722326;4971.577415919687;5023.1711767557945 09:43:13 INFO - PROCESS | 22740 | |1;ext.html;582.4466756581246;611.5963464113686;617.2284644194757;625.9499240060795;630.501903496238;36114;41402.378964315525;41505.58494415055;41524;41648.58351416492;41716.58283417165;42159.78920105395;42344;42374;42422;7721.459497835153;7846.136924938281;7870.527768333918;7896.249856263646;7918.049834019926;7758.262965018343;7869.52782833029;7870.645820938043;7882.724104656339;7888.250616191482;7889;7929;7932.524048557077;7937.841243175133;7954;7903.683852645887;7923.683052677915;7925.524468531907;7930.841383172362;7938.40461965352;7827.217278272185;7855.803604909923;7893.539695156414;7893.565853878034;7894.486858354188;31118.53322200169;38734.418983715266;38795.22409551793;38991.61008389908;39020.41469377962;3110.3934732727125;3197.2006998250436;3248.691374319436;3366.208940898887;3374.3926093303194;30812.38375232483;30872.8456357719;30905.690943090507;31002.897280936704;31988.360232795447;3391.1522119470133;3463.8614455421753;3488.8953331399844;3608.8015159166234;3703.3519134151684;272734;273667;274112;275174;275982;35255;36323.63676363203;63166;63288.36711632825;63721.36278637247;37227.81386093106;37264;37281.62718372782;37355.813220934266;37476.06501317377;12634.305113218677;12674.556390526472;12713.682157946125;12730.23618582888;12778.233306001484;11937.88062119385;11961.820572691417;11993.520259189709;12036.097292703082;12091.214071085527;8477.915220847835;8576.528290944058;8580.613872375758;8601.78495537604;8672.696455624024;3358.277970236411;3384.983075084609;3409.7954122752712;3410.4884267360094;3419.794812311269;934.4019827310527;945.0691069296737;962.8026254617787;1022.8005538919839;1030.2015937648232;30068;30243.578760763947;30262.54606180909;30468.695313046584;30628.693713062585;1029.1920842138884;1052.5158427123608;1053.7681710023783;1059.6185373265773;1106.5407855739938;15846.207689615474;16038.599035023984;16167.757483637755;16275.267612957208;16511.422100226435;404949;407680;410588;410700;410926;52507.21239181415;53023.20465193025;53251.467485325426;53342.466575334525;53479.73260133674;1290.1420555330787;1294.9482020719254;1328.4752522753458;1329.7074643578396;1331.5539294336506;28326.716732832407;29336.26659333534;29517;29619.555706664847;30163;46066.30900536427;46512.30231546462;46566.30150547812;46701.53298466972;47096.7645161772;319684;321145;324669;324876;326019;26936.191914242605;27241.31896702519;27271.86364068167;27391.589126163522;27477.17568472949;44126.779366102965;44968.55031449644;45034.54965450435;45802.08395831998;45831.31253031274;38622.80688596539;38748.6125138745;38941.41587876241;39040;39405.802970984965;37592;37728.245435091696;38005.42991855069;38237.61762382452;38375.42436863393;36542;38334.233315334095;39425;39716.40425393564;41451;31384.372312553165;34851;35247.82376088206;35261.47107793334;35479;26521.336966575218;26824.731752682223;26867.462650746485;26888.193354199404;27218.591721124594 09:43:13 INFO - PROCESS | 22740 | |2;jquery.html;374.6197609426432;378.249175386857;378.62137862137877;382.2336215887146;391.1882843100567;16105.194740262983;16542.17289135543;17375.503437563766;17463.650726985452;17575.384861529834;17307;17455.73816392755;17573.3849315274;18225.36211232604;18315.267389304412;4586.495485496601;4753.643476739258;4778.450478195;4780.450248221447;4799.376081109468;3468.1156305142154;5148.536631703146;5432.158015507603;5433.755481003364;5528.143137813625;5476.2333273341765;5479.205515200293;5487.862803429906;5504.174373843915;5512.33851937768;5002.874928126807;5304.416514183436;5310.548603368699;5374.7043912584795;5384.757685904144;5026;5200.29795977542;5345.1714984177515;5370.7046112463795;5387.380451248078;12248.690066483128;12481.563145289962;12630.684232894158;12661.177023493443;12666.176698514568;1716.6223430845318;1875.3436297295973;1941.708743688444;1993.900304984745;2046.2326627514683;9043.59303831329;9473.384230025027;9601.855972160423;9702.27232957531;9754.219662426989;1626.2356692354574;1697.524693085938;1775.6892543804784;1790.1228398084845;1790.185465613143;61535.38464615341;64547.70904581929;72373.27626723718;73464.63267683628;75070.62464687697;9824.557894894748;9842.80314393708;9860.408375497493;10141.797164056825;10329.173666106693;14177.78733319001;14227.573172804832;14298.356573953988;14309.57071287863;14346.210958397389;7470.5144165630145;7598.848023039508;7647.770566883002;7694.615269236516;7714.807129821687;7143.42852571793;7327.560346379234;7418.406527477789;7460.843569246776;7522.398208143335;4315.870523884289;4405.823767049346;4407.801648925806;4430.291153415503;4467.776611169428;1722.3885520639992;1795.784505859279;1845.355423039513;1881.8306352428347;1888.7355770192185;831.6922738586761;911.694582314932;941.7975135345796;950.2255661635745;973.0950216298769;15190.620234494227;16616.83383166153;17078.48764537066;17138.742918856227;17552.210150543255;899.5277479323407;900.8558630619201;929.7210836748948;987.1559816357055;988.6391467114452;9470.573824177929;9733;9753.902460975441;9889.357191782512;9904.504774761233;380354;382796;398691;415405;418477;74096.62951685207;74719.25280747232;75209.6239518799;77010;77792;907.1155623267261;912.2337236721186;918.6187732091241;933.5658918602883;939.0703203828161;14901.874597283982;15205.6198595036;15234.923825381245;15265.847341526887;15365;33962.320753585285;34593.65406345904;35145;35393.64606353903;35746.463803042454;45659;45740.31389529226;46913.53086469092;47687;47758.522414775405;7831.608419579112;7881.13307536182;7931.286184243446;7966.84066318682;8002.9599852000365;11071.667849964513;11684.357360345262;11863.228890122115;11957.103217258915;12138.514459421523;9864.802703946025;10414.271001029856;10653.094486968694;10655.413952232391;10665.680029599125;10311.845322320021;10354.792904142025;10633;10703.19726020536;10745.785084298426;10165.695029149138;10519.474026298807;10767.300125491818;10830.891691082988;11106.333619982504;7722.691092356243;7987.64055617487;8007.759767206993;8037.397195210499;8155.429119961545;9435.716928492157;10633.426861669293;10821.350718956888;10978.725531861448;11026.50380732885 09:43:13 INFO - PROCESS | 22740 | |3;mootools.html;1364.7202323523675;1405.3113974152668;1430.141914851089;1516.0600427734812;1531.647721024165;6671.733130674767;7324.890126648104;7362.484626076177;7632.122305934819;7821.452498325119;7410.184879663233;7698.384129269659;7702;7703.999999999986;7718.8456230875345;2188.6607575825774;2234.8770817605027;2238.171876405724;2238.630625946725;2243.45035466311;2220.156340590573;2226.421130506064;2275.6586512023246;2280.5894938910988;2283.246528645543;2179.858309209896;2199.186301068599;2214.136486770161;2257.525919556895;2258.175765845471;2265.354374003401;2266.320103968811;2275.476640372707;2293.3578597992587;2298.0118549023914;2163.8268938484885;2195.2316689158824;2196.8132708719777;2200.3728937252804;2206.2167930384644;7776.066871975343;7810.765677029698;7825.0218722659665;7828.021497312836;7833.451658383916;4406.603405693471;4507.3689683444345;4523.411956445674;4529.456465224194;4539.455265368144;2758.6965433802266;2862.255813488508;2865.799394042418;2874.7125287471295;2892.450434417454;868.2402897464718;898.24996128233;915.1260546178383;915.940463869853;917.6742256498981;10231.488425578691;10271.897281027168;10281.177505799593;10330.431826249629;10371.585136594527;3992.6606238469476;4046.1503084352616;4081.8775436736946;4106.958930410718;4136.338185890243;8178.263956243966;8259.876101858477;8293.709720159886;8294.170582941657;8324.916750832535;4450.221211288012;4459.175052615276;4485.327200919823;4497.325401189848;4500.819967201275;3625.9456108158397;4020.7788571628257;4132.40080188371;4181.059261666162;4253.3194688849635;3504.807235602015;3519.278547897726;3526.3299973005046;3560.0743806610467;3716.9814150929074;1059.2267644619317;1064.8243039898484;1072.7908057928785;1073.9087177589836;1078.757279612081;786.949422520941;868.7654333329965;876.6668665906915;896.9641214351483;906.4833045164193;4991.251312303184;5006.674566153189;5014.473480284591;5018.698878067327;5019.67372120811;402.2638571414305;406.99389509157385;413.52238164919567;413.6628647652154;418.4037746211636;3590.335787879251;3595.1910820065277;3677.9080522986606;3680.411134218512;3743.494628225209;8876.934767827903;9193.586288616894;9330.626774928927;9350.251979841732;9383.765405864771;9166.17504424605;9219.769505762275;9283.25733941283;9374.296927730447;9388.155066043952;7087.1849737279845;7100.5029647925185;7203;7227.602481863443;7333.303336183054;5167.715775632376;5174.016936781999;5184.118699821115;5271.20931860224;5355.571554275726;8226.136255693305;8663.696770612998;8675.305975521816;8765.649374025223;8768.736937891874;8741.125887411208;8795.956020219857;8805.647774088964;8899.065598112105;8942.195202431813;6547.279799222177;6985.231624521197;7090.539114957512;7236.819079523054;7265.273472652692;7406.222346653523;7429.962850185714;7447.962760186165;7482.738104166328;7489.8876516851205;6521.217453905561;6545.083688283739;6622.271550129578;6680.5323627345615;6722.394984451423;6560.245571759118;6594.10979517759;6638.468922486093;6639;6744.224414192235;6352.36476352361;6428.935710643021;6440.452561532322;6479.222493300834;6485.44873685742;4350.238708225985;4524.140413321458;4557.453105627346;4623.3758442609815;4666.743329116795;4628.097520983376;4696;4707.082118986902;4730.739809310521;4794.808207671794 09:43:13 INFO - PROCESS | 22740 | |4;prototype.html;297.16496644429157;308.46789288477373;310.3792415169661;316.2867733261495;316.51257064121256;4832.994307362449;4904.509549045094;5011.494252873563;5012.170557746424;5022.598192144629;4885.9511404886025;4918.409790825097;4925.359703238583;4936.531029552196;4938.333325001124;3857.7106716996195;3876.186000939806;3887.378019516878;3887.533495980479;3919;3673.3020726062095;3882.514685664292;3890.9610903891025;3897.1036661567855;3903.7852918089493;3803.2963901678277;3821.617838216184;3823.5985221551614;3840.423936409547;3844.2311537692435;3793.2603142387106;3814.9618503814886;3815.275097731436;3839.6352346527037;3847.269018886431;3386.1196089016785;3393.2025973896116;3398.2014226656715;3398.9660103398896;3409.369266685671;4608.654350923694;4665.790039448233;4675.532446755297;4727.3854398927915;4742.786574604151;4362.76004819738;4363.432753742025;4385.846495372679;4389.18800021997;4401.493828209765;5118.411382691001;5120.462351453081;5122.20605806097;5124.231365295198;5155.922661160085;3573.6962358199585;3624.1302087499075;3677.485152078711;3680.4847321375028;3683.1712864605515;5341.332333458279;5399.191270924245;5414.620976531644;5418;5421.051316019681;3713.387291096939;3721.6464435878547;3733.757305775116;3735.850565977385;3743.2513497300106;3773.2453509298252;3790.753601015925;3829.904252393657;3830.8276127574327;3841;4105.363668631367;4356.520782713899;4357.716748411343;4362.7818609070055;4375.868723938287;5186.040582492251;5199.844004679866;5226.869328266747;5241.580673546107;5251.689256727028;1203.5667159822458;1240.6092080994458;1262.9810552841714;1269.27651238793;1272.8727127287198;861.866410706329;872.4024043530076;873.6592728835759;874.8469017921839;883.3595643158659;4320.783960801948;4373.300271956472;4402.449693788277;4452.4211852458975;4477.283634618446;5095.197641297272;5111.207762796773;5117.897642047138;5134.204198349262;5134.739440455338;4423.1153769246275;4443.711158774734;4459;4475.776211189427;4479.350494178326;2641.630171775953;2798.286436958603;2799.2861820236117;2827.618271533358;2828.6464191976;4843.588294994895;4875.731834749052;4956.90086198274;4971.235211499866;4985.626078044161;5203;5343.385510666323;5460.116259890331;5481.834675303313;5485.040117979338;4802.255650374198;4826.77968134662;4835.808366478108;4854.247591623304;4869.587819532367;5220.216967454912;5231.3199284092825;5249.527542521038;5277.261183434245;5278.683279003272;5029.622778291569;5080.26336181259;5157.277981082727;5179.30079439286;5187.948120518898;4780.255206849405;4818.397700287464;4821.662483626253;4892.993872512253;4910.21436570147;3607.981960090183;3642.4354225095153;3653.9269214616093;3673.651003154696;3703;5068.72122033277;5172.19830926207;5210.957808438403;5250.477361565103;5273.419923808301;5067.5185857343495;5075.6042088425975;5078.949210507848;5111.207762796773;5133.409657889241;5006.299118123538;5061.58343118401;5071.568916642127;5074.289599456153;5081.745912704424;4787.928181077356;4891.486393928586;4945.205958633361;4952.851414457572;4971.9005619886675;5032.3961124665275;5062.898742025212;5063.35440981675;5106.617003724809;5108.438071812172;4805.975970120127;4874.463808980939;4937.210046392704;4979.751012449436;5015.448300686994 09:43:13 INFO - PROCESS | 22740 | |5;yui.html;751.4138971602152;770.1182146442322;791.6833266693322;804.4047404920357;819.2462934100627;14185.929070354647;14526.782098268508;14653.633659158526;14755.631109222275;14765.630859228499;14104.15375077496;14167.858321416783;14176.362063707133;14196.503122390719;14245.928770356133;691.1119211812821;857.4855086947844;874.8425283448977;883.7702197428666;893.7452825944574;887.5562218890555;888.0719647967857;890.4924193209873;890.8040231149137;890.8930928288614;913.1005959130251;917.6604656277186;917.729269865388;919.1681528216974;921.0789210789211;908.5684299957534;909.9772505687345;911.5487833522383;911.7492689510404;911.7629416351763;670.0853335197469;671.4896678524308;674.0596867370041;674.2212744280364;675.0684056002734;13166.407511661999;13271.336433178303;13299.20204787716;13299.268540230283;13333.799993000113;13005.284709340982;13041.543545975845;13043.804342934864;13070.411831467512;13282.73434531304;9843.852342214872;10166.59333626654;10251.53868075931;10355.068043876012;10369.844452333222;3412.419888618916;3419.982900085484;3444.7416443766565;3445.0753984491103;3511.0695665648623;43414.782926085485;43547.78226108849;43967.99999999968;43994.34008489875;44146.337804932955;9320.067993200626;9374.11568459036;9437.292203084797;9472;9518.95240523793;18389.448316550526;18410.26358945627;18577.44267671972;18702.438926832216;18777.53056173579;6720.193576770721;6972.337627925339;6995.475339349569;7021.122359705037;7184.461165412615;3726.6459686329754;3739.775613463201;3746.119661879456;3793.430985352219;3842.4044273137706;2950.542665886791;3046.8933587324336;3053.9389212215633;3061.525463553153;3063.2188791857934;532.9014132385521;545.9727013649301;549.9378223453105;558.2742434834698;559.6809818403552;631.2834932351722;658.9670516474253;667.7696194812781;668.5153263883743;671.4460570029745;7964.561949092739;8199.075128481922;8214.4660597061;8249.381296402793;8452.57737113142;498.980040798364;603.3212635784743;618.5855476830534;628.214731585518;632.1371328137152;3731.272401881661;3778.7354885157774;3787.280416720814;3807;3902.9609703903166;49588.752056239486;49651.50348496541;51074.489255107714;51246;51356.48643513592;46148.538514614425;46164.076718466116;46252.306215406796;47122.29316560255;47474;38569.421458678145;39414.2117157661;39563.40654890179;43237.135257295304;44182.33726494105;8401.243888050105;8419.579021049045;8425.199606037417;8540.14598540141;8651.307895368229;27278.590821137303;27895.302617434725;28611.14166575006;29310.41379172362;29743.702562974093;37477.812610937865;37558.62441375551;37925;38028;38647.03382415462;10533.841992370273;10539.156867450432;10603.310784798963;10709.08972737326;10797.838032429678;11921.82117268259;11971.694020137453;12101.81847272274;12135.635930922086;12207.45066471993;11225.831612525983;11298.717532061764;11407.543698251977;11504.597339093092;11549.88450115488;11365.033972112464;11375.146863985068;11439.771204576029;11509;11870.347130907883;8169.0605580359015;10449;10905.18211134184;10938.398388088732;11571.132165087483;9408;9497.382670126419;9818.901810982084;9965.800683986135;10325.432101234504;9925.255605829447;10012.249081319076;10106.595736170471;10184;10241.897581024392 09:43:13 INFO - PROCESS | 22740 | __end_tp_report 09:43:13 INFO - PROCESS | 22740 | __start_cc_report 09:43:13 INFO - PROCESS | 22740 | _x_x_mozilla_cycle_collect,370 09:43:13 INFO - PROCESS | 22740 | __end_cc_report 09:43:13 INFO - PROCESS | 22740 | __startTimestamp1462552993211__endTimestamp 09:43:13 INFO - PROCESS | 22740 | 09:43:13 INFO - PROCESS | 22740 | ------- Summary: start ------- 09:43:13 INFO - PROCESS | 22740 | Number of tests: 6 09:43:13 INFO - PROCESS | 22740 | 09:43:13 INFO - PROCESS | 22740 | [#0] dojo.html Cycles:165 Average:4785.87 Median:4897.29 stddev:507.93 (10.4%) stddev-sans-first:480.75 09:43:13 INFO - PROCESS | 22740 | Values: 2638.6 2655.8 2662.1 2663.4 2673.0 4654.8 4677.6 4696.4 4776.0 4832.7 4711.8 4773.6 4791.6 4816.7 4840.7 4357.4 4396.4 4471.2 4490.1 4500.3 4414.7 4607.4 4618.4 4650.2 4657.3 4342.2 4347.7 4369.0 4432.7 4509.9 4422.3 4422.9 4431.1 4447.0 4488.1 4463.0 4464.4 4466.8 4468.4 4515.7 4718.0 4774.2 4775.0 4795.7 4807.1 5224.2 5230.3 5249.3 5251.1 5276.6 5054.2 5267.2 5277.9 5281.8 5283.2 4866.6 4895.0 4915.0 4924.4 4942.0 5369.4 5411.2 5419.7 5427.9 5474.3 4926.2 4960.7 5173.3 5175.7 5178.6 5059.7 5085.6 5106.4 5119.8 5172.0 5013.7 5089.2 5105.3 5160.3 5189.3 4979.3 5167.3 5168.6 5180.2 5187.2 4375.5 4402.8 4422.6 4426.7 4432.3 3851.9 3857.8 3882.8 3884.5 3907.0 4413.1 4466.0 4485.5 4518.5 4523.0 5204.8 5248.0 5264.6 5271.2 5301.3 4410.3 4504.2 4510.1 4518.1 4554.8 4573.5 4687.4 4688.2 4745.8 4786.3 4844.8 4867.9 4869.5 4904.9 4925.3 5232.7 5239.2 5239.6 5254.0 5259.5 4677.0 4752.2 4778.2 4786.4 4839.6 5100.7 5125.3 5125.5 5131.2 5183.4 5142.5 5142.8 5146.9 5162.6 5162.6 4855.6 4875.4 4959.7 4996.7 5015.5 4985.5 5028.3 5039.0 5044.6 5070.8 4992.2 5001.4 5028.8 5044.8 5072.6 4897.3 5024.1 5028.1 5057.4 5110.6 4903.0 4944.0 4956.6 4971.6 5023.2 09:43:13 INFO - PROCESS | 22740 | 09:43:13 INFO - PROCESS | 22740 | [#1] ext.html Cycles:180 Average:48877.32 Median:37415.94 stddev:89706.80 (239.8%) stddev-sans-first:89885.17 09:43:13 INFO - PROCESS | 22740 | Values: 582.4 611.6 617.2 625.9 630.5 36114.0 41402.4 41505.6 41524.0 41648.6 41716.6 42159.8 42344.0 42374.0 42422.0 7721.5 7846.1 7870.5 7896.2 7918.0 7758.3 7869.5 7870.6 7882.7 7888.3 7889.0 7929.0 7932.5 7937.8 7954.0 7903.7 7923.7 7925.5 7930.8 7938.4 7827.2 7855.8 7893.5 7893.6 7894.5 31118.5 38734.4 38795.2 38991.6 39020.4 3110.4 3197.2 3248.7 3366.2 3374.4 30812.4 30872.8 30905.7 31002.9 31988.4 3391.2 3463.9 3488.9 3608.8 3703.4 272734.0 273667.0 274112.0 275174.0 275982.0 35255.0 36323.6 63166.0 63288.4 63721.4 37227.8 37264.0 37281.6 37355.8 37476.1 12634.3 12674.6 12713.7 12730.2 12778.2 11937.9 11961.8 11993.5 12036.1 12091.2 8477.9 8576.5 8580.6 8601.8 8672.7 3358.3 3385.0 3409.8 3410.5 3419.8 934.4 945.1 962.8 1022.8 1030.2 30068.0 30243.6 30262.5 30468.7 30628.7 1029.2 1052.5 1053.8 1059.6 1106.5 15846.2 16038.6 16167.8 16275.3 16511.4 404949.0 407680.0 410588.0 410700.0 410926.0 52507.2 53023.2 53251.5 53342.5 53479.7 1290.1 1294.9 1328.5 1329.7 1331.6 28326.7 29336.3 29517.0 29619.6 30163.0 46066.3 46512.3 46566.3 46701.5 47096.8 319684.0 321145.0 324669.0 324876.0 326019.0 26936.2 27241.3 27271.9 27391.6 27477.2 44126.8 44968.6 45034.5 45802.1 45831.3 38622.8 38748.6 38941.4 39040.0 39405.8 37592.0 37728.2 38005.4 38237.6 38375.4 36542.0 38334.2 39425.0 39716.4 41451.0 31384.4 34851.0 35247.8 35261.5 35479.0 26521.3 26824.7 26867.5 26888.2 27218.6 09:43:13 INFO - PROCESS | 22740 | 09:43:13 INFO - PROCESS | 22740 | [#2] jquery.html Cycles:180 Average:24236.95 Median:25063.39 stddev:65836.08 (262.7%) stddev-sans-first:65996.39 09:43:13 INFO - PROCESS | 22740 | Values: 374.6 378.2 378.6 382.2 391.2 16105.2 16542.2 17375.5 17463.7 17575.4 17307.0 17455.7 17573.4 18225.4 18315.3 4586.5 4753.6 4778.5 4780.5 4799.4 3468.1 5148.5 5432.2 5433.8 5528.1 5476.2 5479.2 5487.9 5504.2 5512.3 5002.9 5304.4 5310.5 5374.7 5384.8 5026.0 5200.3 5345.2 5370.7 5387.4 12248.7 12481.6 12630.7 12661.2 12666.2 1716.6 1875.3 1941.7 1993.9 2046.2 9043.6 9473.4 9601.9 9702.3 9754.2 1626.2 1697.5 1775.7 1790.1 1790.2 61535.4 64547.7 72373.3 73464.6 75070.6 9824.6 9842.8 9860.4 10141.8 10329.2 14177.8 14227.6 14298.4 14309.6 14346.2 7470.5 7598.8 7647.8 7694.6 7714.8 7143.4 7327.6 7418.4 7460.8 7522.4 4315.9 4405.8 4407.8 4430.3 4467.8 1722.4 1795.8 1845.4 1881.8 1888.7 831.7 911.7 941.8 950.2 973.1 15190.6 16616.8 17078.5 17138.7 17552.2 899.5 900.9 929.7 987.2 988.6 9470.6 9733.0 9753.9 9889.4 9904.5 380354.0 382796.0 398691.0 415405.0 418477.0 74096.6 74719.3 75209.6 77010.0 77792.0 907.1 912.2 918.6 933.6 939.1 14901.9 15205.6 15234.9 15265.8 15365.0 33962.3 34593.7 35145.0 35393.6 35746.5 45659.0 45740.3 46913.5 47687.0 47758.5 7831.6 7881.1 7931.3 7966.8 8003.0 11071.7 11684.4 11863.2 11957.1 12138.5 9864.8 10414.3 10653.1 10655.4 10665.7 10311.8 10354.8 10633.0 10703.2 10745.8 10165.7 10519.5 10767.3 10830.9 11106.3 7722.7 7987.6 8007.8 8037.4 8155.4 9435.7 10633.4 10821.4 10978.7 11026.5 09:43:13 INFO - PROCESS | 22740 | 09:43:13 INFO - PROCESS | 22740 | [#3] mootools.html Cycles:180 Average:5035.14 Median:4998.96 stddev:2788.11 (55.8%) stddev-sans-first:2782.29 09:43:13 INFO - PROCESS | 22740 | Values: 1364.7 1405.3 1430.1 1516.1 1531.6 6671.7 7324.9 7362.5 7632.1 7821.5 7410.2 7698.4 7702.0 7704.0 7718.8 2188.7 2234.9 2238.2 2238.6 2243.5 2220.2 2226.4 2275.7 2280.6 2283.2 2179.9 2199.2 2214.1 2257.5 2258.2 2265.4 2266.3 2275.5 2293.4 2298.0 2163.8 2195.2 2196.8 2200.4 2206.2 7776.1 7810.8 7825.0 7828.0 7833.5 4406.6 4507.4 4523.4 4529.5 4539.5 2758.7 2862.3 2865.8 2874.7 2892.5 868.2 898.2 915.1 915.9 917.7 10231.5 10271.9 10281.2 10330.4 10371.6 3992.7 4046.2 4081.9 4107.0 4136.3 8178.3 8259.9 8293.7 8294.2 8324.9 4450.2 4459.2 4485.3 4497.3 4500.8 3625.9 4020.8 4132.4 4181.1 4253.3 3504.8 3519.3 3526.3 3560.1 3717.0 1059.2 1064.8 1072.8 1073.9 1078.8 786.9 868.8 876.7 897.0 906.5 4991.3 5006.7 5014.5 5018.7 5019.7 402.3 407.0 413.5 413.7 418.4 3590.3 3595.2 3677.9 3680.4 3743.5 8876.9 9193.6 9330.6 9350.3 9383.8 9166.2 9219.8 9283.3 9374.3 9388.2 7087.2 7100.5 7203.0 7227.6 7333.3 5167.7 5174.0 5184.1 5271.2 5355.6 8226.1 8663.7 8675.3 8765.6 8768.7 8741.1 8796.0 8805.6 8899.1 8942.2 6547.3 6985.2 7090.5 7236.8 7265.3 7406.2 7430.0 7448.0 7482.7 7489.9 6521.2 6545.1 6622.3 6680.5 6722.4 6560.2 6594.1 6638.5 6639.0 6744.2 6352.4 6428.9 6440.5 6479.2 6485.4 4350.2 4524.1 4557.5 4623.4 4666.7 4628.1 4696.0 4707.1 4730.7 4794.8 09:43:13 INFO - PROCESS | 22740 | 09:43:13 INFO - PROCESS | 22740 | [#4] prototype.html Cycles:180 Average:4234.96 Median:4824.22 stddev:1225.97 (25.4%) stddev-sans-first:1193.25 09:43:13 INFO - PROCESS | 22740 | Values: 297.2 308.5 310.4 316.3 316.5 4833.0 4904.5 5011.5 5012.2 5022.6 4886.0 4918.4 4925.4 4936.5 4938.3 3857.7 3876.2 3887.4 3887.5 3919.0 3673.3 3882.5 3891.0 3897.1 3903.8 3803.3 3821.6 3823.6 3840.4 3844.2 3793.3 3815.0 3815.3 3839.6 3847.3 3386.1 3393.2 3398.2 3399.0 3409.4 4608.7 4665.8 4675.5 4727.4 4742.8 4362.8 4363.4 4385.8 4389.2 4401.5 5118.4 5120.5 5122.2 5124.2 5155.9 3573.7 3624.1 3677.5 3680.5 3683.2 5341.3 5399.2 5414.6 5418.0 5421.1 3713.4 3721.6 3733.8 3735.9 3743.3 3773.2 3790.8 3829.9 3830.8 3841.0 4105.4 4356.5 4357.7 4362.8 4375.9 5186.0 5199.8 5226.9 5241.6 5251.7 1203.6 1240.6 1263.0 1269.3 1272.9 861.9 872.4 873.7 874.8 883.4 4320.8 4373.3 4402.4 4452.4 4477.3 5095.2 5111.2 5117.9 5134.2 5134.7 4423.1 4443.7 4459.0 4475.8 4479.4 2641.6 2798.3 2799.3 2827.6 2828.6 4843.6 4875.7 4956.9 4971.2 4985.6 5203.0 5343.4 5460.1 5481.8 5485.0 4802.3 4826.8 4835.8 4854.2 4869.6 5220.2 5231.3 5249.5 5277.3 5278.7 5029.6 5080.3 5157.3 5179.3 5187.9 4780.3 4818.4 4821.7 4893.0 4910.2 3608.0 3642.4 3653.9 3673.7 3703.0 5068.7 5172.2 5211.0 5250.5 5273.4 5067.5 5075.6 5078.9 5111.2 5133.4 5006.3 5061.6 5071.6 5074.3 5081.7 4787.9 4891.5 4945.2 4952.9 4971.9 5032.4 5062.9 5063.4 5106.6 5108.4 4806.0 4874.5 4937.2 4979.8 5015.4 09:43:13 INFO - PROCESS | 22740 | 09:43:13 INFO - PROCESS | 22740 | [#5] yui.html Cycles:180 Average:12841.84 Median:41400.27 stddev:14012.74 (33.8%) stddev-sans-first:14022.63 09:43:13 INFO - PROCESS | 22740 | Values: 751.4 770.1 791.7 804.4 819.2 14185.9 14526.8 14653.6 14755.6 14765.6 14104.2 14167.9 14176.4 14196.5 14245.9 691.1 857.5 874.8 883.8 893.7 887.6 888.1 890.5 890.8 890.9 913.1 917.7 917.7 919.2 921.1 908.6 910.0 911.5 911.7 911.8 670.1 671.5 674.1 674.2 675.1 13166.4 13271.3 13299.2 13299.3 13333.8 13005.3 13041.5 13043.8 13070.4 13282.7 9843.9 10166.6 10251.5 10355.1 10369.8 3412.4 3420.0 3444.7 3445.1 3511.1 43414.8 43547.8 43968.0 43994.3 44146.3 9320.1 9374.1 9437.3 9472.0 9519.0 18389.4 18410.3 18577.4 18702.4 18777.5 6720.2 6972.3 6995.5 7021.1 7184.5 3726.6 3739.8 3746.1 3793.4 3842.4 2950.5 3046.9 3053.9 3061.5 3063.2 532.9 546.0 549.9 558.3 559.7 631.3 659.0 667.8 668.5 671.4 7964.6 8199.1 8214.5 8249.4 8452.6 499.0 603.3 618.6 628.2 632.1 3731.3 3778.7 3787.3 3807.0 3903.0 49588.8 49651.5 51074.5 51246.0 51356.5 46148.5 46164.1 46252.3 47122.3 47474.0 38569.4 39414.2 39563.4 43237.1 44182.3 8401.2 8419.6 8425.2 8540.1 8651.3 27278.6 27895.3 28611.1 29310.4 29743.7 37477.8 37558.6 37925.0 38028.0 38647.0 10533.8 10539.2 10603.3 10709.1 10797.8 11921.8 11971.7 12101.8 12135.6 12207.5 11225.8 11298.7 11407.5 11504.6 11549.9 11365.0 11375.1 11439.8 11509.0 11870.3 8169.1 10449.0 10905.2 10938.4 11571.1 9408.0 9497.4 9818.9 9965.8 10325.4 9925.3 10012.2 10106.6 10184.0 10241.9 09:43:13 INFO - PROCESS | 22740 | -------- Summary: end -------- 09:43:13 INFO - PROCESS | 22740 | 09:43:13 INFO - TEST-INFO | 22740: exit 0 09:43:13 INFO - TEST-OK | dromaeo_css | took 1115715ms 09:43:13 INFO - TEST-START | kraken 09:43:13 INFO - operating with platform_type : linux_ 09:43:13 INFO - Initialising browser for kraken test... 09:43:13 INFO - TEST-INFO | started process 22971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTfGqGQ/profile http://localhost:50534/getInfo.html) 09:43:17 INFO - PROCESS | 22971 | 09:43:17 INFO - PROCESS | 22971 | (process:23041): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:43:18 INFO - PROCESS | 22971 | __metrics Screen width/height:1600/1200 09:43:18 INFO - PROCESS | 22971 | colorDepth:24 09:43:18 INFO - PROCESS | 22971 | Browser inner width/height: 1024/697 09:43:18 INFO - PROCESS | 22971 | __metrics 09:43:19 ERROR - PROCESS | 22971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 09:43:20 INFO - TEST-INFO | 22971: exit 0 09:43:20 INFO - Browser initialized. 09:43:20 INFO - Running cycle 1/1 for kraken test... 09:43:20 INFO - TEST-INFO | started process 23092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTfGqGQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:22 INFO - PROCESS | 23092 | 09:43:22 INFO - PROCESS | 23092 | (process:23153): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:43:32 INFO - PROCESS | 23092 | RSS: Main: 164790272 09:43:32 INFO - PROCESS | 23092 | 09:43:34 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50534/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:35 INFO - PROCESS | 23092 | RSS: Main: 168673280 09:43:35 INFO - PROCESS | 23092 | 09:43:38 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50534/tests/kraken/driver.html?testName=audio-dft) 09:43:39 INFO - PROCESS | 23092 | RSS: Main: 168435712 09:43:39 INFO - PROCESS | 23092 | 09:43:42 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50534/tests/kraken/driver.html?testName=audio-fft) 09:43:42 INFO - PROCESS | 23092 | RSS: Main: 164327424 09:43:42 INFO - PROCESS | 23092 | 09:43:44 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50534/tests/kraken/driver.html?testName=audio-oscillator) 09:43:45 INFO - PROCESS | 23092 | RSS: Main: 164040704 09:43:45 INFO - PROCESS | 23092 | 09:43:47 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50534/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:48 INFO - PROCESS | 23092 | RSS: Main: 164737024 09:43:48 INFO - PROCESS | 23092 | 09:43:51 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50534/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:52 INFO - PROCESS | 23092 | RSS: Main: 164315136 09:43:52 INFO - PROCESS | 23092 | 09:43:55 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50534/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:56 INFO - PROCESS | 23092 | RSS: Main: 163561472 09:43:56 INFO - PROCESS | 23092 | 09:43:59 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50534/tests/kraken/driver.html?testName=json-parse-financial) 09:43:59 INFO - PROCESS | 23092 | RSS: Main: 163815424 09:43:59 INFO - PROCESS | 23092 | 09:44:01 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50534/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:02 INFO - PROCESS | 23092 | RSS: Main: 164388864 09:44:02 INFO - PROCESS | 23092 | 09:44:04 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50534/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:04 INFO - PROCESS | 23092 | RSS: Main: 164225024 09:44:04 INFO - PROCESS | 23092 | 09:44:06 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50534/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:07 INFO - PROCESS | 23092 | RSS: Main: 164454400 09:44:07 INFO - PROCESS | 23092 | 09:44:10 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50534/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:11 INFO - PROCESS | 23092 | RSS: Main: 164720640 09:44:11 INFO - PROCESS | 23092 | 09:44:14 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50534/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:14 INFO - PROCESS | 23092 | RSS: Main: 164626432 09:44:14 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | Cycle 1(1): loaded http://localhost:50534/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50534/tests/kraken/driver.html?testName=ai-astar) 09:44:16 INFO - PROCESS | 23092 | RSS: Main: 166277120 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | __start_tp_report 09:44:16 INFO - PROCESS | 23092 | _x_x_mozilla_page_load 09:44:16 INFO - PROCESS | 23092 | _x_x_mozilla_page_load_details 09:44:16 INFO - PROCESS | 23092 | |i|pagename|runs| 09:44:16 INFO - PROCESS | 23092 | |0;ai-astar;110;112;106;116;113;115;106;112;113;114 09:44:16 INFO - PROCESS | 23092 | |1;audio-beat-detection;157;131;158;192;134;173;154;133;198;134 09:44:16 INFO - PROCESS | 23092 | |2;audio-dft;161;165;163;167;168;161;162;162;162;162 09:44:16 INFO - PROCESS | 23092 | |3;audio-fft;75;77;76;158;79;76;76;76;158;77 09:44:16 INFO - PROCESS | 23092 | |4;audio-oscillator;92;93;150;93;95;92;148;93;92;146 09:44:16 INFO - PROCESS | 23092 | |5;imaging-gaussian-blur;117;117;118;117;118;118;118;117;118;117 09:44:16 INFO - PROCESS | 23092 | |6;imaging-darkroom;148;146;148;147;146;148;155;147;146;147 09:44:16 INFO - PROCESS | 23092 | |7;imaging-desaturate;95;95;95;95;97;95;96;95;96;95 09:44:16 INFO - PROCESS | 23092 | |8;json-parse-financial;67;67;65;66;67;66;66;81;64;68 09:44:16 INFO - PROCESS | 23092 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;64;68;64 09:44:16 INFO - PROCESS | 23092 | |10;stanford-crypto-aes;83;83;83;83;84;84;83;83;87;83 09:44:16 INFO - PROCESS | 23092 | |11;stanford-crypto-ccm;136;145;138;133;151;141;131;147;173;138 09:44:16 INFO - PROCESS | 23092 | |12;stanford-crypto-pbkdf2;171;172;176;174;170;173;173;177;174;178 09:44:16 INFO - PROCESS | 23092 | |13;stanford-crypto-sha256-iterative;76;73;70;68;71;68;69;66;70;68 09:44:16 INFO - PROCESS | 23092 | __end_tp_report 09:44:16 INFO - PROCESS | 23092 | __start_cc_report 09:44:16 INFO - PROCESS | 23092 | _x_x_mozilla_cycle_collect,939 09:44:16 INFO - PROCESS | 23092 | __end_cc_report 09:44:16 INFO - PROCESS | 23092 | __startTimestamp1462553056668__endTimestamp 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | ------- Summary: start ------- 09:44:16 INFO - PROCESS | 23092 | Number of tests: 14 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.43 (3.0%) stddev-sans-first:3.59 09:44:16 INFO - PROCESS | 23092 | Values: 110.0 112.0 106.0 116.0 113.0 115.0 106.0 112.0 113.0 114.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:157.50 stddev:24.67 (15.7%) stddev-sans-first:26.17 09:44:16 INFO - PROCESS | 23092 | Values: 157.0 131.0 158.0 192.0 134.0 173.0 154.0 133.0 198.0 134.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#2] audio-dft Cycles:10 Average:163.30 Median:162.50 stddev:2.50 (1.5%) stddev-sans-first:2.51 09:44:16 INFO - PROCESS | 23092 | Values: 161.0 165.0 163.0 167.0 168.0 161.0 162.0 162.0 162.0 162.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:34.38 (45.2%) stddev-sans-first:35.86 09:44:16 INFO - PROCESS | 23092 | Values: 75.0 77.0 76.0 158.0 79.0 76.0 76.0 76.0 158.0 77.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.50 stddev:26.67 (28.8%) stddev-sans-first:27.53 09:44:16 INFO - PROCESS | 23092 | Values: 92.0 93.0 150.0 93.0 95.0 92.0 148.0 93.0 92.0 146.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:44:16 INFO - PROCESS | 23092 | Values: 117.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:2.66 (1.8%) stddev-sans-first:2.82 09:44:16 INFO - PROCESS | 23092 | Values: 148.0 146.0 148.0 147.0 146.0 148.0 155.0 147.0 146.0 147.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 09:44:16 INFO - PROCESS | 23092 | Values: 95.0 95.0 95.0 95.0 97.0 95.0 96.0 95.0 96.0 95.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:67.00 stddev:4.81 (7.2%) stddev-sans-first:5.09 09:44:16 INFO - PROCESS | 23092 | Values: 67.0 67.0 65.0 66.0 67.0 66.0 66.0 81.0 64.0 68.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.00 stddev:1.27 (2.0%) stddev-sans-first:1.33 09:44:16 INFO - PROCESS | 23092 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 68.0 64.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 09:44:16 INFO - PROCESS | 23092 | Values: 83.0 83.0 83.0 83.0 84.0 84.0 83.0 83.0 87.0 83.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:143.00 stddev:12.16 (8.5%) stddev-sans-first:12.60 09:44:16 INFO - PROCESS | 23092 | Values: 136.0 145.0 138.0 133.0 151.0 141.0 131.0 147.0 173.0 138.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.00 stddev:2.57 (1.5%) stddev-sans-first:2.52 09:44:16 INFO - PROCESS | 23092 | Values: 171.0 172.0 176.0 174.0 170.0 173.0 173.0 177.0 174.0 178.0 09:44:16 INFO - PROCESS | 23092 | 09:44:16 INFO - PROCESS | 23092 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:2.88 (4.1%) stddev-sans-first:2.05 09:44:16 INFO - PROCESS | 23092 | Values: 76.0 73.0 70.0 68.0 71.0 68.0 69.0 66.0 70.0 68.0 09:44:16 INFO - PROCESS | 23092 | -------- Summary: end -------- 09:44:16 INFO - PROCESS | 23092 | 09:44:17 INFO - TEST-INFO | 23092: exit 0 09:44:17 INFO - TEST-OK | kraken | took 63719ms 09:44:17 INFO - SUITE-END | took 1179s 09:44:17 INFO - Completed test suite (00:19:39) 09:44:17 INFO - javascript benchmark 09:44:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2638.564636834922, 2655.760981511665, 2662.094887738171, 2663.4273631169294, 2673.0, 4654.837080702172, 4677.555632214942, 4696.436427628685, 4776.020915712279, 4832.661713680044, 4711.764411779406, 4773.594244489213, 4791.616670666347, 4816.7350795706225, 4840.709557426557, 4357.368181613656, 4396.384506169139, 4471.150481408538, 4490.146872094291, 4500.34744961982, 4414.668899832509, 4607.3549703041435, 4618.399608050949, 4650.162970665279, 4657.301404789275, 4342.174986752507, 4347.69566130371, 4368.978155109204, 4432.667549933768, 4509.887252818673, 4422.292433210703, 4422.867313980586, 4431.135928493945, 4446.977765111186, 4488.079943611585, 4463.0, 4464.397306363632, 4466.82132714691, 4468.396766436522, 4515.683902126852, 4717.95282047182, 4774.236122220428, 4774.976125119387, 4795.712257264575, 4807.11068452334, 5224.164133738622, 5230.320058392384, 5249.291345668324, 5251.133562962106, 5276.630635855492, 5054.1660625996665, 5267.183586544092, 5277.920831187535, 5281.841544753664, 5283.181106928432, 4866.58634016109, 4894.99652571222, 4915.0, 4924.43369012561, 4941.975290123598, 5369.40936496985, 5411.188321751769, 5419.701916394557, 5427.891442171213, 5474.343078830566, 4926.211806111005, 4960.70235785854, 5173.275741396207, 5175.715335656575, 5178.585713142939, 5059.671121377172, 5085.593152547787, 5106.361704786902, 5119.795208191631, 5172.0, 5013.674111182761, 5089.211172268304, 5105.2597373381395, 5160.251763494272, 5189.325387699575, 4979.30289759434, 5167.250748641426, 5168.586513078944, 5180.171172612364, 5187.221916712523, 4375.518692943773, 4402.779861006937, 4422.557744225552, 4426.734395936254, 4432.268675668479, 3851.9229615407535, 3857.8263978121054, 3882.8446862125766, 3884.4561761353434, 3907.023244188953, 4413.051193993307, 4466.0, 4485.506594274627, 4518.548145185455, 4522.954770452319, 5204.7918083277, 5247.973760131251, 5264.6314757966575, 5271.156614941591, 5301.3373328333955, 4410.29435290352, 4504.189245935698, 4510.0979804039325, 4518.051209246095, 4554.772261386917, 4573.47405048417, 4687.437507499122, 4688.226442636927, 4745.786439610226, 4786.305985632064, 4844.781984810622, 4867.853964381075, 4869.488703686133, 4904.926426103682, 4925.335079764258, 5232.686038837682, 5239.24031015493, 5239.554637855673, 5254.0, 5259.47405259471, 4677.041206552581, 4752.239641657318, 4778.163821331323, 4786.425628924551, 4839.564439200489, 5100.69395836251, 5125.2568377585785, 5125.513076257749, 5131.153359695758, 5183.352080989876, 5142.485751424828, 5142.820001299937, 5146.948530514647, 5162.586993040472, 5162.612804039637, 4855.635827313036, 4875.390576177978, 4959.70241785494, 4996.650234483552, 5015.473375295542, 4985.501449855131, 5028.296038554532, 5039.042581909425, 5044.571211447068, 5070.8225212117395, 4992.201247800334, 5001.399832020035, 5028.773705183348, 5044.772985215747, 5072.594192464668, 4897.289892965571, 5024.0956627807345, 5028.069807085701, 5057.367829021372, 5110.642255042111, 4902.950970490249, 4943.975280123576, 4956.603471722326, 4971.577415919687, 5023.1711767557945], "value": 4752.867174775412, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.4466756581246, 611.5963464113686, 617.2284644194757, 625.9499240060795, 630.501903496238, 36114.0, 41402.378964315525, 41505.58494415055, 41524.0, 41648.58351416492, 41716.58283417165, 42159.78920105395, 42344.0, 42374.0, 42422.0, 7721.459497835153, 7846.136924938281, 7870.527768333918, 7896.249856263646, 7918.049834019926, 7758.262965018343, 7869.52782833029, 7870.645820938043, 7882.724104656339, 7888.250616191482, 7889.0, 7929.0, 7932.524048557077, 7937.841243175133, 7954.0, 7903.683852645887, 7923.683052677915, 7925.524468531907, 7930.841383172362, 7938.40461965352, 7827.217278272185, 7855.803604909923, 7893.539695156414, 7893.565853878034, 7894.486858354188, 31118.53322200169, 38734.418983715266, 38795.22409551793, 38991.61008389908, 39020.41469377962, 3110.3934732727125, 3197.2006998250436, 3248.691374319436, 3366.208940898887, 3374.3926093303194, 30812.38375232483, 30872.8456357719, 30905.690943090507, 31002.897280936704, 31988.360232795447, 3391.1522119470133, 3463.8614455421753, 3488.8953331399844, 3608.8015159166234, 3703.3519134151684, 272734.0, 273667.0, 274112.0, 275174.0, 275982.0, 35255.0, 36323.63676363203, 63166.0, 63288.36711632825, 63721.36278637247, 37227.81386093106, 37264.0, 37281.62718372782, 37355.813220934266, 37476.06501317377, 12634.305113218677, 12674.556390526472, 12713.682157946125, 12730.23618582888, 12778.233306001484, 11937.88062119385, 11961.820572691417, 11993.520259189709, 12036.097292703082, 12091.214071085527, 8477.915220847835, 8576.528290944058, 8580.613872375758, 8601.78495537604, 8672.696455624024, 3358.277970236411, 3384.983075084609, 3409.7954122752712, 3410.4884267360094, 3419.794812311269, 934.4019827310527, 945.0691069296737, 962.8026254617787, 1022.8005538919839, 1030.2015937648232, 30068.0, 30243.578760763947, 30262.54606180909, 30468.695313046584, 30628.693713062585, 1029.1920842138884, 1052.5158427123608, 1053.7681710023783, 1059.6185373265773, 1106.5407855739938, 15846.207689615474, 16038.599035023984, 16167.757483637755, 16275.267612957208, 16511.422100226435, 404949.0, 407680.0, 410588.0, 410700.0, 410926.0, 52507.21239181415, 53023.20465193025, 53251.467485325426, 53342.466575334525, 53479.73260133674, 1290.1420555330787, 1294.9482020719254, 1328.4752522753458, 1329.7074643578396, 1331.5539294336506, 28326.716732832407, 29336.26659333534, 29517.0, 29619.555706664847, 30163.0, 46066.30900536427, 46512.30231546462, 46566.30150547812, 46701.53298466972, 47096.7645161772, 319684.0, 321145.0, 324669.0, 324876.0, 326019.0, 26936.191914242605, 27241.31896702519, 27271.86364068167, 27391.589126163522, 27477.17568472949, 44126.779366102965, 44968.55031449644, 45034.54965450435, 45802.08395831998, 45831.31253031274, 38622.80688596539, 38748.6125138745, 38941.41587876241, 39040.0, 39405.802970984965, 37592.0, 37728.245435091696, 38005.42991855069, 38237.61762382452, 38375.42436863393, 36542.0, 38334.233315334095, 39425.0, 39716.40425393564, 41451.0, 31384.372312553165, 34851.0, 35247.82376088206, 35261.47107793334, 35479.0, 26521.336966575218, 26824.731752682223, 26867.462650746485, 26888.193354199404, 27218.591721124594], "value": 17374.866806765276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.6197609426432, 378.249175386857, 378.62137862137877, 382.2336215887146, 391.1882843100567, 16105.194740262983, 16542.17289135543, 17375.503437563766, 17463.650726985452, 17575.384861529834, 17307.0, 17455.73816392755, 17573.3849315274, 18225.36211232604, 18315.267389304412, 4586.495485496601, 4753.643476739258, 4778.450478195, 4780.450248221447, 4799.376081109468, 3468.1156305142154, 5148.536631703146, 5432.158015507603, 5433.755481003364, 5528.143137813625, 5476.2333273341765, 5479.205515200293, 5487.862803429906, 5504.174373843915, 5512.33851937768, 5002.874928126807, 5304.416514183436, 5310.548603368699, 5374.7043912584795, 5384.757685904144, 5026.0, 5200.29795977542, 5345.1714984177515, 5370.7046112463795, 5387.380451248078, 12248.690066483128, 12481.563145289962, 12630.684232894158, 12661.177023493443, 12666.176698514568, 1716.6223430845318, 1875.3436297295973, 1941.708743688444, 1993.900304984745, 2046.2326627514683, 9043.59303831329, 9473.384230025027, 9601.855972160423, 9702.27232957531, 9754.219662426989, 1626.2356692354574, 1697.524693085938, 1775.6892543804784, 1790.1228398084845, 1790.185465613143, 61535.38464615341, 64547.70904581929, 72373.27626723718, 73464.63267683628, 75070.62464687697, 9824.557894894748, 9842.80314393708, 9860.408375497493, 10141.797164056825, 10329.173666106693, 14177.78733319001, 14227.573172804832, 14298.356573953988, 14309.57071287863, 14346.210958397389, 7470.5144165630145, 7598.848023039508, 7647.770566883002, 7694.615269236516, 7714.807129821687, 7143.42852571793, 7327.560346379234, 7418.406527477789, 7460.843569246776, 7522.398208143335, 4315.870523884289, 4405.823767049346, 4407.801648925806, 4430.291153415503, 4467.776611169428, 1722.3885520639992, 1795.784505859279, 1845.355423039513, 1881.8306352428347, 1888.7355770192185, 831.6922738586761, 911.694582314932, 941.7975135345796, 950.2255661635745, 973.0950216298769, 15190.620234494227, 16616.83383166153, 17078.48764537066, 17138.742918856227, 17552.210150543255, 899.5277479323407, 900.8558630619201, 929.7210836748948, 987.1559816357055, 988.6391467114452, 9470.573824177929, 9733.0, 9753.902460975441, 9889.357191782512, 9904.504774761233, 380354.0, 382796.0, 398691.0, 415405.0, 418477.0, 74096.62951685207, 74719.25280747232, 75209.6239518799, 77010.0, 77792.0, 907.1155623267261, 912.2337236721186, 918.6187732091241, 933.5658918602883, 939.0703203828161, 14901.874597283982, 15205.6198595036, 15234.923825381245, 15265.847341526887, 15365.0, 33962.320753585285, 34593.65406345904, 35145.0, 35393.64606353903, 35746.463803042454, 45659.0, 45740.31389529226, 46913.53086469092, 47687.0, 47758.522414775405, 7831.608419579112, 7881.13307536182, 7931.286184243446, 7966.84066318682, 8002.9599852000365, 11071.667849964513, 11684.357360345262, 11863.228890122115, 11957.103217258915, 12138.514459421523, 9864.802703946025, 10414.271001029856, 10653.094486968694, 10655.413952232391, 10665.680029599125, 10311.845322320021, 10354.792904142025, 10633.0, 10703.19726020536, 10745.785084298426, 10165.695029149138, 10519.474026298807, 10767.300125491818, 10830.891691082988, 11106.333619982504, 7722.691092356243, 7987.64055617487, 8007.759767206993, 8037.397195210499, 8155.429119961545, 9435.716928492157, 10633.426861669293, 10821.350718956888, 10978.725531861448, 11026.50380732885], "value": 8164.419400685155, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.7202323523675, 1405.3113974152668, 1430.141914851089, 1516.0600427734812, 1531.647721024165, 6671.733130674767, 7324.890126648104, 7362.484626076177, 7632.122305934819, 7821.452498325119, 7410.184879663233, 7698.384129269659, 7702.0, 7703.999999999986, 7718.8456230875345, 2188.6607575825774, 2234.8770817605027, 2238.171876405724, 2238.630625946725, 2243.45035466311, 2220.156340590573, 2226.421130506064, 2275.6586512023246, 2280.5894938910988, 2283.246528645543, 2179.858309209896, 2199.186301068599, 2214.136486770161, 2257.525919556895, 2258.175765845471, 2265.354374003401, 2266.320103968811, 2275.476640372707, 2293.3578597992587, 2298.0118549023914, 2163.8268938484885, 2195.2316689158824, 2196.8132708719777, 2200.3728937252804, 2206.2167930384644, 7776.066871975343, 7810.765677029698, 7825.0218722659665, 7828.021497312836, 7833.451658383916, 4406.603405693471, 4507.3689683444345, 4523.411956445674, 4529.456465224194, 4539.455265368144, 2758.6965433802266, 2862.255813488508, 2865.799394042418, 2874.7125287471295, 2892.450434417454, 868.2402897464718, 898.24996128233, 915.1260546178383, 915.940463869853, 917.6742256498981, 10231.488425578691, 10271.897281027168, 10281.177505799593, 10330.431826249629, 10371.585136594527, 3992.6606238469476, 4046.1503084352616, 4081.8775436736946, 4106.958930410718, 4136.338185890243, 8178.263956243966, 8259.876101858477, 8293.709720159886, 8294.170582941657, 8324.916750832535, 4450.221211288012, 4459.175052615276, 4485.327200919823, 4497.325401189848, 4500.819967201275, 3625.9456108158397, 4020.7788571628257, 4132.40080188371, 4181.059261666162, 4253.3194688849635, 3504.807235602015, 3519.278547897726, 3526.3299973005046, 3560.0743806610467, 3716.9814150929074, 1059.2267644619317, 1064.8243039898484, 1072.7908057928785, 1073.9087177589836, 1078.757279612081, 786.949422520941, 868.7654333329965, 876.6668665906915, 896.9641214351483, 906.4833045164193, 4991.251312303184, 5006.674566153189, 5014.473480284591, 5018.698878067327, 5019.67372120811, 402.2638571414305, 406.99389509157385, 413.52238164919567, 413.6628647652154, 418.4037746211636, 3590.335787879251, 3595.1910820065277, 3677.9080522986606, 3680.411134218512, 3743.494628225209, 8876.934767827903, 9193.586288616894, 9330.626774928927, 9350.251979841732, 9383.765405864771, 9166.17504424605, 9219.769505762275, 9283.25733941283, 9374.296927730447, 9388.155066043952, 7087.1849737279845, 7100.5029647925185, 7203.0, 7227.602481863443, 7333.303336183054, 5167.715775632376, 5174.016936781999, 5184.118699821115, 5271.20931860224, 5355.571554275726, 8226.136255693305, 8663.696770612998, 8675.305975521816, 8765.649374025223, 8768.736937891874, 8741.125887411208, 8795.956020219857, 8805.647774088964, 8899.065598112105, 8942.195202431813, 6547.279799222177, 6985.231624521197, 7090.539114957512, 7236.819079523054, 7265.273472652692, 7406.222346653523, 7429.962850185714, 7447.962760186165, 7482.738104166328, 7489.8876516851205, 6521.217453905561, 6545.083688283739, 6622.271550129578, 6680.5323627345615, 6722.394984451423, 6560.245571759118, 6594.10979517759, 6638.468922486093, 6639.0, 6744.224414192235, 6352.36476352361, 6428.935710643021, 6440.452561532322, 6479.222493300834, 6485.44873685742, 4350.238708225985, 4524.140413321458, 4557.453105627346, 4623.3758442609815, 4666.743329116795, 4628.097520983376, 4696.0, 4707.082118986902, 4730.739809310521, 4794.808207671794], "value": 4007.32803884211, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.16496644429157, 308.46789288477373, 310.3792415169661, 316.2867733261495, 316.51257064121256, 4832.994307362449, 4904.509549045094, 5011.494252873563, 5012.170557746424, 5022.598192144629, 4885.9511404886025, 4918.409790825097, 4925.359703238583, 4936.531029552196, 4938.333325001124, 3857.7106716996195, 3876.186000939806, 3887.378019516878, 3887.533495980479, 3919.0, 3673.3020726062095, 3882.514685664292, 3890.9610903891025, 3897.1036661567855, 3903.7852918089493, 3803.2963901678277, 3821.617838216184, 3823.5985221551614, 3840.423936409547, 3844.2311537692435, 3793.2603142387106, 3814.9618503814886, 3815.275097731436, 3839.6352346527037, 3847.269018886431, 3386.1196089016785, 3393.2025973896116, 3398.2014226656715, 3398.9660103398896, 3409.369266685671, 4608.654350923694, 4665.790039448233, 4675.532446755297, 4727.3854398927915, 4742.786574604151, 4362.76004819738, 4363.432753742025, 4385.846495372679, 4389.18800021997, 4401.493828209765, 5118.411382691001, 5120.462351453081, 5122.20605806097, 5124.231365295198, 5155.922661160085, 3573.6962358199585, 3624.1302087499075, 3677.485152078711, 3680.4847321375028, 3683.1712864605515, 5341.332333458279, 5399.191270924245, 5414.620976531644, 5418.0, 5421.051316019681, 3713.387291096939, 3721.6464435878547, 3733.757305775116, 3735.850565977385, 3743.2513497300106, 3773.2453509298252, 3790.753601015925, 3829.904252393657, 3830.8276127574327, 3841.0, 4105.363668631367, 4356.520782713899, 4357.716748411343, 4362.7818609070055, 4375.868723938287, 5186.040582492251, 5199.844004679866, 5226.869328266747, 5241.580673546107, 5251.689256727028, 1203.5667159822458, 1240.6092080994458, 1262.9810552841714, 1269.27651238793, 1272.8727127287198, 861.866410706329, 872.4024043530076, 873.6592728835759, 874.8469017921839, 883.3595643158659, 4320.783960801948, 4373.300271956472, 4402.449693788277, 4452.4211852458975, 4477.283634618446, 5095.197641297272, 5111.207762796773, 5117.897642047138, 5134.204198349262, 5134.739440455338, 4423.1153769246275, 4443.711158774734, 4459.0, 4475.776211189427, 4479.350494178326, 2641.630171775953, 2798.286436958603, 2799.2861820236117, 2827.618271533358, 2828.6464191976, 4843.588294994895, 4875.731834749052, 4956.90086198274, 4971.235211499866, 4985.626078044161, 5203.0, 5343.385510666323, 5460.116259890331, 5481.834675303313, 5485.040117979338, 4802.255650374198, 4826.77968134662, 4835.808366478108, 4854.247591623304, 4869.587819532367, 5220.216967454912, 5231.3199284092825, 5249.527542521038, 5277.261183434245, 5278.683279003272, 5029.622778291569, 5080.26336181259, 5157.277981082727, 5179.30079439286, 5187.948120518898, 4780.255206849405, 4818.397700287464, 4821.662483626253, 4892.993872512253, 4910.21436570147, 3607.981960090183, 3642.4354225095153, 3653.9269214616093, 3673.651003154696, 3703.0, 5068.72122033277, 5172.19830926207, 5210.957808438403, 5250.477361565103, 5273.419923808301, 5067.5185857343495, 5075.6042088425975, 5078.949210507848, 5111.207762796773, 5133.409657889241, 5006.299118123538, 5061.58343118401, 5071.568916642127, 5074.289599456153, 5081.745912704424, 4787.928181077356, 4891.486393928586, 4945.205958633361, 4952.851414457572, 4971.9005619886675, 5032.3961124665275, 5062.898742025212, 5063.35440981675, 5106.617003724809, 5108.438071812172, 4805.975970120127, 4874.463808980939, 4937.210046392704, 4979.751012449436, 5015.448300686994], "value": 3845.794699207083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.4138971602152, 770.1182146442322, 791.6833266693322, 804.4047404920357, 819.2462934100627, 14185.929070354647, 14526.782098268508, 14653.633659158526, 14755.631109222275, 14765.630859228499, 14104.15375077496, 14167.858321416783, 14176.362063707133, 14196.503122390719, 14245.928770356133, 691.1119211812821, 857.4855086947844, 874.8425283448977, 883.7702197428666, 893.7452825944574, 887.5562218890555, 888.0719647967857, 890.4924193209873, 890.8040231149137, 890.8930928288614, 913.1005959130251, 917.6604656277186, 917.729269865388, 919.1681528216974, 921.0789210789211, 908.5684299957534, 909.9772505687345, 911.5487833522383, 911.7492689510404, 911.7629416351763, 670.0853335197469, 671.4896678524308, 674.0596867370041, 674.2212744280364, 675.0684056002734, 13166.407511661999, 13271.336433178303, 13299.20204787716, 13299.268540230283, 13333.799993000113, 13005.284709340982, 13041.543545975845, 13043.804342934864, 13070.411831467512, 13282.73434531304, 9843.852342214872, 10166.59333626654, 10251.53868075931, 10355.068043876012, 10369.844452333222, 3412.419888618916, 3419.982900085484, 3444.7416443766565, 3445.0753984491103, 3511.0695665648623, 43414.782926085485, 43547.78226108849, 43967.99999999968, 43994.34008489875, 44146.337804932955, 9320.067993200626, 9374.11568459036, 9437.292203084797, 9472.0, 9518.95240523793, 18389.448316550526, 18410.26358945627, 18577.44267671972, 18702.438926832216, 18777.53056173579, 6720.193576770721, 6972.337627925339, 6995.475339349569, 7021.122359705037, 7184.461165412615, 3726.6459686329754, 3739.775613463201, 3746.119661879456, 3793.430985352219, 3842.4044273137706, 2950.542665886791, 3046.8933587324336, 3053.9389212215633, 3061.525463553153, 3063.2188791857934, 532.9014132385521, 545.9727013649301, 549.9378223453105, 558.2742434834698, 559.6809818403552, 631.2834932351722, 658.9670516474253, 667.7696194812781, 668.5153263883743, 671.4460570029745, 7964.561949092739, 8199.075128481922, 8214.4660597061, 8249.381296402793, 8452.57737113142, 498.980040798364, 603.3212635784743, 618.5855476830534, 628.214731585518, 632.1371328137152, 3731.272401881661, 3778.7354885157774, 3787.280416720814, 3807.0, 3902.9609703903166, 49588.752056239486, 49651.50348496541, 51074.489255107714, 51246.0, 51356.48643513592, 46148.538514614425, 46164.076718466116, 46252.306215406796, 47122.29316560255, 47474.0, 38569.421458678145, 39414.2117157661, 39563.40654890179, 43237.135257295304, 44182.33726494105, 8401.243888050105, 8419.579021049045, 8425.199606037417, 8540.14598540141, 8651.307895368229, 27278.590821137303, 27895.302617434725, 28611.14166575006, 29310.41379172362, 29743.702562974093, 37477.812610937865, 37558.62441375551, 37925.0, 38028.0, 38647.03382415462, 10533.841992370273, 10539.156867450432, 10603.310784798963, 10709.08972737326, 10797.838032429678, 11921.82117268259, 11971.694020137453, 12101.81847272274, 12135.635930922086, 12207.45066471993, 11225.831612525983, 11298.717532061764, 11407.543698251977, 11504.597339093092, 11549.88450115488, 11365.033972112464, 11375.146863985068, 11439.771204576029, 11509.0, 11870.347130907883, 8169.0605580359015, 10449.0, 10905.18211134184, 10938.398388088732, 11571.132165087483, 9408.0, 9497.382670126419, 9818.901810982084, 9965.800683986135, 10325.432101234504, 9925.255605829447, 10012.249081319076, 10106.595736170471, 10184.0, 10241.897581024392], "value": 6161.716373369661, "unit": "score"}], "name": "dromaeo_css", "value": 6325.076082299742, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 106.0, 116.0, 113.0, 115.0, 106.0, 112.0, 113.0, 114.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 158.0, 192.0, 134.0, 173.0, 154.0, 133.0, 198.0, 134.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 163.0, 167.0, 168.0, 161.0, 162.0, 162.0, 162.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 158.0, 79.0, 76.0, 76.0, 76.0, 158.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 150.0, 93.0, 95.0, 92.0, 148.0, 93.0, 92.0, 146.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 148.0, 147.0, 146.0, 148.0, 155.0, 147.0, 146.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 66.0, 67.0, 66.0, 66.0, 81.0, 64.0, 68.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 68.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 84.0, 84.0, 83.0, 83.0, 87.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 145.0, 138.0, 133.0, 151.0, 141.0, 131.0, 147.0, 173.0, 138.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 176.0, 174.0, 170.0, 173.0, 173.0, 177.0, 174.0, 178.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 70.0, 68.0, 71.0, 68.0, 69.0, 66.0, 70.0, 68.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1597.1, "alertThreshold": 2.0}]} 09:44:17 INFO - Return code: 0 09:44:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:44:17 ERROR - # TBPL SUCCESS # 09:44:17 INFO - Running post-action listener: _resource_record_post_action 09:44:17 INFO - ##### 09:44:17 INFO - ##### Finished run-tests step (success) 09:44:17 INFO - ##### 09:44:17 INFO - Running post-run listener: _resource_record_post_run 09:44:19 INFO - Total resource usage - Wall time: 1196s; CPU: 14.0%; Read bytes: 0; Write bytes: 525467648; Read time: 0; Write time: 589328 09:44:19 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241799168; Read time: 0; Write time: 270960 09:44:19 INFO - run-tests - Wall time: 1181s; CPU: 14.0%; Read bytes: 0; Write bytes: 283668480; Read time: 0; Write time: 318368 09:44:19 INFO - Running post-run listener: _upload_blobber_files 09:44:19 INFO - Blob upload gear active. 09:44:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:19 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 09:44:19 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'] 09:44:19 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 09:44:19 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:44:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:44:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:20 INFO - (blobuploader) - INFO - Done attempting. 09:44:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:44:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:44:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:21 INFO - (blobuploader) - INFO - Done attempting. 09:44:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:21 INFO - Return code: 0 09:44:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53198d67b53e85ee246156b4e802eb3a078fc3b1222bc8239e142cd767e9d3392c3337d1c7c852c20cedb195d26a52e61db5dcda6b6f01b47692c866a3a0214b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f12182ecf41ac0cc6831da655c2ac5b459234b7781f54a5f0bb260b1a02582e5ee39fc0e29b3e99af6071b0c7475bcb4fdd51fbbf0b16ebbf31ab94267700e"} 09:44:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:21 INFO - Contents: 09:44:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53198d67b53e85ee246156b4e802eb3a078fc3b1222bc8239e142cd767e9d3392c3337d1c7c852c20cedb195d26a52e61db5dcda6b6f01b47692c866a3a0214b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f12182ecf41ac0cc6831da655c2ac5b459234b7781f54a5f0bb260b1a02582e5ee39fc0e29b3e99af6071b0c7475bcb4fdd51fbbf0b16ebbf31ab94267700e"} 09:44:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:21 INFO - Copying logs to upload dir... 09:44:21 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.914179 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-06 09:44:20.483591) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 09:44:20.487196) ========= 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=1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742 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/53198d67b53e85ee246156b4e802eb3a078fc3b1222bc8239e142cd767e9d3392c3337d1c7c852c20cedb195d26a52e61db5dcda6b6f01b47692c866a3a0214b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f12182ecf41ac0cc6831da655c2ac5b459234b7781f54a5f0bb260b1a02582e5ee39fc0e29b3e99af6071b0c7475bcb4fdd51fbbf0b16ebbf31ab94267700e"} build_url:https://queue.taskcluster.net/v1/task/cUos7TwrTh-hLjFWMo7fFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/cUos7TwrTh-hLjFWMo7fFA/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/53198d67b53e85ee246156b4e802eb3a078fc3b1222bc8239e142cd767e9d3392c3337d1c7c852c20cedb195d26a52e61db5dcda6b6f01b47692c866a3a0214b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f12182ecf41ac0cc6831da655c2ac5b459234b7781f54a5f0bb260b1a02582e5ee39fc0e29b3e99af6071b0c7475bcb4fdd51fbbf0b16ebbf31ab94267700e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 09:44:20.512186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:44:20.512544) ========= 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=1f5564757af27664ca02d71f000001b0-1462551819.828333-160939742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:44:20.595569) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 09:44:20.595899) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 09:44:20.596197) ========= ========= Total master_lag: 0.17 =========