builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1462991020.87 results: success (0) buildid: 20160511104611 builduid: 0adef02fcfc744b4bcf38f175d1fcb0f revision: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:40.872734) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:40.874338) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:40.874609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:40.894767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:40.895031) ========= 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=5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 11:23:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.5M=0.001s 2016-05-11 11:23:41 (21.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086827 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:40.994904) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:40.995185) ========= 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=5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018129 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:41.044788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:41.045112) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 --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 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 --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=5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 11:23:41,559 truncating revision to first 12 chars 2016-05-11 11:23:41,559 Setting DEBUG logging. 2016-05-11 11:23:41,559 attempt 1/10 2016-05-11 11:23:41,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/45daaf6edeae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 11:23:42,073 unpacking tar archive at: fx-team-45daaf6edeae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.783156 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:41.841163) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:41.841480) ========= script_repo_revision: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:41.841945) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:41.842222) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 11:23:41.851050) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-11 11:23:41.851451) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:23:42 INFO - MultiFileLogger online at 20160511 11:23:42 in /builds/slave/test 11:23:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 11:23:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:23:42 INFO - {'append_to_log': False, 11:23:42 INFO - 'base_work_dir': '/builds/slave/test', 11:23:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:23:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:23:42 INFO - 'branch': 'Fx-Team-Non-PGO', 11:23:42 INFO - 'buildbot_json_path': 'buildprops.json', 11:23:42 INFO - 'config_files': ('talos/linux_config.py',), 11:23:42 INFO - 'default_actions': ('clobber', 11:23:42 INFO - 'read-buildbot-config', 11:23:42 INFO - 'download-and-extract', 11:23:42 INFO - 'populate-webroot', 11:23:42 INFO - 'create-virtualenv', 11:23:42 INFO - 'install', 11:23:42 INFO - 'run-tests'), 11:23:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:23:42 INFO - 'download_minidump_stackwalk': True, 11:23:42 INFO - 'download_symbols': 'ondemand', 11:23:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:23:42 INFO - 'tooltool.py': '/tools/tooltool.py', 11:23:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:23:42 INFO - '/tools/misc-python/virtualenv.py')}, 11:23:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:23:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:23:42 INFO - 'installer_path': 'installer.exe', 11:23:42 INFO - 'log_level': 'info', 11:23:42 INFO - 'log_name': 'talos', 11:23:42 INFO - 'log_to_console': True, 11:23:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:23:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:23:42 INFO - 'opt_config_files': (), 11:23:42 INFO - 'pip_index': False, 11:23:42 INFO - 'sps_profile': False, 11:23:42 INFO - 'sps_profile_interval': 0, 11:23:42 INFO - 'suite': 'dromaeojs', 11:23:42 INFO - 'system_bits': '32', 11:23:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:23:42 INFO - 'title': 'talos-linux64-ix-011', 11:23:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:23:42 INFO - 'use_talos_json': True, 11:23:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:23:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:23:42 INFO - 'work_dir': 'build'} 11:23:42 INFO - ##### 11:23:42 INFO - ##### Running clobber step. 11:23:42 INFO - ##### 11:23:42 INFO - Running pre-action listener: _resource_record_pre_action 11:23:42 INFO - Running main action method: clobber 11:23:42 INFO - rmtree: /builds/slave/test/build 11:23:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:23:43 INFO - Running post-action listener: _resource_record_post_action 11:23:43 INFO - ##### 11:23:43 INFO - ##### Finished clobber step (success) 11:23:43 INFO - ##### 11:23:43 INFO - ##### 11:23:43 INFO - ##### Running read-buildbot-config step. 11:23:43 INFO - ##### 11:23:43 INFO - Running pre-action listener: _resource_record_pre_action 11:23:43 INFO - Running main action method: read_buildbot_config 11:23:43 INFO - Using buildbot properties: 11:23:43 INFO - { 11:23:43 INFO - "project": "", 11:23:43 INFO - "product": "firefox", 11:23:43 INFO - "script_repo_revision": "production", 11:23:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:23:43 INFO - "repository": "", 11:23:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:23:43 INFO - "buildid": "20160511104611", 11:23:43 INFO - "pgo_build": "False", 11:23:43 INFO - "basedir": "/builds/slave/test", 11:23:43 INFO - "buildnumber": 2965, 11:23:43 INFO - "slavename": "talos-linux64-ix-011", 11:23:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:23:43 INFO - "platform": "ubuntu64_hw", 11:23:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:23:43 INFO - "branch": "fx-team", 11:23:43 INFO - "repo_path": "integration/fx-team", 11:23:43 INFO - "revision": "45daaf6edeae80ec8c67da50fa1d31f4a1b1a454", 11:23:43 INFO - "stage_platform": "linux64", 11:23:43 INFO - "builduid": "0adef02fcfc744b4bcf38f175d1fcb0f", 11:23:43 INFO - "slavebuilddir": "test" 11:23:43 INFO - } 11:23:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:23:43 INFO - Running post-action listener: _resource_record_post_action 11:23:43 INFO - ##### 11:23:43 INFO - ##### Finished read-buildbot-config step (success) 11:23:43 INFO - ##### 11:23:43 INFO - ##### 11:23:43 INFO - ##### Running download-and-extract step. 11:23:43 INFO - ##### 11:23:43 INFO - Running pre-action listener: _resource_record_pre_action 11:23:43 INFO - Running main action method: download_and_extract 11:23:43 INFO - mkdir: /builds/slave/test/build/tests 11:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:23:43 INFO - https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:23:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:23:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:23:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/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 11:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/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 11:23:47 INFO - Downloaded 1361 bytes. 11:23:47 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:23:47 INFO - Using the following test package requirements: 11:23:47 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:23:47 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:23:47 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:23:48 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:48 INFO - u'jsshell-linux-x86_64.zip'], 11:23:48 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:23:48 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:23:48 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:23:48 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:23:48 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:23:48 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:23:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:23:48 INFO - https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:23:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:23:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:23:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/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 11:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/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 11:23:51 INFO - Downloaded 22329056 bytes. 11: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'] 11: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 11:23:52 INFO - Return code: 0 11:23:52 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 11: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')]} 11:23:52 INFO - https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:23:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:23:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:23:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/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 11:23:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/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 11:23:54 INFO - Downloaded 22329056 bytes. 11:23:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:23:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:23:55 INFO - Return code: 0 11:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:23:55 INFO - https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:23:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:23:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:23:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/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 11:23:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/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 11:23:56 INFO - Downloaded 10840152 bytes. 11:23:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:23:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:23:57 INFO - Return code: 0 11:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:23:57 INFO - https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:23:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:23:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:23:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/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 11:23:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8rnt1t-REG1dkAlIPK6xg/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 11:23:59 INFO - Downloaded 54679518 bytes. 11:23:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:23:59 INFO - mkdir: /builds/slave/test/properties 11:23:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:23:59 INFO - Writing to file /builds/slave/test/properties/build_url 11:23:59 INFO - Contents: 11:23:59 INFO - build_url:https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:23:59 INFO - Running post-action listener: _resource_record_post_action 11:23:59 INFO - Running post-action listener: set_extra_try_arguments 11:23:59 INFO - ##### 11:23:59 INFO - ##### Finished download-and-extract step (success) 11:23:59 INFO - ##### 11:23:59 INFO - ##### 11:23:59 INFO - ##### Running populate-webroot step. 11:23:59 INFO - ##### 11:23:59 INFO - Running pre-action listener: _resource_record_pre_action 11:23:59 INFO - Running main action method: populate_webroot 11:23:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:23:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:23:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:23:59 INFO - '--tppagecycles', 11:23:59 INFO - '7'], 11:23:59 INFO - 'tests': ['tsvgm']}}, 11:23:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:23:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:23:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:23:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:23:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:23:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:23:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:59 INFO - 'talos_options': ['--disable-e10s'], 11:23:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:59 INFO - 'talos_options': ['--disable-e10s'], 11:23:59 INFO - 'tests': ['damp', 'tps']}, 11:23:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:59 INFO - 'tests': ['damp', 'tps']}, 11:23:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:23:59 INFO - 'tests': ['dromaeo_dom']}, 11:23:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:23:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:23:59 INFO - 'tests': ['a11yr', 11:23:59 INFO - 'ts_paint', 11:23:59 INFO - 'tpaint', 11:23:59 INFO - 'sessionrestore', 11:23:59 INFO - 'sessionrestore_no_auto_restore', 11:23:59 INFO - 'tabpaint']}, 11:23:59 INFO - 'other-e10s': {'tests': ['a11yr', 11:23:59 INFO - 'ts_paint', 11:23:59 INFO - 'tpaint', 11:23:59 INFO - 'sessionrestore', 11:23:59 INFO - 'sessionrestore_no_auto_restore', 11:23:59 INFO - 'tabpaint']}, 11:23:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:23:59 INFO - 'ts_paint', 11:23:59 INFO - 'tpaint', 11:23:59 INFO - 'sessionrestore', 11:23:59 INFO - 'sessionrestore_no_auto_restore', 11:23:59 INFO - 'tabpaint']}, 11:23:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:23:59 INFO - 'ts_paint', 11:23:59 INFO - 'tpaint', 11:23:59 INFO - 'sessionrestore', 11:23:59 INFO - 'sessionrestore_no_auto_restore', 11:23:59 INFO - 'tabpaint']}, 11:23:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:23:59 INFO - 'tests': ['a11yr', 11:23:59 INFO - 'ts_paint', 11:23:59 INFO - 'tpaint', 11:23:59 INFO - 'sessionrestore', 11:23:59 INFO - 'sessionrestore_no_auto_restore', 11:23:59 INFO - 'tabpaint']}, 11:23:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:23:59 INFO - 'tests': ['a11yr', 11:23:59 INFO - 'ts_paint', 11:23:59 INFO - 'tpaint', 11:23:59 INFO - 'sessionrestore', 11:23:59 INFO - 'sessionrestore_no_auto_restore', 11:23:59 INFO - 'tabpaint']}, 11:23:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:23:59 INFO - 'tests': ['tsvgx', 11:23:59 INFO - 'tsvgr_opacity', 11:23:59 INFO - 'tart', 11:23:59 INFO - 'tscrollx', 11:23:59 INFO - 'cart']}, 11:23:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:23:59 INFO - 'tsvgr_opacity', 11:23:59 INFO - 'tart', 11:23:59 INFO - 'tscrollx', 11:23:59 INFO - 'cart']}, 11:23:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:59 INFO - 'talos_options': ['--disable-e10s'], 11:23:59 INFO - 'tests': ['tp5o']}, 11:23:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:59 INFO - 'tests': ['tp5o']}, 11:23:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:59 INFO - 'talos_options': ['--disable-e10s', 11:23:59 INFO - '--xperf_path', 11:23:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:59 INFO - 'tests': ['tp5n']}, 11:23:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:59 INFO - 'talos_options': ['--xperf_path', 11:23:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:59 INFO - 'tests': ['tp5n']}}, 11:23:59 INFO - 'talos.zip': {'path': '', 11:23:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:23:59 INFO - Running post-action listener: _resource_record_post_action 11:23:59 INFO - ##### 11:23:59 INFO - ##### Finished populate-webroot step (success) 11:23:59 INFO - ##### 11:23:59 INFO - ##### 11:23:59 INFO - ##### Running create-virtualenv step. 11:23:59 INFO - ##### 11:23:59 INFO - Running pre-action listener: _resource_record_pre_action 11:23:59 INFO - Running main action method: create_virtualenv 11:23:59 INFO - Creating virtualenv /builds/slave/test/build/venv 11:23:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:23:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:23:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:23:59 INFO - Using real prefix '/usr' 11:23:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:00 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:02 INFO - Installing pip.................done. 11:24:02 INFO - Return code: 0 11:24:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11: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')]} 11:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e112e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1156770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e59c0>, '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 0x11e68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11: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', 'pip>=1.5'] in /builds/slave/test/build 11: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 pip>=1.5 11:24:02 INFO - Using env: {'DISPLAY': ':0', 11:24:02 INFO - 'HOME': '/home/cltbld', 11:24:02 INFO - 'LANG': 'en_US.UTF-8', 11:24:02 INFO - 'LANGUAGE': 'en_US:en', 11:24:02 INFO - 'LOGNAME': 'cltbld', 11:24:02 INFO - 'MAIL': '/var/mail/cltbld', 11:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:02 INFO - 'MOZ_NO_REMOTE': '1', 11:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:02 INFO - 'NO_EM_RESTART': '1', 11:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:02 INFO - 'PWD': '/builds/slave/test', 11:24:02 INFO - 'SHELL': '/bin/bash', 11:24:02 INFO - 'SHLVL': '1', 11:24:02 INFO - 'TERM': 'linux', 11:24:02 INFO - 'TMOUT': '86400', 11:24:02 INFO - 'USER': 'cltbld', 11:24:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 11:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:02 INFO - '_': '/tools/buildbot/bin/python'} 11:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:24:02 INFO - Cleaning up... 11:24:02 INFO - Return code: 0 11:24:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11: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')]} 11:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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', '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 0x7f9e112e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1156770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e59c0>, '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 0x11e68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11: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', 'psutil>=0.7.1'] in /builds/slave/test/build 11: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 psutil>=0.7.1 11:24:02 INFO - Using env: {'DISPLAY': ':0', 11:24:02 INFO - 'HOME': '/home/cltbld', 11:24:02 INFO - 'LANG': 'en_US.UTF-8', 11:24:02 INFO - 'LANGUAGE': 'en_US:en', 11:24:02 INFO - 'LOGNAME': 'cltbld', 11:24:02 INFO - 'MAIL': '/var/mail/cltbld', 11:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:02 INFO - 'MOZ_NO_REMOTE': '1', 11:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:02 INFO - 'NO_EM_RESTART': '1', 11:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:02 INFO - 'PWD': '/builds/slave/test', 11:24:02 INFO - 'SHELL': '/bin/bash', 11:24:02 INFO - 'SHLVL': '1', 11:24:02 INFO - 'TERM': 'linux', 11:24:02 INFO - 'TMOUT': '86400', 11:24:02 INFO - 'USER': 'cltbld', 11:24:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 11:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:02 INFO - '_': '/tools/buildbot/bin/python'} 11:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:02 INFO - Downloading/unpacking psutil>=0.7.1 11: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 11: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 11: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 11: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 11: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 11: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 11:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:04 INFO - Installing collected packages: psutil 11:24:04 INFO - Running setup.py install for psutil 11:24:04 INFO - building 'psutil._psutil_linux' extension 11:24:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:24:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:24:05 INFO - building 'psutil._psutil_posix' extension 11:24:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:24:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:24:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:05 INFO - Successfully installed psutil 11:24:05 INFO - Cleaning up... 11:24:05 INFO - Return code: 0 11:24:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e112e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1156770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e59c0>, '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 0x11e68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:24:05 INFO - Using env: {'DISPLAY': ':0', 11:24:05 INFO - 'HOME': '/home/cltbld', 11:24:05 INFO - 'LANG': 'en_US.UTF-8', 11:24:05 INFO - 'LANGUAGE': 'en_US:en', 11:24:05 INFO - 'LOGNAME': 'cltbld', 11:24:05 INFO - 'MAIL': '/var/mail/cltbld', 11:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:05 INFO - 'MOZ_NO_REMOTE': '1', 11:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:05 INFO - 'NO_EM_RESTART': '1', 11:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:05 INFO - 'PWD': '/builds/slave/test', 11:24:05 INFO - 'SHELL': '/bin/bash', 11:24:05 INFO - 'SHLVL': '1', 11:24:05 INFO - 'TERM': 'linux', 11:24:05 INFO - 'TMOUT': '86400', 11:24:05 INFO - 'USER': 'cltbld', 11:24:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 11:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:05 INFO - '_': '/tools/buildbot/bin/python'} 11:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:24:08 INFO - Installing collected packages: mozsystemmonitor 11:24:08 INFO - Running setup.py install for mozsystemmonitor 11:24:08 INFO - Successfully installed mozsystemmonitor 11:24:08 INFO - Cleaning up... 11:24:08 INFO - Return code: 0 11:24:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11: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')]} 11:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:08 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 0x7f9e112e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1156770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e59c0>, '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 0x11e68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:24:08 INFO - Using env: {'DISPLAY': ':0', 11:24:08 INFO - 'HOME': '/home/cltbld', 11:24:08 INFO - 'LANG': 'en_US.UTF-8', 11:24:08 INFO - 'LANGUAGE': 'en_US:en', 11:24:08 INFO - 'LOGNAME': 'cltbld', 11:24:08 INFO - 'MAIL': '/var/mail/cltbld', 11:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:08 INFO - 'MOZ_NO_REMOTE': '1', 11:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:08 INFO - 'NO_EM_RESTART': '1', 11:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:08 INFO - 'PWD': '/builds/slave/test', 11:24:08 INFO - 'SHELL': '/bin/bash', 11:24:08 INFO - 'SHLVL': '1', 11:24:08 INFO - 'TERM': 'linux', 11:24:08 INFO - 'TMOUT': '86400', 11:24:08 INFO - 'USER': 'cltbld', 11:24:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 11:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:08 INFO - '_': '/tools/buildbot/bin/python'} 11:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:08 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:11 INFO - Downloading docopt-0.6.1.tar.gz 11:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:11 INFO - Running setup.py install for blobuploader 11:24:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:11 INFO - Running setup.py install for requests 11:24:12 INFO - Running setup.py install for docopt 11:24:12 INFO - Successfully installed blobuploader requests docopt 11:24:12 INFO - Cleaning up... 11:24:12 INFO - Return code: 0 11:24:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:12 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 0x7f9e112e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1156770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e59c0>, '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 0x11e68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:24:12 INFO - Using env: {'DISPLAY': ':0', 11:24:12 INFO - 'HOME': '/home/cltbld', 11:24:12 INFO - 'LANG': 'en_US.UTF-8', 11:24:12 INFO - 'LANGUAGE': 'en_US:en', 11:24:12 INFO - 'LOGNAME': 'cltbld', 11:24:12 INFO - 'MAIL': '/var/mail/cltbld', 11:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:12 INFO - 'MOZ_NO_REMOTE': '1', 11:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:12 INFO - 'NO_EM_RESTART': '1', 11:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:12 INFO - 'PWD': '/builds/slave/test', 11:24:12 INFO - 'SHELL': '/bin/bash', 11:24:12 INFO - 'SHLVL': '1', 11:24:12 INFO - 'TERM': 'linux', 11:24:12 INFO - 'TMOUT': '86400', 11:24:12 INFO - 'USER': 'cltbld', 11:24:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 11:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:12 INFO - '_': '/tools/buildbot/bin/python'} 11:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:12 INFO - Running setup.py (path:/tmp/pip-EHY_u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:12 INFO - Running setup.py (path:/tmp/pip-tX53oV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:12 INFO - Running setup.py (path:/tmp/pip-Xeff9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:12 INFO - Running setup.py (path:/tmp/pip-QGJf4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:12 INFO - Running setup.py (path:/tmp/pip-6gF8uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:12 INFO - Running setup.py (path:/tmp/pip-2blt15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:12 INFO - Running setup.py (path:/tmp/pip-NGpgCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:12 INFO - Running setup.py (path:/tmp/pip-ISNXyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:12 INFO - Running setup.py (path:/tmp/pip-86yTyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:13 INFO - Running setup.py (path:/tmp/pip-xDGbrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:13 INFO - Running setup.py (path:/tmp/pip-TaWDiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:13 INFO - Running setup.py (path:/tmp/pip-IJSsCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:13 INFO - Running setup.py (path:/tmp/pip-hLf32A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:13 INFO - Running setup.py (path:/tmp/pip-Zgwql_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:13 INFO - Running setup.py (path:/tmp/pip-_CNqL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:13 INFO - Running setup.py (path:/tmp/pip-Yvq05S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:13 INFO - Running setup.py (path:/tmp/pip-01zUkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:13 INFO - Running setup.py install for manifestparser 11:24:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:13 INFO - Running setup.py install for mozcrash 11:24:13 INFO - Running setup.py install for mozdebug 11:24:13 INFO - Running setup.py install for mozdevice 11:24:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Running setup.py install for mozfile 11:24:14 INFO - Running setup.py install for mozhttpd 11:24:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Running setup.py install for mozinfo 11:24:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Running setup.py install for mozInstall 11:24:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Running setup.py install for mozleak 11:24:14 INFO - Running setup.py install for mozlog 11:24:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Running setup.py install for moznetwork 11:24:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Running setup.py install for mozprocess 11:24:14 INFO - Running setup.py install for mozprofile 11:24:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:14 INFO - Running setup.py install for mozrunner 11:24:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:15 INFO - Running setup.py install for mozscreenshot 11:24:15 INFO - Running setup.py install for moztest 11:24:15 INFO - Running setup.py install for mozversion 11:24:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:15 INFO - Cleaning up... 11:24:15 INFO - Return code: 0 11:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11: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')]} 11:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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/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 0x7f9e112e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1156770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e59c0>, '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 0x11e68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:24:15 INFO - Using env: {'DISPLAY': ':0', 11:24:15 INFO - 'HOME': '/home/cltbld', 11:24:15 INFO - 'LANG': 'en_US.UTF-8', 11:24:15 INFO - 'LANGUAGE': 'en_US:en', 11:24:15 INFO - 'LOGNAME': 'cltbld', 11:24:15 INFO - 'MAIL': '/var/mail/cltbld', 11:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:15 INFO - 'MOZ_NO_REMOTE': '1', 11:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:15 INFO - 'NO_EM_RESTART': '1', 11:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:15 INFO - 'PWD': '/builds/slave/test', 11:24:15 INFO - 'SHELL': '/bin/bash', 11:24:15 INFO - 'SHLVL': '1', 11:24:15 INFO - 'TERM': 'linux', 11:24:15 INFO - 'TMOUT': '86400', 11:24:15 INFO - 'USER': 'cltbld', 11:24:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 11:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:15 INFO - '_': '/tools/buildbot/bin/python'} 11:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:15 INFO - Running setup.py (path:/tmp/pip-g9az7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:15 INFO - Running setup.py (path:/tmp/pip-Eo5Vh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:15 INFO - Running setup.py (path:/tmp/pip-xJK169-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:15 INFO - Running setup.py (path:/tmp/pip-1PeE1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:15 INFO - Running setup.py (path:/tmp/pip-ihVohm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:16 INFO - Running setup.py (path:/tmp/pip-TSYTgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:16 INFO - Running setup.py (path:/tmp/pip-rUmMpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:16 INFO - Running setup.py (path:/tmp/pip-RuI9mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:16 INFO - Running setup.py (path:/tmp/pip-fY2T42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:16 INFO - Running setup.py (path:/tmp/pip-k8gpbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:16 INFO - Running setup.py (path:/tmp/pip-0Jy5fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:16 INFO - Running setup.py (path:/tmp/pip-wZew_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:16 INFO - Running setup.py (path:/tmp/pip-bGLTkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:16 INFO - Running setup.py (path:/tmp/pip-OqSWTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:16 INFO - Running setup.py (path:/tmp/pip-22_hwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:16 INFO - Running setup.py (path:/tmp/pip-uBXF4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:16 INFO - Running setup.py (path:/tmp/pip-OgWdGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:18 INFO - Downloading blessings-1.6.tar.gz 11:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:18 INFO - Installing collected packages: blessings 11:24:18 INFO - Running setup.py install for blessings 11:24:18 INFO - Successfully installed blessings 11:24:18 INFO - Cleaning up... 11:24:18 INFO - Return code: 0 11:24:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:19 INFO - Reading from file tmpfile_stdout 11:24:19 INFO - Current package versions: 11:24:19 INFO - argparse == 1.2.1 11:24:19 INFO - blessings == 1.6 11:24:19 INFO - blobuploader == 1.2.4 11:24:19 INFO - docopt == 0.6.1 11:24:19 INFO - manifestparser == 1.1 11:24:19 INFO - mozInstall == 1.12 11:24:19 INFO - mozcrash == 0.17 11:24:19 INFO - mozdebug == 0.1 11:24:19 INFO - mozdevice == 0.48 11:24:19 INFO - mozfile == 1.2 11:24:19 INFO - mozhttpd == 0.7 11:24:19 INFO - mozinfo == 0.9 11:24:19 INFO - mozleak == 0.1 11:24:19 INFO - mozlog == 3.1 11:24:19 INFO - moznetwork == 0.27 11:24:19 INFO - mozprocess == 0.22 11:24:19 INFO - mozprofile == 0.28 11:24:19 INFO - mozrunner == 6.11 11:24:19 INFO - mozscreenshot == 0.1 11:24:19 INFO - mozsystemmonitor == 0.0 11:24:19 INFO - moztest == 0.7 11:24:19 INFO - mozversion == 1.4 11:24:19 INFO - psutil == 3.1.1 11:24:19 INFO - requests == 1.2.3 11:24:19 INFO - wsgiref == 0.1.2 11:24:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:19 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 0x7f9e112e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1156770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e59c0>, '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 0x11e68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:24:19 INFO - Using env: {'DISPLAY': ':0', 11:24:19 INFO - 'HOME': '/home/cltbld', 11:24:19 INFO - 'LANG': 'en_US.UTF-8', 11:24:19 INFO - 'LANGUAGE': 'en_US:en', 11:24:19 INFO - 'LOGNAME': 'cltbld', 11:24:19 INFO - 'MAIL': '/var/mail/cltbld', 11:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:19 INFO - 'MOZ_NO_REMOTE': '1', 11:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:19 INFO - 'NO_EM_RESTART': '1', 11:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:19 INFO - 'PWD': '/builds/slave/test', 11:24:19 INFO - 'SHELL': '/bin/bash', 11:24:19 INFO - 'SHLVL': '1', 11:24:19 INFO - 'TERM': 'linux', 11:24:19 INFO - 'TMOUT': '86400', 11:24:19 INFO - 'USER': 'cltbld', 11:24:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 11:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:19 INFO - '_': '/tools/buildbot/bin/python'} 11:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:24:19 INFO - Cleaning up... 11:24:19 INFO - Return code: 0 11:24:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e112e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1156770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e59c0>, '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 0x11e68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:24:19 INFO - Using env: {'DISPLAY': ':0', 11:24:19 INFO - 'HOME': '/home/cltbld', 11:24:19 INFO - 'LANG': 'en_US.UTF-8', 11:24:19 INFO - 'LANGUAGE': 'en_US:en', 11:24:19 INFO - 'LOGNAME': 'cltbld', 11:24:19 INFO - 'MAIL': '/var/mail/cltbld', 11:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:19 INFO - 'MOZ_NO_REMOTE': '1', 11:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:19 INFO - 'NO_EM_RESTART': '1', 11:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:19 INFO - 'PWD': '/builds/slave/test', 11:24:19 INFO - 'SHELL': '/bin/bash', 11:24:19 INFO - 'SHLVL': '1', 11:24:19 INFO - 'TERM': 'linux', 11:24:19 INFO - 'TMOUT': '86400', 11:24:19 INFO - 'USER': 'cltbld', 11:24:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 11:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:19 INFO - '_': '/tools/buildbot/bin/python'} 11:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:19 INFO - Downloading/unpacking jsonschema 11:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:21 INFO - Downloading/unpacking functools32 (from jsonschema) 11:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:21 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:21 INFO - warning: no files found matching '*.txt' 11:24:21 INFO - no previously-included directories found matching 'build' 11:24:21 INFO - no previously-included directories found matching 'dist' 11:24:21 INFO - no previously-included directories found matching '.git*' 11:24:21 INFO - Installing collected packages: jsonschema, functools32 11:24:22 INFO - Running setup.py install for functools32 11:24:22 INFO - warning: no files found matching '*.txt' 11:24:22 INFO - no previously-included directories found matching 'build' 11:24:22 INFO - no previously-included directories found matching 'dist' 11:24:22 INFO - no previously-included directories found matching '.git*' 11:24:22 INFO - Successfully installed jsonschema functools32 11:24:22 INFO - Cleaning up... 11:24:22 INFO - Return code: 0 11:24:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:22 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 0x7f9e112e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1156770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e59c0>, '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 0x11e68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:24:22 INFO - Using env: {'DISPLAY': ':0', 11:24:22 INFO - 'HOME': '/home/cltbld', 11:24:22 INFO - 'LANG': 'en_US.UTF-8', 11:24:22 INFO - 'LANGUAGE': 'en_US:en', 11:24:22 INFO - 'LOGNAME': 'cltbld', 11:24:22 INFO - 'MAIL': '/var/mail/cltbld', 11:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:22 INFO - 'MOZ_NO_REMOTE': '1', 11:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:22 INFO - 'NO_EM_RESTART': '1', 11:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:22 INFO - 'PWD': '/builds/slave/test', 11:24:22 INFO - 'SHELL': '/bin/bash', 11:24:22 INFO - 'SHLVL': '1', 11:24:22 INFO - 'TERM': 'linux', 11:24:22 INFO - 'TMOUT': '86400', 11:24:22 INFO - 'USER': 'cltbld', 11:24:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 11:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:22 INFO - '_': '/tools/buildbot/bin/python'} 11:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:22 INFO - Downloading/unpacking flake8 11:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:24:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:24:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:24:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:24 INFO - no previously-included directories found matching 'docs/_build' 11:24:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:24:25 INFO - Running setup.py install for pep8 11:24:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:25 INFO - no previously-included directories found matching 'docs/_build' 11:24:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:24:25 INFO - Cleaning up... 11:24:25 INFO - Return code: 0 11:24:25 INFO - Running post-action listener: _resource_record_post_action 11:24:25 INFO - Running post-action listener: _start_resource_monitoring 11:24:25 INFO - Starting resource monitoring. 11:24:25 INFO - ##### 11:24:25 INFO - ##### Finished create-virtualenv step (success) 11:24:25 INFO - ##### 11:24:25 INFO - ##### 11:24:25 INFO - ##### Running install step. 11:24:25 INFO - ##### 11:24:25 INFO - Running pre-action listener: _resource_record_pre_action 11:24:25 INFO - Running main action method: install 11:24:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:25 INFO - Reading from file tmpfile_stdout 11:24:25 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:25 INFO - Reading from file tmpfile_stdout 11:24:25 INFO - Output received: 11:24:25 INFO - Usage: mozinstall [options] installer 11:24:25 INFO - Options: 11:24:25 INFO - -h, --help show this help message and exit 11:24:25 INFO - -d DEST, --destination=DEST 11:24:25 INFO - Directory to install application into. [default: 11:24:25 INFO - "/builds/slave/test"] 11:24:25 INFO - --app=APP Application being installed. [default: firefox] 11:24:25 INFO - mkdir: /builds/slave/test/build/application 11:24:25 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'] 11:24:25 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 11:24:41 INFO - Reading from file tmpfile_stdout 11:24:41 INFO - Output received: 11:24:41 INFO - /builds/slave/test/build/application/firefox/firefox 11:24:41 INFO - Running post-action listener: _resource_record_post_action 11:24:41 INFO - ##### 11:24:41 INFO - ##### Finished install step (success) 11:24:41 INFO - ##### 11:24:41 INFO - ##### 11:24:41 INFO - ##### Running run-tests step. 11:24:41 INFO - ##### 11:24:41 INFO - Running pre-action listener: _resource_record_pre_action 11:24:41 INFO - Running main action method: run_tests 11:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:24:41 INFO - Python 2.7.3 11:24:41 INFO - Return code: 0 11:24:41 INFO - grabbing minidump binary from tooltool 11:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:41 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e59c0>, '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 0x11e68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:24:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:24:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:24:41 INFO - Calling ['/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'] with output_timeout 600 11:24:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:24:41 INFO - Return code: 0 11:24:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:24:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:24:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:24:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:24:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:24:42 INFO - Return code: 0 11:24:42 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:24:42 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:24:42 INFO - Using env: {'DISPLAY': ':0', 11:24:42 INFO - 'HOME': '/home/cltbld', 11:24:42 INFO - 'LANG': 'en_US.UTF-8', 11:24:42 INFO - 'LANGUAGE': 'en_US:en', 11:24:42 INFO - 'LOGNAME': 'cltbld', 11:24:42 INFO - 'MAIL': '/var/mail/cltbld', 11:24:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:24:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:42 INFO - 'MOZ_NO_REMOTE': '1', 11:24:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:42 INFO - 'NO_EM_RESTART': '1', 11:24:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:42 INFO - 'PWD': '/builds/slave/test', 11:24:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:24:42 INFO - 'SHELL': '/bin/bash', 11:24:42 INFO - 'SHLVL': '1', 11:24:42 INFO - 'TERM': 'linux', 11:24:42 INFO - 'TMOUT': '86400', 11:24:42 INFO - 'USER': 'cltbld', 11:24:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325', 11:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:42 INFO - '_': '/tools/buildbot/bin/python'} 11:24:42 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:24:42 INFO - mozversion application_buildid: 20160511104611 11:24:42 INFO - mozversion application_changeset: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 11:24:42 INFO - mozversion application_display_name: Nightly 11:24:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:24:42 INFO - mozversion application_name: Firefox 11:24:42 INFO - mozversion application_remotingname: firefox 11:24:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:24:42 INFO - mozversion application_vendor: Mozilla 11:24:42 INFO - mozversion application_version: 49.0a1 11:24:42 INFO - mozversion platform_buildid: 20160511104611 11:24:42 INFO - mozversion platform_changeset: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 11:24:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:24:42 INFO - mozversion platform_version: 49.0a1 11:24:42 INFO - using testdate: 1462991082 11:24:42 INFO - actual date: 1462991082 11:24:42 INFO - starting webserver on 'localhost:57719' 11:24:42 INFO - SUITE-START | Running 2 tests 11:24:42 INFO - TEST-START | dromaeo_css 11:24:42 INFO - operating with platform_type : linux_ 11:24:42 INFO - Initialising browser for dromaeo_css test... 11:24:42 INFO - TEST-INFO | started process 10649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkhByED/profile http://localhost:57719/getInfo.html) 11:24:48 INFO - PROCESS | 10649 | __metrics Screen width/height:1600/1200 11:24:48 INFO - PROCESS | 10649 | colorDepth:24 11:24:48 INFO - PROCESS | 10649 | Browser inner width/height: 1024/697 11:24:48 INFO - PROCESS | 10649 | __metrics 11:24:49 ERROR - PROCESS | 10649 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:24:50 INFO - TEST-INFO | 10649: exit 0 11:24:50 INFO - Browser initialized. 11:24:50 INFO - Running cycle 1/1 for dromaeo_css test... 11:24:50 INFO - TEST-INFO | started process 10730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkhByED/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:02 INFO - PROCESS | 10730 | RSS: Main: 154128384 11:25:02 INFO - PROCESS | 10730 | 11:25:53 INFO - PROCESS | 10730 | 1462991153647 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:28:05 INFO - PROCESS | 10730 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57719/tests/dromaeo/cssquery-ext.html) 11:28:06 INFO - PROCESS | 10730 | RSS: Main: 233508864 11:28:06 INFO - PROCESS | 10730 | 11:31:09 INFO - PROCESS | 10730 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-ext.html (next: http://localhost:57719/tests/dromaeo/cssquery-jquery.html) 11:31:10 INFO - PROCESS | 10730 | RSS: Main: 238194688 11:31:10 INFO - PROCESS | 10730 | 11:34:12 INFO - PROCESS | 10730 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57719/tests/dromaeo/cssquery-mootools.html) 11:34:13 INFO - PROCESS | 10730 | RSS: Main: 233750528 11:34:13 INFO - PROCESS | 10730 | 11:37:15 INFO - PROCESS | 10730 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57719/tests/dromaeo/cssquery-prototype.html) 11:37:15 INFO - PROCESS | 10730 | RSS: Main: 233840640 11:37:15 INFO - PROCESS | 10730 | 11:40:18 INFO - PROCESS | 10730 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57719/tests/dromaeo/cssquery-yui.html) 11:40:19 INFO - PROCESS | 10730 | RSS: Main: 217178112 11:40:19 INFO - PROCESS | 10730 | 11:43:22 INFO - PROCESS | 10730 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-yui.html (next: http://localhost:57719/tests/dromaeo/cssquery-dojo.html) 11:43:22 INFO - PROCESS | 10730 | RSS: Main: 267059200 11:43:22 INFO - PROCESS | 10730 | 11:43:22 INFO - PROCESS | 10730 | __start_tp_report 11:43:22 INFO - PROCESS | 10730 | _x_x_mozilla_page_load 11:43:22 INFO - PROCESS | 10730 | _x_x_mozilla_page_load_details 11:43:22 INFO - PROCESS | 10730 | |i|pagename|runs| 11:43:22 INFO - PROCESS | 10730 | |0;dojo.html;2603.7786788123008;2620.4104076582767;2636.617690434888;2645.061003343813;2659.973400265998;4558.452985641724;4614.9307760383535;4639.489656137826;4669.112868554977;4714;4666.719996800194;4669.6264298856095;4687.90624187516;4767.594754445876;4786.4974177711365;4257.425247591582;4272.444582204317;4341.891452713691;4456.79944402501;4486.618637415823;4442.955570444303;4497.842575509858;4506.684532082755;4506.8873278167985;4533.433320834895;4270.124624451995;4338.934915976263;4348.956510434887;4415.779211039468;4430.313301438282;4402.987312918015;4409.669274804402;4410.05183885463;4453.933191002106;4457.264551349023;4367.781610919473;4374.606285434326;4392.824287028515;4404.515503294635;4432;4446.3108218226225;4480.260756975095;4486.080353527519;4531.093781243764;4675.836345727883;4897.975510122426;4898.975505122487;4904.09274284255;4952.108620448318;4952.851414457572;4950.925736113961;4957.082939656175;4964.602831773485;4968.826091086795;5008.048470790574;4634.374359461497;4720.008798152392;4764.404449443819;4775.5463230993;4777.378940737752;5207.531322181022;5269.78920843162;5274.050670879278;5283.682979021271;5284.471552844685;4827.131116399011;5023.447420783711;5028.84913452597;5065.468125846806;5078.13671675816;5015.523525265094;5061.645684802029;5072.923906141337;5076.898462030738;5088.440271570124;5020.221865610836;5020.297158397827;5021.548060674484;5027.572656324253;5077.213031980049;4897.706137631753;4963.230699241623;5001.299818025479;5014.52362025607;5015.699058056528;4257.233697934402;4279.764612946318;4283.485981682155;4292.613664770186;4337.327714204303;3719.1817800083936;3737.2712321097124;3740.775553466801;3778;3778.8110594470168;4273.508546517191;4310.913781724348;4310.935335969963;4328.7402755834755;4373.868783936487;5043.924341134886;5083.237514372874;5096.184610462308;5099.69401835891;5121.513456221653;4339.414179085783;4360.563943605614;4374.956250437519;4375.343698445195;4425.291953287458;4334.934975975363;4456.888577785517;4573.108243892409;4581.816727330869;4621.098885717252;4741.312509686145;4744.59670927975;4766.571008609242;4776.785044672929;4828.396450443624;5030;5031.698098114125;5032.144535429059;5046.520580544842;5066.08810414129;4683.063387322481;4703.6942598730975;4732.952670473389;4775.880602984953;4820.807167713252;4886.853394398174;4909.239067944474;4910.214365701613;4915.18899381598;4961.7271050092595;4977.203647416541;4980.078685443204;4988.102141614544;4990.8253211137435;5014.724190169576;4784.521547845187;4809.615230781459;4837.588804951478;4861.562459378673;4895.069936712013;4846.903061938671;4858.611311095175;4860.441049279237;4865.489123641966;4921.581665558468;4784.593309568587;4786.473487916257;4800.399950006249;4829.227323628203;4855.271709243641;4760.143174228672;4885.975570122127;4923.753812309298;4943.530364615356;4960.404751429852;4804.8798780030775;4822.156122678447;4845.152098382699;4849.393825771778;4900.460949295503 11:43:22 INFO - PROCESS | 10730 | |1;ext.html;569.7493103034665;592.7569696424467;608.7230310208855;618.7648693496468;641.387474961412;41951.58048419515;43436.78281608596;43512.56487435125;43600.56399436008;47391;42953;43229.35155972663;43495.56504434955;43677.56322436775;43699.34450983238;7622.504537205092;8076.1923807619205;8201.13888041756;8229.341652667772;10038.845532763753;9962.651307204249;10310.226732995017;10315.793684126313;10317.43254121023;10324.793504129913;10315.277930544866;10361.637342693008;10366.118879895217;10372.481375931211;10375.377477351383;7693.692252309901;10140.797184056351;10302.918193589678;10386.117180039706;10410.89589104107;10214.693559193161;10278.7430314242;10293.330933489298;10296.742581435448;10300.227482938735;40246.79876600627;40634.59365406338;40662.91713535808;40676.1864762706;40677.186456271;3358.529805827186;3928.7839168845703;3978.3634618460906;3981.5222173339384;4011.839526418969;30068.8496557518;30147;30244.243893902607;30259.697403025908;31602.209944751565;3316.9170770730925;3328.962269774087;3389.5254664347012;3465.2722928185112;3524.6299138590593;247076;248278;248630;249092.9999999982;249895;34216.82891585526;56741.43258567444;56861;57101.71449142728;57193.42806571964;33142.834285828416;35444;35459.82270088633;35463;35467.64532354695;14223.217723025125;14224.359903804147;14308.57074287773;14308.713825723427;14359;10985.945070274598;12101.515939362327;12274.938625306995;12280.815787763191;12585.24488530691;8491.74524764258;8492.278156356779;8529.829403411897;8581.528015959182;8593.785155371166;3288.7369010479106;3322.235885746292;3330.9167270818425;3336.4828451590042;3344.2308269097757;931.9767005824908;936.0779632062549;952.8713623660717;954.9945115257902;968.6222373274429;28248.85875570609;29521;29559.408811824072;29586.260343491584;29976.25059373533;1031.1441503552035;1109.5062697099875;1123.8258069999163;1156.1848896527927;1165.3998190931677;15490.30293636789;15646.139462329682;15774.605634859221;15776.60211619081;16002.279897404645;373693;374335;375037;376710;377027;52120.218196726324;52902.20646690303;52942.735286323325;52981.7350913243;52991;1169.7309618787726;1207.3842340406457;1259.7606454773563;1316.3155159317103;1331.9600411987656;27064.1880743578;29822.552661710524;29996.400071998873;30669.53995690022;30792;44399.55600443954;44897;44898.326525102806;45066;45090;278358;280643;280653;280746;281283;26537.469250615264;26824.731752683005;27468.56642919635;27629.03298384627;29071.563926540697;42932;43035.3544696836;43516.56483435125;44359.55640443684;44645.33032004457;36624.26751465009;37526.43710344292;37887.81056094702;37915.241695165394;38191.236175275786;37146.8142659285;37778.9221592815;38321.80839095786;38375.232495350494;38927.6107238924;37024.25951481009;37216.627833721315;37798.24403511969;38019.04952376213;38247.80876095602;31035.689643104182;34165;34278.82860585681;34594.135146621535;34997.47503787394;25940.740592593833;26167.476650466502;26168.34579135537;26181.73818261869;26484.470310594064 11:43:22 INFO - PROCESS | 10730 | |2;jquery.html;376.6309017163181;379.16016024505717;380.94095415210654;387.09999251739714;399.7941060353916;15933.681326373466;17248.137593120326;17867.910660446712;17988.370407035756;18009.90995045023;16744.246508907097;17229.74155387667;17411.564710882234;17450.38923637673;17457;5026.924596131052;5181.35233095863;5187.714675692835;5226.111561034614;5231.973840130794;3688.243909998444;3869.941950870739;5601.103823388259;5926.081457374093;5926.762929482837;5876.853078673046;5892.616979896293;5945.197398351233;5963.2247807784925;5967;5841.3282472515775;5949.7025148742605;5951.345352011275;5952.345242023374;5969;3369.3261347730554;4978.626603004789;5276.12943864262;5280.551153151987;5359.249705041298;20512;20745.377638670863;20976.685349719766;21015.47461313464;21046.789532104634;2007.989960050205;2082.083883091435;2120.613611725748;2448.2899959011866;2563.192594332779;12967.054941758717;13005.86994130056;13131.277779722112;13647.727045459034;13827.723445531134;1730;1798.4065258464675;1833.1659095111693;1877.662020836249;1900.6483800496815;67178.66410667964;67797.66101169462;67982.32017679859;69689;70172.64913675399;9659.565319560637;10060.39637621745;10133.746656333504;10148.949255253676;10253.897461025443;13988.090774099854;14024.298785060706;14115.929420353037;14138.081024733565;14155.716885662436;7536.643404187299;7633.465657403928;7680.270374314431;7841.451098423056;7856.057273127261;7105.786826395217;7251.8187045324285;7320.67056982437;7431.628418579049;7471.551706897603;6328.398802113792;6410.8076757697345;6411.422971932455;6425.903611445832;6493.837654058686;1661.567992322005;1686.207482483231;1813.5647444613462;1830.7436958825774;1835.3209312554172;927.1979737526991;983.0808194338174;989.5299732626945;1016.8881423043459;1037.5486663301338;17120.486385408458;17779.822201778075;18031.155793819216;18150.636987260183;18189.27242910295;944.7401964459829;959.2565761534727;961.1061712607202;961.8268711631973;994.7562847102506;8513.616887240089;10287.537060832281;10411.219158563137;10493.52779124926;10500.422476763699;393824;401439;402759;415333;425377;72547.63726181441;72788.27211727815;73060.63469682618;73384.63307683427;73779.63110184523;959.6737109382843;972.5040229483014;1002.7543251903185;1019.2304809868501;1022.5909636145601;15378.615534611725;15575.688486229985;15642.921785391;15750.763738543701;16139.273732681822;33119.17202069871;34308.14229644279;34891.82554087213;35320.646793531734;35389.34579906466;44528;45195.774021129684;46583;46876.29685554651;47225.291620626405;7893.5658538778625;8031.196880311922;8157.959210204149;8273.296769774637;8388.245057944814;5624.4718607403665;8437.578121094044;8576.356773241907;8664.523451209992;8774.912250877665;7804.141544430222;7888.408369372205;7937.126916039116;8028.237317454832;8415.579221039046;8045.637946292314;8136.593170341341;8150.75547733569;8158.592070396575;8236.711715089943;7917.643706033357;8080.636371363185;8228.876566851623;8263.338932885235;8407.3694472916;11686.766264674488;12060;12214.26714397139;12489.375531223584;12667.80998285045;11228.045616122721;11434.256773309708;11705.590304339648;11721.296722196696;11861.347625880659 11:43:22 INFO - PROCESS | 10730 | |3;mootools.html;1253.6176466177824;1501.6471129284616;1522.3606085444112;1688.2909178145178;1837.0355563329251;6927.792166235008;7698.422618303629;7936.285734283913;7963.960180199106;8195.67217311307;7933.167017463155;8074.677012919491;8089.757307280776;8092.716754913579;8097.838043239147;2244.865308081516;2273.795358417742;2277.772222777717;2278.9544209115807;2280.8859557022165;2258.2773512476015;2267.7392099908475;2307.573098976695;2310.4570425949887;2312.3063081075693;2229.687843701883;2236.2285011670947;2255.560165767676;2300.735415427222;2301.470661747799;2130.371540395587;2145.09905839547;2146.1200907627954;2153.353993801853;2153.364757396572;2193.7367515898036;2198.318521258415;2201.0315461197024;2205.228170140454;2207.6357401028813;7788.493747906425;7966.402519810979;8087.272145506932;8090.150534193943;8118.431709780318;4761.6904901181315;4933.45731969483;4958.7024778513405;4991.226359914219;5001.89996200074;2895.826250424981;2911.417716456696;2970.9554356684666;2971;2973.613430254075;891.728022952999;898.847195976679;926.703454894434;934.1779234273863;941.1764705882352;11129.054030407344;11341.036011938995;11376.658700239006;11376.658700239006;11387.316760994285;4303.935440968388;4425.291953287458;4502.077074199781;4513.571210734975;4518;9580.0898914603;9584.808303833885;9610.66362677303;9615.134637882624;9617.374870633386;4865.270209468537;4877.780499877514;4878;4901.485344038896;4906.681065730716;3877.6703980162;4343.2399330117105;4407.162639098625;4499.595036446735;4503.572160644799;3813.1992281620614;3824.1395685970992;3932.075962148893;3961.58403367648;3966.2662407454714;1210.8789121087998;1285.8714128587253;1290.451558087809;1297.9545715900088;1300.7333496633169;702.9121359830021;777.8483195776882;920.6547544670749;928.2388441478058;954.2795189631784;5471.972640136773;5509.311336082989;5663.292088488939;5830.562707796932;5893.823185304448;467.53947361848554;482.41627630566705;482.7875734676731;483.38851353038433;641.3906788550895;3659.7438179327723;3821.4458903458844;3855.8843234703004;3873.670737987303;3879.728419010642;9603.231741460666;10055.64805231828;10084.294099412971;10211.642592509226;10218.744531386776;10047.748806279902;10102.343347682377;10128.746781330377;10135.138513226311;10144.28989970695;7730.188330225358;7734.57459839703;7758.68965241384;7820.804479888048;7838.118851475605;5508.510563890416;5587.720613969366;5589.496945274945;5591.245181900392;5753.395893431297;9347.532623368668;9383.671571494964;9410.058994100535;9503.19222866064;9547.665831695856;9279.67521136757;9472.194863436685;9506.714798555779;9506.762330941781;9524.428534287965;6682.097916781172;6909.930900690929;6925.757598484029;6941.965290173719;7069.575825450489;7822.882656760267;7891.408144389079;7923.84152316962;7933.3653307736395;7966.721164759206;5537.944620553904;6830.897536536857;6973.302669732986;7021.1574611047;7101.2898710128575;6741.629210393476;6767.763128290683;6856.794296171123;6907.792766217021;6937.861242775015;6449.290578036318;6752.966235168989;6791.286914873867;6823.55646882951;6824.829379265558;4845.709257444564;4880.023995200903;4890.853274401774;4927.285543596086;4988.251762235694;4937.23472861707;4983.925241121314;5041.420236672683;5050.292958985671;5069.695818250917 11:43:22 INFO - PROCESS | 10730 | |4;prototype.html;297.2316561688036;302.7275452093116;307.071109892575;313.86660669215604;314.330476085937;4581.67928245023;4724.834630787923;4781.378420805295;4825.227963525832;4831.130396528623;4513.458384993797;4694.685488063339;4706.882327941803;4718.834840780573;4746;3785.432185172219;3785.889049782792;3790.914996751789;3792.033031576944;3802.3345914464994;3537.788881948782;3612.548431446069;3735.3463143949834;3798.8290526926353;3803.7717736935874;3733.6453036961443;3749.1189570450924;3769.18962423079;3779.3197224499577;3781.5840257571645;3740.4202348636004;3743.5507739071213;3743.7192210584317;3752.5309336332957;3758.3986562149926;3335.282914173464;3353.413152698268;3357.345317663057;3377.628460869302;3389.5085212644276;4441.666874984357;4471.837322296194;4532.388127602764;4546.340780586829;4551.180787458256;4231.8518851840345;4306.837153968442;4307.203167414038;4313.288307429302;4321.978390108061;4890.8043678252825;4910.90178196434;4924.901501969941;4926.433460152092;4960.578350840183;3533.0990597397754;3646.981765091184;3661.7802931824176;3677.595464498903;3680.907977300562;5079.542841144278;5125.666831655931;5127;5128.589712822965;5153.510416510426;3746.138388170736;3763.6612704856148;3772.8868133955475;3774.9811250944117;3787.772733635991;3838;3841.2317536492255;3842.769433833979;3843.6925045996254;3846.3268927938057;4090.2228576570355;4197.187884117588;4215.156968606291;4262.994588814878;4263.616274535245;4725.763711814396;4906.460289368167;4937.987827425268;4949.356583644103;4956.281339205867;1253.7993920972601;1291.3349624943162;1292.3279894454831;1300.219868079145;1303.1659737767836;860.4708104515678;860.9741707748777;866.5970323799463;880.564120760215;892.1123482135317;3952.529668956902;3961.088949541622;3990.324063893172;3993.6805055595482;4001.7598944063448;4536;4561.29299958507;4566.520515345907;4574.428196475441;4597.632189424838;3903.414487826792;3910.9413358799643;3918.6081391860585;3925.4896863407575;3931.5282166139673;2291.258643430971;2374.2877136858874;2379.6668466414717;2401.219603628828;2422.115927686382;4235.30117530604;4273.850415235514;4297.183535128315;4312.741235525878;4317.380982131701;4574.382458368144;4593.494715581283;4600.493945665974;4601.309803529431;4612.86161415158;4088.8364465421646;4270;4282.850100246476;4308.3968244445805;4308.655307575386;4434.84478043267;4460.3532487789735;4473.740760915717;4511.481179664381;4522.530177692197;4376.474823021258;4379.781010949503;4400.119976004876;4414.492333381702;4428.535003824552;4103;4266.274733295285;4305.375720520569;4335.371371151228;4379.211741886491;3429.519867218641;3462.601800792941;3463.0303515015835;3473.84367703459;3476.322117187124;4511.05267893746;4530.229860923717;4531.864044078683;4851.660383773102;4979.253112033224;4719.8112075517965;4850.975745121252;4867.269909513601;4876.341693871424;4912.214045752662;4908.6073114151495;4927.384076990376;4937;4944.678595891256;4951.801927922843;4730.408698912636;4822.614190864792;4856.902861942812;4861.319415281792;4877.268409738425;4921.655484116078;4946.480619535041;4951.678140920829;4951.727654978867;4993.300937868774;4792.5207479253195;4792.592629626521;4802.927956080592;4810.59109975656;4842.661013729005 11:43:22 INFO - PROCESS | 10730 | |5;yui.html;761.2615762710171;765.4297548326498;777.8599852026637;785.4501848705904;799.668137722845;11681.357525336103;11927.224730392518;11973.76052478951;11976.700582485442;12004.999999999989;12059.155859089868;12108.636740897766;12116.636500904964;12125.393730313494;12133.332666703327;680.2721088435376;843.5360551696542;863.6459051788784;867.8307729992622;876.9342299327544;873.6068769053951;875.0374587953232;877.5480627476854;878.995605021974;879.577802654723;918.591226904028;920.9769755756126;921.6589861751162;922.0318665401335;923.3305853256403;724;888.5424006636588;915.7847905742178;918.8346097702411;920.2132176988712;681.3561184680478;682.0996284903929;682.9419499342562;683.665004147969;684.2404930527111;12675.556355527513;12718.491260349574;12740.235585864877;12755.043371747157;12762.106652534327;12125.454354553978;12329.321887296195;12398.194117382342;12538;12664.620061398173;9647.228221742243;9705.417674939456;9872.60509579616;10981.011708946153;11040.33757974524;4188.162367526507;4195.769232692201;4206.074663574009;4280.6361459275995;4337.934930976038;40547.59452405468;41687;44896;45502.77248613769;45504.317435238496;9754.853677194847;10146.086852183338;10154.949225253826;10209.97900209973;10250;16602.667946641;17370.82629173692;17596.03221822812;17603.911980440014;17697.823021769877;6716.664166791641;6821.113255276782;6856.417204537571;7026;7119.4660400470175;3615.7107431405425;3688.870889518854;3751.118487155516;3751.3060083884025;3792.639699228569;2759.7930155238437;2858.0711268837713;2860.685324614291;2868.827870327745;2873.4684083444213;499.0692358750976;528.0547819403225;532.6644214145064;542.6933782413003;552.4641098134883;541.3341589844513;643.44342144046;644.2365796531126;646.4343699263145;653.7156336993423;7738.110117336579;8016.478928869605;8082.7171049013;8209.09699933007;8237.093919668832;564.9237352957298;571.7455732199131;598.8741166606751;613.4172536090732;621.1490258346095;3681.7238707097076;3762.3227818992295;3876.8836934891433;3906.1015966327905;3933.9213215735526;43713.56286437158;49030.50969490331;50829;51404.48595513997;51767;45790.542094579294;45897.31154032692;46318.305225421645;46766.29850552244;48359.758201208766;43082.13835723331;43445;43483.130337393704;43755;44199.77900110543;7997.200279971957;8313.168683131638;8329.95835020821;8399.496030238206;8411.285040771603;28331;29619.259518512208;29993.250168745955;30296.455531670425;30650.693493064784;39806.402903957045;39904.40143397793;40131.19737605173;40230.39654405128;40749;10682.198835087243;10732.785344292914;11274.436278185894;11280.887191127984;11411.657650270505;11307.491162897524;11749.060075193793;12419.37903104823;12731.93634031824;13156.079074465079;11019.228653994143;11274.718132046437;11449.484773185393;11585.6524304271;11837.289762614271;11660.242084264495;11682.24065435744;12110.152289339661;12122.757544848877;12191.817122742988;10630.25588208818;10633.361998280128;10690.62582809598;10781.568737250736;10873.401962892116;9338.766530836783;9387.624495020124;9492.240620750461;9660.468674222986;9927.453990030617;9372.67195648149;9504.239660827256;9628.47043412591;9636.903630963881;9673.22614190849 11:43:22 INFO - PROCESS | 10730 | __end_tp_report 11:43:22 INFO - PROCESS | 10730 | __start_cc_report 11:43:22 INFO - PROCESS | 10730 | _x_x_mozilla_cycle_collect,1065 11:43:22 INFO - PROCESS | 10730 | __end_cc_report 11:43:22 INFO - PROCESS | 10730 | __startTimestamp1462992202566__endTimestamp 11:43:22 INFO - PROCESS | 10730 | 11:43:22 INFO - PROCESS | 10730 | ------- Summary: start ------- 11:43:22 INFO - PROCESS | 10730 | Number of tests: 6 11:43:22 INFO - PROCESS | 10730 | 11:43:22 INFO - PROCESS | 10730 | [#0] dojo.html Cycles:165 Average:4654.03 Median:4777.38 stddev:477.51 (10.0%) stddev-sans-first:451.07 11:43:22 INFO - PROCESS | 10730 | Values: 2603.8 2620.4 2636.6 2645.1 2660.0 4558.5 4614.9 4639.5 4669.1 4714.0 4666.7 4669.6 4687.9 4767.6 4786.5 4257.4 4272.4 4341.9 4456.8 4486.6 4443.0 4497.8 4506.7 4506.9 4533.4 4270.1 4338.9 4349.0 4415.8 4430.3 4403.0 4409.7 4410.1 4453.9 4457.3 4367.8 4374.6 4392.8 4404.5 4432.0 4446.3 4480.3 4486.1 4531.1 4675.8 4898.0 4899.0 4904.1 4952.1 4952.9 4950.9 4957.1 4964.6 4968.8 5008.0 4634.4 4720.0 4764.4 4775.5 4777.4 5207.5 5269.8 5274.1 5283.7 5284.5 4827.1 5023.4 5028.8 5065.5 5078.1 5015.5 5061.6 5072.9 5076.9 5088.4 5020.2 5020.3 5021.5 5027.6 5077.2 4897.7 4963.2 5001.3 5014.5 5015.7 4257.2 4279.8 4283.5 4292.6 4337.3 3719.2 3737.3 3740.8 3778.0 3778.8 4273.5 4310.9 4310.9 4328.7 4373.9 5043.9 5083.2 5096.2 5099.7 5121.5 4339.4 4360.6 4375.0 4375.3 4425.3 4334.9 4456.9 4573.1 4581.8 4621.1 4741.3 4744.6 4766.6 4776.8 4828.4 5030.0 5031.7 5032.1 5046.5 5066.1 4683.1 4703.7 4733.0 4775.9 4820.8 4886.9 4909.2 4910.2 4915.2 4961.7 4977.2 4980.1 4988.1 4990.8 5014.7 4784.5 4809.6 4837.6 4861.6 4895.1 4846.9 4858.6 4860.4 4865.5 4921.6 4784.6 4786.5 4800.4 4829.2 4855.3 4760.1 4886.0 4923.8 4943.5 4960.4 4804.9 4822.2 4845.2 4849.4 4900.5 11:43:22 INFO - PROCESS | 10730 | 11:43:22 INFO - PROCESS | 10730 | [#1] ext.html Cycles:180 Average:46268.72 Median:34190.91 stddev:80362.66 (235.0%) stddev-sans-first:80514.85 11:43:22 INFO - PROCESS | 10730 | Values: 569.7 592.8 608.7 618.8 641.4 41951.6 43436.8 43512.6 43600.6 47391.0 42953.0 43229.4 43495.6 43677.6 43699.3 7622.5 8076.2 8201.1 8229.3 10038.8 9962.7 10310.2 10315.8 10317.4 10324.8 10315.3 10361.6 10366.1 10372.5 10375.4 7693.7 10140.8 10302.9 10386.1 10410.9 10214.7 10278.7 10293.3 10296.7 10300.2 40246.8 40634.6 40662.9 40676.2 40677.2 3358.5 3928.8 3978.4 3981.5 4011.8 30068.8 30147.0 30244.2 30259.7 31602.2 3316.9 3329.0 3389.5 3465.3 3524.6 247076.0 248278.0 248630.0 249093.0 249895.0 34216.8 56741.4 56861.0 57101.7 57193.4 33142.8 35444.0 35459.8 35463.0 35467.6 14223.2 14224.4 14308.6 14308.7 14359.0 10985.9 12101.5 12274.9 12280.8 12585.2 8491.7 8492.3 8529.8 8581.5 8593.8 3288.7 3322.2 3330.9 3336.5 3344.2 932.0 936.1 952.9 955.0 968.6 28248.9 29521.0 29559.4 29586.3 29976.3 1031.1 1109.5 1123.8 1156.2 1165.4 15490.3 15646.1 15774.6 15776.6 16002.3 373693.0 374335.0 375037.0 376710.0 377027.0 52120.2 52902.2 52942.7 52981.7 52991.0 1169.7 1207.4 1259.8 1316.3 1332.0 27064.2 29822.6 29996.4 30669.5 30792.0 44399.6 44897.0 44898.3 45066.0 45090.0 278358.0 280643.0 280653.0 280746.0 281283.0 26537.5 26824.7 27468.6 27629.0 29071.6 42932.0 43035.4 43516.6 44359.6 44645.3 36624.3 37526.4 37887.8 37915.2 38191.2 37146.8 37778.9 38321.8 38375.2 38927.6 37024.3 37216.6 37798.2 38019.0 38247.8 31035.7 34165.0 34278.8 34594.1 34997.5 25940.7 26167.5 26168.3 26181.7 26484.5 11:43:22 INFO - PROCESS | 10730 | 11:43:22 INFO - PROCESS | 10730 | [#2] jquery.html Cycles:180 Average:24680.59 Median:234952.50 stddev:67047.61 (28.5%) stddev-sans-first:67210.87 11:43:22 INFO - PROCESS | 10730 | Values: 376.6 379.2 380.9 387.1 399.8 15933.7 17248.1 17867.9 17988.4 18009.9 16744.2 17229.7 17411.6 17450.4 17457.0 5026.9 5181.4 5187.7 5226.1 5232.0 3688.2 3869.9 5601.1 5926.1 5926.8 5876.9 5892.6 5945.2 5963.2 5967.0 5841.3 5949.7 5951.3 5952.3 5969.0 3369.3 4978.6 5276.1 5280.6 5359.2 20512.0 20745.4 20976.7 21015.5 21046.8 2008.0 2082.1 2120.6 2448.3 2563.2 12967.1 13005.9 13131.3 13647.7 13827.7 1730.0 1798.4 1833.2 1877.7 1900.6 67178.7 67797.7 67982.3 69689.0 70172.6 9659.6 10060.4 10133.7 10148.9 10253.9 13988.1 14024.3 14115.9 14138.1 14155.7 7536.6 7633.5 7680.3 7841.5 7856.1 7105.8 7251.8 7320.7 7431.6 7471.6 6328.4 6410.8 6411.4 6425.9 6493.8 1661.6 1686.2 1813.6 1830.7 1835.3 927.2 983.1 989.5 1016.9 1037.5 17120.5 17779.8 18031.2 18150.6 18189.3 944.7 959.3 961.1 961.8 994.8 8513.6 10287.5 10411.2 10493.5 10500.4 393824.0 401439.0 402759.0 415333.0 425377.0 72547.6 72788.3 73060.6 73384.6 73779.6 959.7 972.5 1002.8 1019.2 1022.6 15378.6 15575.7 15642.9 15750.8 16139.3 33119.2 34308.1 34891.8 35320.6 35389.3 44528.0 45195.8 46583.0 46876.3 47225.3 7893.6 8031.2 8158.0 8273.3 8388.2 5624.5 8437.6 8576.4 8664.5 8774.9 7804.1 7888.4 7937.1 8028.2 8415.6 8045.6 8136.6 8150.8 8158.6 8236.7 7917.6 8080.6 8228.9 8263.3 8407.4 11686.8 12060.0 12214.3 12489.4 12667.8 11228.0 11434.3 11705.6 11721.3 11861.3 11:43:22 INFO - PROCESS | 10730 | 11:43:22 INFO - PROCESS | 10730 | [#3] mootools.html Cycles:180 Average:5371.95 Median:4971.31 stddev:3033.29 (61.0%) stddev-sans-first:3026.00 11:43:22 INFO - PROCESS | 10730 | Values: 1253.6 1501.6 1522.4 1688.3 1837.0 6927.8 7698.4 7936.3 7964.0 8195.7 7933.2 8074.7 8089.8 8092.7 8097.8 2244.9 2273.8 2277.8 2279.0 2280.9 2258.3 2267.7 2307.6 2310.5 2312.3 2229.7 2236.2 2255.6 2300.7 2301.5 2130.4 2145.1 2146.1 2153.4 2153.4 2193.7 2198.3 2201.0 2205.2 2207.6 7788.5 7966.4 8087.3 8090.2 8118.4 4761.7 4933.5 4958.7 4991.2 5001.9 2895.8 2911.4 2971.0 2971.0 2973.6 891.7 898.8 926.7 934.2 941.2 11129.1 11341.0 11376.7 11376.7 11387.3 4303.9 4425.3 4502.1 4513.6 4518.0 9580.1 9584.8 9610.7 9615.1 9617.4 4865.3 4877.8 4878.0 4901.5 4906.7 3877.7 4343.2 4407.2 4499.6 4503.6 3813.2 3824.1 3932.1 3961.6 3966.3 1210.9 1285.9 1290.5 1298.0 1300.7 702.9 777.8 920.7 928.2 954.3 5472.0 5509.3 5663.3 5830.6 5893.8 467.5 482.4 482.8 483.4 641.4 3659.7 3821.4 3855.9 3873.7 3879.7 9603.2 10055.6 10084.3 10211.6 10218.7 10047.7 10102.3 10128.7 10135.1 10144.3 7730.2 7734.6 7758.7 7820.8 7838.1 5508.5 5587.7 5589.5 5591.2 5753.4 9347.5 9383.7 9410.1 9503.2 9547.7 9279.7 9472.2 9506.7 9506.8 9524.4 6682.1 6909.9 6925.8 6942.0 7069.6 7822.9 7891.4 7923.8 7933.4 7966.7 5537.9 6830.9 6973.3 7021.2 7101.3 6741.6 6767.8 6856.8 6907.8 6937.9 6449.3 6753.0 6791.3 6823.6 6824.8 4845.7 4880.0 4890.9 4927.3 4988.3 4937.2 4983.9 5041.4 5050.3 5069.7 11:43:22 INFO - PROCESS | 10730 | 11:43:22 INFO - PROCESS | 10730 | [#4] prototype.html Cycles:180 Average:3975.05 Median:4315.33 stddev:1116.04 (25.9%) stddev-sans-first:1084.50 11:43:22 INFO - PROCESS | 10730 | Values: 297.2 302.7 307.1 313.9 314.3 4581.7 4724.8 4781.4 4825.2 4831.1 4513.5 4694.7 4706.9 4718.8 4746.0 3785.4 3785.9 3790.9 3792.0 3802.3 3537.8 3612.5 3735.3 3798.8 3803.8 3733.6 3749.1 3769.2 3779.3 3781.6 3740.4 3743.6 3743.7 3752.5 3758.4 3335.3 3353.4 3357.3 3377.6 3389.5 4441.7 4471.8 4532.4 4546.3 4551.2 4231.9 4306.8 4307.2 4313.3 4322.0 4890.8 4910.9 4924.9 4926.4 4960.6 3533.1 3647.0 3661.8 3677.6 3680.9 5079.5 5125.7 5127.0 5128.6 5153.5 3746.1 3763.7 3772.9 3775.0 3787.8 3838.0 3841.2 3842.8 3843.7 3846.3 4090.2 4197.2 4215.2 4263.0 4263.6 4725.8 4906.5 4938.0 4949.4 4956.3 1253.8 1291.3 1292.3 1300.2 1303.2 860.5 861.0 866.6 880.6 892.1 3952.5 3961.1 3990.3 3993.7 4001.8 4536.0 4561.3 4566.5 4574.4 4597.6 3903.4 3910.9 3918.6 3925.5 3931.5 2291.3 2374.3 2379.7 2401.2 2422.1 4235.3 4273.9 4297.2 4312.7 4317.4 4574.4 4593.5 4600.5 4601.3 4612.9 4088.8 4270.0 4282.9 4308.4 4308.7 4434.8 4460.4 4473.7 4511.5 4522.5 4376.5 4379.8 4400.1 4414.5 4428.5 4103.0 4266.3 4305.4 4335.4 4379.2 3429.5 3462.6 3463.0 3473.8 3476.3 4511.1 4530.2 4531.9 4851.7 4979.3 4719.8 4851.0 4867.3 4876.3 4912.2 4908.6 4927.4 4937.0 4944.7 4951.8 4730.4 4822.6 4856.9 4861.3 4877.3 4921.7 4946.5 4951.7 4951.7 4993.3 4792.5 4792.6 4802.9 4810.6 4842.7 11:43:22 INFO - PROCESS | 10730 | 11:43:22 INFO - PROCESS | 10730 | [#5] yui.html Cycles:180 Average:12811.47 Median:43598.35 stddev:14201.33 (32.6%) stddev-sans-first:14212.34 11:43:22 INFO - PROCESS | 10730 | Values: 761.3 765.4 777.9 785.5 799.7 11681.4 11927.2 11973.8 11976.7 12005.0 12059.2 12108.6 12116.6 12125.4 12133.3 680.3 843.5 863.6 867.8 876.9 873.6 875.0 877.5 879.0 879.6 918.6 921.0 921.7 922.0 923.3 724.0 888.5 915.8 918.8 920.2 681.4 682.1 682.9 683.7 684.2 12675.6 12718.5 12740.2 12755.0 12762.1 12125.5 12329.3 12398.2 12538.0 12664.6 9647.2 9705.4 9872.6 10981.0 11040.3 4188.2 4195.8 4206.1 4280.6 4337.9 40547.6 41687.0 44896.0 45502.8 45504.3 9754.9 10146.1 10154.9 10210.0 10250.0 16602.7 17370.8 17596.0 17603.9 17697.8 6716.7 6821.1 6856.4 7026.0 7119.5 3615.7 3688.9 3751.1 3751.3 3792.6 2759.8 2858.1 2860.7 2868.8 2873.5 499.1 528.1 532.7 542.7 552.5 541.3 643.4 644.2 646.4 653.7 7738.1 8016.5 8082.7 8209.1 8237.1 564.9 571.7 598.9 613.4 621.1 3681.7 3762.3 3876.9 3906.1 3933.9 43713.6 49030.5 50829.0 51404.5 51767.0 45790.5 45897.3 46318.3 46766.3 48359.8 43082.1 43445.0 43483.1 43755.0 44199.8 7997.2 8313.2 8330.0 8399.5 8411.3 28331.0 29619.3 29993.3 30296.5 30650.7 39806.4 39904.4 40131.2 40230.4 40749.0 10682.2 10732.8 11274.4 11280.9 11411.7 11307.5 11749.1 12419.4 12731.9 13156.1 11019.2 11274.7 11449.5 11585.7 11837.3 11660.2 11682.2 12110.2 12122.8 12191.8 10630.3 10633.4 10690.6 10781.6 10873.4 9338.8 9387.6 9492.2 9660.5 9927.5 9372.7 9504.2 9628.5 9636.9 9673.2 11:43:22 INFO - PROCESS | 10730 | -------- Summary: end -------- 11:43:22 INFO - PROCESS | 10730 | 11:43:23 INFO - TEST-INFO | 10730: exit 0 11:43:23 INFO - TEST-OK | dromaeo_css | took 1120912ms 11:43:23 INFO - TEST-START | kraken 11:43:23 INFO - operating with platform_type : linux_ 11:43:23 INFO - Initialising browser for kraken test... 11:43:23 INFO - TEST-INFO | started process 10906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPo2J7c/profile http://localhost:57719/getInfo.html) 11:43:28 INFO - PROCESS | 10906 | __metrics Screen width/height:1600/1200 11:43:28 INFO - PROCESS | 10906 | colorDepth:24 11:43:28 INFO - PROCESS | 10906 | Browser inner width/height: 1024/697 11:43:28 INFO - PROCESS | 10906 | __metrics 11:43:30 ERROR - PROCESS | 10906 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:43:31 INFO - TEST-INFO | 10906: exit 0 11:43:31 INFO - Browser initialized. 11:43:31 INFO - Running cycle 1/1 for kraken test... 11:43:31 INFO - TEST-INFO | started process 10987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPo2J7c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:43 INFO - PROCESS | 10987 | RSS: Main: 154206208 11:43:43 INFO - PROCESS | 10987 | 11:43:46 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-beat-detection) 11:43:47 INFO - PROCESS | 10987 | RSS: Main: 210731008 11:43:47 INFO - PROCESS | 10987 | 11:43:49 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-dft) 11:43:50 INFO - PROCESS | 10987 | RSS: Main: 198950912 11:43:50 INFO - PROCESS | 10987 | 11:43:53 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-fft) 11:43:54 INFO - PROCESS | 10987 | RSS: Main: 267001856 11:43:54 INFO - PROCESS | 10987 | 11:43:56 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-oscillator) 11:43:57 INFO - PROCESS | 10987 | RSS: Main: 175394816 11:43:57 INFO - PROCESS | 10987 | 11:43:59 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57719/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:00 INFO - PROCESS | 10987 | RSS: Main: 179183616 11:44:00 INFO - PROCESS | 10987 | 11:44:03 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57719/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:04 INFO - PROCESS | 10987 | RSS: Main: 215502848 11:44:04 INFO - PROCESS | 10987 | 11:44:07 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57719/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:08 INFO - PROCESS | 10987 | RSS: Main: 213757952 11:44:08 INFO - PROCESS | 10987 | 11:44:11 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57719/tests/kraken/driver.html?testName=json-parse-financial) 11:44:12 INFO - PROCESS | 10987 | RSS: Main: 214134784 11:44:12 INFO - PROCESS | 10987 | 11:44:13 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57719/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:14 INFO - PROCESS | 10987 | RSS: Main: 208162816 11:44:14 INFO - PROCESS | 10987 | 11:44:16 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:17 INFO - PROCESS | 10987 | RSS: Main: 213016576 11:44:17 INFO - PROCESS | 10987 | 11:44:19 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:20 INFO - PROCESS | 10987 | RSS: Main: 215519232 11:44:20 INFO - PROCESS | 10987 | 11:44:23 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:23 INFO - PROCESS | 10987 | RSS: Main: 220692480 11:44:23 INFO - PROCESS | 10987 | 11:44:26 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:27 INFO - PROCESS | 10987 | RSS: Main: 218181632 11:44:27 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57719/tests/kraken/driver.html?testName=ai-astar) 11:44:29 INFO - PROCESS | 10987 | RSS: Main: 265158656 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | __start_tp_report 11:44:29 INFO - PROCESS | 10987 | _x_x_mozilla_page_load 11:44:29 INFO - PROCESS | 10987 | _x_x_mozilla_page_load_details 11:44:29 INFO - PROCESS | 10987 | |i|pagename|runs| 11:44:29 INFO - PROCESS | 10987 | |0;ai-astar;114;110;112;113;113;113;112;112;113;114 11:44:29 INFO - PROCESS | 10987 | |1;audio-beat-detection;155;134;157;208;131;150;155;134;187;130 11:44:29 INFO - PROCESS | 10987 | |2;audio-dft;161;161;161;163;162;162;161;162;161;162 11:44:29 INFO - PROCESS | 10987 | |3;audio-fft;76;76;75;150;76;75;77;76;124;77 11:44:29 INFO - PROCESS | 10987 | |4;audio-oscillator;93;94;156;98;94;93;120;93;93;127 11:44:29 INFO - PROCESS | 10987 | |5;imaging-gaussian-blur;116;117;116;116;116;118;117;117;117;116 11:44:29 INFO - PROCESS | 10987 | |6;imaging-darkroom;147;147;145;146;146;147;146;146;146;146 11:44:29 INFO - PROCESS | 10987 | |7;imaging-desaturate;95;94;94;95;94;95;94;94;95;95 11:44:29 INFO - PROCESS | 10987 | |8;json-parse-financial;66;67;68;66;72;69;67;66;67;66 11:44:29 INFO - PROCESS | 10987 | |9;json-stringify-tinderbox;63;64;64;63;64;64;63;63;64;64 11:44:29 INFO - PROCESS | 10987 | |10;stanford-crypto-aes;81;82;81;87;83;83;83;83;166;82 11:44:29 INFO - PROCESS | 10987 | |11;stanford-crypto-ccm;132;144;142;138;131;131;131;131;158;135 11:44:29 INFO - PROCESS | 10987 | |12;stanford-crypto-pbkdf2;174;175;180;178;175;180;177;178;175;171 11:44:29 INFO - PROCESS | 10987 | |13;stanford-crypto-sha256-iterative;69;69;68;68;68;67;68;67;67;67 11:44:29 INFO - PROCESS | 10987 | __end_tp_report 11:44:29 INFO - PROCESS | 10987 | __start_cc_report 11:44:29 INFO - PROCESS | 10987 | _x_x_mozilla_cycle_collect,2051 11:44:29 INFO - PROCESS | 10987 | __end_cc_report 11:44:29 INFO - PROCESS | 10987 | __startTimestamp1462992269302__endTimestamp 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | ------- Summary: start ------- 11:44:29 INFO - PROCESS | 10987 | Number of tests: 14 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:1.17 (1.0%) stddev-sans-first:1.13 11:44:29 INFO - PROCESS | 10987 | Values: 114.0 110.0 112.0 113.0 113.0 113.0 112.0 112.0 113.0 114.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:155.00 stddev:25.68 (16.6%) stddev-sans-first:27.24 11:44:29 INFO - PROCESS | 10987 | Values: 155.0 134.0 157.0 208.0 131.0 150.0 155.0 134.0 187.0 130.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 11:44:29 INFO - PROCESS | 10987 | Values: 161.0 161.0 161.0 163.0 162.0 162.0 161.0 162.0 161.0 162.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#3] audio-fft Cycles:10 Average:88.20 Median:76.00 stddev:26.45 (34.8%) stddev-sans-first:27.68 11:44:29 INFO - PROCESS | 10987 | Values: 76.0 76.0 75.0 150.0 76.0 75.0 77.0 76.0 124.0 77.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:93.00 stddev:21.51 (23.1%) stddev-sans-first:22.29 11:44:29 INFO - PROCESS | 10987 | Values: 93.0 94.0 156.0 98.0 94.0 93.0 120.0 93.0 93.0 127.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 11:44:29 INFO - PROCESS | 10987 | Values: 116.0 117.0 116.0 116.0 116.0 118.0 117.0 117.0 117.0 116.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 11:44:29 INFO - PROCESS | 10987 | Values: 147.0 147.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 11:44:29 INFO - PROCESS | 10987 | Values: 95.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:67.00 stddev:1.90 (2.8%) stddev-sans-first:1.94 11:44:29 INFO - PROCESS | 10987 | Values: 66.0 67.0 68.0 66.0 72.0 69.0 67.0 66.0 67.0 66.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 11:44:29 INFO - PROCESS | 10987 | Values: 63.0 64.0 64.0 63.0 64.0 64.0 63.0 63.0 64.0 64.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:83.00 stddev:26.37 (31.8%) stddev-sans-first:27.72 11:44:29 INFO - PROCESS | 10987 | Values: 81.0 82.0 81.0 87.0 83.0 83.0 83.0 83.0 166.0 82.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:136.50 stddev:8.74 (6.4%) stddev-sans-first:9.06 11:44:29 INFO - PROCESS | 10987 | Values: 132.0 144.0 142.0 138.0 131.0 131.0 131.0 131.0 158.0 135.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:177.50 stddev:2.83 (1.6%) stddev-sans-first:2.88 11:44:29 INFO - PROCESS | 10987 | Values: 174.0 175.0 180.0 178.0 175.0 180.0 177.0 178.0 175.0 171.0 11:44:29 INFO - PROCESS | 10987 | 11:44:29 INFO - PROCESS | 10987 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 11:44:29 INFO - PROCESS | 10987 | Values: 69.0 69.0 68.0 68.0 68.0 67.0 68.0 67.0 67.0 67.0 11:44:29 INFO - PROCESS | 10987 | -------- Summary: end -------- 11:44:29 INFO - PROCESS | 10987 | 11:44:30 INFO - TEST-INFO | 10987: exit 0 11:44:30 INFO - TEST-OK | kraken | took 67064ms 11:44:30 INFO - SUITE-END | took 1187s 11:44:30 INFO - Completed test suite (00:19:48) 11:44:30 INFO - javascript benchmark 11:44:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.7786788123008, 2620.4104076582767, 2636.617690434888, 2645.061003343813, 2659.973400265998, 4558.452985641724, 4614.9307760383535, 4639.489656137826, 4669.112868554977, 4714.0, 4666.719996800194, 4669.6264298856095, 4687.90624187516, 4767.594754445876, 4786.4974177711365, 4257.425247591582, 4272.444582204317, 4341.891452713691, 4456.79944402501, 4486.618637415823, 4442.955570444303, 4497.842575509858, 4506.684532082755, 4506.8873278167985, 4533.433320834895, 4270.124624451995, 4338.934915976263, 4348.956510434887, 4415.779211039468, 4430.313301438282, 4402.987312918015, 4409.669274804402, 4410.05183885463, 4453.933191002106, 4457.264551349023, 4367.781610919473, 4374.606285434326, 4392.824287028515, 4404.515503294635, 4432.0, 4446.3108218226225, 4480.260756975095, 4486.080353527519, 4531.093781243764, 4675.836345727883, 4897.975510122426, 4898.975505122487, 4904.09274284255, 4952.108620448318, 4952.851414457572, 4950.925736113961, 4957.082939656175, 4964.602831773485, 4968.826091086795, 5008.048470790574, 4634.374359461497, 4720.008798152392, 4764.404449443819, 4775.5463230993, 4777.378940737752, 5207.531322181022, 5269.78920843162, 5274.050670879278, 5283.682979021271, 5284.471552844685, 4827.131116399011, 5023.447420783711, 5028.84913452597, 5065.468125846806, 5078.13671675816, 5015.523525265094, 5061.645684802029, 5072.923906141337, 5076.898462030738, 5088.440271570124, 5020.221865610836, 5020.297158397827, 5021.548060674484, 5027.572656324253, 5077.213031980049, 4897.706137631753, 4963.230699241623, 5001.299818025479, 5014.52362025607, 5015.699058056528, 4257.233697934402, 4279.764612946318, 4283.485981682155, 4292.613664770186, 4337.327714204303, 3719.1817800083936, 3737.2712321097124, 3740.775553466801, 3778.0, 3778.8110594470168, 4273.508546517191, 4310.913781724348, 4310.935335969963, 4328.7402755834755, 4373.868783936487, 5043.924341134886, 5083.237514372874, 5096.184610462308, 5099.69401835891, 5121.513456221653, 4339.414179085783, 4360.563943605614, 4374.956250437519, 4375.343698445195, 4425.291953287458, 4334.934975975363, 4456.888577785517, 4573.108243892409, 4581.816727330869, 4621.098885717252, 4741.312509686145, 4744.59670927975, 4766.571008609242, 4776.785044672929, 4828.396450443624, 5030.0, 5031.698098114125, 5032.144535429059, 5046.520580544842, 5066.08810414129, 4683.063387322481, 4703.6942598730975, 4732.952670473389, 4775.880602984953, 4820.807167713252, 4886.853394398174, 4909.239067944474, 4910.214365701613, 4915.18899381598, 4961.7271050092595, 4977.203647416541, 4980.078685443204, 4988.102141614544, 4990.8253211137435, 5014.724190169576, 4784.521547845187, 4809.615230781459, 4837.588804951478, 4861.562459378673, 4895.069936712013, 4846.903061938671, 4858.611311095175, 4860.441049279237, 4865.489123641966, 4921.581665558468, 4784.593309568587, 4786.473487916257, 4800.399950006249, 4829.227323628203, 4855.271709243641, 4760.143174228672, 4885.975570122127, 4923.753812309298, 4943.530364615356, 4960.404751429852, 4804.8798780030775, 4822.156122678447, 4845.152098382699, 4849.393825771778, 4900.460949295503], "value": 4624.044473642348, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.7493103034665, 592.7569696424467, 608.7230310208855, 618.7648693496468, 641.387474961412, 41951.58048419515, 43436.78281608596, 43512.56487435125, 43600.56399436008, 47391.0, 42953.0, 43229.35155972663, 43495.56504434955, 43677.56322436775, 43699.34450983238, 7622.504537205092, 8076.1923807619205, 8201.13888041756, 8229.341652667772, 10038.845532763753, 9962.651307204249, 10310.226732995017, 10315.793684126313, 10317.43254121023, 10324.793504129913, 10315.277930544866, 10361.637342693008, 10366.118879895217, 10372.481375931211, 10375.377477351383, 7693.692252309901, 10140.797184056351, 10302.918193589678, 10386.117180039706, 10410.89589104107, 10214.693559193161, 10278.7430314242, 10293.330933489298, 10296.742581435448, 10300.227482938735, 40246.79876600627, 40634.59365406338, 40662.91713535808, 40676.1864762706, 40677.186456271, 3358.529805827186, 3928.7839168845703, 3978.3634618460906, 3981.5222173339384, 4011.839526418969, 30068.8496557518, 30147.0, 30244.243893902607, 30259.697403025908, 31602.209944751565, 3316.9170770730925, 3328.962269774087, 3389.5254664347012, 3465.2722928185112, 3524.6299138590593, 247076.0, 248278.0, 248630.0, 249092.9999999982, 249895.0, 34216.82891585526, 56741.43258567444, 56861.0, 57101.71449142728, 57193.42806571964, 33142.834285828416, 35444.0, 35459.82270088633, 35463.0, 35467.64532354695, 14223.217723025125, 14224.359903804147, 14308.57074287773, 14308.713825723427, 14359.0, 10985.945070274598, 12101.515939362327, 12274.938625306995, 12280.815787763191, 12585.24488530691, 8491.74524764258, 8492.278156356779, 8529.829403411897, 8581.528015959182, 8593.785155371166, 3288.7369010479106, 3322.235885746292, 3330.9167270818425, 3336.4828451590042, 3344.2308269097757, 931.9767005824908, 936.0779632062549, 952.8713623660717, 954.9945115257902, 968.6222373274429, 28248.85875570609, 29521.0, 29559.408811824072, 29586.260343491584, 29976.25059373533, 1031.1441503552035, 1109.5062697099875, 1123.8258069999163, 1156.1848896527927, 1165.3998190931677, 15490.30293636789, 15646.139462329682, 15774.605634859221, 15776.60211619081, 16002.279897404645, 373693.0, 374335.0, 375037.0, 376710.0, 377027.0, 52120.218196726324, 52902.20646690303, 52942.735286323325, 52981.7350913243, 52991.0, 1169.7309618787726, 1207.3842340406457, 1259.7606454773563, 1316.3155159317103, 1331.9600411987656, 27064.1880743578, 29822.552661710524, 29996.400071998873, 30669.53995690022, 30792.0, 44399.55600443954, 44897.0, 44898.326525102806, 45066.0, 45090.0, 278358.0, 280643.0, 280653.0, 280746.0, 281283.0, 26537.469250615264, 26824.731752683005, 27468.56642919635, 27629.03298384627, 29071.563926540697, 42932.0, 43035.3544696836, 43516.56483435125, 44359.55640443684, 44645.33032004457, 36624.26751465009, 37526.43710344292, 37887.81056094702, 37915.241695165394, 38191.236175275786, 37146.8142659285, 37778.9221592815, 38321.80839095786, 38375.232495350494, 38927.6107238924, 37024.25951481009, 37216.627833721315, 37798.24403511969, 38019.04952376213, 38247.80876095602, 31035.689643104182, 34165.0, 34278.82860585681, 34594.135146621535, 34997.47503787394, 25940.740592593833, 26167.476650466502, 26168.34579135537, 26181.73818261869, 26484.470310594064], "value": 17777.901312151484, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.6309017163181, 379.16016024505717, 380.94095415210654, 387.09999251739714, 399.7941060353916, 15933.681326373466, 17248.137593120326, 17867.910660446712, 17988.370407035756, 18009.90995045023, 16744.246508907097, 17229.74155387667, 17411.564710882234, 17450.38923637673, 17457.0, 5026.924596131052, 5181.35233095863, 5187.714675692835, 5226.111561034614, 5231.973840130794, 3688.243909998444, 3869.941950870739, 5601.103823388259, 5926.081457374093, 5926.762929482837, 5876.853078673046, 5892.616979896293, 5945.197398351233, 5963.2247807784925, 5967.0, 5841.3282472515775, 5949.7025148742605, 5951.345352011275, 5952.345242023374, 5969.0, 3369.3261347730554, 4978.626603004789, 5276.12943864262, 5280.551153151987, 5359.249705041298, 20512.0, 20745.377638670863, 20976.685349719766, 21015.47461313464, 21046.789532104634, 2007.989960050205, 2082.083883091435, 2120.613611725748, 2448.2899959011866, 2563.192594332779, 12967.054941758717, 13005.86994130056, 13131.277779722112, 13647.727045459034, 13827.723445531134, 1730.0, 1798.4065258464675, 1833.1659095111693, 1877.662020836249, 1900.6483800496815, 67178.66410667964, 67797.66101169462, 67982.32017679859, 69689.0, 70172.64913675399, 9659.565319560637, 10060.39637621745, 10133.746656333504, 10148.949255253676, 10253.897461025443, 13988.090774099854, 14024.298785060706, 14115.929420353037, 14138.081024733565, 14155.716885662436, 7536.643404187299, 7633.465657403928, 7680.270374314431, 7841.451098423056, 7856.057273127261, 7105.786826395217, 7251.8187045324285, 7320.67056982437, 7431.628418579049, 7471.551706897603, 6328.398802113792, 6410.8076757697345, 6411.422971932455, 6425.903611445832, 6493.837654058686, 1661.567992322005, 1686.207482483231, 1813.5647444613462, 1830.7436958825774, 1835.3209312554172, 927.1979737526991, 983.0808194338174, 989.5299732626945, 1016.8881423043459, 1037.5486663301338, 17120.486385408458, 17779.822201778075, 18031.155793819216, 18150.636987260183, 18189.27242910295, 944.7401964459829, 959.2565761534727, 961.1061712607202, 961.8268711631973, 994.7562847102506, 8513.616887240089, 10287.537060832281, 10411.219158563137, 10493.52779124926, 10500.422476763699, 393824.0, 401439.0, 402759.0, 415333.0, 425377.0, 72547.63726181441, 72788.27211727815, 73060.63469682618, 73384.63307683427, 73779.63110184523, 959.6737109382843, 972.5040229483014, 1002.7543251903185, 1019.2304809868501, 1022.5909636145601, 15378.615534611725, 15575.688486229985, 15642.921785391, 15750.763738543701, 16139.273732681822, 33119.17202069871, 34308.14229644279, 34891.82554087213, 35320.646793531734, 35389.34579906466, 44528.0, 45195.774021129684, 46583.0, 46876.29685554651, 47225.291620626405, 7893.5658538778625, 8031.196880311922, 8157.959210204149, 8273.296769774637, 8388.245057944814, 5624.4718607403665, 8437.578121094044, 8576.356773241907, 8664.523451209992, 8774.912250877665, 7804.141544430222, 7888.408369372205, 7937.126916039116, 8028.237317454832, 8415.579221039046, 8045.637946292314, 8136.593170341341, 8150.75547733569, 8158.592070396575, 8236.711715089943, 7917.643706033357, 8080.636371363185, 8228.876566851623, 8263.338932885235, 8407.3694472916, 11686.766264674488, 12060.0, 12214.26714397139, 12489.375531223584, 12667.80998285045, 11228.045616122721, 11434.256773309708, 11705.590304339648, 11721.296722196696, 11861.347625880659], "value": 8445.246826829054, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.6176466177824, 1501.6471129284616, 1522.3606085444112, 1688.2909178145178, 1837.0355563329251, 6927.792166235008, 7698.422618303629, 7936.285734283913, 7963.960180199106, 8195.67217311307, 7933.167017463155, 8074.677012919491, 8089.757307280776, 8092.716754913579, 8097.838043239147, 2244.865308081516, 2273.795358417742, 2277.772222777717, 2278.9544209115807, 2280.8859557022165, 2258.2773512476015, 2267.7392099908475, 2307.573098976695, 2310.4570425949887, 2312.3063081075693, 2229.687843701883, 2236.2285011670947, 2255.560165767676, 2300.735415427222, 2301.470661747799, 2130.371540395587, 2145.09905839547, 2146.1200907627954, 2153.353993801853, 2153.364757396572, 2193.7367515898036, 2198.318521258415, 2201.0315461197024, 2205.228170140454, 2207.6357401028813, 7788.493747906425, 7966.402519810979, 8087.272145506932, 8090.150534193943, 8118.431709780318, 4761.6904901181315, 4933.45731969483, 4958.7024778513405, 4991.226359914219, 5001.89996200074, 2895.826250424981, 2911.417716456696, 2970.9554356684666, 2971.0, 2973.613430254075, 891.728022952999, 898.847195976679, 926.703454894434, 934.1779234273863, 941.1764705882352, 11129.054030407344, 11341.036011938995, 11376.658700239006, 11376.658700239006, 11387.316760994285, 4303.935440968388, 4425.291953287458, 4502.077074199781, 4513.571210734975, 4518.0, 9580.0898914603, 9584.808303833885, 9610.66362677303, 9615.134637882624, 9617.374870633386, 4865.270209468537, 4877.780499877514, 4878.0, 4901.485344038896, 4906.681065730716, 3877.6703980162, 4343.2399330117105, 4407.162639098625, 4499.595036446735, 4503.572160644799, 3813.1992281620614, 3824.1395685970992, 3932.075962148893, 3961.58403367648, 3966.2662407454714, 1210.8789121087998, 1285.8714128587253, 1290.451558087809, 1297.9545715900088, 1300.7333496633169, 702.9121359830021, 777.8483195776882, 920.6547544670749, 928.2388441478058, 954.2795189631784, 5471.972640136773, 5509.311336082989, 5663.292088488939, 5830.562707796932, 5893.823185304448, 467.53947361848554, 482.41627630566705, 482.7875734676731, 483.38851353038433, 641.3906788550895, 3659.7438179327723, 3821.4458903458844, 3855.8843234703004, 3873.670737987303, 3879.728419010642, 9603.231741460666, 10055.64805231828, 10084.294099412971, 10211.642592509226, 10218.744531386776, 10047.748806279902, 10102.343347682377, 10128.746781330377, 10135.138513226311, 10144.28989970695, 7730.188330225358, 7734.57459839703, 7758.68965241384, 7820.804479888048, 7838.118851475605, 5508.510563890416, 5587.720613969366, 5589.496945274945, 5591.245181900392, 5753.395893431297, 9347.532623368668, 9383.671571494964, 9410.058994100535, 9503.19222866064, 9547.665831695856, 9279.67521136757, 9472.194863436685, 9506.714798555779, 9506.762330941781, 9524.428534287965, 6682.097916781172, 6909.930900690929, 6925.757598484029, 6941.965290173719, 7069.575825450489, 7822.882656760267, 7891.408144389079, 7923.84152316962, 7933.3653307736395, 7966.721164759206, 5537.944620553904, 6830.897536536857, 6973.302669732986, 7021.1574611047, 7101.2898710128575, 6741.629210393476, 6767.763128290683, 6856.794296171123, 6907.792766217021, 6937.861242775015, 6449.290578036318, 6752.966235168989, 6791.286914873867, 6823.55646882951, 6824.829379265558, 4845.709257444564, 4880.023995200903, 4890.853274401774, 4927.285543596086, 4988.251762235694, 4937.23472861707, 4983.925241121314, 5041.420236672683, 5050.292958985671, 5069.695818250917], "value": 4261.020948600314, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.2316561688036, 302.7275452093116, 307.071109892575, 313.86660669215604, 314.330476085937, 4581.67928245023, 4724.834630787923, 4781.378420805295, 4825.227963525832, 4831.130396528623, 4513.458384993797, 4694.685488063339, 4706.882327941803, 4718.834840780573, 4746.0, 3785.432185172219, 3785.889049782792, 3790.914996751789, 3792.033031576944, 3802.3345914464994, 3537.788881948782, 3612.548431446069, 3735.3463143949834, 3798.8290526926353, 3803.7717736935874, 3733.6453036961443, 3749.1189570450924, 3769.18962423079, 3779.3197224499577, 3781.5840257571645, 3740.4202348636004, 3743.5507739071213, 3743.7192210584317, 3752.5309336332957, 3758.3986562149926, 3335.282914173464, 3353.413152698268, 3357.345317663057, 3377.628460869302, 3389.5085212644276, 4441.666874984357, 4471.837322296194, 4532.388127602764, 4546.340780586829, 4551.180787458256, 4231.8518851840345, 4306.837153968442, 4307.203167414038, 4313.288307429302, 4321.978390108061, 4890.8043678252825, 4910.90178196434, 4924.901501969941, 4926.433460152092, 4960.578350840183, 3533.0990597397754, 3646.981765091184, 3661.7802931824176, 3677.595464498903, 3680.907977300562, 5079.542841144278, 5125.666831655931, 5127.0, 5128.589712822965, 5153.510416510426, 3746.138388170736, 3763.6612704856148, 3772.8868133955475, 3774.9811250944117, 3787.772733635991, 3838.0, 3841.2317536492255, 3842.769433833979, 3843.6925045996254, 3846.3268927938057, 4090.2228576570355, 4197.187884117588, 4215.156968606291, 4262.994588814878, 4263.616274535245, 4725.763711814396, 4906.460289368167, 4937.987827425268, 4949.356583644103, 4956.281339205867, 1253.7993920972601, 1291.3349624943162, 1292.3279894454831, 1300.219868079145, 1303.1659737767836, 860.4708104515678, 860.9741707748777, 866.5970323799463, 880.564120760215, 892.1123482135317, 3952.529668956902, 3961.088949541622, 3990.324063893172, 3993.6805055595482, 4001.7598944063448, 4536.0, 4561.29299958507, 4566.520515345907, 4574.428196475441, 4597.632189424838, 3903.414487826792, 3910.9413358799643, 3918.6081391860585, 3925.4896863407575, 3931.5282166139673, 2291.258643430971, 2374.2877136858874, 2379.6668466414717, 2401.219603628828, 2422.115927686382, 4235.30117530604, 4273.850415235514, 4297.183535128315, 4312.741235525878, 4317.380982131701, 4574.382458368144, 4593.494715581283, 4600.493945665974, 4601.309803529431, 4612.86161415158, 4088.8364465421646, 4270.0, 4282.850100246476, 4308.3968244445805, 4308.655307575386, 4434.84478043267, 4460.3532487789735, 4473.740760915717, 4511.481179664381, 4522.530177692197, 4376.474823021258, 4379.781010949503, 4400.119976004876, 4414.492333381702, 4428.535003824552, 4103.0, 4266.274733295285, 4305.375720520569, 4335.371371151228, 4379.211741886491, 3429.519867218641, 3462.601800792941, 3463.0303515015835, 3473.84367703459, 3476.322117187124, 4511.05267893746, 4530.229860923717, 4531.864044078683, 4851.660383773102, 4979.253112033224, 4719.8112075517965, 4850.975745121252, 4867.269909513601, 4876.341693871424, 4912.214045752662, 4908.6073114151495, 4927.384076990376, 4937.0, 4944.678595891256, 4951.801927922843, 4730.408698912636, 4822.614190864792, 4856.902861942812, 4861.319415281792, 4877.268409738425, 4921.655484116078, 4946.480619535041, 4951.678140920829, 4951.727654978867, 4993.300937868774, 4792.5207479253195, 4792.592629626521, 4802.927956080592, 4810.59109975656, 4842.661013729005], "value": 3630.47601307022, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.2615762710171, 765.4297548326498, 777.8599852026637, 785.4501848705904, 799.668137722845, 11681.357525336103, 11927.224730392518, 11973.76052478951, 11976.700582485442, 12004.999999999989, 12059.155859089868, 12108.636740897766, 12116.636500904964, 12125.393730313494, 12133.332666703327, 680.2721088435376, 843.5360551696542, 863.6459051788784, 867.8307729992622, 876.9342299327544, 873.6068769053951, 875.0374587953232, 877.5480627476854, 878.995605021974, 879.577802654723, 918.591226904028, 920.9769755756126, 921.6589861751162, 922.0318665401335, 923.3305853256403, 724.0, 888.5424006636588, 915.7847905742178, 918.8346097702411, 920.2132176988712, 681.3561184680478, 682.0996284903929, 682.9419499342562, 683.665004147969, 684.2404930527111, 12675.556355527513, 12718.491260349574, 12740.235585864877, 12755.043371747157, 12762.106652534327, 12125.454354553978, 12329.321887296195, 12398.194117382342, 12538.0, 12664.620061398173, 9647.228221742243, 9705.417674939456, 9872.60509579616, 10981.011708946153, 11040.33757974524, 4188.162367526507, 4195.769232692201, 4206.074663574009, 4280.6361459275995, 4337.934930976038, 40547.59452405468, 41687.0, 44896.0, 45502.77248613769, 45504.317435238496, 9754.853677194847, 10146.086852183338, 10154.949225253826, 10209.97900209973, 10250.0, 16602.667946641, 17370.82629173692, 17596.03221822812, 17603.911980440014, 17697.823021769877, 6716.664166791641, 6821.113255276782, 6856.417204537571, 7026.0, 7119.4660400470175, 3615.7107431405425, 3688.870889518854, 3751.118487155516, 3751.3060083884025, 3792.639699228569, 2759.7930155238437, 2858.0711268837713, 2860.685324614291, 2868.827870327745, 2873.4684083444213, 499.0692358750976, 528.0547819403225, 532.6644214145064, 542.6933782413003, 552.4641098134883, 541.3341589844513, 643.44342144046, 644.2365796531126, 646.4343699263145, 653.7156336993423, 7738.110117336579, 8016.478928869605, 8082.7171049013, 8209.09699933007, 8237.093919668832, 564.9237352957298, 571.7455732199131, 598.8741166606751, 613.4172536090732, 621.1490258346095, 3681.7238707097076, 3762.3227818992295, 3876.8836934891433, 3906.1015966327905, 3933.9213215735526, 43713.56286437158, 49030.50969490331, 50829.0, 51404.48595513997, 51767.0, 45790.542094579294, 45897.31154032692, 46318.305225421645, 46766.29850552244, 48359.758201208766, 43082.13835723331, 43445.0, 43483.130337393704, 43755.0, 44199.77900110543, 7997.200279971957, 8313.168683131638, 8329.95835020821, 8399.496030238206, 8411.285040771603, 28331.0, 29619.259518512208, 29993.250168745955, 30296.455531670425, 30650.693493064784, 39806.402903957045, 39904.40143397793, 40131.19737605173, 40230.39654405128, 40749.0, 10682.198835087243, 10732.785344292914, 11274.436278185894, 11280.887191127984, 11411.657650270505, 11307.491162897524, 11749.060075193793, 12419.37903104823, 12731.93634031824, 13156.079074465079, 11019.228653994143, 11274.718132046437, 11449.484773185393, 11585.6524304271, 11837.289762614271, 11660.242084264495, 11682.24065435744, 12110.152289339661, 12122.757544848877, 12191.817122742988, 10630.25588208818, 10633.361998280128, 10690.62582809598, 10781.568737250736, 10873.401962892116, 9338.766530836783, 9387.624495020124, 9492.240620750461, 9660.468674222986, 9927.453990030617, 9372.67195648149, 9504.239660827256, 9628.47043412591, 9636.903630963881, 9673.22614190849], "value": 6104.016580229505, "unit": "score"}], "name": "dromaeo_css", "value": 6350.0427316756495, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 112.0, 113.0, 113.0, 113.0, 112.0, 112.0, 113.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 134.0, 157.0, 208.0, 131.0, 150.0, 155.0, 134.0, 187.0, 130.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 150.0, 76.0, 75.0, 77.0, 76.0, 124.0, 77.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 156.0, 98.0, 94.0, 93.0, 120.0, 93.0, 93.0, 127.0], "value": 106.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 118.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 66.0, 72.0, 69.0, 67.0, 66.0, 67.0, 66.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 64.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 81.0, 87.0, 83.0, 83.0, 83.0, 83.0, 166.0, 82.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 144.0, 142.0, 138.0, 131.0, 131.0, 131.0, 131.0, 158.0, 135.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 180.0, 178.0, 175.0, 180.0, 177.0, 178.0, 175.0, 171.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1583.3999999999999, "alertThreshold": 2.0}]} 11:44:31 INFO - Return code: 0 11:44:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:44:31 ERROR - # TBPL SUCCESS # 11:44:31 INFO - Running post-action listener: _resource_record_post_action 11:44:31 INFO - ##### 11:44:31 INFO - ##### Finished run-tests step (success) 11:44:31 INFO - ##### 11:44:31 INFO - Running post-run listener: _resource_record_post_run 11:44:32 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 0; Write bytes: 524349440; Read time: 0; Write time: 967648 11:44:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234672128; Read time: 0; Write time: 392504 11:44:32 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 289677312; Read time: 0; Write time: 575144 11:44:32 INFO - Running post-run listener: _upload_blobber_files 11:44:32 INFO - Blob upload gear active. 11:44:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:44:32 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'] 11:44:32 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 11:44:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:33 INFO - (blobuploader) - INFO - Done attempting. 11:44:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:44:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:44:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:34 INFO - (blobuploader) - INFO - Done attempting. 11:44:34 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:34 INFO - Return code: 0 11:44:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dec79dce95c8181c9d840b60f8862172b5bda7bef50d1b5ba45dd6245a137b706a2e4293597b0e415ba1e1ae73e6379896d5facac867bf9ecd201d336347a4b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e8369fc92ef9fd5941664e7637f3c3d561640496d1c2b1857e3a341f0ff63e284069765f87baa33bd4629963da2aea5d5f07f6fe244b72c696e6019e21226e"} 11:44:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:34 INFO - Contents: 11:44:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dec79dce95c8181c9d840b60f8862172b5bda7bef50d1b5ba45dd6245a137b706a2e4293597b0e415ba1e1ae73e6379896d5facac867bf9ecd201d336347a4b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e8369fc92ef9fd5941664e7637f3c3d561640496d1c2b1857e3a341f0ff63e284069765f87baa33bd4629963da2aea5d5f07f6fe244b72c696e6019e21226e"} 11:44:34 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:34 INFO - Copying logs to upload dir... 11:44:34 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.165274 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-11 11:44:34.033140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 11:44:34.037153) ========= 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=5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dec79dce95c8181c9d840b60f8862172b5bda7bef50d1b5ba45dd6245a137b706a2e4293597b0e415ba1e1ae73e6379896d5facac867bf9ecd201d336347a4b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e8369fc92ef9fd5941664e7637f3c3d561640496d1c2b1857e3a341f0ff63e284069765f87baa33bd4629963da2aea5d5f07f6fe244b72c696e6019e21226e"} build_url:https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/H8rnt1t-REG1dkAlIPK6xg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dec79dce95c8181c9d840b60f8862172b5bda7bef50d1b5ba45dd6245a137b706a2e4293597b0e415ba1e1ae73e6379896d5facac867bf9ecd201d336347a4b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e8369fc92ef9fd5941664e7637f3c3d561640496d1c2b1857e3a341f0ff63e284069765f87baa33bd4629963da2aea5d5f07f6fe244b72c696e6019e21226e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 11:44:34.061639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:44:34.061970) ========= 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=5cf47e208febbcd81da23b2e0000026f-1462990928.972632-823467325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004754 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:44:34.147504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 11:44:34.147839) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 11:44:34.148162) ========= ========= Total master_lag: 0.17 =========