builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1461986076.51 results: success (0) buildid: 20160429173026 builduid: d1fba5bb84344b91b233ddfa2beff242 revision: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:36.514286) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:36.514789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:36.515310) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:36.532260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:36.532620) ========= 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-1461985749.892754-902876798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 20:14: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% 46.5M=0s 2016-04-29 20:14:36 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149006 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:36.696621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:36.697158) ========= 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-1461985749.892754-902876798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017185 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:36.748015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:36.748368) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b7b5c87cf2b319aa751a5903f42ee2e5883749a --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 3b7b5c87cf2b319aa751a5903f42ee2e5883749a --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-1461985749.892754-902876798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 20:14:37,038 truncating revision to first 12 chars 2016-04-29 20:14:37,038 Setting DEBUG logging. 2016-04-29 20:14:37,039 attempt 1/10 2016-04-29 20:14:37,039 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b7b5c87cf2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 20:14:37,295 unpacking tar archive at: fx-team-3b7b5c87cf2b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523542 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:37.285340) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:37.285665) ========= script_repo_revision: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:37.286105) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:37.286372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 20:14:37.296368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-29 20:14:37.296795) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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-1461985749.892754-902876798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:14:37 INFO - MultiFileLogger online at 20160429 20:14:37 in /builds/slave/test 20:14:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:14:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:14:37 INFO - {'append_to_log': False, 20:14:37 INFO - 'base_work_dir': '/builds/slave/test', 20:14:37 INFO - 'blob_upload_branch': 'Fx-Team', 20:14:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:14:37 INFO - 'branch': 'Fx-Team', 20:14:37 INFO - 'buildbot_json_path': 'buildprops.json', 20:14:37 INFO - 'config_files': ('talos/linux_config.py',), 20:14:37 INFO - 'default_actions': ('clobber', 20:14:37 INFO - 'read-buildbot-config', 20:14:37 INFO - 'download-and-extract', 20:14:37 INFO - 'populate-webroot', 20:14:37 INFO - 'create-virtualenv', 20:14:37 INFO - 'install', 20:14:37 INFO - 'run-tests'), 20:14:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:14:37 INFO - 'download_minidump_stackwalk': True, 20:14:37 INFO - 'download_symbols': 'ondemand', 20:14:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:14:37 INFO - 'tooltool.py': '/tools/tooltool.py', 20:14:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:14:37 INFO - '/tools/misc-python/virtualenv.py')}, 20:14:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:14:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:14:37 INFO - 'installer_path': 'installer.exe', 20:14:37 INFO - 'log_level': 'info', 20:14:37 INFO - 'log_name': 'talos', 20:14:37 INFO - 'log_to_console': True, 20:14:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:14:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:14:37 INFO - 'opt_config_files': (), 20:14:37 INFO - 'pip_index': False, 20:14:37 INFO - 'sps_profile': False, 20:14:37 INFO - 'sps_profile_interval': 0, 20:14:37 INFO - 'suite': 'dromaeojs', 20:14:37 INFO - 'system_bits': '32', 20:14:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:14:37 INFO - 'title': 'talos-linux64-ix-059', 20:14:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:14:37 INFO - 'use_talos_json': True, 20:14:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:14:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:14:37 INFO - 'work_dir': 'build'} 20:14:37 INFO - ##### 20:14:37 INFO - ##### Running clobber step. 20:14:37 INFO - ##### 20:14:37 INFO - Running pre-action listener: _resource_record_pre_action 20:14:37 INFO - Running main action method: clobber 20:14:37 INFO - rmtree: /builds/slave/test/build 20:14:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:14:38 INFO - Running post-action listener: _resource_record_post_action 20:14:38 INFO - ##### 20:14:38 INFO - ##### Running read-buildbot-config step. 20:14:38 INFO - ##### 20:14:38 INFO - Running pre-action listener: _resource_record_pre_action 20:14:38 INFO - Running main action method: read_buildbot_config 20:14:38 INFO - Using buildbot properties: 20:14:38 INFO - { 20:14:38 INFO - "project": "", 20:14:38 INFO - "product": "firefox", 20:14:38 INFO - "script_repo_revision": "production", 20:14:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:14:38 INFO - "repository": "", 20:14:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:14:38 INFO - "buildid": "20160429173026", 20:14:38 INFO - "pgo_build": "True", 20:14:38 INFO - "basedir": "/builds/slave/test", 20:14:38 INFO - "buildnumber": 625, 20:14:38 INFO - "slavename": "talos-linux64-ix-059", 20:14:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:14:38 INFO - "platform": "ubuntu64_hw", 20:14:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:14:38 INFO - "branch": "fx-team", 20:14:38 INFO - "repo_path": "integration/fx-team", 20:14:38 INFO - "revision": "3b7b5c87cf2b319aa751a5903f42ee2e5883749a", 20:14:38 INFO - "stage_platform": "linux64-pgo", 20:14:38 INFO - "builduid": "d1fba5bb84344b91b233ddfa2beff242", 20:14:38 INFO - "slavebuilddir": "test" 20:14:38 INFO - } 20:14:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:14:38 INFO - Running post-action listener: _resource_record_post_action 20:14:38 INFO - ##### 20:14:38 INFO - ##### Running download-and-extract step. 20:14:38 INFO - ##### 20:14:38 INFO - Running pre-action listener: _resource_record_pre_action 20:14:38 INFO - Running main action method: download_and_extract 20:14:38 INFO - mkdir: /builds/slave/test/build/tests 20:14: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')]} 20:14:38 INFO - https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:14:43 INFO - Downloaded 1361 bytes. 20:14:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:14:43 INFO - Using the following test package requirements: 20:14:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:14:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:14:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:43 INFO - u'jsshell-linux-x86_64.zip'], 20:14:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:14:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:14:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:14:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:14:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:14:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:43 INFO - https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:14:57 INFO - Downloaded 23877414 bytes. 20:14:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:14:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:14:58 INFO - Return code: 0 20:14:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:14:58 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')]} 20:14:58 INFO - https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:14:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:14:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:14:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:14:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:14:59 INFO - Downloaded 23877414 bytes. 20:14:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:14:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:15:01 INFO - Return code: 0 20:15:01 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')]} 20:15:01 INFO - https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:15:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:15:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:15:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:15:02 INFO - Downloaded 10840152 bytes. 20:15:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:15:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:15:02 INFO - Return code: 0 20:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:02 INFO - https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:15:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:15:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:15:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:15:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:15:05 INFO - Downloaded 58603342 bytes. 20:15:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:15:05 INFO - mkdir: /builds/slave/test/properties 20:15:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:15:05 INFO - Writing to file /builds/slave/test/properties/build_url 20:15:06 INFO - Contents: 20:15:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:15:06 INFO - Running post-action listener: _resource_record_post_action 20:15:06 INFO - Running post-action listener: set_extra_try_arguments 20:15:06 INFO - ##### 20:15:06 INFO - ##### Running populate-webroot step. 20:15:06 INFO - ##### 20:15:06 INFO - Running pre-action listener: _resource_record_pre_action 20:15:06 INFO - Running main action method: populate_webroot 20:15:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:15:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:15:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:15:06 INFO - '--tppagecycles', 20:15:06 INFO - '7'], 20:15:06 INFO - 'tests': ['tsvgm']}}, 20:15:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:15:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:15:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:15:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:15:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:15:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:15:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:06 INFO - 'talos_options': ['--disable-e10s'], 20:15:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:15:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:15:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:06 INFO - 'talos_options': ['--disable-e10s'], 20:15:06 INFO - 'tests': ['damp', 'tps']}, 20:15:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:06 INFO - 'tests': ['damp', 'tps']}, 20:15:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:15:06 INFO - 'tests': ['dromaeo_dom']}, 20:15:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:15:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:15:06 INFO - 'tests': ['a11yr', 20:15:06 INFO - 'ts_paint', 20:15:06 INFO - 'tpaint', 20:15:06 INFO - 'sessionrestore', 20:15:06 INFO - 'sessionrestore_no_auto_restore', 20:15:06 INFO - 'tabpaint']}, 20:15:06 INFO - 'other-e10s': {'tests': ['a11yr', 20:15:06 INFO - 'ts_paint', 20:15:06 INFO - 'tpaint', 20:15:06 INFO - 'sessionrestore', 20:15:06 INFO - 'sessionrestore_no_auto_restore', 20:15:06 INFO - 'tabpaint']}, 20:15:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:15:06 INFO - 'ts_paint', 20:15:06 INFO - 'tpaint', 20:15:06 INFO - 'sessionrestore', 20:15:06 INFO - 'sessionrestore_no_auto_restore', 20:15:06 INFO - 'tabpaint']}, 20:15:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:15:06 INFO - 'ts_paint', 20:15:06 INFO - 'tpaint', 20:15:06 INFO - 'sessionrestore', 20:15:06 INFO - 'sessionrestore_no_auto_restore', 20:15:06 INFO - 'tabpaint']}, 20:15:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:15:06 INFO - 'tests': ['a11yr', 20:15:06 INFO - 'ts_paint', 20:15:06 INFO - 'tpaint', 20:15:06 INFO - 'sessionrestore', 20:15:06 INFO - 'sessionrestore_no_auto_restore', 20:15:06 INFO - 'tabpaint']}, 20:15:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:15:06 INFO - 'tests': ['a11yr', 20:15:06 INFO - 'ts_paint', 20:15:06 INFO - 'tpaint', 20:15:06 INFO - 'sessionrestore', 20:15:06 INFO - 'sessionrestore_no_auto_restore', 20:15:06 INFO - 'tabpaint']}, 20:15:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:15:06 INFO - 'tests': ['tsvgx', 20:15:06 INFO - 'tsvgr_opacity', 20:15:06 INFO - 'tart', 20:15:06 INFO - 'tscrollx', 20:15:06 INFO - 'cart']}, 20:15:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:15:06 INFO - 'tsvgr_opacity', 20:15:06 INFO - 'tart', 20:15:06 INFO - 'tscrollx', 20:15:06 INFO - 'cart']}, 20:15:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:06 INFO - 'talos_options': ['--disable-e10s'], 20:15:06 INFO - 'tests': ['tp5o']}, 20:15:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:06 INFO - 'tests': ['tp5o']}, 20:15:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:06 INFO - 'talos_options': ['--disable-e10s', 20:15:06 INFO - '--xperf_path', 20:15:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:15:06 INFO - 'tests': ['tp5n']}, 20:15:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:06 INFO - 'talos_options': ['--xperf_path', 20:15:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:15:06 INFO - 'tests': ['tp5n']}}, 20:15:06 INFO - 'talos.zip': {'path': '', 20:15:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:15:06 INFO - Running post-action listener: _resource_record_post_action 20:15:06 INFO - ##### 20:15:06 INFO - ##### Running create-virtualenv step. 20:15:06 INFO - ##### 20:15:06 INFO - Running pre-action listener: _resource_record_pre_action 20:15:06 INFO - Running main action method: create_virtualenv 20:15:06 INFO - Creating virtualenv /builds/slave/test/build/venv 20:15:06 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 20:15:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:15:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:15:06 INFO - Using real prefix '/usr' 20:15:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:15:07 INFO - Installing distribute.............................................................................................................................................................................................done. 20:15:09 INFO - Installing pip.................done. 20:15:09 INFO - Return code: 0 20:15:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:15: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')]} 20:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15: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')]} 20:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15532def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1304810>, '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 0x1305710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305ba0>, '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-1461985749.892754-902876798', '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 20:15: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', 'pip>=1.5'] in /builds/slave/test/build 20:15: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 pip>=1.5 20:15:09 INFO - Using env: {'DISPLAY': ':0', 20:15:09 INFO - 'HOME': '/home/cltbld', 20:15:09 INFO - 'LANG': 'en_US.UTF-8', 20:15:09 INFO - 'LANGUAGE': 'en_US:en', 20:15:09 INFO - 'LOGNAME': 'cltbld', 20:15:09 INFO - 'MAIL': '/var/mail/cltbld', 20:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:09 INFO - 'MOZ_NO_REMOTE': '1', 20:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:09 INFO - 'NO_EM_RESTART': '1', 20:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:09 INFO - 'PWD': '/builds/slave/test', 20:15:09 INFO - 'SHELL': '/bin/bash', 20:15:09 INFO - 'SHLVL': '1', 20:15:09 INFO - 'TERM': 'linux', 20:15:09 INFO - 'TMOUT': '86400', 20:15:09 INFO - 'USER': 'cltbld', 20:15:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1461985749.892754-902876798', 20:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:09 INFO - '_': '/tools/buildbot/bin/python'} 20:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:09 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 20:15:09 INFO - Cleaning up... 20:15:09 INFO - Return code: 0 20:15:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:15: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')]} 20:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15: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')]} 20:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15: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', '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 0x7f15532def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1304810>, '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 0x1305710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305ba0>, '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-1461985749.892754-902876798', '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 20:15: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', 'psutil>=0.7.1'] in /builds/slave/test/build 20:15: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 psutil>=0.7.1 20:15:09 INFO - Using env: {'DISPLAY': ':0', 20:15:09 INFO - 'HOME': '/home/cltbld', 20:15:09 INFO - 'LANG': 'en_US.UTF-8', 20:15:09 INFO - 'LANGUAGE': 'en_US:en', 20:15:09 INFO - 'LOGNAME': 'cltbld', 20:15:09 INFO - 'MAIL': '/var/mail/cltbld', 20:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:09 INFO - 'MOZ_NO_REMOTE': '1', 20:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:09 INFO - 'NO_EM_RESTART': '1', 20:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:09 INFO - 'PWD': '/builds/slave/test', 20:15:09 INFO - 'SHELL': '/bin/bash', 20:15:09 INFO - 'SHLVL': '1', 20:15:09 INFO - 'TERM': 'linux', 20:15:09 INFO - 'TMOUT': '86400', 20:15:09 INFO - 'USER': 'cltbld', 20:15:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1461985749.892754-902876798', 20:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:09 INFO - '_': '/tools/buildbot/bin/python'} 20:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:09 INFO - Downloading/unpacking psutil>=0.7.1 20:15: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 20:15: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 20:15: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 20:15: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 20:15: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 20:15: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 20:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:15:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:15:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:15:11 INFO - Installing collected packages: psutil 20:15:11 INFO - Running setup.py install for psutil 20:15:11 INFO - building 'psutil._psutil_linux' extension 20:15:11 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 20:15:11 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 20:15:11 INFO - building 'psutil._psutil_posix' extension 20:15:11 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 20:15:12 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 20:15:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:15:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:15:12 INFO - Successfully installed psutil 20:15:12 INFO - Cleaning up... 20:15:12 INFO - Return code: 0 20:15:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:12 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 0x7f15532def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1304810>, '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 0x1305710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305ba0>, '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-1461985749.892754-902876798', '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 20:15:12 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 20:15:12 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 20:15:12 INFO - Using env: {'DISPLAY': ':0', 20:15:12 INFO - 'HOME': '/home/cltbld', 20:15:12 INFO - 'LANG': 'en_US.UTF-8', 20:15:12 INFO - 'LANGUAGE': 'en_US:en', 20:15:12 INFO - 'LOGNAME': 'cltbld', 20:15:12 INFO - 'MAIL': '/var/mail/cltbld', 20:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:12 INFO - 'MOZ_NO_REMOTE': '1', 20:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:12 INFO - 'NO_EM_RESTART': '1', 20:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:12 INFO - 'PWD': '/builds/slave/test', 20:15:12 INFO - 'SHELL': '/bin/bash', 20:15:12 INFO - 'SHLVL': '1', 20:15:12 INFO - 'TERM': 'linux', 20:15:12 INFO - 'TMOUT': '86400', 20:15:12 INFO - 'USER': 'cltbld', 20:15:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1461985749.892754-902876798', 20:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:12 INFO - '_': '/tools/buildbot/bin/python'} 20:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:15: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 20:15: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 20:15: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 20:15: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 20:15: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 20:15: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 20:15:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:15:14 INFO - Installing collected packages: mozsystemmonitor 20:15:14 INFO - Running setup.py install for mozsystemmonitor 20:15:14 INFO - Successfully installed mozsystemmonitor 20:15:14 INFO - Cleaning up... 20:15:14 INFO - Return code: 0 20:15:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:14 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 0x7f15532def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1304810>, '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 0x1305710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305ba0>, '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-1461985749.892754-902876798', '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 20:15:14 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 20:15:14 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 20:15:14 INFO - Using env: {'DISPLAY': ':0', 20:15:14 INFO - 'HOME': '/home/cltbld', 20:15:14 INFO - 'LANG': 'en_US.UTF-8', 20:15:14 INFO - 'LANGUAGE': 'en_US:en', 20:15:14 INFO - 'LOGNAME': 'cltbld', 20:15:14 INFO - 'MAIL': '/var/mail/cltbld', 20:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:14 INFO - 'MOZ_NO_REMOTE': '1', 20:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:14 INFO - 'NO_EM_RESTART': '1', 20:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:14 INFO - 'PWD': '/builds/slave/test', 20:15:14 INFO - 'SHELL': '/bin/bash', 20:15:14 INFO - 'SHLVL': '1', 20:15:14 INFO - 'TERM': 'linux', 20:15:14 INFO - 'TMOUT': '86400', 20:15:14 INFO - 'USER': 'cltbld', 20:15:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1461985749.892754-902876798', 20:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:14 INFO - '_': '/tools/buildbot/bin/python'} 20:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:14 INFO - Downloading/unpacking blobuploader==1.2.4 20:15:14 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 20:15:14 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 20:15:14 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 20:15:14 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 20:15:14 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 20:15:14 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 20:15:16 INFO - Downloading blobuploader-1.2.4.tar.gz 20:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:15:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:15:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:17 INFO - Downloading docopt-0.6.1.tar.gz 20:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:15:17 INFO - Installing collected packages: blobuploader, requests, docopt 20:15:17 INFO - Running setup.py install for blobuploader 20:15:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:15:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:15:17 INFO - Running setup.py install for requests 20:15:17 INFO - Running setup.py install for docopt 20:15:17 INFO - Successfully installed blobuploader requests docopt 20:15:17 INFO - Cleaning up... 20:15:17 INFO - Return code: 0 20:15:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:17 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 0x7f15532def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1304810>, '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 0x1305710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305ba0>, '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-1461985749.892754-902876798', '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 20:15:17 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 20:15:17 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 20:15:17 INFO - Using env: {'DISPLAY': ':0', 20:15:17 INFO - 'HOME': '/home/cltbld', 20:15:17 INFO - 'LANG': 'en_US.UTF-8', 20:15:17 INFO - 'LANGUAGE': 'en_US:en', 20:15:17 INFO - 'LOGNAME': 'cltbld', 20:15:17 INFO - 'MAIL': '/var/mail/cltbld', 20:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:17 INFO - 'MOZ_NO_REMOTE': '1', 20:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:17 INFO - 'NO_EM_RESTART': '1', 20:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:17 INFO - 'PWD': '/builds/slave/test', 20:15:17 INFO - 'SHELL': '/bin/bash', 20:15:17 INFO - 'SHLVL': '1', 20:15:17 INFO - 'TERM': 'linux', 20:15:17 INFO - 'TMOUT': '86400', 20:15:17 INFO - 'USER': 'cltbld', 20:15:17 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1461985749.892754-902876798', 20:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:17 INFO - '_': '/tools/buildbot/bin/python'} 20:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:18 INFO - Running setup.py (path:/tmp/pip-Qekrta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:18 INFO - Running setup.py (path:/tmp/pip-4sRaVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:18 INFO - Running setup.py (path:/tmp/pip-gdYkXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:18 INFO - Running setup.py (path:/tmp/pip-xpEy42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:18 INFO - Running setup.py (path:/tmp/pip-1vUWqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:18 INFO - Running setup.py (path:/tmp/pip-mvSq6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:18 INFO - Running setup.py (path:/tmp/pip-P9QJwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:18 INFO - Running setup.py (path:/tmp/pip-mgfuVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:18 INFO - Running setup.py (path:/tmp/pip-qgyNwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:18 INFO - Running setup.py (path:/tmp/pip-wmRPwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:18 INFO - Running setup.py (path:/tmp/pip-n06JW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:18 INFO - Running setup.py (path:/tmp/pip-3LG_KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:19 INFO - Running setup.py (path:/tmp/pip-UU1VeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:19 INFO - Running setup.py (path:/tmp/pip-nCdLJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:19 INFO - Running setup.py (path:/tmp/pip-xI7dcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:19 INFO - Running setup.py (path:/tmp/pip-WddP2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:19 INFO - Running setup.py (path:/tmp/pip-TiAMuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:15:19 INFO - Running setup.py install for manifestparser 20:15:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:15:19 INFO - Running setup.py install for mozcrash 20:15:19 INFO - Running setup.py install for mozdebug 20:15:19 INFO - Running setup.py install for mozdevice 20:15:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:15:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:15:19 INFO - Running setup.py install for mozfile 20:15:19 INFO - Running setup.py install for mozhttpd 20:15:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:15:19 INFO - Running setup.py install for mozinfo 20:15:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:15:20 INFO - Running setup.py install for mozInstall 20:15:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:15:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:15:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:15:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:15:20 INFO - Running setup.py install for mozleak 20:15:20 INFO - Running setup.py install for mozlog 20:15:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:15:20 INFO - Running setup.py install for moznetwork 20:15:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:15:20 INFO - Running setup.py install for mozprocess 20:15:20 INFO - Running setup.py install for mozprofile 20:15:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:15:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:15:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:15:20 INFO - Running setup.py install for mozrunner 20:15:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:15:20 INFO - Running setup.py install for mozscreenshot 20:15:20 INFO - Running setup.py install for moztest 20:15:21 INFO - Running setup.py install for mozversion 20:15:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:15:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:15:21 INFO - Cleaning up... 20:15:21 INFO - Return code: 0 20:15:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:21 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')]} 20:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:21 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')]} 20:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:21 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 0x7f15532def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1304810>, '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 0x1305710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305ba0>, '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-1461985749.892754-902876798', '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 20:15:21 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 20:15:21 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 20:15:21 INFO - Using env: {'DISPLAY': ':0', 20:15:21 INFO - 'HOME': '/home/cltbld', 20:15:21 INFO - 'LANG': 'en_US.UTF-8', 20:15:21 INFO - 'LANGUAGE': 'en_US:en', 20:15:21 INFO - 'LOGNAME': 'cltbld', 20:15:21 INFO - 'MAIL': '/var/mail/cltbld', 20:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:21 INFO - 'MOZ_NO_REMOTE': '1', 20:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:21 INFO - 'NO_EM_RESTART': '1', 20:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:21 INFO - 'PWD': '/builds/slave/test', 20:15:21 INFO - 'SHELL': '/bin/bash', 20:15:21 INFO - 'SHLVL': '1', 20:15:21 INFO - 'TERM': 'linux', 20:15:21 INFO - 'TMOUT': '86400', 20:15:21 INFO - 'USER': 'cltbld', 20:15:21 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1461985749.892754-902876798', 20:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:21 INFO - '_': '/tools/buildbot/bin/python'} 20:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:21 INFO - Running setup.py (path:/tmp/pip-89iimh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:21 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)) 20:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:21 INFO - Running setup.py (path:/tmp/pip-Y_09OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:21 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)) 20:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:21 INFO - Running setup.py (path:/tmp/pip-YLtTCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:21 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)) 20:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:21 INFO - Running setup.py (path:/tmp/pip-v4hC8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:21 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)) 20:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:21 INFO - Running setup.py (path:/tmp/pip-hpilUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:21 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)) 20:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:21 INFO - Running setup.py (path:/tmp/pip-caOjjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:21 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)) 20:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:21 INFO - Running setup.py (path:/tmp/pip-3eQ1cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:21 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)) 20:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:21 INFO - Running setup.py (path:/tmp/pip-IPbw_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:21 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)) 20:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:21 INFO - Running setup.py (path:/tmp/pip-INv7Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:21 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)) 20:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:22 INFO - Running setup.py (path:/tmp/pip-d3nPtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:22 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)) 20:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:22 INFO - Running setup.py (path:/tmp/pip-QIfb1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:22 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)) 20:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:22 INFO - Running setup.py (path:/tmp/pip-gyGP0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:22 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)) 20:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:22 INFO - Running setup.py (path:/tmp/pip-tUEnYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:22 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)) 20:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:22 INFO - Running setup.py (path:/tmp/pip-sfidNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:22 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)) 20:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:22 INFO - Running setup.py (path:/tmp/pip-4smSac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:22 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)) 20:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:22 INFO - Running setup.py (path:/tmp/pip-ohd4LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:22 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)) 20:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:22 INFO - Running setup.py (path:/tmp/pip-IeiR6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:22 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)) 20:15:22 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)) 20:15:22 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)) 20:15:22 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)) 20:15:22 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)) 20:15:22 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)) 20:15:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:24 INFO - Downloading blessings-1.6.tar.gz 20:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:15:24 INFO - Installing collected packages: blessings 20:15:24 INFO - Running setup.py install for blessings 20:15:24 INFO - Successfully installed blessings 20:15:24 INFO - Cleaning up... 20:15:24 INFO - Return code: 0 20:15:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:24 INFO - Reading from file tmpfile_stdout 20:15:24 INFO - Current package versions: 20:15:24 INFO - argparse == 1.2.1 20:15:24 INFO - blessings == 1.6 20:15:24 INFO - blobuploader == 1.2.4 20:15:24 INFO - docopt == 0.6.1 20:15:24 INFO - manifestparser == 1.1 20:15:24 INFO - mozInstall == 1.12 20:15:24 INFO - mozcrash == 0.17 20:15:24 INFO - mozdebug == 0.1 20:15:24 INFO - mozdevice == 0.48 20:15:24 INFO - mozfile == 1.2 20:15:24 INFO - mozhttpd == 0.7 20:15:24 INFO - mozinfo == 0.9 20:15:24 INFO - mozleak == 0.1 20:15:24 INFO - mozlog == 3.1 20:15:24 INFO - moznetwork == 0.27 20:15:24 INFO - mozprocess == 0.22 20:15:24 INFO - mozprofile == 0.28 20:15:24 INFO - mozrunner == 6.11 20:15:24 INFO - mozscreenshot == 0.1 20:15:24 INFO - mozsystemmonitor == 0.0 20:15:24 INFO - moztest == 0.7 20:15:24 INFO - mozversion == 1.4 20:15:24 INFO - psutil == 3.1.1 20:15:24 INFO - requests == 1.2.3 20:15:24 INFO - wsgiref == 0.1.2 20:15:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:24 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')]} 20:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:24 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')]} 20:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:24 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 0x7f15532def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1304810>, '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 0x1305710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305ba0>, '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-1461985749.892754-902876798', '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 20:15:24 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 20:15:24 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 20:15:24 INFO - Using env: {'DISPLAY': ':0', 20:15:24 INFO - 'HOME': '/home/cltbld', 20:15:24 INFO - 'LANG': 'en_US.UTF-8', 20:15:24 INFO - 'LANGUAGE': 'en_US:en', 20:15:24 INFO - 'LOGNAME': 'cltbld', 20:15:24 INFO - 'MAIL': '/var/mail/cltbld', 20:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:24 INFO - 'MOZ_NO_REMOTE': '1', 20:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:24 INFO - 'NO_EM_RESTART': '1', 20:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:24 INFO - 'PWD': '/builds/slave/test', 20:15:24 INFO - 'SHELL': '/bin/bash', 20:15:24 INFO - 'SHLVL': '1', 20:15:24 INFO - 'TERM': 'linux', 20:15:24 INFO - 'TMOUT': '86400', 20:15:24 INFO - 'USER': 'cltbld', 20:15:24 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1461985749.892754-902876798', 20:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:24 INFO - '_': '/tools/buildbot/bin/python'} 20:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:25 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)) 20:15:25 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)) 20:15:25 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)) 20:15:25 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)) 20:15:25 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)) 20:15:25 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)) 20:15:25 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)) 20:15:25 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)) 20:15:25 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)) 20:15:25 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)) 20:15:25 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)) 20:15:25 INFO - Cleaning up... 20:15:25 INFO - Return code: 0 20:15:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:15:25 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')]} 20:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:25 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')]} 20:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:25 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 0x7f15532def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1304810>, '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 0x1305710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305ba0>, '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-1461985749.892754-902876798', '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 20:15:25 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 20:15:25 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 20:15:25 INFO - Using env: {'DISPLAY': ':0', 20:15:25 INFO - 'HOME': '/home/cltbld', 20:15:25 INFO - 'LANG': 'en_US.UTF-8', 20:15:25 INFO - 'LANGUAGE': 'en_US:en', 20:15:25 INFO - 'LOGNAME': 'cltbld', 20:15:25 INFO - 'MAIL': '/var/mail/cltbld', 20:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:25 INFO - 'MOZ_NO_REMOTE': '1', 20:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:25 INFO - 'NO_EM_RESTART': '1', 20:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:25 INFO - 'PWD': '/builds/slave/test', 20:15:25 INFO - 'SHELL': '/bin/bash', 20:15:25 INFO - 'SHLVL': '1', 20:15:25 INFO - 'TERM': 'linux', 20:15:25 INFO - 'TMOUT': '86400', 20:15:25 INFO - 'USER': 'cltbld', 20:15:25 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1461985749.892754-902876798', 20:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:25 INFO - '_': '/tools/buildbot/bin/python'} 20:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:25 INFO - Downloading/unpacking jsonschema 20:15:25 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 20:15:25 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 20:15:25 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 20:15:25 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 20:15:25 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 20:15:25 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 20:15:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:15:27 INFO - Downloading/unpacking functools32 (from jsonschema) 20:15:27 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 20:15:27 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 20:15:27 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 20:15:27 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 20:15:27 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 20:15:27 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 20:15:27 INFO - Downloading functools32-3.2.3-2.tar.gz 20:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:15:27 INFO - warning: no files found matching '*.txt' 20:15:27 INFO - no previously-included directories found matching 'build' 20:15:27 INFO - no previously-included directories found matching 'dist' 20:15:27 INFO - no previously-included directories found matching '.git*' 20:15:27 INFO - Installing collected packages: jsonschema, functools32 20:15:27 INFO - Running setup.py install for functools32 20:15:27 INFO - warning: no files found matching '*.txt' 20:15:27 INFO - no previously-included directories found matching 'build' 20:15:27 INFO - no previously-included directories found matching 'dist' 20:15:27 INFO - no previously-included directories found matching '.git*' 20:15:27 INFO - Successfully installed jsonschema functools32 20:15:27 INFO - Cleaning up... 20:15:27 INFO - Return code: 0 20:15:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:15:27 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')]} 20:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:27 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')]} 20:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:27 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 0x7f15532def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1304810>, '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 0x1305710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305ba0>, '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-1461985749.892754-902876798', '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 20:15:27 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 20:15:27 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 20:15:27 INFO - Using env: {'DISPLAY': ':0', 20:15:27 INFO - 'HOME': '/home/cltbld', 20:15:27 INFO - 'LANG': 'en_US.UTF-8', 20:15:27 INFO - 'LANGUAGE': 'en_US:en', 20:15:27 INFO - 'LOGNAME': 'cltbld', 20:15:27 INFO - 'MAIL': '/var/mail/cltbld', 20:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:27 INFO - 'MOZ_NO_REMOTE': '1', 20:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:27 INFO - 'NO_EM_RESTART': '1', 20:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:27 INFO - 'PWD': '/builds/slave/test', 20:15:27 INFO - 'SHELL': '/bin/bash', 20:15:27 INFO - 'SHLVL': '1', 20:15:27 INFO - 'TERM': 'linux', 20:15:27 INFO - 'TMOUT': '86400', 20:15:27 INFO - 'USER': 'cltbld', 20:15:27 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1461985749.892754-902876798', 20:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:27 INFO - '_': '/tools/buildbot/bin/python'} 20:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:27 INFO - Downloading/unpacking flake8 20:15:27 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 20:15:27 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 20:15:27 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 20:15:27 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 20:15:27 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 20:15:27 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 20:15:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:15:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:15:29 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 20:15:29 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 20:15:29 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 20:15:29 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 20:15:29 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 20:15:29 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 20:15:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:15:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:15:30 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 20:15:30 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 20:15:30 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 20:15:30 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 20:15:30 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 20:15:30 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 20:15:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:15:30 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 20:15:30 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 20:15:30 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 20:15:30 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 20:15:30 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 20:15:30 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 20:15:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:15:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:15:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:15:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:15:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:15:30 INFO - no previously-included directories found matching 'docs/_build' 20:15:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:15:30 INFO - Running setup.py install for pep8 20:15:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:15:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:15:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:15:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:15:30 INFO - no previously-included directories found matching 'docs/_build' 20:15:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:15:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:15:30 INFO - Cleaning up... 20:15:30 INFO - Return code: 0 20:15:30 INFO - Running post-action listener: _resource_record_post_action 20:15:30 INFO - Running post-action listener: _start_resource_monitoring 20:15:30 INFO - Starting resource monitoring. 20:15:30 INFO - ##### 20:15:30 INFO - ##### Running install step. 20:15:30 INFO - ##### 20:15:30 INFO - Running pre-action listener: _resource_record_pre_action 20:15:30 INFO - Running main action method: install 20:15:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:31 INFO - Reading from file tmpfile_stdout 20:15:31 INFO - Detecting whether we're running mozinstall >=1.0... 20:15:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:15:31 INFO - Reading from file tmpfile_stdout 20:15:31 INFO - Output received: 20:15:31 INFO - Usage: mozinstall [options] installer 20:15:31 INFO - Options: 20:15:31 INFO - -h, --help show this help message and exit 20:15:31 INFO - -d DEST, --destination=DEST 20:15:31 INFO - Directory to install application into. [default: 20:15:31 INFO - "/builds/slave/test"] 20:15:31 INFO - --app=APP Application being installed. [default: firefox] 20:15:31 INFO - mkdir: /builds/slave/test/build/application 20:15:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:15:47 INFO - Reading from file tmpfile_stdout 20:15:47 INFO - Output received: 20:15:47 INFO - /builds/slave/test/build/application/firefox/firefox 20:15:47 INFO - Running post-action listener: _resource_record_post_action 20:15:47 INFO - ##### 20:15:47 INFO - ##### Running run-tests step. 20:15:47 INFO - ##### 20:15:47 INFO - Running pre-action listener: _resource_record_pre_action 20:15:47 INFO - Running main action method: run_tests 20:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:15:47 INFO - Python 2.7.3 20:15:47 INFO - Return code: 0 20:15:47 INFO - grabbing minidump binary from tooltool 20:15:47 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')]} 20:15:47 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 0x1304810>, '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 0x1305710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:15:47 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 20:15:47 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 20:15:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:15:47 INFO - Return code: 0 20:15:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:15:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:15:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:15:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:15:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:15:48 INFO - Return code: 0 20:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.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 20:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.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 20:15:48 INFO - Using env: {'DISPLAY': ':0', 20:15:48 INFO - 'HOME': '/home/cltbld', 20:15:48 INFO - 'LANG': 'en_US.UTF-8', 20:15:48 INFO - 'LANGUAGE': 'en_US:en', 20:15:48 INFO - 'LOGNAME': 'cltbld', 20:15:48 INFO - 'MAIL': '/var/mail/cltbld', 20:15:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:48 INFO - 'MOZ_NO_REMOTE': '1', 20:15:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:48 INFO - 'NO_EM_RESTART': '1', 20:15:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:48 INFO - 'PWD': '/builds/slave/test', 20:15:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:48 INFO - 'SHELL': '/bin/bash', 20:15:48 INFO - 'SHLVL': '1', 20:15:48 INFO - 'TERM': 'linux', 20:15:48 INFO - 'TMOUT': '86400', 20:15:48 INFO - 'USER': 'cltbld', 20:15:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1461985749.892754-902876798', 20:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:48 INFO - '_': '/tools/buildbot/bin/python'} 20:15:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.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 20:15:49 INFO - mozversion application_buildid: 20160429173026 20:15:49 INFO - mozversion application_changeset: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a 20:15:49 INFO - mozversion application_display_name: Nightly 20:15:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:15:49 INFO - mozversion application_name: Firefox 20:15:49 INFO - mozversion application_remotingname: firefox 20:15:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:15:49 INFO - mozversion application_vendor: Mozilla 20:15:49 INFO - mozversion application_version: 49.0a1 20:15:49 INFO - mozversion platform_buildid: 20160429173026 20:15:49 INFO - mozversion platform_changeset: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a 20:15:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:15:49 INFO - mozversion platform_version: 49.0a1 20:15:49 INFO - using testdate: 1461986149 20:15:49 INFO - actual date: 1461986149 20:15:49 INFO - starting webserver on 'localhost:59304' 20:15:49 INFO - SUITE-START | Running 2 tests 20:15:49 INFO - TEST-START | dromaeo_css 20:15:49 INFO - operating with platform_type : linux_ 20:15:49 INFO - Initialising browser for dromaeo_css test... 20:15:49 INFO - TEST-INFO | started process 4718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpijC6tm/profile http://localhost:59304/getInfo.html) 20:15:52 INFO - PROCESS | 4718 | __metrics Screen width/height:1600/1200 20:15:52 INFO - PROCESS | 4718 | colorDepth:24 20:15:52 INFO - PROCESS | 4718 | Browser inner width/height: 1024/697 20:15:52 INFO - PROCESS | 4718 | __metrics 20:15:53 ERROR - PROCESS | 4718 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:15:54 INFO - TEST-INFO | 4718: exit 0 20:15:54 INFO - Browser initialized. 20:15:54 INFO - Running cycle 1/1 for dromaeo_css test... 20:15:54 INFO - TEST-INFO | started process 4803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpijC6tm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:06 INFO - PROCESS | 4803 | RSS: Main: 154304512 20:16:06 INFO - PROCESS | 4803 | 20:16:57 INFO - PROCESS | 4803 | 1461986217339 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] 20:19:05 INFO - PROCESS | 4803 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59304/tests/dromaeo/cssquery-ext.html) 20:19:06 INFO - PROCESS | 4803 | RSS: Main: 235986944 20:19:06 INFO - PROCESS | 4803 | 20:22:08 INFO - PROCESS | 4803 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-ext.html (next: http://localhost:59304/tests/dromaeo/cssquery-jquery.html) 20:22:09 INFO - PROCESS | 4803 | RSS: Main: 239521792 20:22:09 INFO - PROCESS | 4803 | 20:25:10 INFO - PROCESS | 4803 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59304/tests/dromaeo/cssquery-mootools.html) 20:25:11 INFO - PROCESS | 4803 | RSS: Main: 245964800 20:25:11 INFO - PROCESS | 4803 | 20:28:13 INFO - PROCESS | 4803 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59304/tests/dromaeo/cssquery-prototype.html) 20:28:14 INFO - PROCESS | 4803 | RSS: Main: 236269568 20:28:14 INFO - PROCESS | 4803 | 20:31:16 INFO - PROCESS | 4803 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59304/tests/dromaeo/cssquery-yui.html) 20:31:17 INFO - PROCESS | 4803 | RSS: Main: 201490432 20:31:17 INFO - PROCESS | 4803 | 20:34:19 INFO - PROCESS | 4803 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-yui.html (next: http://localhost:59304/tests/dromaeo/cssquery-dojo.html) 20:34:20 INFO - PROCESS | 4803 | RSS: Main: 270950400 20:34:20 INFO - PROCESS | 4803 | 20:34:20 INFO - PROCESS | 4803 | __start_tp_report 20:34:20 INFO - PROCESS | 4803 | _x_x_mozilla_page_load 20:34:20 INFO - PROCESS | 4803 | _x_x_mozilla_page_load_details 20:34:20 INFO - PROCESS | 4803 | |i|pagename|runs| 20:34:20 INFO - PROCESS | 4803 | |0;dojo.html;3029.772767042472;3088.7220150186477;3125.7968232064914;3125.9843700781507;3160;5229.215617657349;5244.921326180111;5272.841814745559;5288.973555132224;5328.92006619901;5291.973540132303;5338.306020217376;5412.431694672062;5412.539934105596;5419.5393391561765;4824.517548245174;4848.175810112271;4858.514148585148;4861.805527778884;4889.877753056185;4823.517648235166;4867.756612169395;4921.311016457699;4933.136701077315;4968.801247950096;4721.291806229059;4774.832880849189;4931.926021109686;4933.383327084114;4964.131277026524;4853.538913803219;4875.804967801284;4876.268559716071;4881.682690625134;4882.145624515695;4783.832565860213;4827.227643577011;4842.806287748486;4850.95149048512;4851.781669824866;5180.041692286902;5204.505571970657;5217.73911304437;5218.452062533455;5226.947730522722;5645.633033852787;5695.430456954313;5697.829065128053;5706.572007099484;5708.914366284509;5538.141588053858;5625.8593535161945;5697.202391665129;5733.140028995643;5757.9712101439645;5348.946510534884;5361.276227709287;5380.7309634518115;5403.945960540423;5415.891682166334;5819.88360232793;5829.795957141479;5830.242068531149;5831.008728516163;5833.970830145907;5440.619156659075;5598.10430331145;5616.466435688603;5623.718814059281;5627.902559001037;5545.140503222007;5548.9722551387795;5554.611177217556;5602.579806514527;5605.299337582802;5525.143602741581;5530.087535556588;5531.170324451284;5535.833924982257;5536.584756143306;5378.139497680352;5460.372057213472;5544.695041772741;5568.1091025435735;5603.2435621191435;4330.545292744217;4335.046289816235;4338.197433474817;4367.366731823931;4373.103513779667;3873.12854607711;3875.457435958968;3878.2825177342283;3909.2963266611714;3915.471411359487;5209.0623687735815;5359.732013399314;5389.784408623689;5403.810866619728;5455.563554915597;5655.151727240865;5658.632188907708;5672.602917795797;5678.659280443187;5684.090545512699;5331.280277162611;5354.7858085676135;5366.356037275552;5370.252787809006;5417.295751552273;4767.237242041326;4839.104765618302;4883.487233840467;4919.87700307488;4936.234883592977;5873.295204575393;5917.674527900921;5927.970360148258;5932.021216499315;5933.58464907461;5580.86047848807;5703.828885133453;5732.856678583069;5734.483896449173;5738.942610574008;5799.884002320015;5802.071668533184;5835.7373918174635;5840.123981402823;5865.178874957594;5518.586106041983;5518.889622207614;5523;5532.336119665666;5556.555475561864;5626.1842032905815;5632.183333416713;5639.351474580476;5639.7744090237575;5705.030144875298;5511.338639363302;5518.91721624184;5520.696361700145;5534.501894829485;5564.081926482247;5500.202470641654;5504.834854954358;5513.3108361454815;5514.145307477347;5519.39286678457;5299.655522391032;5448.863778405572;5454.318210223722;5502.8349149525575;5565.888682226414;5490.890182196414;5517.834464966058;5525.254090697705;5577.107662774099;5651.943480565142;5437.483439073281;5476.288082549243;5476.67139971603;5489.258950041693;5504.146857237135 20:34:20 INFO - PROCESS | 4803 | |1;ext.html;602.9689231414284;621.9222597175353;622.2688341199091;633.14209246471;642.4892210692498;30767.230819229502;31325.686743132563;37309.44035839465;37881;38114.04714882129;40613.59386406135;41370;41372.37941430881;41519.37720934188;41576.168476630446;8297.751067467985;8521.872171917426;8526.658933642648;8529.914700853005;8530.488170709747;8351.457155284887;8466.238038576526;8491.617877195511;8499.915000850006;8503.362247831406;8484.575771211446;8577;8736.8689469658;8747.387682862201;8749.868751968694;8627.741167764945;8701.56492175395;8712.128787121268;8713.388023215693;8723.084076172037;8553.529555874424;8682.522461264627;8687.69593064246;8692.521911294876;8712.085231050713;41371.793141034104;41784.37323440151;41844.790776046226;41918.58081419177;41945.161096778196;3476.3568739783223;3501.5973163086314;3512.2799826035603;3532.8056956867363;3669.5963444021136;31972.84013579917;32117.1970700732;32118.35763284721;32301;33016.50475242873;4273.273543497613;4313.374560688682;4340.565943405634;4374.956250437487;4447.866564003053;323070;323731;325547;325762;327537;33834.939807223294;58033.70983145057;59104.40895591075;59214.70392648095;59358.40641593615;35401.69888957261;35564.02103705483;35886.28227435489;35901.82049089738;35902;15092;15240.542783716506;15245.466408675866;15301.311440985182;15309.617259568377;12712.936435317764;12740.936295318465;12759.872401276054;12763.106582539318;12763.234205947672;8447.45091569046;8495.277901378453;8505.745977316015;8562.61468233931;8575.914240857637;3167.8099314041233;3193.872245110216;3222.5971753530807;3225.0647312279643;3244.416005119101;996.835522138839;1035.49260862177;1047.8218702820539;1128.323006196292;1139.8518192634904;32141.03576892697;32850.83574582112;32866.67133328684;32997;33221.83389083087;1083.2092572422175;1107.0479387726548;1124.960626378073;1125.060574420368;1190.5058901601133;15145.394184232728;15623.218839058001;15746.842531574766;16026.439074632332;16042.197890105448;490975;496130;498593;500341;501615;58005.70997144987;58986;59086.11370829355;59120.70439647774;59125.70437147787;1275.1392809853498;1369;1385.5496963486705;1406.9366878490493;1419.5954153066327;30746.231344216572;32552;32787.34425311528;32975.8351208252;33050;48172.75913620409;49370.50629493659;49371.25943110784;49383.25925111198;49443.25835112548;325491;330951;333044;334326;334393;43975.340369895115;44487.332690009025;45720.31419528776;45847.31229031501;45880.31179532377;43521.78239108784;48575.75712121417;49496;50195.49804502054;50701;40852.59147408607;41490.792546037075;42592.57407425886;42976.14047719091;43355.349669754345;36319.455208172425;41893.371599426646;41984.58015419929;42331.7883410581;42706;36952.44571331486;37306;37674.246515070095;37879.62120378871;38219.61780382161;32411.837940810146;33413.66586334203;33452.330953381286;33844.83077584596;33897.830510847285;25797.226083217534;26029.6095558563;26045.479090417706;26425.300671694633;26624.467510650065 20:34:20 INFO - PROCESS | 4803 | |2;jquery.html;378.1170965794869;389.31286279716295;396.548632006855;396.8372967083495;405.9533153687325;18035.36876209333;18585.163667634955;18734;18742.469766581507;19461;18619.813801861976;18677.252909883624;19536.218551257967;19603;19651;5454.809081682142;5459.290292262001;5481.972590137044;5506.256655351516;5658.981383350995;5311.123664595337;5526.778928842841;5542.473465020837;5550.4449555044375;5568.470995255444;5472.425395333493;5522.061249587559;5522.475364840334;5550.888982220353;5557.110862262019;5341.4925582069645;5488.1493368528145;5489.505944464978;5498.725063746817;5510.228568000483;4816.494268101869;4901.877453063702;4921.458639549646;4933.580645645125;4935.90128197434;23148;23265.651015234784;23374.415639608975;23594;23606.29181124552;2358.5165041166692;2411.4212588978694;2448.963265551018;2538.8095892808115;2799.5800629905475;13735.175889446666;14236.217008064552;14261.78607320891;14610.31368939528;14715.55853324402;1923.807619238079;1925.8459323254106;1979.1489659446431;1980.5939782344728;2026.0781344488223;80246.5987670058;80304;82376.17623823685;82503.58748206281;83124.58437707834;10195.337303075425;10489.737756556147;10528.947355263175;10648.520816563274;10853.131749460024;14632.414703411958;14635.414583416758;14709.264536773333;14711;14747.115173089649;8047.315978141806;8227.341812654973;8277.54473503951;8416.452930559493;8523.95738021306;8128.431009829255;8146.963259185204;8147.714829981041;8316.334693224528;8336.333093352518;6465.77369792055;6664.333566643297;6738;6774.762883299061;6876.449884009267;1754.876599314818;1856.675081860669;1880.6238752249606;1889.4803928919382;1894.725264836591;890.105444028747;983.7294743945472;990.2820455170088;1030.948452577383;1080.9729756756144;18967.525811854815;19102.595390952163;19706.408807735792;19725.704114438297;19936;1051.8159322118752;1052.826283663187;1055.8785739639886;1058.7882423515327;1077.6012875236213;10586.841197382046;11343.773124537463;11432;11439.885601143882;11450.484728187252;457273;459027;459923;462041;463446;82443.5877820619;82725;82921;82980;83006;1016.9898301017043;1051.5005372448027;1071.089573862211;1076.8438576406534;1080.9405482698528;16292.837071629132;16605.91697041507;16748.330066797193;16979.745303820204;17105.14474276306;35035.29929401448;36416.635833641325;36446;37444.25111497809;37637.811810941865;49116.263256051905;51112.23331650103;52105.47894521006;52109.47890521198;52501.7374913123;8436.325093992344;8665.267649301722;8724.56377181151;8856.424332418372;8870.556472176495;12611.684707882376;13266;13356.332183390987;13450.46198152063;13598.11612245201;11668.299902005907;11925;12145.453454594388;12213.267203967791;12270.877291226974;11412.543498259976;11633.770889609117;11760.529578816751;11944.462499187732;11948.641540753792;11985.880141198477;12019.879801202225;12071.879281207075;12315.261084334968;12342.568010119961;8527.360447966303;8561.48631082137;8602.354823388147;8687.305015598611;8776.868346974928;11366;11949.64151075469;12106.75786484283;12180.634580962585;12212 20:34:20 INFO - PROCESS | 4803 | |3;mootools.html;1245.9563915262968;1291.5221368093808;1351.4459071780573;1374.2647683489333;1721.5696075980998;7684.692612295508;7946.801329966739;7958;7958.681652733883;7966.044074711028;7913.683452661887;8148.388870834697;8157.0211574610985;8159.5104293742415;8165.34677225822;2030.9492262693402;2083.2500299892104;2086.3740877736695;2282.7374851891996;2331.0442718485424;2287.1994801819396;2351.447409858682;2352.5765362234793;2355;2355.1403737635724;2250.1449449209276;2273.8521996070203;2293.919712810052;2302.896369663361;2304.9884750576225;1980.7028945658124;2036.643587372204;2290.518991011881;2301.2060839010596;2302.0561569756405;2037.0731317250763;2198.9450263743533;2264.445210923318;2266.0935625749667;2266.795988361039;7952.284294413531;8009.759707208793;8030.718924837661;8033.317168040723;8037.638306276232;4853.150698627726;5017.623678224148;5050.419201791804;5070.974645126787;5072.315237442935;3162.9525557116663;3193.8562764675644;3215.6623554526905;3366.4445366514497;3427.0232983599803;1054.204075922681;1055.1875056206754;1058.449606204777;1068.513826209081;1069.893010698924;11234.382108984002;11237.550497980154;11269.211155219138;11308.37803920784;11308.830367544493;4485.452518880981;4547.317902314613;4583.197940360424;4593.333966574828;4594.150082234797;9691.12779849817;9693.9030609693;9698.272629552812;9739.659111931049;9743.171830394496;5107.208382700687;5155.407128180233;5156.149235376196;5157.8452646420665;5170.095233334151;4136.234796562646;4567.725936443824;4630.675852690347;4678.041001594733;4697.295405689174;3819.427085937132;3845.1540661054523;3851.345271303885;3920.9607903921165;3930.3711406174875;1226.2274766896799;1232.8335674683804;1234.1484375780683;1234.7530493901256;1239.2688313894846;971.4317124482257;979.4661909259471;982.6167794560128;994.6518718448485;1007.7883644434604;5560.777568897199;5564.805231816867;5599.776008959596;5766.740496677659;5879.764809407576;442.5309172277396;460.2199272233599;460.4842576314549;465.22075523498006;467.94618618858584;3768.397056471006;4034.435179074932;4057.411675307064;4063.7358571692744;4093.1813637272667;9310.441373517611;9561.139497445125;9659.951700241454;9664.226861851035;9729.318947673595;9460.432374057578;9615.423074615546;9638.277129215337;9672;9677.225821934227;7124.5725256484775;7167.498275120795;7204.53170543913;7255;7317.670704818296;5527.39198688152;5589.55283577321;5630.339049980347;5650.434956504317;5709.22925405065;8964.910350896407;8976.237019853386;9023.503707296162;9032.14194651507;9064.048274931038;9070.956118391436;9072.183503484717;9146.771330716785;9161.86257206129;9324.11420915012;6616.801495955129;6959.304069593;7064.470164737562;7118.85762284741;7202.71189152449;7706.845863082594;7727.9227207729455;7738.574378409242;7761.805954851174;7811.2188781123705;6918.965405172942;7007.614581198083;7110.288971102848;7126.857462850818;7153.3919616833155;6917.757878474229;6923.653817309215;6955.791326260221;6988.8951665724035;7033.577985320897;6329.461995730415;6341;6360.268569114426;6366.140571022853;6432.9678351607945;4908.8772780680765;4910.729909854992;5009.899802004013;5010.949890501194;5041.193409054534;5008.499150084962;5044.167712327425;5072.949270507248;5080.212567052113;5161.741912904415 20:34:20 INFO - PROCESS | 4803 | |4;prototype.html;309.86365998960457;324.30436713250094;325.4110060789971;326.36847699701065;328.0535654636374;4838.927416088762;4970.6520543561965;5139.383274007115;5210.348706411699;5265.183896496044;5045.54590086893;5204.42751297357;5205.0370681423865;5241.723922548407;5250.238715386266;4106;4107.069677251702;4110.732802367851;4122.196171746511;4125.608067233608;3896.045468860119;3941.4284928685465;4081.204165187775;4105.876823695294;4125.443065186207;4016.6385025347713;4051.311277082903;4065.695072869532;4079.2045551117544;4092.909853060935;4063.613956674141;4072.6945479089186;4076.3070278052655;4101.79491025449;4120.320147175712;3648.087978005499;3648.121217572952;3651.47053677218;3656.579493358271;3658.2317713280245;4850.733209673466;5066.923996140061;5067.163917953533;5074.4120498545635;5090.363704536933;4495.9325610115875;4606.355110284563;4646.767661616906;4651.116287905287;4668.626509879202;5353.652012619206;5435.537979271767;5447.155690867922;5463.48096930791;5476.371341755979;3933.7049721270732;4001.8399264029404;4002.199560087965;4009;4013.979930100331;5630.943690563083;5657.57568182388;5663.971680141614;5734.397888221718;5736.74184661687;4096.651784598283;4110.219058378899;4110.588941105925;4117.876463706094;4139.130782535641;4169.624733773914;4177.352510360899;4178.22702799983;4180.749155050707;4198.517170525429;4538.819906824249;4647.34937108805;4667.369905062841;4679.227927391942;4691.3432119503295;5459.372172200168;5483.8338856151595;5494.088133289283;5506.449355064542;5513.531349835229;1502.8797696184279;1503.624093976506;1512.7579587266205;1514.5986313626897;1515.3484001879299;1001.6344034427527;1027.712240572641;1028.943408112561;1032.5818043692316;1033.116685234114;5487.807926722546;5535.861603459945;5552.972235138798;5556.611037227436;5596.356419011784;5899.351071382144;5915.408459154136;5932.762689492372;5957.4638282553915;5976.462118409364;5377.919331210035;5571.164325351148;5576.637518561281;5577.3028371453565;5593.776248949996;3135.9181082526493;3165.09794708507;3175.523671449301;3178.1419016865316;3189.3940151371166;5902.625164822068;6046.246588489377;6085.695715214221;6096.329403765582;6111.280480186363;5471.206675032098;5576.693281869536;5620.381758006616;5627.380988091307;5965.194698715704;5841.328247251536;5849.502792262705;5852.356240813422;5855.502282306052;5871.735771890189;5491.395946445968;5546.694931778791;5620.414609279777;5621.606487545832;5627.943720562906;5532.510370333446;5553.8333849984565;5559.91581641576;5572.972135139298;5587.832365029056;5779.826605201851;5790.449907258803;5805.738741756715;5825.3592104867585;5851.795187168429;3898.337282662011;3988.3618621020496;3995.10110225197;4002.4396584478777;4017.2969730296495;5634.774609015757;5642.379338272704;5665.575081868794;5671.688057156731;5689.914651280317;5507.642003269774;5516.586256030733;5520.475554822286;5525.530329922001;5529.672878509209;5259.526642602184;5485.149801780731;5493.807716729895;5497.900419916113;5522.806701765419;5380.381256155592;5411.78352865881;5412.373709614489;5417.322834645669;5425.240466334795;5340.572754179579;5524.1989911463415;5565.471280228372;5567.415421380697;5574.77700891976;5432.0765469871;5464.836054918359;5477.603211181124;5487.560995120461;5489.972550137224 20:34:20 INFO - PROCESS | 4803 | |5;yui.html;736.6611358774963;771.3096778383343;791.817881887166;805.9435839491235;837.8533756592597;14310.642233944156;14592.270386480686;14636.268186590682;14683.853161468382;14744.6313842154;13466.596002119952;13501.527446539349;13510.121842080258;13558.254296013716;13577.93211033946;666.4701562257992;780.9921900781005;803.9959800201005;815.946963447377;819.1971867569786;801.7915342011061;809.5304723260494;811.6591031766643;812.3947658994028;812.5612169428501;858.5321000054985;858.8926384201975;860.9483430994161;861.0399404663787;861.8147098373848;703.3669697272445;824.8391563645091;846.4878748357278;847.5380917400032;848.9533075680835;620.0389396435507;620.2371083567192;621.5680102328884;624.3943374926314;626.896562067263;13786.517471888435;13797.724045519133;13816.654583635389;13839.654008649764;13841.238731869744;12616.873831261753;12817.23096614206;12921.353932303347;12998.155119917175;13664.180149191081;11053.336799792038;11089;11199.104071674246;11225.775484490265;11493.425328733614;3773.641504057138;3791.1848952475075;3880.3209438348176;3881.243157584272;3926.0773718176492;48054;49320.260196097086;49354.50645493535;49380.259296110584;49606.50393496055;9413.717588472357;9618.374805637612;9671.274654400948;10195.949020254851;10530.73673158162;18300.26798928028;18318.084095795424;18537.165827537792;18630.627387452176;18786.154623041995;8373.413861029669;8440.409171357946;8532.786680333042;8543.871841922377;8548.786280342916;4679.836205732783;4702.6473014524045;4769.976150119227;4837.588804951548;4917.901641967141;3409.1988382730037;3498.965010349915;3504.404251277289;3505.106197919514;3518.40187168182;646.1277275677797;654.3227759269133;670.6981858163846;671.5064427645676;702.1714377035046;752.1575835064654;762.7025460070577;767.85794627994;790.0874489964101;793.8491686579531;9359.15767580921;9635.56639951204;9741.853872191923;9767.51162441875;9788.265880059023;648.4876947211744;679.7247114918466;737.4432303610739;764.2319468933686;779.4465929190225;4514.0971805639;4638.253130621521;4729.172394830891;4752.738599377068;4833.347498087714;56719.43280567224;56989.43010569841;57112.14331785026;59071;66306.66846665736;47933.76033119882;52427.73786131121;53780.731096344265;53892;54906.72546637321;48437.27344089842;48562.27156592654;48924.75537622289;49079.26381104286;49271.01457970821;9420.105090016437;9420.152186303265;9482.762930926781;9510.286728495528;9510.904890951002;32228.19429514281;32255;32710;33214.335713286084;33874.661253388134;40768;44012.33981490344;44847.32729009002;45511.31733023941;45754.77122614365;11437.828432573351;11843;11895;12064.939675301568;12103.455344509342;12389.380530973596;13365.331733413484;13917.443302267797;14181.078229915023;14218.857811421753;12350.505979760708;12528.436220370288;12571.057170712416;12924.159929604546;13524.729505410034;12444.502219911103;13075.084744068205;13115.737685246433;13323.866761332263;13598.184108953494;11788.174827761974;12480.126391152895;12821.871781282067;13015.349232538147;13118;10295.94852025735;10606.893931060898;10655.733606659585;11008.119350452105;11300.378479183724;10898.455077246264;11039.227254092457;11058.22592418523;11100.944495277472;11187.664370068911 20:34:20 INFO - PROCESS | 4803 | __end_tp_report 20:34:20 INFO - PROCESS | 4803 | __start_cc_report 20:34:20 INFO - PROCESS | 4803 | _x_x_mozilla_cycle_collect,1090 20:34:20 INFO - PROCESS | 4803 | __end_cc_report 20:34:20 INFO - PROCESS | 4803 | __startTimestamp1461987260194__endTimestamp 20:34:20 INFO - PROCESS | 4803 | 20:34:20 INFO - PROCESS | 4803 | ------- Summary: start ------- 20:34:20 INFO - PROCESS | 4803 | Number of tests: 6 20:34:20 INFO - PROCESS | 4803 | 20:34:20 INFO - PROCESS | 4803 | [#0] dojo.html Cycles:165 Average:5264.15 Median:5476.29 stddev:580.65 (10.6%) stddev-sans-first:555.35 20:34:20 INFO - PROCESS | 4803 | Values: 3029.8 3088.7 3125.8 3126.0 3160.0 5229.2 5244.9 5272.8 5289.0 5328.9 5292.0 5338.3 5412.4 5412.5 5419.5 4824.5 4848.2 4858.5 4861.8 4889.9 4823.5 4867.8 4921.3 4933.1 4968.8 4721.3 4774.8 4931.9 4933.4 4964.1 4853.5 4875.8 4876.3 4881.7 4882.1 4783.8 4827.2 4842.8 4851.0 4851.8 5180.0 5204.5 5217.7 5218.5 5226.9 5645.6 5695.4 5697.8 5706.6 5708.9 5538.1 5625.9 5697.2 5733.1 5758.0 5348.9 5361.3 5380.7 5403.9 5415.9 5819.9 5829.8 5830.2 5831.0 5834.0 5440.6 5598.1 5616.5 5623.7 5627.9 5545.1 5549.0 5554.6 5602.6 5605.3 5525.1 5530.1 5531.2 5535.8 5536.6 5378.1 5460.4 5544.7 5568.1 5603.2 4330.5 4335.0 4338.2 4367.4 4373.1 3873.1 3875.5 3878.3 3909.3 3915.5 5209.1 5359.7 5389.8 5403.8 5455.6 5655.2 5658.6 5672.6 5678.7 5684.1 5331.3 5354.8 5366.4 5370.3 5417.3 4767.2 4839.1 4883.5 4919.9 4936.2 5873.3 5917.7 5928.0 5932.0 5933.6 5580.9 5703.8 5732.9 5734.5 5738.9 5799.9 5802.1 5835.7 5840.1 5865.2 5518.6 5518.9 5523.0 5532.3 5556.6 5626.2 5632.2 5639.4 5639.8 5705.0 5511.3 5518.9 5520.7 5534.5 5564.1 5500.2 5504.8 5513.3 5514.1 5519.4 5299.7 5448.9 5454.3 5502.8 5565.9 5490.9 5517.8 5525.3 5577.1 5651.9 5437.5 5476.3 5476.7 5489.3 5504.1 20:34:20 INFO - PROCESS | 4803 | 20:34:20 INFO - PROCESS | 4803 | [#1] ext.html Cycles:180 Average:54230.31 Median:39416.61 stddev:104057.25 (264.0%) stddev-sans-first:104271.26 20:34:20 INFO - PROCESS | 4803 | Values: 603.0 621.9 622.3 633.1 642.5 30767.2 31325.7 37309.4 37881.0 38114.0 40613.6 41370.0 41372.4 41519.4 41576.2 8297.8 8521.9 8526.7 8529.9 8530.5 8351.5 8466.2 8491.6 8499.9 8503.4 8484.6 8577.0 8736.9 8747.4 8749.9 8627.7 8701.6 8712.1 8713.4 8723.1 8553.5 8682.5 8687.7 8692.5 8712.1 41371.8 41784.4 41844.8 41918.6 41945.2 3476.4 3501.6 3512.3 3532.8 3669.6 31972.8 32117.2 32118.4 32301.0 33016.5 4273.3 4313.4 4340.6 4375.0 4447.9 323070.0 323731.0 325547.0 325762.0 327537.0 33834.9 58033.7 59104.4 59214.7 59358.4 35401.7 35564.0 35886.3 35901.8 35902.0 15092.0 15240.5 15245.5 15301.3 15309.6 12712.9 12740.9 12759.9 12763.1 12763.2 8447.5 8495.3 8505.7 8562.6 8575.9 3167.8 3193.9 3222.6 3225.1 3244.4 996.8 1035.5 1047.8 1128.3 1139.9 32141.0 32850.8 32866.7 32997.0 33221.8 1083.2 1107.0 1125.0 1125.1 1190.5 15145.4 15623.2 15746.8 16026.4 16042.2 490975.0 496130.0 498593.0 500341.0 501615.0 58005.7 58986.0 59086.1 59120.7 59125.7 1275.1 1369.0 1385.5 1406.9 1419.6 30746.2 32552.0 32787.3 32975.8 33050.0 48172.8 49370.5 49371.3 49383.3 49443.3 325491.0 330951.0 333044.0 334326.0 334393.0 43975.3 44487.3 45720.3 45847.3 45880.3 43521.8 48575.8 49496.0 50195.5 50701.0 40852.6 41490.8 42592.6 42976.1 43355.3 36319.5 41893.4 41984.6 42331.8 42706.0 36952.4 37306.0 37674.2 37879.6 38219.6 32411.8 33413.7 33452.3 33844.8 33897.8 25797.2 26029.6 26045.5 26425.3 26624.5 20:34:20 INFO - PROCESS | 4803 | 20:34:20 INFO - PROCESS | 4803 | [#2] jquery.html Cycles:180 Average:27768.41 Median:12976.26 stddev:75765.97 (583.9%) stddev-sans-first:75950.61 20:34:20 INFO - PROCESS | 4803 | Values: 378.1 389.3 396.5 396.8 406.0 18035.4 18585.2 18734.0 18742.5 19461.0 18619.8 18677.3 19536.2 19603.0 19651.0 5454.8 5459.3 5482.0 5506.3 5659.0 5311.1 5526.8 5542.5 5550.4 5568.5 5472.4 5522.1 5522.5 5550.9 5557.1 5341.5 5488.1 5489.5 5498.7 5510.2 4816.5 4901.9 4921.5 4933.6 4935.9 23148.0 23265.7 23374.4 23594.0 23606.3 2358.5 2411.4 2449.0 2538.8 2799.6 13735.2 14236.2 14261.8 14610.3 14715.6 1923.8 1925.8 1979.1 1980.6 2026.1 80246.6 80304.0 82376.2 82503.6 83124.6 10195.3 10489.7 10528.9 10648.5 10853.1 14632.4 14635.4 14709.3 14711.0 14747.1 8047.3 8227.3 8277.5 8416.5 8524.0 8128.4 8147.0 8147.7 8316.3 8336.3 6465.8 6664.3 6738.0 6774.8 6876.4 1754.9 1856.7 1880.6 1889.5 1894.7 890.1 983.7 990.3 1030.9 1081.0 18967.5 19102.6 19706.4 19725.7 19936.0 1051.8 1052.8 1055.9 1058.8 1077.6 10586.8 11343.8 11432.0 11439.9 11450.5 457273.0 459027.0 459923.0 462041.0 463446.0 82443.6 82725.0 82921.0 82980.0 83006.0 1017.0 1051.5 1071.1 1076.8 1080.9 16292.8 16605.9 16748.3 16979.7 17105.1 35035.3 36416.6 36446.0 37444.3 37637.8 49116.3 51112.2 52105.5 52109.5 52501.7 8436.3 8665.3 8724.6 8856.4 8870.6 12611.7 13266.0 13356.3 13450.5 13598.1 11668.3 11925.0 12145.5 12213.3 12270.9 11412.5 11633.8 11760.5 11944.5 11948.6 11985.9 12019.9 12071.9 12315.3 12342.6 8527.4 8561.5 8602.4 8687.3 8776.9 11366.0 11949.6 12106.8 12180.6 12212.0 20:34:20 INFO - PROCESS | 4803 | 20:34:20 INFO - PROCESS | 4803 | [#3] mootools.html Cycles:180 Average:5355.53 Median:5131.31 stddev:2945.93 (57.4%) stddev-sans-first:2938.00 20:34:20 INFO - PROCESS | 4803 | Values: 1246.0 1291.5 1351.4 1374.3 1721.6 7684.7 7946.8 7958.0 7958.7 7966.0 7913.7 8148.4 8157.0 8159.5 8165.3 2030.9 2083.3 2086.4 2282.7 2331.0 2287.2 2351.4 2352.6 2355.0 2355.1 2250.1 2273.9 2293.9 2302.9 2305.0 1980.7 2036.6 2290.5 2301.2 2302.1 2037.1 2198.9 2264.4 2266.1 2266.8 7952.3 8009.8 8030.7 8033.3 8037.6 4853.2 5017.6 5050.4 5071.0 5072.3 3163.0 3193.9 3215.7 3366.4 3427.0 1054.2 1055.2 1058.4 1068.5 1069.9 11234.4 11237.6 11269.2 11308.4 11308.8 4485.5 4547.3 4583.2 4593.3 4594.2 9691.1 9693.9 9698.3 9739.7 9743.2 5107.2 5155.4 5156.1 5157.8 5170.1 4136.2 4567.7 4630.7 4678.0 4697.3 3819.4 3845.2 3851.3 3921.0 3930.4 1226.2 1232.8 1234.1 1234.8 1239.3 971.4 979.5 982.6 994.7 1007.8 5560.8 5564.8 5599.8 5766.7 5879.8 442.5 460.2 460.5 465.2 467.9 3768.4 4034.4 4057.4 4063.7 4093.2 9310.4 9561.1 9660.0 9664.2 9729.3 9460.4 9615.4 9638.3 9672.0 9677.2 7124.6 7167.5 7204.5 7255.0 7317.7 5527.4 5589.6 5630.3 5650.4 5709.2 8964.9 8976.2 9023.5 9032.1 9064.0 9071.0 9072.2 9146.8 9161.9 9324.1 6616.8 6959.3 7064.5 7118.9 7202.7 7706.8 7727.9 7738.6 7761.8 7811.2 6919.0 7007.6 7110.3 7126.9 7153.4 6917.8 6923.7 6955.8 6988.9 7033.6 6329.5 6341.0 6360.3 6366.1 6433.0 4908.9 4910.7 5009.9 5010.9 5041.2 5008.5 5044.2 5072.9 5080.2 5161.7 20:34:20 INFO - PROCESS | 4803 | 20:34:20 INFO - PROCESS | 4803 | [#4] prototype.html Cycles:180 Average:4665.85 Median:5302.88 stddev:1356.76 (25.6%) stddev-sans-first:1320.59 20:34:20 INFO - PROCESS | 4803 | Values: 309.9 324.3 325.4 326.4 328.1 4838.9 4970.7 5139.4 5210.3 5265.2 5045.5 5204.4 5205.0 5241.7 5250.2 4106.0 4107.1 4110.7 4122.2 4125.6 3896.0 3941.4 4081.2 4105.9 4125.4 4016.6 4051.3 4065.7 4079.2 4092.9 4063.6 4072.7 4076.3 4101.8 4120.3 3648.1 3648.1 3651.5 3656.6 3658.2 4850.7 5066.9 5067.2 5074.4 5090.4 4495.9 4606.4 4646.8 4651.1 4668.6 5353.7 5435.5 5447.2 5463.5 5476.4 3933.7 4001.8 4002.2 4009.0 4014.0 5630.9 5657.6 5664.0 5734.4 5736.7 4096.7 4110.2 4110.6 4117.9 4139.1 4169.6 4177.4 4178.2 4180.7 4198.5 4538.8 4647.3 4667.4 4679.2 4691.3 5459.4 5483.8 5494.1 5506.4 5513.5 1502.9 1503.6 1512.8 1514.6 1515.3 1001.6 1027.7 1028.9 1032.6 1033.1 5487.8 5535.9 5553.0 5556.6 5596.4 5899.4 5915.4 5932.8 5957.5 5976.5 5377.9 5571.2 5576.6 5577.3 5593.8 3135.9 3165.1 3175.5 3178.1 3189.4 5902.6 6046.2 6085.7 6096.3 6111.3 5471.2 5576.7 5620.4 5627.4 5965.2 5841.3 5849.5 5852.4 5855.5 5871.7 5491.4 5546.7 5620.4 5621.6 5627.9 5532.5 5553.8 5559.9 5573.0 5587.8 5779.8 5790.4 5805.7 5825.4 5851.8 3898.3 3988.4 3995.1 4002.4 4017.3 5634.8 5642.4 5665.6 5671.7 5689.9 5507.6 5516.6 5520.5 5525.5 5529.7 5259.5 5485.1 5493.8 5497.9 5522.8 5380.4 5411.8 5412.4 5417.3 5425.2 5340.6 5524.2 5565.5 5567.4 5574.8 5432.1 5464.8 5477.6 5487.6 5490.0 20:34:20 INFO - PROCESS | 4803 | 20:34:20 INFO - PROCESS | 4803 | [#5] yui.html Cycles:180 Average:14403.46 Median:4715.91 stddev:16185.24 (343.2%) stddev-sans-first:16198.10 20:34:20 INFO - PROCESS | 4803 | Values: 736.7 771.3 791.8 805.9 837.9 14310.6 14592.3 14636.3 14683.9 14744.6 13466.6 13501.5 13510.1 13558.3 13577.9 666.5 781.0 804.0 815.9 819.2 801.8 809.5 811.7 812.4 812.6 858.5 858.9 860.9 861.0 861.8 703.4 824.8 846.5 847.5 849.0 620.0 620.2 621.6 624.4 626.9 13786.5 13797.7 13816.7 13839.7 13841.2 12616.9 12817.2 12921.4 12998.2 13664.2 11053.3 11089.0 11199.1 11225.8 11493.4 3773.6 3791.2 3880.3 3881.2 3926.1 48054.0 49320.3 49354.5 49380.3 49606.5 9413.7 9618.4 9671.3 10195.9 10530.7 18300.3 18318.1 18537.2 18630.6 18786.2 8373.4 8440.4 8532.8 8543.9 8548.8 4679.8 4702.6 4770.0 4837.6 4917.9 3409.2 3499.0 3504.4 3505.1 3518.4 646.1 654.3 670.7 671.5 702.2 752.2 762.7 767.9 790.1 793.8 9359.2 9635.6 9741.9 9767.5 9788.3 648.5 679.7 737.4 764.2 779.4 4514.1 4638.3 4729.2 4752.7 4833.3 56719.4 56989.4 57112.1 59071.0 66306.7 47933.8 52427.7 53780.7 53892.0 54906.7 48437.3 48562.3 48924.8 49079.3 49271.0 9420.1 9420.2 9482.8 9510.3 9510.9 32228.2 32255.0 32710.0 33214.3 33874.7 40768.0 44012.3 44847.3 45511.3 45754.8 11437.8 11843.0 11895.0 12064.9 12103.5 12389.4 13365.3 13917.4 14181.1 14218.9 12350.5 12528.4 12571.1 12924.2 13524.7 12444.5 13075.1 13115.7 13323.9 13598.2 11788.2 12480.1 12821.9 13015.3 13118.0 10295.9 10606.9 10655.7 11008.1 11300.4 10898.5 11039.2 11058.2 11100.9 11187.7 20:34:20 INFO - PROCESS | 4803 | -------- Summary: end -------- 20:34:20 INFO - PROCESS | 4803 | 20:34:20 INFO - TEST-INFO | 4803: exit 0 20:34:20 INFO - TEST-OK | dromaeo_css | took 1111719ms 20:34:20 INFO - TEST-START | kraken 20:34:20 INFO - operating with platform_type : linux_ 20:34:20 INFO - Initialising browser for kraken test... 20:34:20 INFO - TEST-INFO | started process 4987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgccIQl/profile http://localhost:59304/getInfo.html) 20:34:24 INFO - PROCESS | 4987 | __metrics Screen width/height:1600/1200 20:34:24 INFO - PROCESS | 4987 | colorDepth:24 20:34:24 INFO - PROCESS | 4987 | Browser inner width/height: 1024/697 20:34:24 INFO - PROCESS | 4987 | __metrics 20:34:25 ERROR - PROCESS | 4987 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:34:26 INFO - TEST-INFO | 4987: exit 0 20:34:26 INFO - Browser initialized. 20:34:26 INFO - Running cycle 1/1 for kraken test... 20:34:26 INFO - TEST-INFO | started process 5069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgccIQl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:38 INFO - PROCESS | 5069 | RSS: Main: 154705920 20:34:38 INFO - PROCESS | 5069 | 20:34:40 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59304/tests/kraken/driver.html?testName=audio-beat-detection) 20:34:41 INFO - PROCESS | 5069 | RSS: Main: 209342464 20:34:41 INFO - PROCESS | 5069 | 20:34:44 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59304/tests/kraken/driver.html?testName=audio-dft) 20:34:44 INFO - PROCESS | 5069 | RSS: Main: 196050944 20:34:44 INFO - PROCESS | 5069 | 20:34:47 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59304/tests/kraken/driver.html?testName=audio-fft) 20:34:48 INFO - PROCESS | 5069 | RSS: Main: 265527296 20:34:48 INFO - PROCESS | 5069 | 20:34:50 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59304/tests/kraken/driver.html?testName=audio-oscillator) 20:34:51 INFO - PROCESS | 5069 | RSS: Main: 173076480 20:34:51 INFO - PROCESS | 5069 | 20:34:53 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59304/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:34:54 INFO - PROCESS | 5069 | RSS: Main: 178552832 20:34:54 INFO - PROCESS | 5069 | 20:34:57 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59304/tests/kraken/driver.html?testName=imaging-darkroom) 20:34:57 INFO - PROCESS | 5069 | RSS: Main: 214859776 20:34:57 INFO - PROCESS | 5069 | 20:35:01 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59304/tests/kraken/driver.html?testName=imaging-desaturate) 20:35:01 INFO - PROCESS | 5069 | RSS: Main: 214933504 20:35:01 INFO - PROCESS | 5069 | 20:35:04 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59304/tests/kraken/driver.html?testName=json-parse-financial) 20:35:05 INFO - PROCESS | 5069 | RSS: Main: 215392256 20:35:05 INFO - PROCESS | 5069 | 20:35:06 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59304/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:35:07 INFO - PROCESS | 5069 | RSS: Main: 204603392 20:35:07 INFO - PROCESS | 5069 | 20:35:09 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:35:09 INFO - PROCESS | 5069 | RSS: Main: 200810496 20:35:09 INFO - PROCESS | 5069 | 20:35:11 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:35:12 INFO - PROCESS | 5069 | RSS: Main: 212361216 20:35:12 INFO - PROCESS | 5069 | 20:35:14 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:35:15 INFO - PROCESS | 5069 | RSS: Main: 222932992 20:35:15 INFO - PROCESS | 5069 | 20:35:18 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:35:18 INFO - PROCESS | 5069 | RSS: Main: 220016640 20:35:18 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59304/tests/kraken/driver.html?testName=ai-astar) 20:35:20 INFO - PROCESS | 5069 | RSS: Main: 284192768 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | __start_tp_report 20:35:20 INFO - PROCESS | 5069 | _x_x_mozilla_page_load 20:35:20 INFO - PROCESS | 5069 | _x_x_mozilla_page_load_details 20:35:20 INFO - PROCESS | 5069 | |i|pagename|runs| 20:35:20 INFO - PROCESS | 5069 | |0;ai-astar;111;111;108;110;111;111;101;110;111;112 20:35:20 INFO - PROCESS | 5069 | |1;audio-beat-detection;154;129;154;179;131;158;153;130;195;129 20:35:20 INFO - PROCESS | 5069 | |2;audio-dft;160;160;161;161;161;160;160;161;161;162 20:35:20 INFO - PROCESS | 5069 | |3;audio-fft;79;76;139;116;79;79;75;129;105;77 20:35:20 INFO - PROCESS | 5069 | |4;audio-oscillator;93;94;155;94;94;95;151;94;93;153 20:35:20 INFO - PROCESS | 5069 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;117 20:35:20 INFO - PROCESS | 5069 | |6;imaging-darkroom;148;149;148;149;148;150;148;149;149;149 20:35:20 INFO - PROCESS | 5069 | |7;imaging-desaturate;95;94;94;95;94;95;94;95;95;94 20:35:20 INFO - PROCESS | 5069 | |8;json-parse-financial;58;57;57;57;57;58;60;75;55;54 20:35:20 INFO - PROCESS | 5069 | |9;json-stringify-tinderbox;65;63;64;64;64;66;65;64;64;64 20:35:20 INFO - PROCESS | 5069 | |10;stanford-crypto-aes;78;83;78;78;79;79;79;86;87;81 20:35:20 INFO - PROCESS | 5069 | |11;stanford-crypto-ccm;125;130;131;124;127;129;123;126;156;126 20:35:20 INFO - PROCESS | 5069 | |12;stanford-crypto-pbkdf2;175;176;169;172;176;176;170;176;170;173 20:35:20 INFO - PROCESS | 5069 | |13;stanford-crypto-sha256-iterative;68;69;69;70;71;70;68;69;69;69 20:35:20 INFO - PROCESS | 5069 | __end_tp_report 20:35:20 INFO - PROCESS | 5069 | __start_cc_report 20:35:20 INFO - PROCESS | 5069 | _x_x_mozilla_cycle_collect,1626 20:35:20 INFO - PROCESS | 5069 | __end_cc_report 20:35:20 INFO - PROCESS | 5069 | __startTimestamp1461987320931__endTimestamp 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | ------- Summary: start ------- 20:35:20 INFO - PROCESS | 5069 | Number of tests: 14 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.20 (2.9%) stddev-sans-first:3.36 20:35:20 INFO - PROCESS | 5069 | Values: 111.0 111.0 108.0 110.0 111.0 111.0 101.0 110.0 111.0 112.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:154.00 stddev:22.61 (14.7%) stddev-sans-first:23.96 20:35:20 INFO - PROCESS | 5069 | Values: 154.0 129.0 154.0 179.0 131.0 158.0 153.0 130.0 195.0 129.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 20:35:20 INFO - PROCESS | 5069 | Values: 160.0 160.0 161.0 161.0 161.0 160.0 160.0 161.0 161.0 162.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.50 stddev:24.69 (32.3%) stddev-sans-first:25.46 20:35:20 INFO - PROCESS | 5069 | Values: 79.0 76.0 139.0 116.0 79.0 79.0 75.0 129.0 105.0 77.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:94.00 stddev:28.59 (30.4%) stddev-sans-first:29.52 20:35:20 INFO - PROCESS | 5069 | Values: 93.0 94.0 155.0 94.0 94.0 95.0 151.0 94.0 93.0 153.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:35:20 INFO - PROCESS | 5069 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 20:35:20 INFO - PROCESS | 5069 | Values: 148.0 149.0 148.0 149.0 148.0 150.0 148.0 149.0 149.0 149.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 20:35:20 INFO - PROCESS | 5069 | Values: 95.0 94.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:57.50 stddev:5.92 (10.3%) stddev-sans-first:6.27 20:35:20 INFO - PROCESS | 5069 | Values: 58.0 57.0 57.0 57.0 57.0 58.0 60.0 75.0 55.0 54.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 20:35:20 INFO - PROCESS | 5069 | Values: 65.0 63.0 64.0 64.0 64.0 66.0 65.0 64.0 64.0 64.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:3.39 (4.2%) stddev-sans-first:3.44 20:35:20 INFO - PROCESS | 5069 | Values: 78.0 83.0 78.0 78.0 79.0 79.0 79.0 86.0 87.0 81.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:128.00 stddev:9.59 (7.5%) stddev-sans-first:10.02 20:35:20 INFO - PROCESS | 5069 | Values: 125.0 130.0 131.0 124.0 127.0 129.0 123.0 126.0 156.0 126.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:175.50 stddev:2.87 (1.6%) stddev-sans-first:2.98 20:35:20 INFO - PROCESS | 5069 | Values: 175.0 176.0 169.0 172.0 176.0 176.0 170.0 176.0 170.0 173.0 20:35:20 INFO - PROCESS | 5069 | 20:35:20 INFO - PROCESS | 5069 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.87 20:35:20 INFO - PROCESS | 5069 | Values: 68.0 69.0 69.0 70.0 71.0 70.0 68.0 69.0 69.0 69.0 20:35:20 INFO - PROCESS | 5069 | -------- Summary: end -------- 20:35:20 INFO - PROCESS | 5069 | 20:35:21 INFO - TEST-INFO | 5069: exit 0 20:35:21 INFO - TEST-OK | kraken | took 61020ms 20:35:21 INFO - SUITE-END | took 1172s 20:35:22 INFO - Completed test suite (00:19:32) 20:35:22 INFO - javascript benchmark 20:35:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3029.772767042472, 3088.7220150186477, 3125.7968232064914, 3125.9843700781507, 3160.0, 5229.215617657349, 5244.921326180111, 5272.841814745559, 5288.973555132224, 5328.92006619901, 5291.973540132303, 5338.306020217376, 5412.431694672062, 5412.539934105596, 5419.5393391561765, 4824.517548245174, 4848.175810112271, 4858.514148585148, 4861.805527778884, 4889.877753056185, 4823.517648235166, 4867.756612169395, 4921.311016457699, 4933.136701077315, 4968.801247950096, 4721.291806229059, 4774.832880849189, 4931.926021109686, 4933.383327084114, 4964.131277026524, 4853.538913803219, 4875.804967801284, 4876.268559716071, 4881.682690625134, 4882.145624515695, 4783.832565860213, 4827.227643577011, 4842.806287748486, 4850.95149048512, 4851.781669824866, 5180.041692286902, 5204.505571970657, 5217.73911304437, 5218.452062533455, 5226.947730522722, 5645.633033852787, 5695.430456954313, 5697.829065128053, 5706.572007099484, 5708.914366284509, 5538.141588053858, 5625.8593535161945, 5697.202391665129, 5733.140028995643, 5757.9712101439645, 5348.946510534884, 5361.276227709287, 5380.7309634518115, 5403.945960540423, 5415.891682166334, 5819.88360232793, 5829.795957141479, 5830.242068531149, 5831.008728516163, 5833.970830145907, 5440.619156659075, 5598.10430331145, 5616.466435688603, 5623.718814059281, 5627.902559001037, 5545.140503222007, 5548.9722551387795, 5554.611177217556, 5602.579806514527, 5605.299337582802, 5525.143602741581, 5530.087535556588, 5531.170324451284, 5535.833924982257, 5536.584756143306, 5378.139497680352, 5460.372057213472, 5544.695041772741, 5568.1091025435735, 5603.2435621191435, 4330.545292744217, 4335.046289816235, 4338.197433474817, 4367.366731823931, 4373.103513779667, 3873.12854607711, 3875.457435958968, 3878.2825177342283, 3909.2963266611714, 3915.471411359487, 5209.0623687735815, 5359.732013399314, 5389.784408623689, 5403.810866619728, 5455.563554915597, 5655.151727240865, 5658.632188907708, 5672.602917795797, 5678.659280443187, 5684.090545512699, 5331.280277162611, 5354.7858085676135, 5366.356037275552, 5370.252787809006, 5417.295751552273, 4767.237242041326, 4839.104765618302, 4883.487233840467, 4919.87700307488, 4936.234883592977, 5873.295204575393, 5917.674527900921, 5927.970360148258, 5932.021216499315, 5933.58464907461, 5580.86047848807, 5703.828885133453, 5732.856678583069, 5734.483896449173, 5738.942610574008, 5799.884002320015, 5802.071668533184, 5835.7373918174635, 5840.123981402823, 5865.178874957594, 5518.586106041983, 5518.889622207614, 5523.0, 5532.336119665666, 5556.555475561864, 5626.1842032905815, 5632.183333416713, 5639.351474580476, 5639.7744090237575, 5705.030144875298, 5511.338639363302, 5518.91721624184, 5520.696361700145, 5534.501894829485, 5564.081926482247, 5500.202470641654, 5504.834854954358, 5513.3108361454815, 5514.145307477347, 5519.39286678457, 5299.655522391032, 5448.863778405572, 5454.318210223722, 5502.8349149525575, 5565.888682226414, 5490.890182196414, 5517.834464966058, 5525.254090697705, 5577.107662774099, 5651.943480565142, 5437.483439073281, 5476.288082549243, 5476.67139971603, 5489.258950041693, 5504.146857237135], "value": 5226.067078051471, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.9689231414284, 621.9222597175353, 622.2688341199091, 633.14209246471, 642.4892210692498, 30767.230819229502, 31325.686743132563, 37309.44035839465, 37881.0, 38114.04714882129, 40613.59386406135, 41370.0, 41372.37941430881, 41519.37720934188, 41576.168476630446, 8297.751067467985, 8521.872171917426, 8526.658933642648, 8529.914700853005, 8530.488170709747, 8351.457155284887, 8466.238038576526, 8491.617877195511, 8499.915000850006, 8503.362247831406, 8484.575771211446, 8577.0, 8736.8689469658, 8747.387682862201, 8749.868751968694, 8627.741167764945, 8701.56492175395, 8712.128787121268, 8713.388023215693, 8723.084076172037, 8553.529555874424, 8682.522461264627, 8687.69593064246, 8692.521911294876, 8712.085231050713, 41371.793141034104, 41784.37323440151, 41844.790776046226, 41918.58081419177, 41945.161096778196, 3476.3568739783223, 3501.5973163086314, 3512.2799826035603, 3532.8056956867363, 3669.5963444021136, 31972.84013579917, 32117.1970700732, 32118.35763284721, 32301.0, 33016.50475242873, 4273.273543497613, 4313.374560688682, 4340.565943405634, 4374.956250437487, 4447.866564003053, 323070.0, 323731.0, 325547.0, 325762.0, 327537.0, 33834.939807223294, 58033.70983145057, 59104.40895591075, 59214.70392648095, 59358.40641593615, 35401.69888957261, 35564.02103705483, 35886.28227435489, 35901.82049089738, 35902.0, 15092.0, 15240.542783716506, 15245.466408675866, 15301.311440985182, 15309.617259568377, 12712.936435317764, 12740.936295318465, 12759.872401276054, 12763.106582539318, 12763.234205947672, 8447.45091569046, 8495.277901378453, 8505.745977316015, 8562.61468233931, 8575.914240857637, 3167.8099314041233, 3193.872245110216, 3222.5971753530807, 3225.0647312279643, 3244.416005119101, 996.835522138839, 1035.49260862177, 1047.8218702820539, 1128.323006196292, 1139.8518192634904, 32141.03576892697, 32850.83574582112, 32866.67133328684, 32997.0, 33221.83389083087, 1083.2092572422175, 1107.0479387726548, 1124.960626378073, 1125.060574420368, 1190.5058901601133, 15145.394184232728, 15623.218839058001, 15746.842531574766, 16026.439074632332, 16042.197890105448, 490975.0, 496130.0, 498593.0, 500341.0, 501615.0, 58005.70997144987, 58986.0, 59086.11370829355, 59120.70439647774, 59125.70437147787, 1275.1392809853498, 1369.0, 1385.5496963486705, 1406.9366878490493, 1419.5954153066327, 30746.231344216572, 32552.0, 32787.34425311528, 32975.8351208252, 33050.0, 48172.75913620409, 49370.50629493659, 49371.25943110784, 49383.25925111198, 49443.25835112548, 325491.0, 330951.0, 333044.0, 334326.0, 334393.0, 43975.340369895115, 44487.332690009025, 45720.31419528776, 45847.31229031501, 45880.31179532377, 43521.78239108784, 48575.75712121417, 49496.0, 50195.49804502054, 50701.0, 40852.59147408607, 41490.792546037075, 42592.57407425886, 42976.14047719091, 43355.349669754345, 36319.455208172425, 41893.371599426646, 41984.58015419929, 42331.7883410581, 42706.0, 36952.44571331486, 37306.0, 37674.246515070095, 37879.62120378871, 38219.61780382161, 32411.837940810146, 33413.66586334203, 33452.330953381286, 33844.83077584596, 33897.830510847285, 25797.226083217534, 26029.6095558563, 26045.479090417706, 26425.300671694633, 26624.467510650065], "value": 18579.808882850048, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.1170965794869, 389.31286279716295, 396.548632006855, 396.8372967083495, 405.9533153687325, 18035.36876209333, 18585.163667634955, 18734.0, 18742.469766581507, 19461.0, 18619.813801861976, 18677.252909883624, 19536.218551257967, 19603.0, 19651.0, 5454.809081682142, 5459.290292262001, 5481.972590137044, 5506.256655351516, 5658.981383350995, 5311.123664595337, 5526.778928842841, 5542.473465020837, 5550.4449555044375, 5568.470995255444, 5472.425395333493, 5522.061249587559, 5522.475364840334, 5550.888982220353, 5557.110862262019, 5341.4925582069645, 5488.1493368528145, 5489.505944464978, 5498.725063746817, 5510.228568000483, 4816.494268101869, 4901.877453063702, 4921.458639549646, 4933.580645645125, 4935.90128197434, 23148.0, 23265.651015234784, 23374.415639608975, 23594.0, 23606.29181124552, 2358.5165041166692, 2411.4212588978694, 2448.963265551018, 2538.8095892808115, 2799.5800629905475, 13735.175889446666, 14236.217008064552, 14261.78607320891, 14610.31368939528, 14715.55853324402, 1923.807619238079, 1925.8459323254106, 1979.1489659446431, 1980.5939782344728, 2026.0781344488223, 80246.5987670058, 80304.0, 82376.17623823685, 82503.58748206281, 83124.58437707834, 10195.337303075425, 10489.737756556147, 10528.947355263175, 10648.520816563274, 10853.131749460024, 14632.414703411958, 14635.414583416758, 14709.264536773333, 14711.0, 14747.115173089649, 8047.315978141806, 8227.341812654973, 8277.54473503951, 8416.452930559493, 8523.95738021306, 8128.431009829255, 8146.963259185204, 8147.714829981041, 8316.334693224528, 8336.333093352518, 6465.77369792055, 6664.333566643297, 6738.0, 6774.762883299061, 6876.449884009267, 1754.876599314818, 1856.675081860669, 1880.6238752249606, 1889.4803928919382, 1894.725264836591, 890.105444028747, 983.7294743945472, 990.2820455170088, 1030.948452577383, 1080.9729756756144, 18967.525811854815, 19102.595390952163, 19706.408807735792, 19725.704114438297, 19936.0, 1051.8159322118752, 1052.826283663187, 1055.8785739639886, 1058.7882423515327, 1077.6012875236213, 10586.841197382046, 11343.773124537463, 11432.0, 11439.885601143882, 11450.484728187252, 457273.0, 459027.0, 459923.0, 462041.0, 463446.0, 82443.5877820619, 82725.0, 82921.0, 82980.0, 83006.0, 1016.9898301017043, 1051.5005372448027, 1071.089573862211, 1076.8438576406534, 1080.9405482698528, 16292.837071629132, 16605.91697041507, 16748.330066797193, 16979.745303820204, 17105.14474276306, 35035.29929401448, 36416.635833641325, 36446.0, 37444.25111497809, 37637.811810941865, 49116.263256051905, 51112.23331650103, 52105.47894521006, 52109.47890521198, 52501.7374913123, 8436.325093992344, 8665.267649301722, 8724.56377181151, 8856.424332418372, 8870.556472176495, 12611.684707882376, 13266.0, 13356.332183390987, 13450.46198152063, 13598.11612245201, 11668.299902005907, 11925.0, 12145.453454594388, 12213.267203967791, 12270.877291226974, 11412.543498259976, 11633.770889609117, 11760.529578816751, 11944.462499187732, 11948.641540753792, 11985.880141198477, 12019.879801202225, 12071.879281207075, 12315.261084334968, 12342.568010119961, 8527.360447966303, 8561.48631082137, 8602.354823388147, 8687.305015598611, 8776.868346974928, 11366.0, 11949.64151075469, 12106.75786484283, 12180.634580962585, 12212.0], "value": 9281.300470958682, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.9563915262968, 1291.5221368093808, 1351.4459071780573, 1374.2647683489333, 1721.5696075980998, 7684.692612295508, 7946.801329966739, 7958.0, 7958.681652733883, 7966.044074711028, 7913.683452661887, 8148.388870834697, 8157.0211574610985, 8159.5104293742415, 8165.34677225822, 2030.9492262693402, 2083.2500299892104, 2086.3740877736695, 2282.7374851891996, 2331.0442718485424, 2287.1994801819396, 2351.447409858682, 2352.5765362234793, 2355.0, 2355.1403737635724, 2250.1449449209276, 2273.8521996070203, 2293.919712810052, 2302.896369663361, 2304.9884750576225, 1980.7028945658124, 2036.643587372204, 2290.518991011881, 2301.2060839010596, 2302.0561569756405, 2037.0731317250763, 2198.9450263743533, 2264.445210923318, 2266.0935625749667, 2266.795988361039, 7952.284294413531, 8009.759707208793, 8030.718924837661, 8033.317168040723, 8037.638306276232, 4853.150698627726, 5017.623678224148, 5050.419201791804, 5070.974645126787, 5072.315237442935, 3162.9525557116663, 3193.8562764675644, 3215.6623554526905, 3366.4445366514497, 3427.0232983599803, 1054.204075922681, 1055.1875056206754, 1058.449606204777, 1068.513826209081, 1069.893010698924, 11234.382108984002, 11237.550497980154, 11269.211155219138, 11308.37803920784, 11308.830367544493, 4485.452518880981, 4547.317902314613, 4583.197940360424, 4593.333966574828, 4594.150082234797, 9691.12779849817, 9693.9030609693, 9698.272629552812, 9739.659111931049, 9743.171830394496, 5107.208382700687, 5155.407128180233, 5156.149235376196, 5157.8452646420665, 5170.095233334151, 4136.234796562646, 4567.725936443824, 4630.675852690347, 4678.041001594733, 4697.295405689174, 3819.427085937132, 3845.1540661054523, 3851.345271303885, 3920.9607903921165, 3930.3711406174875, 1226.2274766896799, 1232.8335674683804, 1234.1484375780683, 1234.7530493901256, 1239.2688313894846, 971.4317124482257, 979.4661909259471, 982.6167794560128, 994.6518718448485, 1007.7883644434604, 5560.777568897199, 5564.805231816867, 5599.776008959596, 5766.740496677659, 5879.764809407576, 442.5309172277396, 460.2199272233599, 460.4842576314549, 465.22075523498006, 467.94618618858584, 3768.397056471006, 4034.435179074932, 4057.411675307064, 4063.7358571692744, 4093.1813637272667, 9310.441373517611, 9561.139497445125, 9659.951700241454, 9664.226861851035, 9729.318947673595, 9460.432374057578, 9615.423074615546, 9638.277129215337, 9672.0, 9677.225821934227, 7124.5725256484775, 7167.498275120795, 7204.53170543913, 7255.0, 7317.670704818296, 5527.39198688152, 5589.55283577321, 5630.339049980347, 5650.434956504317, 5709.22925405065, 8964.910350896407, 8976.237019853386, 9023.503707296162, 9032.14194651507, 9064.048274931038, 9070.956118391436, 9072.183503484717, 9146.771330716785, 9161.86257206129, 9324.11420915012, 6616.801495955129, 6959.304069593, 7064.470164737562, 7118.85762284741, 7202.71189152449, 7706.845863082594, 7727.9227207729455, 7738.574378409242, 7761.805954851174, 7811.2188781123705, 6918.965405172942, 7007.614581198083, 7110.288971102848, 7126.857462850818, 7153.3919616833155, 6917.757878474229, 6923.653817309215, 6955.791326260221, 6988.8951665724035, 7033.577985320897, 6329.461995730415, 6341.0, 6360.268569114426, 6366.140571022853, 6432.9678351607945, 4908.8772780680765, 4910.729909854992, 5009.899802004013, 5010.949890501194, 5041.193409054534, 5008.499150084962, 5044.167712327425, 5072.949270507248, 5080.212567052113, 5161.741912904415], "value": 4277.888947964259, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.86365998960457, 324.30436713250094, 325.4110060789971, 326.36847699701065, 328.0535654636374, 4838.927416088762, 4970.6520543561965, 5139.383274007115, 5210.348706411699, 5265.183896496044, 5045.54590086893, 5204.42751297357, 5205.0370681423865, 5241.723922548407, 5250.238715386266, 4106.0, 4107.069677251702, 4110.732802367851, 4122.196171746511, 4125.608067233608, 3896.045468860119, 3941.4284928685465, 4081.204165187775, 4105.876823695294, 4125.443065186207, 4016.6385025347713, 4051.311277082903, 4065.695072869532, 4079.2045551117544, 4092.909853060935, 4063.613956674141, 4072.6945479089186, 4076.3070278052655, 4101.79491025449, 4120.320147175712, 3648.087978005499, 3648.121217572952, 3651.47053677218, 3656.579493358271, 3658.2317713280245, 4850.733209673466, 5066.923996140061, 5067.163917953533, 5074.4120498545635, 5090.363704536933, 4495.9325610115875, 4606.355110284563, 4646.767661616906, 4651.116287905287, 4668.626509879202, 5353.652012619206, 5435.537979271767, 5447.155690867922, 5463.48096930791, 5476.371341755979, 3933.7049721270732, 4001.8399264029404, 4002.199560087965, 4009.0, 4013.979930100331, 5630.943690563083, 5657.57568182388, 5663.971680141614, 5734.397888221718, 5736.74184661687, 4096.651784598283, 4110.219058378899, 4110.588941105925, 4117.876463706094, 4139.130782535641, 4169.624733773914, 4177.352510360899, 4178.22702799983, 4180.749155050707, 4198.517170525429, 4538.819906824249, 4647.34937108805, 4667.369905062841, 4679.227927391942, 4691.3432119503295, 5459.372172200168, 5483.8338856151595, 5494.088133289283, 5506.449355064542, 5513.531349835229, 1502.8797696184279, 1503.624093976506, 1512.7579587266205, 1514.5986313626897, 1515.3484001879299, 1001.6344034427527, 1027.712240572641, 1028.943408112561, 1032.5818043692316, 1033.116685234114, 5487.807926722546, 5535.861603459945, 5552.972235138798, 5556.611037227436, 5596.356419011784, 5899.351071382144, 5915.408459154136, 5932.762689492372, 5957.4638282553915, 5976.462118409364, 5377.919331210035, 5571.164325351148, 5576.637518561281, 5577.3028371453565, 5593.776248949996, 3135.9181082526493, 3165.09794708507, 3175.523671449301, 3178.1419016865316, 3189.3940151371166, 5902.625164822068, 6046.246588489377, 6085.695715214221, 6096.329403765582, 6111.280480186363, 5471.206675032098, 5576.693281869536, 5620.381758006616, 5627.380988091307, 5965.194698715704, 5841.328247251536, 5849.502792262705, 5852.356240813422, 5855.502282306052, 5871.735771890189, 5491.395946445968, 5546.694931778791, 5620.414609279777, 5621.606487545832, 5627.943720562906, 5532.510370333446, 5553.8333849984565, 5559.91581641576, 5572.972135139298, 5587.832365029056, 5779.826605201851, 5790.449907258803, 5805.738741756715, 5825.3592104867585, 5851.795187168429, 3898.337282662011, 3988.3618621020496, 3995.10110225197, 4002.4396584478777, 4017.2969730296495, 5634.774609015757, 5642.379338272704, 5665.575081868794, 5671.688057156731, 5689.914651280317, 5507.642003269774, 5516.586256030733, 5520.475554822286, 5525.530329922001, 5529.672878509209, 5259.526642602184, 5485.149801780731, 5493.807716729895, 5497.900419916113, 5522.806701765419, 5380.381256155592, 5411.78352865881, 5412.373709614489, 5417.322834645669, 5425.240466334795, 5340.572754179579, 5524.1989911463415, 5565.471280228372, 5567.415421380697, 5574.77700891976, 5432.0765469871, 5464.836054918359, 5477.603211181124, 5487.560995120461, 5489.972550137224], "value": 4240.164590818057, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.6611358774963, 771.3096778383343, 791.817881887166, 805.9435839491235, 837.8533756592597, 14310.642233944156, 14592.270386480686, 14636.268186590682, 14683.853161468382, 14744.6313842154, 13466.596002119952, 13501.527446539349, 13510.121842080258, 13558.254296013716, 13577.93211033946, 666.4701562257992, 780.9921900781005, 803.9959800201005, 815.946963447377, 819.1971867569786, 801.7915342011061, 809.5304723260494, 811.6591031766643, 812.3947658994028, 812.5612169428501, 858.5321000054985, 858.8926384201975, 860.9483430994161, 861.0399404663787, 861.8147098373848, 703.3669697272445, 824.8391563645091, 846.4878748357278, 847.5380917400032, 848.9533075680835, 620.0389396435507, 620.2371083567192, 621.5680102328884, 624.3943374926314, 626.896562067263, 13786.517471888435, 13797.724045519133, 13816.654583635389, 13839.654008649764, 13841.238731869744, 12616.873831261753, 12817.23096614206, 12921.353932303347, 12998.155119917175, 13664.180149191081, 11053.336799792038, 11089.0, 11199.104071674246, 11225.775484490265, 11493.425328733614, 3773.641504057138, 3791.1848952475075, 3880.3209438348176, 3881.243157584272, 3926.0773718176492, 48054.0, 49320.260196097086, 49354.50645493535, 49380.259296110584, 49606.50393496055, 9413.717588472357, 9618.374805637612, 9671.274654400948, 10195.949020254851, 10530.73673158162, 18300.26798928028, 18318.084095795424, 18537.165827537792, 18630.627387452176, 18786.154623041995, 8373.413861029669, 8440.409171357946, 8532.786680333042, 8543.871841922377, 8548.786280342916, 4679.836205732783, 4702.6473014524045, 4769.976150119227, 4837.588804951548, 4917.901641967141, 3409.1988382730037, 3498.965010349915, 3504.404251277289, 3505.106197919514, 3518.40187168182, 646.1277275677797, 654.3227759269133, 670.6981858163846, 671.5064427645676, 702.1714377035046, 752.1575835064654, 762.7025460070577, 767.85794627994, 790.0874489964101, 793.8491686579531, 9359.15767580921, 9635.56639951204, 9741.853872191923, 9767.51162441875, 9788.265880059023, 648.4876947211744, 679.7247114918466, 737.4432303610739, 764.2319468933686, 779.4465929190225, 4514.0971805639, 4638.253130621521, 4729.172394830891, 4752.738599377068, 4833.347498087714, 56719.43280567224, 56989.43010569841, 57112.14331785026, 59071.0, 66306.66846665736, 47933.76033119882, 52427.73786131121, 53780.731096344265, 53892.0, 54906.72546637321, 48437.27344089842, 48562.27156592654, 48924.75537622289, 49079.26381104286, 49271.01457970821, 9420.105090016437, 9420.152186303265, 9482.762930926781, 9510.286728495528, 9510.904890951002, 32228.19429514281, 32255.0, 32710.0, 33214.335713286084, 33874.661253388134, 40768.0, 44012.33981490344, 44847.32729009002, 45511.31733023941, 45754.77122614365, 11437.828432573351, 11843.0, 11895.0, 12064.939675301568, 12103.455344509342, 12389.380530973596, 13365.331733413484, 13917.443302267797, 14181.078229915023, 14218.857811421753, 12350.505979760708, 12528.436220370288, 12571.057170712416, 12924.159929604546, 13524.729505410034, 12444.502219911103, 13075.084744068205, 13115.737685246433, 13323.866761332263, 13598.184108953494, 11788.174827761974, 12480.126391152895, 12821.871781282067, 13015.349232538147, 13118.0, 10295.94852025735, 10606.893931060898, 10655.733606659585, 11008.119350452105, 11300.378479183724, 10898.455077246264, 11039.227254092457, 11058.22592418523, 11100.944495277472, 11187.664370068911], "value": 6721.480421596117, "unit": "score"}], "name": "dromaeo_css", "value": 6920.8258225800755, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 108.0, 110.0, 111.0, 111.0, 101.0, 110.0, 111.0, 112.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 154.0, 179.0, 131.0, 158.0, 153.0, 130.0, 195.0, 129.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 139.0, 116.0, 79.0, 79.0, 75.0, 129.0, 105.0, 77.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 155.0, 94.0, 94.0, 95.0, 151.0, 94.0, 93.0, 153.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 148.0, 150.0, 148.0, 149.0, 149.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 58.0, 60.0, 75.0, 55.0, 54.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 64.0, 64.0, 66.0, 65.0, 64.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 78.0, 78.0, 79.0, 79.0, 79.0, 86.0, 87.0, 81.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 131.0, 124.0, 127.0, 129.0, 123.0, 126.0, 156.0, 126.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 169.0, 172.0, 176.0, 176.0, 170.0, 176.0, 170.0, 173.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 70.0, 71.0, 70.0, 68.0, 69.0, 69.0, 69.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1564.6, "alertThreshold": 2.0}]} 20:35:22 INFO - Return code: 0 20:35:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:35:22 ERROR - # TBPL SUCCESS # 20:35:22 INFO - Running post-action listener: _resource_record_post_action 20:35:22 INFO - Running post-run listener: _resource_record_post_run 20:35:23 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538832896; Read time: 8; Write time: 416852 20:35:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 214790144; Read time: 0; Write time: 201304 20:35:23 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293912576; Read time: 8; Write time: 210860 20:35:23 INFO - Running post-run listener: _upload_blobber_files 20:35:23 INFO - Blob upload gear active. 20:35:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:35:23 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 20:35:23 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:35:23 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:35:23 INFO - (blobuploader) - INFO - Open directory for files ... 20:35:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:35:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:35:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:24 INFO - (blobuploader) - INFO - Done attempting. 20:35:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:35:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:35:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:25 INFO - (blobuploader) - INFO - Done attempting. 20:35:25 INFO - (blobuploader) - INFO - Iteration through files over. 20:35:25 INFO - Return code: 0 20:35:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:35:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:35:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ed4bd89530e49361885eb14fbaa2781dc13ab43c4fa17c62aa3d8f8df14de0e16e13614dd79a2e0f76aa13a7dde7ef68fad158c164e8c5ffaf77cb227b3509f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/119ca5da1eae2c2e2c931e970e820fbb4434abb2c73caef41324b2e4a1d58e51af2704bef214e96d3f03f847c81436b2c385d603c09b835680dfffb1b103983d"} 20:35:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:35:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:35:25 INFO - Contents: 20:35:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ed4bd89530e49361885eb14fbaa2781dc13ab43c4fa17c62aa3d8f8df14de0e16e13614dd79a2e0f76aa13a7dde7ef68fad158c164e8c5ffaf77cb227b3509f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/119ca5da1eae2c2e2c931e970e820fbb4434abb2c73caef41324b2e4a1d58e51af2704bef214e96d3f03f847c81436b2c385d603c09b835680dfffb1b103983d"} 20:35:25 INFO - Running post-run listener: copy_logs_to_upload_dir 20:35:25 INFO - Copying logs to upload dir... 20:35:25 INFO - mkdir: /builds/slave/test/build/upload/logs 20:35:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.727429 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-29 20:35:25.035209) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 20:35:25.038718) ========= 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-1461985749.892754-902876798 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/sha512/2ed4bd89530e49361885eb14fbaa2781dc13ab43c4fa17c62aa3d8f8df14de0e16e13614dd79a2e0f76aa13a7dde7ef68fad158c164e8c5ffaf77cb227b3509f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/119ca5da1eae2c2e2c931e970e820fbb4434abb2c73caef41324b2e4a1d58e51af2704bef214e96d3f03f847c81436b2c385d603c09b835680dfffb1b103983d"} build_url:https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011129 build_url: 'https://queue.taskcluster.net/v1/task/Fi5UACmNQiOf16KqCLxsnA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ed4bd89530e49361885eb14fbaa2781dc13ab43c4fa17c62aa3d8f8df14de0e16e13614dd79a2e0f76aa13a7dde7ef68fad158c164e8c5ffaf77cb227b3509f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/119ca5da1eae2c2e2c931e970e820fbb4434abb2c73caef41324b2e4a1d58e51af2704bef214e96d3f03f847c81436b2c385d603c09b835680dfffb1b103983d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 20:35:25.068548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 20:35:25.068948) ========= 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-1461985749.892754-902876798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 20:35:25.153100) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 20:35:25.153431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 20:35:25.153733) ========= ========= Total master_lag: 0.17 =========