builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1460556455.43 results: success (0) buildid: 20160413061745 builduid: c4de674dbb6349a3bcf3c7e8f6d46cee revision: e97898890d476686262db5d9a870d35fdc4da8b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:35.429002) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:35.430972) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:35.431292) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:35.451203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:35.451498) ========= 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=3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 07:07:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.3M=0s 2016-04-13 07:07:36 (39.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096899 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:35.678449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:35.678780) ========= 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=3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017225 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:35.730103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:35.730447) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e97898890d476686262db5d9a870d35fdc4da8b9 --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 e97898890d476686262db5d9a870d35fdc4da8b9 --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=3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 07:07:36,319 truncating revision to first 12 chars 2016-04-13 07:07:36,319 Setting DEBUG logging. 2016-04-13 07:07:36,319 attempt 1/10 2016-04-13 07:07:36,319 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e97898890d47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 07:07:36,750 unpacking tar archive at: fx-team-e97898890d47/testing/mozharness/ program finished with exit code 0 elapsedTime=0.719151 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:36.462943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:36.463287) ========= script_repo_revision: e97898890d476686262db5d9a870d35fdc4da8b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:36.463760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:36.464064) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 07:07:36.472527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-13 07:07:36.472855) ========= /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=3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:07:37 INFO - MultiFileLogger online at 20160413 07:07:37 in /builds/slave/test 07:07:37 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 07:07:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:07:37 INFO - {'append_to_log': False, 07:07:37 INFO - 'base_work_dir': '/builds/slave/test', 07:07:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:07:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:07:37 INFO - 'branch': 'Fx-Team-Non-PGO', 07:07:37 INFO - 'buildbot_json_path': 'buildprops.json', 07:07:37 INFO - 'config_files': ('talos/linux_config.py',), 07:07:37 INFO - 'default_actions': ('clobber', 07:07:37 INFO - 'read-buildbot-config', 07:07:37 INFO - 'download-and-extract', 07:07:37 INFO - 'populate-webroot', 07:07:37 INFO - 'create-virtualenv', 07:07:37 INFO - 'install', 07:07:37 INFO - 'run-tests'), 07:07:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:07:37 INFO - 'download_minidump_stackwalk': True, 07:07:37 INFO - 'download_symbols': 'ondemand', 07:07:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:07:37 INFO - 'tooltool.py': '/tools/tooltool.py', 07:07:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:07:37 INFO - '/tools/misc-python/virtualenv.py')}, 07:07:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:07:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:07:37 INFO - 'installer_path': 'installer.exe', 07:07:37 INFO - 'log_level': 'info', 07:07:37 INFO - 'log_name': 'talos', 07:07:37 INFO - 'log_to_console': True, 07:07:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:07:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:07:37 INFO - 'opt_config_files': (), 07:07:37 INFO - 'pip_index': False, 07:07:37 INFO - 'sps_profile': False, 07:07:37 INFO - 'sps_profile_interval': 0, 07:07:37 INFO - 'suite': 'dromaeojs', 07:07:37 INFO - 'system_bits': '32', 07:07:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:07:37 INFO - 'title': 'talos-linux64-ix-059', 07:07:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:07:37 INFO - 'use_talos_json': True, 07:07:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:07:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:07:37 INFO - 'work_dir': 'build'} 07:07:37 INFO - ##### 07:07:37 INFO - ##### Running clobber step. 07:07:37 INFO - ##### 07:07:37 INFO - Running pre-action listener: _resource_record_pre_action 07:07:37 INFO - Running main action method: clobber 07:07:37 INFO - rmtree: /builds/slave/test/build 07:07:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:07:37 INFO - Running post-action listener: _resource_record_post_action 07:07:37 INFO - ##### 07:07:37 INFO - ##### Running read-buildbot-config step. 07:07:37 INFO - ##### 07:07:37 INFO - Running pre-action listener: _resource_record_pre_action 07:07:37 INFO - Running main action method: read_buildbot_config 07:07:37 INFO - Using buildbot properties: 07:07:37 INFO - { 07:07:37 INFO - "project": "", 07:07:37 INFO - "product": "firefox", 07:07:37 INFO - "script_repo_revision": "production", 07:07:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:07:37 INFO - "repository": "", 07:07:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:07:37 INFO - "buildid": "20160413061745", 07:07:37 INFO - "pgo_build": "False", 07:07:37 INFO - "basedir": "/builds/slave/test", 07:07:37 INFO - "buildnumber": 1555, 07:07:37 INFO - "slavename": "talos-linux64-ix-059", 07:07:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:07:37 INFO - "platform": "ubuntu64_hw", 07:07:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:07:37 INFO - "branch": "fx-team", 07:07:37 INFO - "repo_path": "integration/fx-team", 07:07:37 INFO - "revision": "e97898890d476686262db5d9a870d35fdc4da8b9", 07:07:37 INFO - "stage_platform": "linux64", 07:07:37 INFO - "builduid": "c4de674dbb6349a3bcf3c7e8f6d46cee", 07:07:37 INFO - "slavebuilddir": "test" 07:07:37 INFO - } 07:07:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:07:37 INFO - Running post-action listener: _resource_record_post_action 07:07:37 INFO - ##### 07:07:37 INFO - ##### Running download-and-extract step. 07:07:37 INFO - ##### 07:07:37 INFO - Running pre-action listener: _resource_record_pre_action 07:07:37 INFO - Running main action method: download_and_extract 07:07:37 INFO - mkdir: /builds/slave/test/build/tests 07:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:37 INFO - https://queue.taskcluster.net/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:07:38 INFO - Downloaded 1361 bytes. 07:07:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:07:38 INFO - Using the following test package requirements: 07:07:38 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:07:38 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:07:38 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:07:38 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:38 INFO - u'jsshell-linux-x86_64.zip'], 07:07:38 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:07:38 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:07:38 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:07:38 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:07:38 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:07:38 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:07:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:38 INFO - https://queue.taskcluster.net/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:07:40 INFO - Downloaded 22199056 bytes. 07:07:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:07:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:07:42 INFO - Return code: 0 07:07:42 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:42 INFO - https://queue.taskcluster.net/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:07:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:07:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:07:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:07:44 INFO - Downloaded 22199056 bytes. 07:07:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:07:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:07:45 INFO - Return code: 0 07:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:45 INFO - https://queue.taskcluster.net/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:07:46 INFO - Downloaded 10841076 bytes. 07:07:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:07:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:07:46 INFO - Return code: 0 07:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:46 INFO - https://queue.taskcluster.net/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:07:47 INFO - Downloaded 54156793 bytes. 07:07:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:07:47 INFO - mkdir: /builds/slave/test/properties 07:07:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:07:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:07:47 INFO - Contents: 07:07:47 INFO - build_url:https://queue.taskcluster.net/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:07:48 INFO - Running post-action listener: _resource_record_post_action 07:07:48 INFO - Running post-action listener: set_extra_try_arguments 07:07:48 INFO - ##### 07:07:48 INFO - ##### Running populate-webroot step. 07:07:48 INFO - ##### 07:07:48 INFO - Running pre-action listener: _resource_record_pre_action 07:07:48 INFO - Running main action method: populate_webroot 07:07:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:07:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:07:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:07:48 INFO - '--tppagecycles', 07:07:48 INFO - '7'], 07:07:48 INFO - 'tests': ['tsvgm']}}, 07:07:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:07:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:07:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:07:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:07:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['damp', 'tps']}, 07:07:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'tests': ['damp', 'tps']}, 07:07:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['dromaeo_dom']}, 07:07:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:07:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'other-e10s': {'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['tsvgx', 07:07:48 INFO - 'tsvgr_opacity', 07:07:48 INFO - 'tart', 07:07:48 INFO - 'tscrollx', 07:07:48 INFO - 'cart']}, 07:07:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:07:48 INFO - 'tsvgr_opacity', 07:07:48 INFO - 'tart', 07:07:48 INFO - 'tscrollx', 07:07:48 INFO - 'cart']}, 07:07:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['tp5o']}, 07:07:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'tests': ['tp5o']}, 07:07:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'talos_options': ['--disable-e10s', 07:07:48 INFO - '--xperf_path', 07:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:48 INFO - 'tests': ['tp5n']}, 07:07:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'talos_options': ['--xperf_path', 07:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:48 INFO - 'tests': ['tp5n']}}, 07:07:48 INFO - 'talos.zip': {'path': '', 07:07:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:07:48 INFO - Running post-action listener: _resource_record_post_action 07:07:48 INFO - ##### 07:07:48 INFO - ##### Running create-virtualenv step. 07:07:48 INFO - ##### 07:07:48 INFO - Running pre-action listener: _resource_record_pre_action 07:07:48 INFO - Running main action method: create_virtualenv 07:07:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:07:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:07:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:07:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:07:48 INFO - Using real prefix '/usr' 07:07:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:07:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:07:51 INFO - Installing pip.................done. 07:07:51 INFO - Return code: 0 07:07:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:51 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 0x7ffa1397af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d410>, '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 0x204e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:07:51 INFO - Using env: {'DISPLAY': ':0', 07:07:51 INFO - 'HOME': '/home/cltbld', 07:07:51 INFO - 'LANG': 'en_US.UTF-8', 07:07:51 INFO - 'LANGUAGE': 'en_US:en', 07:07:51 INFO - 'LOGNAME': 'cltbld', 07:07:51 INFO - 'MAIL': '/var/mail/cltbld', 07:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:51 INFO - 'MOZ_NO_REMOTE': '1', 07:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:51 INFO - 'NO_EM_RESTART': '1', 07:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:51 INFO - 'PWD': '/builds/slave/test', 07:07:51 INFO - 'SHELL': '/bin/bash', 07:07:51 INFO - 'SHLVL': '1', 07:07:51 INFO - 'TERM': 'linux', 07:07:51 INFO - 'TMOUT': '86400', 07:07:51 INFO - 'USER': 'cltbld', 07:07:51 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 07:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:51 INFO - '_': '/tools/buildbot/bin/python'} 07:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:07:51 INFO - Cleaning up... 07:07:51 INFO - Return code: 0 07:07:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:51 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 0x7ffa1397af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d410>, '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 0x204e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:07:51 INFO - Using env: {'DISPLAY': ':0', 07:07:51 INFO - 'HOME': '/home/cltbld', 07:07:51 INFO - 'LANG': 'en_US.UTF-8', 07:07:51 INFO - 'LANGUAGE': 'en_US:en', 07:07:51 INFO - 'LOGNAME': 'cltbld', 07:07:51 INFO - 'MAIL': '/var/mail/cltbld', 07:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:51 INFO - 'MOZ_NO_REMOTE': '1', 07:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:51 INFO - 'NO_EM_RESTART': '1', 07:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:51 INFO - 'PWD': '/builds/slave/test', 07:07:51 INFO - 'SHELL': '/bin/bash', 07:07:51 INFO - 'SHLVL': '1', 07:07:51 INFO - 'TERM': 'linux', 07:07:51 INFO - 'TMOUT': '86400', 07:07:51 INFO - 'USER': 'cltbld', 07:07:51 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 07:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:51 INFO - '_': '/tools/buildbot/bin/python'} 07:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:51 INFO - Downloading/unpacking psutil>=0.7.1 07:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:07:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:53 INFO - Installing collected packages: psutil 07:07:53 INFO - Running setup.py install for psutil 07:07:53 INFO - building 'psutil._psutil_linux' extension 07:07:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:07:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:07:53 INFO - building 'psutil._psutil_posix' extension 07:07:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:07:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:07:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:54 INFO - Successfully installed psutil 07:07:54 INFO - Cleaning up... 07:07:54 INFO - Return code: 0 07:07:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:54 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 0x7ffa1397af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d410>, '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 0x204e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:07:54 INFO - Using env: {'DISPLAY': ':0', 07:07:54 INFO - 'HOME': '/home/cltbld', 07:07:54 INFO - 'LANG': 'en_US.UTF-8', 07:07:54 INFO - 'LANGUAGE': 'en_US:en', 07:07:54 INFO - 'LOGNAME': 'cltbld', 07:07:54 INFO - 'MAIL': '/var/mail/cltbld', 07:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:54 INFO - 'MOZ_NO_REMOTE': '1', 07:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:54 INFO - 'NO_EM_RESTART': '1', 07:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:54 INFO - 'PWD': '/builds/slave/test', 07:07:54 INFO - 'SHELL': '/bin/bash', 07:07:54 INFO - 'SHLVL': '1', 07:07:54 INFO - 'TERM': 'linux', 07:07:54 INFO - 'TMOUT': '86400', 07:07:54 INFO - 'USER': 'cltbld', 07:07:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 07:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:54 INFO - '_': '/tools/buildbot/bin/python'} 07:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:07:56 INFO - Installing collected packages: mozsystemmonitor 07:07:56 INFO - Running setup.py install for mozsystemmonitor 07:07:56 INFO - Successfully installed mozsystemmonitor 07:07:56 INFO - Cleaning up... 07:07:56 INFO - Return code: 0 07:07:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:56 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 0x7ffa1397af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d410>, '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 0x204e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:07:56 INFO - Using env: {'DISPLAY': ':0', 07:07:56 INFO - 'HOME': '/home/cltbld', 07:07:56 INFO - 'LANG': 'en_US.UTF-8', 07:07:56 INFO - 'LANGUAGE': 'en_US:en', 07:07:56 INFO - 'LOGNAME': 'cltbld', 07:07:56 INFO - 'MAIL': '/var/mail/cltbld', 07:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:56 INFO - 'MOZ_NO_REMOTE': '1', 07:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:56 INFO - 'NO_EM_RESTART': '1', 07:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:56 INFO - 'PWD': '/builds/slave/test', 07:07:56 INFO - 'SHELL': '/bin/bash', 07:07:56 INFO - 'SHLVL': '1', 07:07:56 INFO - 'TERM': 'linux', 07:07:56 INFO - 'TMOUT': '86400', 07:07:56 INFO - 'USER': 'cltbld', 07:07:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 07:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:56 INFO - '_': '/tools/buildbot/bin/python'} 07:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:56 INFO - Downloading/unpacking blobuploader==1.2.4 07:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:58 INFO - Downloading blobuploader-1.2.4.tar.gz 07:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:07:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:07:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:59 INFO - Downloading docopt-0.6.1.tar.gz 07:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:07:59 INFO - Installing collected packages: blobuploader, requests, docopt 07:07:59 INFO - Running setup.py install for blobuploader 07:07:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:07:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:07:59 INFO - Running setup.py install for requests 07:07:59 INFO - Running setup.py install for docopt 07:07:59 INFO - Successfully installed blobuploader requests docopt 07:07:59 INFO - Cleaning up... 07:08:00 INFO - Return code: 0 07:08:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:00 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 0x7ffa1397af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d410>, '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 0x204e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:08:00 INFO - Using env: {'DISPLAY': ':0', 07:08:00 INFO - 'HOME': '/home/cltbld', 07:08:00 INFO - 'LANG': 'en_US.UTF-8', 07:08:00 INFO - 'LANGUAGE': 'en_US:en', 07:08:00 INFO - 'LOGNAME': 'cltbld', 07:08:00 INFO - 'MAIL': '/var/mail/cltbld', 07:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:00 INFO - 'MOZ_NO_REMOTE': '1', 07:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:00 INFO - 'NO_EM_RESTART': '1', 07:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:00 INFO - 'PWD': '/builds/slave/test', 07:08:00 INFO - 'SHELL': '/bin/bash', 07:08:00 INFO - 'SHLVL': '1', 07:08:00 INFO - 'TERM': 'linux', 07:08:00 INFO - 'TMOUT': '86400', 07:08:00 INFO - 'USER': 'cltbld', 07:08:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 07:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:00 INFO - '_': '/tools/buildbot/bin/python'} 07:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:00 INFO - Running setup.py (path:/tmp/pip-yyENR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:00 INFO - Running setup.py (path:/tmp/pip-pMgjIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:00 INFO - Running setup.py (path:/tmp/pip-EEZY2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:00 INFO - Running setup.py (path:/tmp/pip-kDh6rM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:00 INFO - Running setup.py (path:/tmp/pip-c0FaDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:00 INFO - Running setup.py (path:/tmp/pip-aHgMSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:00 INFO - Running setup.py (path:/tmp/pip-40fmtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:00 INFO - Running setup.py (path:/tmp/pip-RSrzYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:00 INFO - Running setup.py (path:/tmp/pip-Yp2D6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:00 INFO - Running setup.py (path:/tmp/pip-SeQv8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:00 INFO - Running setup.py (path:/tmp/pip-DNeTit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:01 INFO - Running setup.py (path:/tmp/pip-EILsoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:01 INFO - Running setup.py (path:/tmp/pip-iHN4wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:01 INFO - Running setup.py (path:/tmp/pip-7O51yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:01 INFO - Running setup.py (path:/tmp/pip-tu4clx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:01 INFO - Running setup.py (path:/tmp/pip-8xBiXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:01 INFO - Running setup.py (path:/tmp/pip-gVQjk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:08:01 INFO - Running setup.py install for manifestparser 07:08:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:08:01 INFO - Running setup.py install for mozcrash 07:08:01 INFO - Running setup.py install for mozdebug 07:08:01 INFO - Running setup.py install for mozdevice 07:08:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:08:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:08:01 INFO - Running setup.py install for mozfile 07:08:02 INFO - Running setup.py install for mozhttpd 07:08:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Running setup.py install for mozinfo 07:08:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Running setup.py install for mozInstall 07:08:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Running setup.py install for mozleak 07:08:02 INFO - Running setup.py install for mozlog 07:08:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Running setup.py install for moznetwork 07:08:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Running setup.py install for mozprocess 07:08:02 INFO - Running setup.py install for mozprofile 07:08:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Running setup.py install for mozrunner 07:08:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Running setup.py install for mozscreenshot 07:08:03 INFO - Running setup.py install for moztest 07:08:03 INFO - Running setup.py install for mozversion 07:08:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:08:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:08:03 INFO - Cleaning up... 07:08:03 INFO - Return code: 0 07:08:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:03 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 0x7ffa1397af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d410>, '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 0x204e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:08:03 INFO - Using env: {'DISPLAY': ':0', 07:08:03 INFO - 'HOME': '/home/cltbld', 07:08:03 INFO - 'LANG': 'en_US.UTF-8', 07:08:03 INFO - 'LANGUAGE': 'en_US:en', 07:08:03 INFO - 'LOGNAME': 'cltbld', 07:08:03 INFO - 'MAIL': '/var/mail/cltbld', 07:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:03 INFO - 'MOZ_NO_REMOTE': '1', 07:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:03 INFO - 'NO_EM_RESTART': '1', 07:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:03 INFO - 'PWD': '/builds/slave/test', 07:08:03 INFO - 'SHELL': '/bin/bash', 07:08:03 INFO - 'SHLVL': '1', 07:08:03 INFO - 'TERM': 'linux', 07:08:03 INFO - 'TMOUT': '86400', 07:08:03 INFO - 'USER': 'cltbld', 07:08:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 07:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:03 INFO - '_': '/tools/buildbot/bin/python'} 07:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:03 INFO - Running setup.py (path:/tmp/pip-3mNAEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:03 INFO - Running setup.py (path:/tmp/pip-Fuwnhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:03 INFO - Running setup.py (path:/tmp/pip-x3UH4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:03 INFO - Running setup.py (path:/tmp/pip-50RslE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:03 INFO - Running setup.py (path:/tmp/pip-JRjJHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:03 INFO - Running setup.py (path:/tmp/pip-pfsZQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:03 INFO - Running setup.py (path:/tmp/pip-ODDr9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:04 INFO - Running setup.py (path:/tmp/pip-eSMrPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:04 INFO - Running setup.py (path:/tmp/pip-YAg_nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:04 INFO - Running setup.py (path:/tmp/pip-KluZ7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:04 INFO - Running setup.py (path:/tmp/pip-T2BqEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:04 INFO - Running setup.py (path:/tmp/pip-Lh8wz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:04 INFO - Running setup.py (path:/tmp/pip-CgUMfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:04 INFO - Running setup.py (path:/tmp/pip-HjXzm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:04 INFO - Running setup.py (path:/tmp/pip-s1c9uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:04 INFO - Running setup.py (path:/tmp/pip-qTJqv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:04 INFO - Running setup.py (path:/tmp/pip-xpUHT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:08:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:06 INFO - Downloading blessings-1.6.tar.gz 07:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:08:06 INFO - Installing collected packages: blessings 07:08:06 INFO - Running setup.py install for blessings 07:08:06 INFO - Successfully installed blessings 07:08:06 INFO - Cleaning up... 07:08:06 INFO - Return code: 0 07:08:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:08:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:07 INFO - Reading from file tmpfile_stdout 07:08:07 INFO - Current package versions: 07:08:07 INFO - argparse == 1.2.1 07:08:07 INFO - blessings == 1.6 07:08:07 INFO - blobuploader == 1.2.4 07:08:07 INFO - docopt == 0.6.1 07:08:07 INFO - manifestparser == 1.1 07:08:07 INFO - mozInstall == 1.12 07:08:07 INFO - mozcrash == 0.17 07:08:07 INFO - mozdebug == 0.1 07:08:07 INFO - mozdevice == 0.48 07:08:07 INFO - mozfile == 1.2 07:08:07 INFO - mozhttpd == 0.7 07:08:07 INFO - mozinfo == 0.9 07:08:07 INFO - mozleak == 0.1 07:08:07 INFO - mozlog == 3.1 07:08:07 INFO - moznetwork == 0.27 07:08:07 INFO - mozprocess == 0.22 07:08:07 INFO - mozprofile == 0.28 07:08:07 INFO - mozrunner == 6.11 07:08:07 INFO - mozscreenshot == 0.1 07:08:07 INFO - mozsystemmonitor == 0.0 07:08:07 INFO - moztest == 0.7 07:08:07 INFO - mozversion == 1.4 07:08:07 INFO - psutil == 3.1.1 07:08:07 INFO - requests == 1.2.3 07:08:07 INFO - wsgiref == 0.1.2 07:08:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:07 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 0x7ffa1397af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d410>, '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 0x204e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:08:07 INFO - Using env: {'DISPLAY': ':0', 07:08:07 INFO - 'HOME': '/home/cltbld', 07:08:07 INFO - 'LANG': 'en_US.UTF-8', 07:08:07 INFO - 'LANGUAGE': 'en_US:en', 07:08:07 INFO - 'LOGNAME': 'cltbld', 07:08:07 INFO - 'MAIL': '/var/mail/cltbld', 07:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:07 INFO - 'MOZ_NO_REMOTE': '1', 07:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:07 INFO - 'NO_EM_RESTART': '1', 07:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:07 INFO - 'PWD': '/builds/slave/test', 07:08:07 INFO - 'SHELL': '/bin/bash', 07:08:07 INFO - 'SHLVL': '1', 07:08:07 INFO - 'TERM': 'linux', 07:08:07 INFO - 'TMOUT': '86400', 07:08:07 INFO - 'USER': 'cltbld', 07:08:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 07:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:07 INFO - '_': '/tools/buildbot/bin/python'} 07:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:08:07 INFO - Cleaning up... 07:08:07 INFO - Return code: 0 07:08:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa1397af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d410>, '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 0x204e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:08:07 INFO - Using env: {'DISPLAY': ':0', 07:08:07 INFO - 'HOME': '/home/cltbld', 07:08:07 INFO - 'LANG': 'en_US.UTF-8', 07:08:07 INFO - 'LANGUAGE': 'en_US:en', 07:08:07 INFO - 'LOGNAME': 'cltbld', 07:08:07 INFO - 'MAIL': '/var/mail/cltbld', 07:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:07 INFO - 'MOZ_NO_REMOTE': '1', 07:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:07 INFO - 'NO_EM_RESTART': '1', 07:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:07 INFO - 'PWD': '/builds/slave/test', 07:08:07 INFO - 'SHELL': '/bin/bash', 07:08:07 INFO - 'SHLVL': '1', 07:08:07 INFO - 'TERM': 'linux', 07:08:07 INFO - 'TMOUT': '86400', 07:08:07 INFO - 'USER': 'cltbld', 07:08:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 07:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:07 INFO - '_': '/tools/buildbot/bin/python'} 07:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:07 INFO - Downloading/unpacking jsonschema 07:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:08:09 INFO - Downloading/unpacking functools32 (from jsonschema) 07:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:09 INFO - Downloading functools32-3.2.3-2.tar.gz 07:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:08:09 INFO - warning: no files found matching '*.txt' 07:08:09 INFO - no previously-included directories found matching 'build' 07:08:09 INFO - no previously-included directories found matching 'dist' 07:08:09 INFO - no previously-included directories found matching '.git*' 07:08:09 INFO - Installing collected packages: jsonschema, functools32 07:08:09 INFO - Running setup.py install for functools32 07:08:09 INFO - warning: no files found matching '*.txt' 07:08:09 INFO - no previously-included directories found matching 'build' 07:08:09 INFO - no previously-included directories found matching 'dist' 07:08:09 INFO - no previously-included directories found matching '.git*' 07:08:09 INFO - Successfully installed jsonschema functools32 07:08:09 INFO - Cleaning up... 07:08:09 INFO - Return code: 0 07:08:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:09 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 0x7ffa1397af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d410>, '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 0x204e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:08:09 INFO - Using env: {'DISPLAY': ':0', 07:08:09 INFO - 'HOME': '/home/cltbld', 07:08:09 INFO - 'LANG': 'en_US.UTF-8', 07:08:09 INFO - 'LANGUAGE': 'en_US:en', 07:08:09 INFO - 'LOGNAME': 'cltbld', 07:08:09 INFO - 'MAIL': '/var/mail/cltbld', 07:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:09 INFO - 'MOZ_NO_REMOTE': '1', 07:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:09 INFO - 'NO_EM_RESTART': '1', 07:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:09 INFO - 'PWD': '/builds/slave/test', 07:08:09 INFO - 'SHELL': '/bin/bash', 07:08:09 INFO - 'SHLVL': '1', 07:08:09 INFO - 'TERM': 'linux', 07:08:09 INFO - 'TMOUT': '86400', 07:08:09 INFO - 'USER': 'cltbld', 07:08:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 07:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:09 INFO - '_': '/tools/buildbot/bin/python'} 07:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:10 INFO - Downloading/unpacking flake8 07:08: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 07:08: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 07:08: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 07:08: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 07:08: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 07:08: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 07:08:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:08:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:08:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:08:12 INFO - no previously-included directories found matching 'docs/_build' 07:08:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:08:12 INFO - Running setup.py install for pep8 07:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:08:12 INFO - no previously-included directories found matching 'docs/_build' 07:08:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:08:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:08:12 INFO - Cleaning up... 07:08:12 INFO - Return code: 0 07:08:12 INFO - Running post-action listener: _resource_record_post_action 07:08:12 INFO - Running post-action listener: _start_resource_monitoring 07:08:12 INFO - Starting resource monitoring. 07:08:12 INFO - ##### 07:08:12 INFO - ##### Running install step. 07:08:12 INFO - ##### 07:08:12 INFO - Running pre-action listener: _resource_record_pre_action 07:08:12 INFO - Running main action method: install 07:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:13 INFO - Reading from file tmpfile_stdout 07:08:13 INFO - Detecting whether we're running mozinstall >=1.0... 07:08:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:08:13 INFO - Reading from file tmpfile_stdout 07:08:13 INFO - Output received: 07:08:13 INFO - Usage: mozinstall [options] installer 07:08:13 INFO - Options: 07:08:13 INFO - -h, --help show this help message and exit 07:08:13 INFO - -d DEST, --destination=DEST 07:08:13 INFO - Directory to install application into. [default: 07:08:13 INFO - "/builds/slave/test"] 07:08:13 INFO - --app=APP Application being installed. [default: firefox] 07:08:13 INFO - mkdir: /builds/slave/test/build/application 07:08:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:08:28 INFO - Reading from file tmpfile_stdout 07:08:28 INFO - Output received: 07:08:28 INFO - /builds/slave/test/build/application/firefox/firefox 07:08:28 INFO - Running post-action listener: _resource_record_post_action 07:08:28 INFO - ##### 07:08:28 INFO - ##### Running run-tests step. 07:08:28 INFO - ##### 07:08:28 INFO - Running pre-action listener: _resource_record_pre_action 07:08:28 INFO - Running main action method: run_tests 07:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:08:28 INFO - Python 2.7.3 07:08:28 INFO - Return code: 0 07:08:28 INFO - grabbing minidump binary from tooltool 07:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d410>, '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 0x204e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:08:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:08:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:08:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:08:29 INFO - Return code: 0 07:08:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:08:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:08:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:08:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:08:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:08:30 INFO - Return code: 0 07:08:30 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/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 07:08:30 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/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 07:08:30 INFO - Using env: {'DISPLAY': ':0', 07:08:30 INFO - 'HOME': '/home/cltbld', 07:08:30 INFO - 'LANG': 'en_US.UTF-8', 07:08:30 INFO - 'LANGUAGE': 'en_US:en', 07:08:30 INFO - 'LOGNAME': 'cltbld', 07:08:30 INFO - 'MAIL': '/var/mail/cltbld', 07:08:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:08:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:30 INFO - 'MOZ_NO_REMOTE': '1', 07:08:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:30 INFO - 'NO_EM_RESTART': '1', 07:08:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:30 INFO - 'PWD': '/builds/slave/test', 07:08:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:08:30 INFO - 'SHELL': '/bin/bash', 07:08:30 INFO - 'SHLVL': '1', 07:08:30 INFO - 'TERM': 'linux', 07:08:30 INFO - 'TMOUT': '86400', 07:08:30 INFO - 'USER': 'cltbld', 07:08:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170', 07:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:30 INFO - '_': '/tools/buildbot/bin/python'} 07:08:30 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/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 07:08:30 INFO - mozversion application_buildid: 20160413061745 07:08:30 INFO - mozversion application_changeset: e97898890d476686262db5d9a870d35fdc4da8b9 07:08:30 INFO - mozversion application_display_name: Nightly 07:08:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:08:30 INFO - mozversion application_name: Firefox 07:08:30 INFO - mozversion application_remotingname: firefox 07:08:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:08:30 INFO - mozversion application_vendor: Mozilla 07:08:30 INFO - mozversion application_version: 48.0a1 07:08:30 INFO - mozversion platform_buildid: 20160413061745 07:08:30 INFO - mozversion platform_changeset: e97898890d476686262db5d9a870d35fdc4da8b9 07:08:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:08:30 INFO - mozversion platform_version: 48.0a1 07:08:30 INFO - using testdate: 1460556510 07:08:30 INFO - actual date: 1460556510 07:08:30 INFO - starting webserver on 'localhost:38590' 07:08:30 INFO - SUITE-START | Running 2 tests 07:08:30 INFO - TEST-START | dromaeo_css 07:08:30 INFO - operating with platform_type : linux_ 07:08:30 INFO - Initialising browser for dromaeo_css test... 07:08:30 INFO - TEST-INFO | started process 11438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_OwyRQ/profile http://localhost:38590/getInfo.html) 07:08:34 INFO - PROCESS | 11438 | __metrics Screen width/height:1600/1200 07:08:34 INFO - PROCESS | 11438 | colorDepth:24 07:08:34 INFO - PROCESS | 11438 | Browser inner width/height: 1024/697 07:08:34 INFO - PROCESS | 11438 | __metrics 07:08:35 ERROR - PROCESS | 11438 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:08:36 INFO - TEST-INFO | 11438: exit 0 07:08:36 INFO - Browser initialized. 07:08:36 INFO - Running cycle 1/1 for dromaeo_css test... 07:08:36 INFO - TEST-INFO | started process 11519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_OwyRQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:48 INFO - PROCESS | 11519 | RSS: Main: 154505216 07:08:48 INFO - PROCESS | 11519 | 07:09:39 INFO - PROCESS | 11519 | 1460556579347 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:11:50 INFO - PROCESS | 11519 | Cycle 1(1): loaded http://localhost:38590/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38590/tests/dromaeo/cssquery-ext.html) 07:11:51 INFO - PROCESS | 11519 | RSS: Main: 238465024 07:11:51 INFO - PROCESS | 11519 | 07:14:53 INFO - PROCESS | 11519 | Cycle 1(1): loaded http://localhost:38590/tests/dromaeo/cssquery-ext.html (next: http://localhost:38590/tests/dromaeo/cssquery-jquery.html) 07:14:54 INFO - PROCESS | 11519 | RSS: Main: 237273088 07:14:54 INFO - PROCESS | 11519 | 07:17:56 INFO - PROCESS | 11519 | Cycle 1(1): loaded http://localhost:38590/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38590/tests/dromaeo/cssquery-mootools.html) 07:17:57 INFO - PROCESS | 11519 | RSS: Main: 237600768 07:17:57 INFO - PROCESS | 11519 | 07:20:59 INFO - PROCESS | 11519 | Cycle 1(1): loaded http://localhost:38590/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38590/tests/dromaeo/cssquery-prototype.html) 07:20:59 INFO - PROCESS | 11519 | RSS: Main: 232595456 07:20:59 INFO - PROCESS | 11519 | 07:24:02 INFO - PROCESS | 11519 | Cycle 1(1): loaded http://localhost:38590/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38590/tests/dromaeo/cssquery-yui.html) 07:24:03 INFO - PROCESS | 11519 | RSS: Main: 208949248 07:24:03 INFO - PROCESS | 11519 | 07:27:06 INFO - PROCESS | 11519 | Cycle 1(1): loaded http://localhost:38590/tests/dromaeo/cssquery-yui.html (next: http://localhost:38590/tests/dromaeo/cssquery-dojo.html) 07:27:06 INFO - PROCESS | 11519 | RSS: Main: 301367296 07:27:06 INFO - PROCESS | 11519 | 07:27:06 INFO - PROCESS | 11519 | __start_tp_report 07:27:06 INFO - PROCESS | 11519 | _x_x_mozilla_page_load 07:27:06 INFO - PROCESS | 11519 | _x_x_mozilla_page_load_details 07:27:06 INFO - PROCESS | 11519 | |i|pagename|runs| 07:27:06 INFO - PROCESS | 11519 | |0;dojo.html;2565.448428587854;2581.5611346071155;2605.3356394119496;2614.934626634335;2632.262966369416;4445.422095127629;4542.772861356935;4590.334401511779;4595.471520775108;4609.884752881179;4541.455025396957;4547.499775024745;4576.199165146095;4579.12996530659;4607.216773148564;4187.68592355573;4195.1190250047375;4224.936625950613;4249.44757181566;4347.891302717426;4263.936040959373;4312.28847240205;4317.050248945227;4331.263685173512;4351.173277077361;4171.895702607429;4178.6448151907125;4205.369194620801;4206.516250631186;4279.037216626265;4159.355299928516;4173.269677806402;4182.769947652878;4217.894552636178;4233.5131459881895;4118.75287482752;4163.167366526676;4164.8125834337525;4174;4195.832166713328;4423.933640995388;4467.039586488921;4471.083427897273;4518.819247230107;4520.457545094577;4843.830465933711;4867.123917694814;4875.536824001714;4883.389576302962;4903.4606193318705;4804.95195048052;4846.61227101831;4897.681650692693;4952.777125029383;4985.302057711923;4597.103564804831;4633.351330813689;4633.4671512775785;4646.5353464653945;4653.7905794239;5017.799288028511;5024.874378140576;5025.045241404122;5026.170681837529;5076.568491678175;4720.197566413718;4826.32431459596;4831.637627177905;4834.395700537433;4854.393200849894;4902.044101400193;4902.828401005948;4905.043516514245;4937.975310123498;4962.082014827269;4850.1997170466475;4857.344258525124;4857.611391088704;4861.197902346144;4894.779734911866;4721.787519561628;4842.297866809364;4863.732494712754;4888.902221955541;4905.509449055137;4118.567550407224;4121.5466298707115;4123;4149.730267532601;4157.605027522381;3593.838277277529;3593.856245750193;3596;3619.4027985382645;3637.0725465006785;4145.486897282531;4219;4219.3249080147025;4300.526942036374;4307.6769242306955;4872.9512704872495;4880.6095512358925;4880.707157570557;4883.902321953541;4901.926471102936;4228.963903843578;4232.978835105805;4234.449521562239;4235.597618226264;4276.059266961263;4358.694891357638;4372.846950356722;4422.624076953495;4479.216137175981;4490.371348011281;4701.717896926195;4703.74129422885;4722.7874745635845;4726.220173671306;4768.284757286435;4922.089413458521;4940.110780059624;4941.061198372297;4943.703377797344;4996.675216110941;4582.243929751687;4672.369230153886;4705.788239529161;4710.552497512868;4755.191617424977;4819.469858315652;4843.200871856105;4878.707277563358;4878.829240976691;4926.3349447824085;4768.76156192182;4904.828331008398;4913.926291105565;4931.0630980113665;4986.950130498649;4794.904101918012;4827.8551643450755;4841.975790121027;4859.052484765437;4885.853424397132;4693.436787585511;4730.574248317668;4733.266343716729;4736.360591320127;4780.378550788375;4622.098690755271;4655.906881862412;4666.859994200179;4713.057388522378;4724.196886529229;4742.78657460422;4764;4770.0936822003705;4776.044791041736;4812.831550895702;4663.067386522641;4669.066186762729;4673.859784206479;4680.040591678766;4724.078804633064 07:27:06 INFO - PROCESS | 11519 | |1;ext.html;582.3506789929228;587.7061469265367;612.0635427795474;613.3222788818355;648.5557393185668;26521.999999999975;27208.86395568022;27246.86376568117;33453.33093338138;34598.654013459854;36410.27179456409;37223.441648375294;37258.81370593143;37356.43965340522;37453.06367340818;7520.473566850323;7700.768976930673;7710.537367757925;7711.768646940601;7715.6527956241825;7430.925690743077;7549.471536992412;7552.735654252102;7553.811154721148;7558.130814956268;7702.8844567331535;7727.88408173875;7774.766756997271;7775.766726998171;7778.338841198505;7685.50044247125;7726.729564465217;7731.961340193291;7733.535987840692;7739.496932699357;7776.144624091346;7880.054393472763;7890.0926393464915;7890.763277101696;7897.289243968071;37441.81279093614;37888.62111378879;37942.86171414862;37967.810160949295;38025.42961855575;3206.983965080183;3292.884749033772;3335.8832440864694;3337.4493208620547;3783;28416.147515574357;29024;29052.41895162085;29261.707382926324;30032.8498357509;3268.591426071741;3297.8021318720953;3328.5839270091237;3336.2993771308056;3366.9663303367142;231926;233026.83486582627;233170;234310;234618.99999999828;33036.17409564732;34215.31569368599;52728.47271527236;53009;53529.92940141253;32259;32266.83866580699;32376.83811580974;32432.675673242964;32454.675453245636;12290.877091228973;12504.749905001849;12523.686907827378;12530.68673283157;12531.31077790712;10101.595936162617;10141.746456338651;10162.339447935861;10167.542460589291;10178.18574514037;8099.514029158269;8181.590920453954;8229.917700823034;8262.917370826215;8292.04641466227;3207.6631953644533;3211.940059780267;3220.9194770130935;3251.7886337387995;3304.719098876574;819.7786597618609;880.7401816464159;884.8407286688329;897.6544030548156;917.7430319510547;26588.202353929413;27299.863500682368;27693.86153069222;27742.445151096865;27812.721872781014;951.695457453622;988.6935050134481;1000.6497725795913;1012.2748286306463;1046.9790604187874;13945.233012184428;14298.49955251582;14567.781483277759;14599;14681.632959176106;352745;404017;417007;417230;417902;44342.11315773666;44786.77606612011;45233.09533809371;45280.54719452829;45451.77274113608;1051.2431049644244;1215.3983778029756;1251.956181533642;1274.3246079577839;1304.5694920675965;24377.756222437547;26487.470250595266;26666.466670666865;26789;27866;38693.61306387013;46528.767356163;48506;48595.27107093467;48615.27077093917;243545;245939;246897;247087;247723;32629.836850815595;36035.099122522144;37010.25979480449;41541;42672.359914601926;41259.1748165041;41553.1058652314;42058.36912446377;42142.57857421387;42170.57829421666;35299;36034;36400.81799590985;36545;36651.266974659826;35418.29163416666;35724.821375892956;35748.64251357557;36008;36308.63691363052;32526.83736581302;33066;33338.66661333355;33417.66582334146;33596.66403335935;30685.846570767004;31679.84160079185;31873.68126318707;32139.67860321367;32174.356512869144;22728.886355568116;22782;22997.195098172153;23196.76803231946;23328.6500702493 07:27:06 INFO - PROCESS | 11519 | |2;jquery.html;370.82385866713315;378.46258313195267;385.29683327926523;392.44860970336686;401.0555142639083;15738.606534836621;16658.66682666346;17117.058561779097;17131.057791821444;17217.311307547683;14328.71342573148;14777.408903643869;15130.697386052272;15268.694626107472;15287.082775033507;4698.812047518095;4804.183288840888;4856.465788763251;4859.805607775685;4864.586510146642;3448.310337932411;5188.325517682715;5516.14499752537;5516.7517461714115;5526.392096869341;5459.426760190182;5498.120300751861;5508.173773933902;5519.613627046108;5525.171224316345;5769.394213607574;5946.43508866657;5953.464188223037;5956.285245770514;5960.582759206857;3319.170207448138;4819.6385271104455;5199.870003249911;5207.1668533034535;5210.843674689765;11121;11451.656450306504;11493.942530287379;11518.308901465938;11725.472353744102;1919.433767038727;1948.5907959328558;1951.4828570428847;2069.5240094778133;2227.4431392151964;8631.741047768577;9438.858417123749;9495.715128546155;9527.90472095284;9553.90446095544;1755.6927537680854;1796.6316905034437;1800.1539276540004;1814.8185181481879;1823.216017112641;68133.65933170351;69706;72360.6381968092;73838;75267;9586.856197157049;9604.471754053595;9708.077732615391;9803.16673082796;9867.259955503367;13413.932930335286;13427;13478.19130852152;13506.662333441742;13518.59444216675;6910.170779506491;7182.784516464514;7192.31672991065;7255.383292420203;7255.963720181471;6814.398616325159;6851;6946.756863509753;6973.12835895513;6977.581345119309;4043.1146294556465;4142.2958097123565;4155.1897380010605;4236.385724069993;4521.163584736834;1576.2118940529735;1618.336482042357;1711.537884771105;1712.5204942616087;1752.4917773845698;783.9608019598998;806.028735373873;829.1004260377438;834.0533494483805;875.4492502168794;15830.366785328459;16322.183890805649;16408.83591164097;16461.176941152895;16812.411565595146;818.1409520003972;819.0580832043198;820.0528389709895;842.4742452834905;866.7053201911381;8894.155055269739;9311.161995420445;9324.906750932403;9381.900650526222;9478.336516443782;366077;397228;402857.8285302891;404725;406025;79005.06955023258;79140;80988.59505702434;81282.59358703169;81772.59113704393;930.7486978515898;932.5383934952107;956.2780101023822;981.8330883749779;985.6353149334792;14628.926855365655;14667.48663796762;14723.631909202355;14764.261786910827;14822.332995015035;34259.31481370309;35239.647603523634;35272.12006679315;35560.644393556766;35654.465183021755;48215;48353;49959;50061.24908126308;50064.249036263755;7539.283768042027;7627.23727627255;7677.462577619513;7758.340541053848;8054.395920306118;9927.950360248153;10741.624043158765;11164.720881978015;11283.097352211638;11615.361155136548;9144.131307525775;9655.758606034906;9708.417494950325;9906.207503399566;9954.253430992849;9482.905170948477;9485.383450075999;9928.106470417697;9985.60057597688;10217.284790064625;9611.279154063614;10045.598176072876;10175.84736228972;10281.228907831794;10293.948530257301;7375.483716139819;7390.076240469942;7896.131425543301;7952.562609056557;8028.759137225892;8313;9444.811103778024;9679.9032009679;9684.128428441474;9713.27150463704 07:27:06 INFO - PROCESS | 11519 | |3;mootools.html;1235.0983781839263;1487.9479218227361;1488.1443170177147;1630.1686140068562;1804.485721569352;7282.635868206588;7563.357114645255;7579.999999999993;7580.658870350833;7584.96207518963;7632.351250143731;7821.843563128734;7842.490238134517;7848.92151078489;7858.057033156015;1953.5213872601162;2225.5882661707597;2232.955340893181;2256.571251462217;2301.0680674326923;2296.5292115116363;2318.7449380568123;2319.4549280918973;2320.9883950580224;2321.466062805556;2251.8536295140843;2276.931692049233;2279.5782780185637;2280.8631482111045;2281.7946384825364;1935.525796179938;2211.170810945903;2259.807916327114;2260.0733699183256;2281.942951426211;2182.03990244292;2193.813525850305;2212.7676593957726;2222.388843068153;2224.7663995280586;7791.571463569501;7850.371970242367;7854.136045035041;7857.842843143162;7871.448998570102;4490.259107247301;4617.37665415168;4620.330052142454;4624.237000894848;4696.919708467038;3043.8021528600793;3083.9691603083907;3131.045031265463;3131.7024882636115;3154.921126971844;936.6440752514001;964.1274646444979;968.5351031504918;980.1423754215061;989.5596459575492;10886.0746836519;10919.890801092046;10938.835917461245;10957.945210273898;11004.229703920728;4388.451443569554;4390.100029493946;4539.137563862855;4575.862724118282;4578.702384345007;8418.158184181533;8512.233898949124;8541.103184165697;8561.700340488052;8570.657173713107;3959.9010024749614;4398.64810815134;4413.227685155085;4424.579664931826;4432.623227025739;4096.078382363944;4152.8131234094535;4153.314703073959;4181.581841815855;4189.916201675949;3638.890833275006;3737.5328083989502;3765.792881391495;3791.450239715226;3845.134844659929;1252.8058150986612;1278.4374875054946;1278.8017857232144;1297.695041665208;1312.3962977030674;785.8546168958761;797.8723404255292;806.5846089264033;837.7026155714756;866.0949307973183;5204.843854684365;5532.6680399176175;5543.390227075019;5551.9722401387735;5829.8251052468495;775.2363921537282;786.8347646994081;873.3929918706565;891.9108089191029;948.2035090523993;3576.678098971105;3769.660730534265;3781.773093614392;3789.6399842014966;3816.9809150954065;9483.478408687588;9811.411315321104;9850.064243896819;9941.65204217849;9975.45135017581;9775.51122443875;9794.412335259907;9816.754581135528;9821.558029888529;9857.901420985841;7210.351068403869;7527.698892044366;7527.924720752722;7596.886046709304;7599.240075992467;5379.569634429158;5389.2455056291365;5432.320959880015;5546.944530554642;5624.718764061862;8933.910660893307;8975.057618949917;9129.224015958718;9136.223421009023;9252.537373131181;9042.638294468148;9333.206677432494;9350.438973661601;9357;9399.96600373972;5810.622309549865;6416.165898433173;6501.642409667514;6607.57050791697;6643.734250630114;7597.886031709419;7600;7651.120121186135;7651.349635280841;7663.386929045774;6607.834804129743;6664.633445160563;6757.493188010821;6806.8638627228165;6829.4877884157895;6704.061431399706;6736;6807.761728339485;6901.861962760616;6907.516473846783;6192.2569291683485;6428.774992875414;6473.158489396348;6494.707738151889;6501.122348482894;4403.273459879084;4447.621952133975;4498.572635599613;4525.208088584551;4545;4286.078493123993;4318.13637272553;4359.869203923888;4411.2721400968485;4430.579094985971 07:27:06 INFO - PROCESS | 11519 | |4;prototype.html;319.10491072541527;319.2609109910557;322.3456383541411;328.0519299225239;330.58841742031143;4944.2089265717495;4956.727379994099;4970.130227210233;4972.751362431877;5007.474215207405;4893.40964186639;4913.238448040551;4914.410270767513;4919.188333924907;4925.630577706668;3647.507586475825;3726.832292546842;3873.612638736132;3902.9609703902884;3913.3347330953807;3844.5578758442716;3858.9035274118232;3866.961330386688;3883.2233553289316;3901.14174881527;3608.9458658120147;3841.654251117399;3842.884713458601;3847.769133851978;3851.48005019323;3756.1736417988;3893.59117292683;3893.805309734502;3899.200663863901;3904.9023774405723;3439.8796042138656;3443.984024712691;3452.171478845084;3467.1678797088516;3468.063622821849;4687.367290349972;4691.225947718623;4692.36653051837;4696.483386827446;4699.765011749399;4296.5059018213;4298.892527686801;4345.217860785057;4351.238533256699;4435.800388982503;5101.591872650179;5102.923456148161;5111.87220319495;5139.203423469368;5155.304033955405;3662.926741465182;3673.1918977825103;3673.2469843682247;3674.926501469956;3680.3743363628246;5199.748881426183;5350.143976963667;5366.838994830161;5369.4630536946;5392.757325920343;3875.5736868944396;3885.261800257942;3892.922141557153;3893.805309734502;3896.649301562873;3932.8201539538595;3934.5475270343704;3950.308695978192;3952.2293152834923;3957.5053118360206;4423.8230470781455;4426.911461770811;4435.26818075014;4435.955640443619;4446.244138496463;4879.194932836042;5172.094883395466;5187.0922588546855;5188.818391356284;5197.428282888879;1305.5104335874048;1325.7481078595035;1328.1898042194255;1328.34247047712;1331.5419615520989;824.3611201319026;866.0646501778065;881.4799268431656;901.427593478133;919.117647058831;4547.909041819145;4552;4568.291914753218;4580.450345958507;4584.472785629695;5261.736913154327;5268.710220937808;5273.2617433559335;5283.1546952487415;5283.313169287968;4477.574630410106;4547.113312903952;4559.6124329431705;4571.314302854598;4583.175028494903;2784.8468334241406;2819.16834533813;2821.943561128807;2823.1953893140358;2836.375997280595;5049.747512624427;5053.570446512088;5056.747162641853;5063.468335824759;5067.087924173684;5220.243064755589;5387.299651045339;5418.133098704188;5419.783208671609;5443.455654434525;5027.396712394463;5047;5056.595472362203;5071.41678706946;5072.264521644267;5277.894442111059;5297.152455607084;5298.443663415286;5300.416954135119;5306;5016.072026675077;5139.408967968731;5169.198774190007;5175.611829112756;5204.869878253074;4990.101781679333;4993.600511959107;4996;5006.271581987752;5006.699598023984;3703.2963736889906;3707.8516859325323;3712.795796231125;3720.8883733488037;3726.16161363691;5064.189729643387;5264.473552644705;5285;5346.652467589594;5359.356877174764;5191.143461328838;5198.220266959835;5206.921896171485;5213.713245771519;5216.452272511484;5178.97410512945;5195.610329225399;5209.218617207449;5209.791608335624;5219.373675159005;4873.95126048735;5114.795408183631;5130.435652078343;5131.769070391916;5143.4085080216255;4964.776585053609;5028.74856257193;5194.42875776493;5236.581073514034;5241.240020197126;5107.923381149211;5115.5396014358885;5122.538971492583;5127.333446651912;5133.743312834418 07:27:06 INFO - PROCESS | 11519 | |5;yui.html;659.9010148477731;671.2750229751869;774.3224678406394;778.2839787395598;793.551643321523;12390.256584604918;12447.813282800766;12464.563740269092;12559.560415385464;12577.11960162788;11699.649010529676;11764.411779411039;11775.941120294408;13438.798418023738;14053.789193162085;843.3379796859466;844.0082902589463;849.1593322610602;849.4011721736192;851.0170752780548;648.9545731798776;809.6599428240124;841.8821365008904;845.3321875718175;845.4800297816829;866.7313132928781;872.4808738800403;877.0834477970536;877.4954401219293;878.7495563764328;663.4758540752799;866.51908190954;868.2533021601417;868.9435186712843;869.2350731356397;618.057462369885;634.936506349366;636.3286732497213;636.3572791480592;636.7643971730489;12187.878121218851;12237.755244895052;12271.38643067843;12283.078769092264;12292.877071229263;11728.53085876564;12070.094742894318;12082.758344833053;12481.812772808415;12622.936885315607;9664.75838104046;9915.90084099157;9919.553620087041;10206.591736330538;10310.845337319946;3293.4071867063917;3332.666733326648;3336.382769187708;3387.7967321960514;3464.8960531184107;47577.76211118922;48299.75850120762;48339;48350;48421.51578484205;9210.125038121369;9622.51887405641;9891.901080989242;9916.504174791231;10023.298369114093;17489.38787142444;17504.562385940455;17544.649107017787;17547.561310967074;17598.47204583839;6663.36698013688;6734.8989765153565;6757.155355580552;6835.829104272433;6911.412529935012;3763.7177211708686;3817.5609804872797;3854.71089668276;3858.5369755629504;3951.0517475806173;2870.598116263725;2946.587477753116;2965.2142182321704;2966.7478264347774;2973.435047340998;514.9922751158736;515.8143068495339;518.6239976017357;527.9815206467755;539.7247403824078;460.26128064456736;579.3106203617682;592.599995003371;604.320139842677;621.316551793024;8134.430589858772;8392.622331995075;8450.915490845136;8457.281131103802;8609.182127697859;502.3469489663496;571.9370869204467;598.4673640459994;599.0176111177672;606.1211243696657;4073.9592604074173;4074.6536544393466;4284.528701842794;4397.0985947881245;4420.491643460979;48084.03831923412;49694.75152624214;53842.46157538374;54033;54156.187657185175;48833.511664883605;49479.50520494821;49871.50128498741;49975;49996.75001624969;44244.99999999936;44969.55030449719;45254.32118518225;45533.54466455359;46915.5308446918;8641.481511109354;8646.654133834827;8917.42036767608;8920.553972301488;8948.328875334246;30089.84955075298;30509.69490305157;30621.387572248877;31303.53044704377;31364.529532057495;38033.04917377088;40007.799961001176;41064.384034238916;41287.74480253801;41349;10479.371237725456;10582.365058096539;10595.205359597907;10858;11057.5024123913;11408.657740267805;11640.126990475579;11799.233049851731;12089.15375923677;12285.324307163191;11181;11346.60286889988;11394.48724807369;12274.079444041554;12354;10878.075363594184;11144.665660030212;11739.11956603241;11780.941095294469;11830.645080647595;11737.47181376823;11947.94026029899;12032.699182520508;12235.510579576718;12367.253130448536;9609.615615375307;9711.951440242754;9836.163926066365;10402.219833512365;10692.358458492516;9535.809283814146;9795.216382689225;10044.497775111362;10303.175745940156;10303.639372621923 07:27:06 INFO - PROCESS | 11519 | __end_tp_report 07:27:06 INFO - PROCESS | 11519 | __start_cc_report 07:27:06 INFO - PROCESS | 11519 | _x_x_mozilla_cycle_collect,881 07:27:06 INFO - PROCESS | 11519 | __end_cc_report 07:27:06 INFO - PROCESS | 11519 | __startTimestamp1460557626518__endTimestamp 07:27:06 INFO - PROCESS | 11519 | 07:27:06 INFO - PROCESS | 11519 | ------- Summary: start ------- 07:27:06 INFO - PROCESS | 11519 | Number of tests: 6 07:27:06 INFO - PROCESS | 11519 | 07:27:06 INFO - PROCESS | 11519 | [#0] dojo.html Cycles:165 Average:4532.72 Median:4673.86 stddev:470.69 (10.1%) stddev-sans-first:446.12 07:27:06 INFO - PROCESS | 11519 | Values: 2565.4 2581.6 2605.3 2614.9 2632.3 4445.4 4542.8 4590.3 4595.5 4609.9 4541.5 4547.5 4576.2 4579.1 4607.2 4187.7 4195.1 4224.9 4249.4 4347.9 4263.9 4312.3 4317.1 4331.3 4351.2 4171.9 4178.6 4205.4 4206.5 4279.0 4159.4 4173.3 4182.8 4217.9 4233.5 4118.8 4163.2 4164.8 4174.0 4195.8 4423.9 4467.0 4471.1 4518.8 4520.5 4843.8 4867.1 4875.5 4883.4 4903.5 4805.0 4846.6 4897.7 4952.8 4985.3 4597.1 4633.4 4633.5 4646.5 4653.8 5017.8 5024.9 5025.0 5026.2 5076.6 4720.2 4826.3 4831.6 4834.4 4854.4 4902.0 4902.8 4905.0 4938.0 4962.1 4850.2 4857.3 4857.6 4861.2 4894.8 4721.8 4842.3 4863.7 4888.9 4905.5 4118.6 4121.5 4123.0 4149.7 4157.6 3593.8 3593.9 3596.0 3619.4 3637.1 4145.5 4219.0 4219.3 4300.5 4307.7 4873.0 4880.6 4880.7 4883.9 4901.9 4229.0 4233.0 4234.4 4235.6 4276.1 4358.7 4372.8 4422.6 4479.2 4490.4 4701.7 4703.7 4722.8 4726.2 4768.3 4922.1 4940.1 4941.1 4943.7 4996.7 4582.2 4672.4 4705.8 4710.6 4755.2 4819.5 4843.2 4878.7 4878.8 4926.3 4768.8 4904.8 4913.9 4931.1 4987.0 4794.9 4827.9 4842.0 4859.1 4885.9 4693.4 4730.6 4733.3 4736.4 4780.4 4622.1 4655.9 4666.9 4713.1 4724.2 4742.8 4764.0 4770.1 4776.0 4812.8 4663.1 4669.1 4673.9 4680.0 4724.1 07:27:06 INFO - PROCESS | 11519 | 07:27:06 INFO - PROCESS | 11519 | [#1] ext.html Cycles:180 Average:43759.11 Median:194022.00 stddev:80314.37 (41.4%) stddev-sans-first:80474.25 07:27:06 INFO - PROCESS | 11519 | Values: 582.4 587.7 612.1 613.3 648.6 26522.0 27208.9 27246.9 33453.3 34598.7 36410.3 37223.4 37258.8 37356.4 37453.1 7520.5 7700.8 7710.5 7711.8 7715.7 7430.9 7549.5 7552.7 7553.8 7558.1 7702.9 7727.9 7774.8 7775.8 7778.3 7685.5 7726.7 7732.0 7733.5 7739.5 7776.1 7880.1 7890.1 7890.8 7897.3 37441.8 37888.6 37942.9 37967.8 38025.4 3207.0 3292.9 3335.9 3337.4 3783.0 28416.1 29024.0 29052.4 29261.7 30032.8 3268.6 3297.8 3328.6 3336.3 3367.0 231926.0 233026.8 233170.0 234310.0 234619.0 33036.2 34215.3 52728.5 53009.0 53529.9 32259.0 32266.8 32376.8 32432.7 32454.7 12290.9 12504.7 12523.7 12530.7 12531.3 10101.6 10141.7 10162.3 10167.5 10178.2 8099.5 8181.6 8229.9 8262.9 8292.0 3207.7 3211.9 3220.9 3251.8 3304.7 819.8 880.7 884.8 897.7 917.7 26588.2 27299.9 27693.9 27742.4 27812.7 951.7 988.7 1000.6 1012.3 1047.0 13945.2 14298.5 14567.8 14599.0 14681.6 352745.0 404017.0 417007.0 417230.0 417902.0 44342.1 44786.8 45233.1 45280.5 45451.8 1051.2 1215.4 1252.0 1274.3 1304.6 24377.8 26487.5 26666.5 26789.0 27866.0 38693.6 46528.8 48506.0 48595.3 48615.3 243545.0 245939.0 246897.0 247087.0 247723.0 32629.8 36035.1 37010.3 41541.0 42672.4 41259.2 41553.1 42058.4 42142.6 42170.6 35299.0 36034.0 36400.8 36545.0 36651.3 35418.3 35724.8 35748.6 36008.0 36308.6 32526.8 33066.0 33338.7 33417.7 33596.7 30685.8 31679.8 31873.7 32139.7 32174.4 22728.9 22782.0 22997.2 23196.8 23328.7 07:27:06 INFO - PROCESS | 11519 | 07:27:06 INFO - PROCESS | 11519 | [#2] jquery.html Cycles:180 Average:24067.94 Median:5335.14 stddev:65474.38 (1227.2%) stddev-sans-first:65633.87 07:27:06 INFO - PROCESS | 11519 | Values: 370.8 378.5 385.3 392.4 401.1 15738.6 16658.7 17117.1 17131.1 17217.3 14328.7 14777.4 15130.7 15268.7 15287.1 4698.8 4804.2 4856.5 4859.8 4864.6 3448.3 5188.3 5516.1 5516.8 5526.4 5459.4 5498.1 5508.2 5519.6 5525.2 5769.4 5946.4 5953.5 5956.3 5960.6 3319.2 4819.6 5199.9 5207.2 5210.8 11121.0 11451.7 11493.9 11518.3 11725.5 1919.4 1948.6 1951.5 2069.5 2227.4 8631.7 9438.9 9495.7 9527.9 9553.9 1755.7 1796.6 1800.2 1814.8 1823.2 68133.7 69706.0 72360.6 73838.0 75267.0 9586.9 9604.5 9708.1 9803.2 9867.3 13413.9 13427.0 13478.2 13506.7 13518.6 6910.2 7182.8 7192.3 7255.4 7256.0 6814.4 6851.0 6946.8 6973.1 6977.6 4043.1 4142.3 4155.2 4236.4 4521.2 1576.2 1618.3 1711.5 1712.5 1752.5 784.0 806.0 829.1 834.1 875.4 15830.4 16322.2 16408.8 16461.2 16812.4 818.1 819.1 820.1 842.5 866.7 8894.2 9311.2 9324.9 9381.9 9478.3 366077.0 397228.0 402857.8 404725.0 406025.0 79005.1 79140.0 80988.6 81282.6 81772.6 930.7 932.5 956.3 981.8 985.6 14628.9 14667.5 14723.6 14764.3 14822.3 34259.3 35239.6 35272.1 35560.6 35654.5 48215.0 48353.0 49959.0 50061.2 50064.2 7539.3 7627.2 7677.5 7758.3 8054.4 9928.0 10741.6 11164.7 11283.1 11615.4 9144.1 9655.8 9708.4 9906.2 9954.3 9482.9 9485.4 9928.1 9985.6 10217.3 9611.3 10045.6 10175.8 10281.2 10293.9 7375.5 7390.1 7896.1 7952.6 8028.8 8313.0 9444.8 9679.9 9684.1 9713.3 07:27:06 INFO - PROCESS | 11519 | 07:27:06 INFO - PROCESS | 11519 | [#3] mootools.html Cycles:180 Average:5188.94 Median:5545.17 stddev:2887.14 (52.1%) stddev-sans-first:2879.94 07:27:06 INFO - PROCESS | 11519 | Values: 1235.1 1487.9 1488.1 1630.2 1804.5 7282.6 7563.4 7580.0 7580.7 7585.0 7632.4 7821.8 7842.5 7848.9 7858.1 1953.5 2225.6 2233.0 2256.6 2301.1 2296.5 2318.7 2319.5 2321.0 2321.5 2251.9 2276.9 2279.6 2280.9 2281.8 1935.5 2211.2 2259.8 2260.1 2281.9 2182.0 2193.8 2212.8 2222.4 2224.8 7791.6 7850.4 7854.1 7857.8 7871.4 4490.3 4617.4 4620.3 4624.2 4696.9 3043.8 3084.0 3131.0 3131.7 3154.9 936.6 964.1 968.5 980.1 989.6 10886.1 10919.9 10938.8 10957.9 11004.2 4388.5 4390.1 4539.1 4575.9 4578.7 8418.2 8512.2 8541.1 8561.7 8570.7 3959.9 4398.6 4413.2 4424.6 4432.6 4096.1 4152.8 4153.3 4181.6 4189.9 3638.9 3737.5 3765.8 3791.5 3845.1 1252.8 1278.4 1278.8 1297.7 1312.4 785.9 797.9 806.6 837.7 866.1 5204.8 5532.7 5543.4 5552.0 5829.8 775.2 786.8 873.4 891.9 948.2 3576.7 3769.7 3781.8 3789.6 3817.0 9483.5 9811.4 9850.1 9941.7 9975.5 9775.5 9794.4 9816.8 9821.6 9857.9 7210.4 7527.7 7527.9 7596.9 7599.2 5379.6 5389.2 5432.3 5546.9 5624.7 8933.9 8975.1 9129.2 9136.2 9252.5 9042.6 9333.2 9350.4 9357.0 9400.0 5810.6 6416.2 6501.6 6607.6 6643.7 7597.9 7600.0 7651.1 7651.3 7663.4 6607.8 6664.6 6757.5 6806.9 6829.5 6704.1 6736.0 6807.8 6901.9 6907.5 6192.3 6428.8 6473.2 6494.7 6501.1 4403.3 4447.6 4498.6 4525.2 4545.0 4286.1 4318.1 4359.9 4411.3 4430.6 07:27:06 INFO - PROCESS | 11519 | 07:27:06 INFO - PROCESS | 11519 | [#4] prototype.html Cycles:180 Average:4295.28 Median:4922.41 stddev:1237.42 (25.1%) stddev-sans-first:1204.36 07:27:06 INFO - PROCESS | 11519 | Values: 319.1 319.3 322.3 328.1 330.6 4944.2 4956.7 4970.1 4972.8 5007.5 4893.4 4913.2 4914.4 4919.2 4925.6 3647.5 3726.8 3873.6 3903.0 3913.3 3844.6 3858.9 3867.0 3883.2 3901.1 3608.9 3841.7 3842.9 3847.8 3851.5 3756.2 3893.6 3893.8 3899.2 3904.9 3439.9 3444.0 3452.2 3467.2 3468.1 4687.4 4691.2 4692.4 4696.5 4699.8 4296.5 4298.9 4345.2 4351.2 4435.8 5101.6 5102.9 5111.9 5139.2 5155.3 3662.9 3673.2 3673.2 3674.9 3680.4 5199.7 5350.1 5366.8 5369.5 5392.8 3875.6 3885.3 3892.9 3893.8 3896.6 3932.8 3934.5 3950.3 3952.2 3957.5 4423.8 4426.9 4435.3 4436.0 4446.2 4879.2 5172.1 5187.1 5188.8 5197.4 1305.5 1325.7 1328.2 1328.3 1331.5 824.4 866.1 881.5 901.4 919.1 4547.9 4552.0 4568.3 4580.5 4584.5 5261.7 5268.7 5273.3 5283.2 5283.3 4477.6 4547.1 4559.6 4571.3 4583.2 2784.8 2819.2 2821.9 2823.2 2836.4 5049.7 5053.6 5056.7 5063.5 5067.1 5220.2 5387.3 5418.1 5419.8 5443.5 5027.4 5047.0 5056.6 5071.4 5072.3 5277.9 5297.2 5298.4 5300.4 5306.0 5016.1 5139.4 5169.2 5175.6 5204.9 4990.1 4993.6 4996.0 5006.3 5006.7 3703.3 3707.9 3712.8 3720.9 3726.2 5064.2 5264.5 5285.0 5346.7 5359.4 5191.1 5198.2 5206.9 5213.7 5216.5 5179.0 5195.6 5209.2 5209.8 5219.4 4874.0 5114.8 5130.4 5131.8 5143.4 4964.8 5028.7 5194.4 5236.6 5241.2 5107.9 5115.5 5122.5 5127.3 5133.7 07:27:06 INFO - PROCESS | 11519 | 07:27:06 INFO - PROCESS | 11519 | [#5] yui.html Cycles:180 Average:13214.23 Median:45393.93 stddev:15026.69 (33.1%) stddev-sans-first:15039.27 07:27:06 INFO - PROCESS | 11519 | Values: 659.9 671.3 774.3 778.3 793.6 12390.3 12447.8 12464.6 12559.6 12577.1 11699.6 11764.4 11775.9 13438.8 14053.8 843.3 844.0 849.2 849.4 851.0 649.0 809.7 841.9 845.3 845.5 866.7 872.5 877.1 877.5 878.7 663.5 866.5 868.3 868.9 869.2 618.1 634.9 636.3 636.4 636.8 12187.9 12237.8 12271.4 12283.1 12292.9 11728.5 12070.1 12082.8 12481.8 12622.9 9664.8 9915.9 9919.6 10206.6 10310.8 3293.4 3332.7 3336.4 3387.8 3464.9 47577.8 48299.8 48339.0 48350.0 48421.5 9210.1 9622.5 9891.9 9916.5 10023.3 17489.4 17504.6 17544.6 17547.6 17598.5 6663.4 6734.9 6757.2 6835.8 6911.4 3763.7 3817.6 3854.7 3858.5 3951.1 2870.6 2946.6 2965.2 2966.7 2973.4 515.0 515.8 518.6 528.0 539.7 460.3 579.3 592.6 604.3 621.3 8134.4 8392.6 8450.9 8457.3 8609.2 502.3 571.9 598.5 599.0 606.1 4074.0 4074.7 4284.5 4397.1 4420.5 48084.0 49694.8 53842.5 54033.0 54156.2 48833.5 49479.5 49871.5 49975.0 49996.8 44245.0 44969.6 45254.3 45533.5 46915.5 8641.5 8646.7 8917.4 8920.6 8948.3 30089.8 30509.7 30621.4 31303.5 31364.5 38033.0 40007.8 41064.4 41287.7 41349.0 10479.4 10582.4 10595.2 10858.0 11057.5 11408.7 11640.1 11799.2 12089.2 12285.3 11181.0 11346.6 11394.5 12274.1 12354.0 10878.1 11144.7 11739.1 11780.9 11830.6 11737.5 11947.9 12032.7 12235.5 12367.3 9609.6 9712.0 9836.2 10402.2 10692.4 9535.8 9795.2 10044.5 10303.2 10303.6 07:27:06 INFO - PROCESS | 11519 | -------- Summary: end -------- 07:27:06 INFO - PROCESS | 11519 | 07:27:07 INFO - TEST-INFO | 11519: exit 0 07:27:07 INFO - TEST-OK | dromaeo_css | took 1117153ms 07:27:07 INFO - TEST-START | kraken 07:27:07 INFO - operating with platform_type : linux_ 07:27:07 INFO - Initialising browser for kraken test... 07:27:07 INFO - TEST-INFO | started process 11703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_xvuU/profile http://localhost:38590/getInfo.html) 07:27:11 INFO - PROCESS | 11703 | __metrics Screen width/height:1600/1200 07:27:11 INFO - PROCESS | 11703 | colorDepth:24 07:27:11 INFO - PROCESS | 11703 | Browser inner width/height: 1024/697 07:27:11 INFO - PROCESS | 11703 | __metrics 07:27:12 ERROR - PROCESS | 11703 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:27:13 INFO - TEST-INFO | 11703: exit 0 07:27:13 INFO - Browser initialized. 07:27:13 INFO - Running cycle 1/1 for kraken test... 07:27:13 INFO - TEST-INFO | started process 11781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_xvuU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:25 INFO - PROCESS | 11781 | RSS: Main: 154464256 07:27:25 INFO - PROCESS | 11781 | 07:27:27 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38590/tests/kraken/driver.html?testName=audio-beat-detection) 07:27:28 INFO - PROCESS | 11781 | RSS: Main: 209342464 07:27:28 INFO - PROCESS | 11781 | 07:27:31 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38590/tests/kraken/driver.html?testName=audio-dft) 07:27:32 INFO - PROCESS | 11781 | RSS: Main: 194486272 07:27:32 INFO - PROCESS | 11781 | 07:27:35 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38590/tests/kraken/driver.html?testName=audio-fft) 07:27:35 INFO - PROCESS | 11781 | RSS: Main: 265154560 07:27:35 INFO - PROCESS | 11781 | 07:27:37 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38590/tests/kraken/driver.html?testName=audio-oscillator) 07:27:38 INFO - PROCESS | 11781 | RSS: Main: 174624768 07:27:38 INFO - PROCESS | 11781 | 07:27:40 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38590/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:27:41 INFO - PROCESS | 11781 | RSS: Main: 179019776 07:27:41 INFO - PROCESS | 11781 | 07:27:44 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38590/tests/kraken/driver.html?testName=imaging-darkroom) 07:27:45 INFO - PROCESS | 11781 | RSS: Main: 214626304 07:27:45 INFO - PROCESS | 11781 | 07:27:48 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38590/tests/kraken/driver.html?testName=imaging-desaturate) 07:27:49 INFO - PROCESS | 11781 | RSS: Main: 214319104 07:27:49 INFO - PROCESS | 11781 | 07:27:52 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38590/tests/kraken/driver.html?testName=json-parse-financial) 07:27:52 INFO - PROCESS | 11781 | RSS: Main: 215617536 07:27:52 INFO - PROCESS | 11781 | 07:27:54 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38590/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:27:54 INFO - PROCESS | 11781 | RSS: Main: 200994816 07:27:54 INFO - PROCESS | 11781 | 07:27:56 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38590/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:27:57 INFO - PROCESS | 11781 | RSS: Main: 202412032 07:27:57 INFO - PROCESS | 11781 | 07:27:59 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38590/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:28:00 INFO - PROCESS | 11781 | RSS: Main: 219213824 07:28:00 INFO - PROCESS | 11781 | 07:28:03 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:28:03 INFO - PROCESS | 11781 | RSS: Main: 224759808 07:28:03 INFO - PROCESS | 11781 | 07:28:06 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:28:07 INFO - PROCESS | 11781 | RSS: Main: 220585984 07:28:07 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:38590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38590/tests/kraken/driver.html?testName=ai-astar) 07:28:09 INFO - PROCESS | 11781 | RSS: Main: 283738112 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | __start_tp_report 07:28:09 INFO - PROCESS | 11781 | _x_x_mozilla_page_load 07:28:09 INFO - PROCESS | 11781 | _x_x_mozilla_page_load_details 07:28:09 INFO - PROCESS | 11781 | |i|pagename|runs| 07:28:09 INFO - PROCESS | 11781 | |0;ai-astar;112;113;107;113;114;113;102;112;111;113 07:28:09 INFO - PROCESS | 11781 | |1;audio-beat-detection;163;132;156;191;133;167;160;133;191;134 07:28:09 INFO - PROCESS | 11781 | |2;audio-dft;163;161;162;160;163;163;163;163;162;163 07:28:09 INFO - PROCESS | 11781 | |3;audio-fft;73;74;106;116;75;77;73;128;106;74 07:28:09 INFO - PROCESS | 11781 | |4;audio-oscillator;95;95;140;95;96;94;139;94;95;138 07:28:09 INFO - PROCESS | 11781 | |5;imaging-gaussian-blur;117;116;117;117;117;118;118;118;116;117 07:28:09 INFO - PROCESS | 11781 | |6;imaging-darkroom;147;146;147;147;147;147;147;147;147;146 07:28:09 INFO - PROCESS | 11781 | |7;imaging-desaturate;95;95;96;96;95;96;95;96;95;95 07:28:09 INFO - PROCESS | 11781 | |8;json-parse-financial;62;65;62;63;62;62;64;81;61;61 07:28:09 INFO - PROCESS | 11781 | |9;json-stringify-tinderbox;64;65;65;64;65;66;64;64;65;64 07:28:09 INFO - PROCESS | 11781 | |10;stanford-crypto-aes;92;83;82;83;85;84;84;85;85;83 07:28:09 INFO - PROCESS | 11781 | |11;stanford-crypto-ccm;147;139;139;137;139;141;139;138;182;143 07:28:09 INFO - PROCESS | 11781 | |12;stanford-crypto-pbkdf2;179;173;171;175;179;174;171;176;176;179 07:28:09 INFO - PROCESS | 11781 | |13;stanford-crypto-sha256-iterative;74;72;70;71;74;70;70;72;70;71 07:28:09 INFO - PROCESS | 11781 | __end_tp_report 07:28:09 INFO - PROCESS | 11781 | __start_cc_report 07:28:09 INFO - PROCESS | 11781 | _x_x_mozilla_cycle_collect,1884 07:28:09 INFO - PROCESS | 11781 | __end_cc_report 07:28:09 INFO - PROCESS | 11781 | __startTimestamp1460557689364__endTimestamp 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | ------- Summary: start ------- 07:28:09 INFO - PROCESS | 11781 | Number of tests: 14 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:3.71 (3.3%) stddev-sans-first:3.92 07:28:09 INFO - PROCESS | 11781 | Values: 112.0 113.0 107.0 113.0 114.0 113.0 102.0 112.0 111.0 113.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:161.50 stddev:22.98 (14.2%) stddev-sans-first:24.24 07:28:09 INFO - PROCESS | 11781 | Values: 163.0 132.0 156.0 191.0 133.0 167.0 160.0 133.0 191.0 134.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.09 07:28:09 INFO - PROCESS | 11781 | Values: 163.0 161.0 162.0 160.0 163.0 163.0 163.0 163.0 162.0 163.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#3] audio-fft Cycles:10 Average:90.20 Median:73.50 stddev:21.38 (29.1%) stddev-sans-first:21.76 07:28:09 INFO - PROCESS | 11781 | Values: 73.0 74.0 106.0 116.0 75.0 77.0 73.0 128.0 106.0 74.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:95.00 stddev:21.34 (22.5%) stddev-sans-first:22.10 07:28:09 INFO - PROCESS | 11781 | Values: 95.0 95.0 140.0 95.0 96.0 94.0 139.0 94.0 95.0 138.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 07:28:09 INFO - PROCESS | 11781 | Values: 117.0 116.0 117.0 117.0 117.0 118.0 118.0 118.0 116.0 117.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 07:28:09 INFO - PROCESS | 11781 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:28:09 INFO - PROCESS | 11781 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:62.50 stddev:6.00 (9.6%) stddev-sans-first:6.31 07:28:09 INFO - PROCESS | 11781 | Values: 62.0 65.0 62.0 63.0 62.0 62.0 64.0 81.0 61.0 61.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 07:28:09 INFO - PROCESS | 11781 | Values: 64.0 65.0 65.0 64.0 65.0 66.0 64.0 64.0 65.0 64.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:2.80 (3.3%) stddev-sans-first:1.09 07:28:09 INFO - PROCESS | 11781 | Values: 92.0 83.0 82.0 83.0 85.0 84.0 84.0 85.0 85.0 83.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:140.00 stddev:13.53 (9.7%) stddev-sans-first:14.31 07:28:09 INFO - PROCESS | 11781 | Values: 147.0 139.0 139.0 137.0 139.0 141.0 139.0 138.0 182.0 143.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:176.00 stddev:3.09 (1.8%) stddev-sans-first:2.98 07:28:09 INFO - PROCESS | 11781 | Values: 179.0 173.0 171.0 175.0 179.0 174.0 171.0 176.0 176.0 179.0 07:28:09 INFO - PROCESS | 11781 | 07:28:09 INFO - PROCESS | 11781 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.58 (2.2%) stddev-sans-first:1.36 07:28:09 INFO - PROCESS | 11781 | Values: 74.0 72.0 70.0 71.0 74.0 70.0 70.0 72.0 70.0 71.0 07:28:09 INFO - PROCESS | 11781 | -------- Summary: end -------- 07:28:09 INFO - PROCESS | 11781 | 07:28:10 INFO - TEST-INFO | 11781: exit 0 07:28:10 INFO - TEST-OK | kraken | took 63009ms 07:28:10 INFO - SUITE-END | took 1180s 07:28:10 INFO - Completed test suite (00:19:40) 07:28:10 INFO - javascript benchmark 07:28:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.448428587854, 2581.5611346071155, 2605.3356394119496, 2614.934626634335, 2632.262966369416, 4445.422095127629, 4542.772861356935, 4590.334401511779, 4595.471520775108, 4609.884752881179, 4541.455025396957, 4547.499775024745, 4576.199165146095, 4579.12996530659, 4607.216773148564, 4187.68592355573, 4195.1190250047375, 4224.936625950613, 4249.44757181566, 4347.891302717426, 4263.936040959373, 4312.28847240205, 4317.050248945227, 4331.263685173512, 4351.173277077361, 4171.895702607429, 4178.6448151907125, 4205.369194620801, 4206.516250631186, 4279.037216626265, 4159.355299928516, 4173.269677806402, 4182.769947652878, 4217.894552636178, 4233.5131459881895, 4118.75287482752, 4163.167366526676, 4164.8125834337525, 4174.0, 4195.832166713328, 4423.933640995388, 4467.039586488921, 4471.083427897273, 4518.819247230107, 4520.457545094577, 4843.830465933711, 4867.123917694814, 4875.536824001714, 4883.389576302962, 4903.4606193318705, 4804.95195048052, 4846.61227101831, 4897.681650692693, 4952.777125029383, 4985.302057711923, 4597.103564804831, 4633.351330813689, 4633.4671512775785, 4646.5353464653945, 4653.7905794239, 5017.799288028511, 5024.874378140576, 5025.045241404122, 5026.170681837529, 5076.568491678175, 4720.197566413718, 4826.32431459596, 4831.637627177905, 4834.395700537433, 4854.393200849894, 4902.044101400193, 4902.828401005948, 4905.043516514245, 4937.975310123498, 4962.082014827269, 4850.1997170466475, 4857.344258525124, 4857.611391088704, 4861.197902346144, 4894.779734911866, 4721.787519561628, 4842.297866809364, 4863.732494712754, 4888.902221955541, 4905.509449055137, 4118.567550407224, 4121.5466298707115, 4123.0, 4149.730267532601, 4157.605027522381, 3593.838277277529, 3593.856245750193, 3596.0, 3619.4027985382645, 3637.0725465006785, 4145.486897282531, 4219.0, 4219.3249080147025, 4300.526942036374, 4307.6769242306955, 4872.9512704872495, 4880.6095512358925, 4880.707157570557, 4883.902321953541, 4901.926471102936, 4228.963903843578, 4232.978835105805, 4234.449521562239, 4235.597618226264, 4276.059266961263, 4358.694891357638, 4372.846950356722, 4422.624076953495, 4479.216137175981, 4490.371348011281, 4701.717896926195, 4703.74129422885, 4722.7874745635845, 4726.220173671306, 4768.284757286435, 4922.089413458521, 4940.110780059624, 4941.061198372297, 4943.703377797344, 4996.675216110941, 4582.243929751687, 4672.369230153886, 4705.788239529161, 4710.552497512868, 4755.191617424977, 4819.469858315652, 4843.200871856105, 4878.707277563358, 4878.829240976691, 4926.3349447824085, 4768.76156192182, 4904.828331008398, 4913.926291105565, 4931.0630980113665, 4986.950130498649, 4794.904101918012, 4827.8551643450755, 4841.975790121027, 4859.052484765437, 4885.853424397132, 4693.436787585511, 4730.574248317668, 4733.266343716729, 4736.360591320127, 4780.378550788375, 4622.098690755271, 4655.906881862412, 4666.859994200179, 4713.057388522378, 4724.196886529229, 4742.78657460422, 4764.0, 4770.0936822003705, 4776.044791041736, 4812.831550895702, 4663.067386522641, 4669.066186762729, 4673.859784206479, 4680.040591678766, 4724.078804633064], "value": 4503.095388785551, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.3506789929228, 587.7061469265367, 612.0635427795474, 613.3222788818355, 648.5557393185668, 26521.999999999975, 27208.86395568022, 27246.86376568117, 33453.33093338138, 34598.654013459854, 36410.27179456409, 37223.441648375294, 37258.81370593143, 37356.43965340522, 37453.06367340818, 7520.473566850323, 7700.768976930673, 7710.537367757925, 7711.768646940601, 7715.6527956241825, 7430.925690743077, 7549.471536992412, 7552.735654252102, 7553.811154721148, 7558.130814956268, 7702.8844567331535, 7727.88408173875, 7774.766756997271, 7775.766726998171, 7778.338841198505, 7685.50044247125, 7726.729564465217, 7731.961340193291, 7733.535987840692, 7739.496932699357, 7776.144624091346, 7880.054393472763, 7890.0926393464915, 7890.763277101696, 7897.289243968071, 37441.81279093614, 37888.62111378879, 37942.86171414862, 37967.810160949295, 38025.42961855575, 3206.983965080183, 3292.884749033772, 3335.8832440864694, 3337.4493208620547, 3783.0, 28416.147515574357, 29024.0, 29052.41895162085, 29261.707382926324, 30032.8498357509, 3268.591426071741, 3297.8021318720953, 3328.5839270091237, 3336.2993771308056, 3366.9663303367142, 231926.0, 233026.83486582627, 233170.0, 234310.0, 234618.99999999828, 33036.17409564732, 34215.31569368599, 52728.47271527236, 53009.0, 53529.92940141253, 32259.0, 32266.83866580699, 32376.83811580974, 32432.675673242964, 32454.675453245636, 12290.877091228973, 12504.749905001849, 12523.686907827378, 12530.68673283157, 12531.31077790712, 10101.595936162617, 10141.746456338651, 10162.339447935861, 10167.542460589291, 10178.18574514037, 8099.514029158269, 8181.590920453954, 8229.917700823034, 8262.917370826215, 8292.04641466227, 3207.6631953644533, 3211.940059780267, 3220.9194770130935, 3251.7886337387995, 3304.719098876574, 819.7786597618609, 880.7401816464159, 884.8407286688329, 897.6544030548156, 917.7430319510547, 26588.202353929413, 27299.863500682368, 27693.86153069222, 27742.445151096865, 27812.721872781014, 951.695457453622, 988.6935050134481, 1000.6497725795913, 1012.2748286306463, 1046.9790604187874, 13945.233012184428, 14298.49955251582, 14567.781483277759, 14599.0, 14681.632959176106, 352745.0, 404017.0, 417007.0, 417230.0, 417902.0, 44342.11315773666, 44786.77606612011, 45233.09533809371, 45280.54719452829, 45451.77274113608, 1051.2431049644244, 1215.3983778029756, 1251.956181533642, 1274.3246079577839, 1304.5694920675965, 24377.756222437547, 26487.470250595266, 26666.466670666865, 26789.0, 27866.0, 38693.61306387013, 46528.767356163, 48506.0, 48595.27107093467, 48615.27077093917, 243545.0, 245939.0, 246897.0, 247087.0, 247723.0, 32629.836850815595, 36035.099122522144, 37010.25979480449, 41541.0, 42672.359914601926, 41259.1748165041, 41553.1058652314, 42058.36912446377, 42142.57857421387, 42170.57829421666, 35299.0, 36034.0, 36400.81799590985, 36545.0, 36651.266974659826, 35418.29163416666, 35724.821375892956, 35748.64251357557, 36008.0, 36308.63691363052, 32526.83736581302, 33066.0, 33338.66661333355, 33417.66582334146, 33596.66403335935, 30685.846570767004, 31679.84160079185, 31873.68126318707, 32139.67860321367, 32174.356512869144, 22728.886355568116, 22782.0, 22997.195098172153, 23196.76803231946, 23328.6500702493], "value": 16138.292197442106, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.82385866713315, 378.46258313195267, 385.29683327926523, 392.44860970336686, 401.0555142639083, 15738.606534836621, 16658.66682666346, 17117.058561779097, 17131.057791821444, 17217.311307547683, 14328.71342573148, 14777.408903643869, 15130.697386052272, 15268.694626107472, 15287.082775033507, 4698.812047518095, 4804.183288840888, 4856.465788763251, 4859.805607775685, 4864.586510146642, 3448.310337932411, 5188.325517682715, 5516.14499752537, 5516.7517461714115, 5526.392096869341, 5459.426760190182, 5498.120300751861, 5508.173773933902, 5519.613627046108, 5525.171224316345, 5769.394213607574, 5946.43508866657, 5953.464188223037, 5956.285245770514, 5960.582759206857, 3319.170207448138, 4819.6385271104455, 5199.870003249911, 5207.1668533034535, 5210.843674689765, 11121.0, 11451.656450306504, 11493.942530287379, 11518.308901465938, 11725.472353744102, 1919.433767038727, 1948.5907959328558, 1951.4828570428847, 2069.5240094778133, 2227.4431392151964, 8631.741047768577, 9438.858417123749, 9495.715128546155, 9527.90472095284, 9553.90446095544, 1755.6927537680854, 1796.6316905034437, 1800.1539276540004, 1814.8185181481879, 1823.216017112641, 68133.65933170351, 69706.0, 72360.6381968092, 73838.0, 75267.0, 9586.856197157049, 9604.471754053595, 9708.077732615391, 9803.16673082796, 9867.259955503367, 13413.932930335286, 13427.0, 13478.19130852152, 13506.662333441742, 13518.59444216675, 6910.170779506491, 7182.784516464514, 7192.31672991065, 7255.383292420203, 7255.963720181471, 6814.398616325159, 6851.0, 6946.756863509753, 6973.12835895513, 6977.581345119309, 4043.1146294556465, 4142.2958097123565, 4155.1897380010605, 4236.385724069993, 4521.163584736834, 1576.2118940529735, 1618.336482042357, 1711.537884771105, 1712.5204942616087, 1752.4917773845698, 783.9608019598998, 806.028735373873, 829.1004260377438, 834.0533494483805, 875.4492502168794, 15830.366785328459, 16322.183890805649, 16408.83591164097, 16461.176941152895, 16812.411565595146, 818.1409520003972, 819.0580832043198, 820.0528389709895, 842.4742452834905, 866.7053201911381, 8894.155055269739, 9311.161995420445, 9324.906750932403, 9381.900650526222, 9478.336516443782, 366077.0, 397228.0, 402857.8285302891, 404725.0, 406025.0, 79005.06955023258, 79140.0, 80988.59505702434, 81282.59358703169, 81772.59113704393, 930.7486978515898, 932.5383934952107, 956.2780101023822, 981.8330883749779, 985.6353149334792, 14628.926855365655, 14667.48663796762, 14723.631909202355, 14764.261786910827, 14822.332995015035, 34259.31481370309, 35239.647603523634, 35272.12006679315, 35560.644393556766, 35654.465183021755, 48215.0, 48353.0, 49959.0, 50061.24908126308, 50064.249036263755, 7539.283768042027, 7627.23727627255, 7677.462577619513, 7758.340541053848, 8054.395920306118, 9927.950360248153, 10741.624043158765, 11164.720881978015, 11283.097352211638, 11615.361155136548, 9144.131307525775, 9655.758606034906, 9708.417494950325, 9906.207503399566, 9954.253430992849, 9482.905170948477, 9485.383450075999, 9928.106470417697, 9985.60057597688, 10217.284790064625, 9611.279154063614, 10045.598176072876, 10175.84736228972, 10281.228907831794, 10293.948530257301, 7375.483716139819, 7390.076240469942, 7896.131425543301, 7952.562609056557, 8028.759137225892, 8313.0, 9444.811103778024, 9679.9032009679, 9684.128428441474, 9713.27150463704], "value": 7917.111091595794, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.0983781839263, 1487.9479218227361, 1488.1443170177147, 1630.1686140068562, 1804.485721569352, 7282.635868206588, 7563.357114645255, 7579.999999999993, 7580.658870350833, 7584.96207518963, 7632.351250143731, 7821.843563128734, 7842.490238134517, 7848.92151078489, 7858.057033156015, 1953.5213872601162, 2225.5882661707597, 2232.955340893181, 2256.571251462217, 2301.0680674326923, 2296.5292115116363, 2318.7449380568123, 2319.4549280918973, 2320.9883950580224, 2321.466062805556, 2251.8536295140843, 2276.931692049233, 2279.5782780185637, 2280.8631482111045, 2281.7946384825364, 1935.525796179938, 2211.170810945903, 2259.807916327114, 2260.0733699183256, 2281.942951426211, 2182.03990244292, 2193.813525850305, 2212.7676593957726, 2222.388843068153, 2224.7663995280586, 7791.571463569501, 7850.371970242367, 7854.136045035041, 7857.842843143162, 7871.448998570102, 4490.259107247301, 4617.37665415168, 4620.330052142454, 4624.237000894848, 4696.919708467038, 3043.8021528600793, 3083.9691603083907, 3131.045031265463, 3131.7024882636115, 3154.921126971844, 936.6440752514001, 964.1274646444979, 968.5351031504918, 980.1423754215061, 989.5596459575492, 10886.0746836519, 10919.890801092046, 10938.835917461245, 10957.945210273898, 11004.229703920728, 4388.451443569554, 4390.100029493946, 4539.137563862855, 4575.862724118282, 4578.702384345007, 8418.158184181533, 8512.233898949124, 8541.103184165697, 8561.700340488052, 8570.657173713107, 3959.9010024749614, 4398.64810815134, 4413.227685155085, 4424.579664931826, 4432.623227025739, 4096.078382363944, 4152.8131234094535, 4153.314703073959, 4181.581841815855, 4189.916201675949, 3638.890833275006, 3737.5328083989502, 3765.792881391495, 3791.450239715226, 3845.134844659929, 1252.8058150986612, 1278.4374875054946, 1278.8017857232144, 1297.695041665208, 1312.3962977030674, 785.8546168958761, 797.8723404255292, 806.5846089264033, 837.7026155714756, 866.0949307973183, 5204.843854684365, 5532.6680399176175, 5543.390227075019, 5551.9722401387735, 5829.8251052468495, 775.2363921537282, 786.8347646994081, 873.3929918706565, 891.9108089191029, 948.2035090523993, 3576.678098971105, 3769.660730534265, 3781.773093614392, 3789.6399842014966, 3816.9809150954065, 9483.478408687588, 9811.411315321104, 9850.064243896819, 9941.65204217849, 9975.45135017581, 9775.51122443875, 9794.412335259907, 9816.754581135528, 9821.558029888529, 9857.901420985841, 7210.351068403869, 7527.698892044366, 7527.924720752722, 7596.886046709304, 7599.240075992467, 5379.569634429158, 5389.2455056291365, 5432.320959880015, 5546.944530554642, 5624.718764061862, 8933.910660893307, 8975.057618949917, 9129.224015958718, 9136.223421009023, 9252.537373131181, 9042.638294468148, 9333.206677432494, 9350.438973661601, 9357.0, 9399.96600373972, 5810.622309549865, 6416.165898433173, 6501.642409667514, 6607.57050791697, 6643.734250630114, 7597.886031709419, 7600.0, 7651.120121186135, 7651.349635280841, 7663.386929045774, 6607.834804129743, 6664.633445160563, 6757.493188010821, 6806.8638627228165, 6829.4877884157895, 6704.061431399706, 6736.0, 6807.761728339485, 6901.861962760616, 6907.516473846783, 6192.2569291683485, 6428.774992875414, 6473.158489396348, 6494.707738151889, 6501.122348482894, 4403.273459879084, 4447.621952133975, 4498.572635599613, 4525.208088584551, 4545.0, 4286.078493123993, 4318.13637272553, 4359.869203923888, 4411.2721400968485, 4430.579094985971], "value": 4198.526078576705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.10491072541527, 319.2609109910557, 322.3456383541411, 328.0519299225239, 330.58841742031143, 4944.2089265717495, 4956.727379994099, 4970.130227210233, 4972.751362431877, 5007.474215207405, 4893.40964186639, 4913.238448040551, 4914.410270767513, 4919.188333924907, 4925.630577706668, 3647.507586475825, 3726.832292546842, 3873.612638736132, 3902.9609703902884, 3913.3347330953807, 3844.5578758442716, 3858.9035274118232, 3866.961330386688, 3883.2233553289316, 3901.14174881527, 3608.9458658120147, 3841.654251117399, 3842.884713458601, 3847.769133851978, 3851.48005019323, 3756.1736417988, 3893.59117292683, 3893.805309734502, 3899.200663863901, 3904.9023774405723, 3439.8796042138656, 3443.984024712691, 3452.171478845084, 3467.1678797088516, 3468.063622821849, 4687.367290349972, 4691.225947718623, 4692.36653051837, 4696.483386827446, 4699.765011749399, 4296.5059018213, 4298.892527686801, 4345.217860785057, 4351.238533256699, 4435.800388982503, 5101.591872650179, 5102.923456148161, 5111.87220319495, 5139.203423469368, 5155.304033955405, 3662.926741465182, 3673.1918977825103, 3673.2469843682247, 3674.926501469956, 3680.3743363628246, 5199.748881426183, 5350.143976963667, 5366.838994830161, 5369.4630536946, 5392.757325920343, 3875.5736868944396, 3885.261800257942, 3892.922141557153, 3893.805309734502, 3896.649301562873, 3932.8201539538595, 3934.5475270343704, 3950.308695978192, 3952.2293152834923, 3957.5053118360206, 4423.8230470781455, 4426.911461770811, 4435.26818075014, 4435.955640443619, 4446.244138496463, 4879.194932836042, 5172.094883395466, 5187.0922588546855, 5188.818391356284, 5197.428282888879, 1305.5104335874048, 1325.7481078595035, 1328.1898042194255, 1328.34247047712, 1331.5419615520989, 824.3611201319026, 866.0646501778065, 881.4799268431656, 901.427593478133, 919.117647058831, 4547.909041819145, 4552.0, 4568.291914753218, 4580.450345958507, 4584.472785629695, 5261.736913154327, 5268.710220937808, 5273.2617433559335, 5283.1546952487415, 5283.313169287968, 4477.574630410106, 4547.113312903952, 4559.6124329431705, 4571.314302854598, 4583.175028494903, 2784.8468334241406, 2819.16834533813, 2821.943561128807, 2823.1953893140358, 2836.375997280595, 5049.747512624427, 5053.570446512088, 5056.747162641853, 5063.468335824759, 5067.087924173684, 5220.243064755589, 5387.299651045339, 5418.133098704188, 5419.783208671609, 5443.455654434525, 5027.396712394463, 5047.0, 5056.595472362203, 5071.41678706946, 5072.264521644267, 5277.894442111059, 5297.152455607084, 5298.443663415286, 5300.416954135119, 5306.0, 5016.072026675077, 5139.408967968731, 5169.198774190007, 5175.611829112756, 5204.869878253074, 4990.101781679333, 4993.600511959107, 4996.0, 5006.271581987752, 5006.699598023984, 3703.2963736889906, 3707.8516859325323, 3712.795796231125, 3720.8883733488037, 3726.16161363691, 5064.189729643387, 5264.473552644705, 5285.0, 5346.652467589594, 5359.356877174764, 5191.143461328838, 5198.220266959835, 5206.921896171485, 5213.713245771519, 5216.452272511484, 5178.97410512945, 5195.610329225399, 5209.218617207449, 5209.791608335624, 5219.373675159005, 4873.95126048735, 5114.795408183631, 5130.435652078343, 5131.769070391916, 5143.4085080216255, 4964.776585053609, 5028.74856257193, 5194.42875776493, 5236.581073514034, 5241.240020197126, 5107.923381149211, 5115.5396014358885, 5122.538971492583, 5127.333446651912, 5133.743312834418], "value": 3906.4542740821403, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.9010148477731, 671.2750229751869, 774.3224678406394, 778.2839787395598, 793.551643321523, 12390.256584604918, 12447.813282800766, 12464.563740269092, 12559.560415385464, 12577.11960162788, 11699.649010529676, 11764.411779411039, 11775.941120294408, 13438.798418023738, 14053.789193162085, 843.3379796859466, 844.0082902589463, 849.1593322610602, 849.4011721736192, 851.0170752780548, 648.9545731798776, 809.6599428240124, 841.8821365008904, 845.3321875718175, 845.4800297816829, 866.7313132928781, 872.4808738800403, 877.0834477970536, 877.4954401219293, 878.7495563764328, 663.4758540752799, 866.51908190954, 868.2533021601417, 868.9435186712843, 869.2350731356397, 618.057462369885, 634.936506349366, 636.3286732497213, 636.3572791480592, 636.7643971730489, 12187.878121218851, 12237.755244895052, 12271.38643067843, 12283.078769092264, 12292.877071229263, 11728.53085876564, 12070.094742894318, 12082.758344833053, 12481.812772808415, 12622.936885315607, 9664.75838104046, 9915.90084099157, 9919.553620087041, 10206.591736330538, 10310.845337319946, 3293.4071867063917, 3332.666733326648, 3336.382769187708, 3387.7967321960514, 3464.8960531184107, 47577.76211118922, 48299.75850120762, 48339.0, 48350.0, 48421.51578484205, 9210.125038121369, 9622.51887405641, 9891.901080989242, 9916.504174791231, 10023.298369114093, 17489.38787142444, 17504.562385940455, 17544.649107017787, 17547.561310967074, 17598.47204583839, 6663.36698013688, 6734.8989765153565, 6757.155355580552, 6835.829104272433, 6911.412529935012, 3763.7177211708686, 3817.5609804872797, 3854.71089668276, 3858.5369755629504, 3951.0517475806173, 2870.598116263725, 2946.587477753116, 2965.2142182321704, 2966.7478264347774, 2973.435047340998, 514.9922751158736, 515.8143068495339, 518.6239976017357, 527.9815206467755, 539.7247403824078, 460.26128064456736, 579.3106203617682, 592.599995003371, 604.320139842677, 621.316551793024, 8134.430589858772, 8392.622331995075, 8450.915490845136, 8457.281131103802, 8609.182127697859, 502.3469489663496, 571.9370869204467, 598.4673640459994, 599.0176111177672, 606.1211243696657, 4073.9592604074173, 4074.6536544393466, 4284.528701842794, 4397.0985947881245, 4420.491643460979, 48084.03831923412, 49694.75152624214, 53842.46157538374, 54033.0, 54156.187657185175, 48833.511664883605, 49479.50520494821, 49871.50128498741, 49975.0, 49996.75001624969, 44244.99999999936, 44969.55030449719, 45254.32118518225, 45533.54466455359, 46915.5308446918, 8641.481511109354, 8646.654133834827, 8917.42036767608, 8920.553972301488, 8948.328875334246, 30089.84955075298, 30509.69490305157, 30621.387572248877, 31303.53044704377, 31364.529532057495, 38033.04917377088, 40007.799961001176, 41064.384034238916, 41287.74480253801, 41349.0, 10479.371237725456, 10582.365058096539, 10595.205359597907, 10858.0, 11057.5024123913, 11408.657740267805, 11640.126990475579, 11799.233049851731, 12089.15375923677, 12285.324307163191, 11181.0, 11346.60286889988, 11394.48724807369, 12274.079444041554, 12354.0, 10878.075363594184, 11144.665660030212, 11739.11956603241, 11780.941095294469, 11830.645080647595, 11737.47181376823, 11947.94026029899, 12032.699182520508, 12235.510579576718, 12367.253130448536, 9609.615615375307, 9711.951440242754, 9836.163926066365, 10402.219833512365, 10692.358458492516, 9535.809283814146, 9795.216382689225, 10044.497775111362, 10303.175745940156, 10303.639372621923], "value": 6099.681324346477, "unit": "score"}], "name": "dromaeo_css", "value": 6213.855425666731, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 107.0, 113.0, 114.0, 113.0, 102.0, 112.0, 111.0, 113.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 156.0, 191.0, 133.0, 167.0, 160.0, 133.0, 191.0, 134.0], "value": 156.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 160.0, 163.0, 163.0, 163.0, 163.0, 162.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 106.0, 116.0, 75.0, 77.0, 73.0, 128.0, 106.0, 74.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 140.0, 95.0, 96.0, 94.0, 139.0, 94.0, 95.0, 138.0], "value": 108.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 116.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 63.0, 62.0, 62.0, 64.0, 81.0, 61.0, 61.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 66.0, 64.0, 64.0, 65.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 83.0, 82.0, 83.0, 85.0, 84.0, 84.0, 85.0, 85.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 139.0, 139.0, 137.0, 139.0, 141.0, 139.0, 138.0, 182.0, 143.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 173.0, 171.0, 175.0, 179.0, 174.0, 171.0, 176.0, 176.0, 179.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 70.0, 71.0, 74.0, 70.0, 70.0, 72.0, 70.0, 71.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1591.5, "alertThreshold": 2.0}]} 07:28:10 INFO - Return code: 0 07:28:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:28:10 ERROR - # TBPL SUCCESS # 07:28:10 INFO - Running post-action listener: _resource_record_post_action 07:28:10 INFO - Running post-run listener: _resource_record_post_run 07:28:11 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 520101888; Read time: 0; Write time: 488160 07:28:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239865856; Read time: 0; Write time: 282256 07:28:11 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 280055808; Read time: 0; Write time: 205884 07:28:11 INFO - Running post-run listener: _upload_blobber_files 07:28:11 INFO - Blob upload gear active. 07:28:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:28:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:28:11 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'] 07:28:11 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 07:28:12 INFO - (blobuploader) - INFO - Open directory for files ... 07:28:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:28:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:28:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:12 INFO - (blobuploader) - INFO - Done attempting. 07:28:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:28:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:28:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:13 INFO - (blobuploader) - INFO - Done attempting. 07:28:13 INFO - (blobuploader) - INFO - Iteration through files over. 07:28:13 INFO - Return code: 0 07:28:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:28:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:28:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8d6a14ed81dc9388f106a5fb11ba7372babdfe1b83a5e2e7a6c6c51f1376337e783b7fdd1dc4ac0c4a32a6a9c16b844a4b6494c91be7a9cc8936df0d3decad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbe534ebb7a55d25fc87c9bce518e79b993ecbcdb0d8106393efdefded399e198b6e41f0037c8b8832d9d1fbe49af4c0f3487b39ed0f963273a35ef42144d0b5"} 07:28:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:28:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:28:13 INFO - Contents: 07:28:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8d6a14ed81dc9388f106a5fb11ba7372babdfe1b83a5e2e7a6c6c51f1376337e783b7fdd1dc4ac0c4a32a6a9c16b844a4b6494c91be7a9cc8936df0d3decad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbe534ebb7a55d25fc87c9bce518e79b993ecbcdb0d8106393efdefded399e198b6e41f0037c8b8832d9d1fbe49af4c0f3487b39ed0f963273a35ef42144d0b5"} 07:28:13 INFO - Running post-run listener: copy_logs_to_upload_dir 07:28:13 INFO - Copying logs to upload dir... 07:28:13 INFO - mkdir: /builds/slave/test/build/upload/logs 07:28:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.886411 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-13 07:28:13.355983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 07:28:13.359155) ========= 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=3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170 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/b8d6a14ed81dc9388f106a5fb11ba7372babdfe1b83a5e2e7a6c6c51f1376337e783b7fdd1dc4ac0c4a32a6a9c16b844a4b6494c91be7a9cc8936df0d3decad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbe534ebb7a55d25fc87c9bce518e79b993ecbcdb0d8106393efdefded399e198b6e41f0037c8b8832d9d1fbe49af4c0f3487b39ed0f963273a35ef42144d0b5"} build_url:https://queue.taskcluster.net/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/YPCtGIOhSY-9UeBRPfhWlA/artifacts/public/build/firefox-48.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/b8d6a14ed81dc9388f106a5fb11ba7372babdfe1b83a5e2e7a6c6c51f1376337e783b7fdd1dc4ac0c4a32a6a9c16b844a4b6494c91be7a9cc8936df0d3decad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbe534ebb7a55d25fc87c9bce518e79b993ecbcdb0d8106393efdefded399e198b6e41f0037c8b8832d9d1fbe49af4c0f3487b39ed0f963273a35ef42144d0b5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 07:28:13.383795) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 07:28:13.384130) ========= 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=3a3620fb28aea1604ab609ef000001d2-1460556453.885101-1693915170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 07:28:13.468597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 07:28:13.468915) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 07:28:13.469205) ========= ========= Total master_lag: 0.27 =========