builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1461563432.8 results: success (0) buildid: 20160424221650 builduid: 36cac20aebb0420f866366d653b76dc1 revision: 0225961ad7adbef25e670abf314ec67f5e6c224d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:32.803767) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:32.804200) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:32.804465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:32.829529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:32.829828) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 22:50:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 106M=0s 2016-04-24 22:50:32 (106 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080974 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:32.926110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:32.926399) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019484 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:32.984152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-24 22:50:32.984491) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0225961ad7adbef25e670abf314ec67f5e6c224d --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 0225961ad7adbef25e670abf314ec67f5e6c224d --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=5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 22:50:33,085 truncating revision to first 12 chars 2016-04-24 22:50:33,085 Setting DEBUG logging. 2016-04-24 22:50:33,085 attempt 1/10 2016-04-24 22:50:33,085 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0225961ad7ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 22:50:33,897 unpacking tar archive at: fx-team-0225961ad7ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.101119 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-24 22:50:34.098561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:34.098824) ========= script_repo_revision: 0225961ad7adbef25e670abf314ec67f5e6c224d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:34.099196) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:34.099453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 22:50:34.108953) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-24 22:50:34.109226) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:50:34 INFO - MultiFileLogger online at 20160424 22:50:34 in /builds/slave/test 22:50:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:50:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:50:34 INFO - {'append_to_log': False, 22:50:34 INFO - 'base_work_dir': '/builds/slave/test', 22:50:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:50:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:50:34 INFO - 'branch': 'Fx-Team-Non-PGO', 22:50:34 INFO - 'buildbot_json_path': 'buildprops.json', 22:50:34 INFO - 'config_files': ('talos/linux_config.py',), 22:50:34 INFO - 'default_actions': ('clobber', 22:50:34 INFO - 'read-buildbot-config', 22:50:34 INFO - 'download-and-extract', 22:50:34 INFO - 'populate-webroot', 22:50:34 INFO - 'create-virtualenv', 22:50:34 INFO - 'install', 22:50:34 INFO - 'run-tests'), 22:50:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:50:34 INFO - 'download_minidump_stackwalk': True, 22:50:34 INFO - 'download_symbols': 'ondemand', 22:50:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:50:34 INFO - 'tooltool.py': '/tools/tooltool.py', 22:50:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:50:34 INFO - '/tools/misc-python/virtualenv.py')}, 22:50:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:50:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:50:34 INFO - 'installer_path': 'installer.exe', 22:50:34 INFO - 'log_level': 'info', 22:50:34 INFO - 'log_name': 'talos', 22:50:34 INFO - 'log_to_console': True, 22:50:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:50:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:50:34 INFO - 'opt_config_files': (), 22:50:34 INFO - 'pip_index': False, 22:50:34 INFO - 'sps_profile': False, 22:50:34 INFO - 'sps_profile_interval': 0, 22:50:34 INFO - 'suite': 'dromaeojs', 22:50:34 INFO - 'system_bits': '32', 22:50:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:50:34 INFO - 'title': 'talos-linux64-ix-039', 22:50:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:50:34 INFO - 'use_talos_json': True, 22:50:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:50:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:50:34 INFO - 'work_dir': 'build'} 22:50:34 INFO - ##### 22:50:34 INFO - ##### Running clobber step. 22:50:34 INFO - ##### 22:50:34 INFO - Running pre-action listener: _resource_record_pre_action 22:50:34 INFO - Running main action method: clobber 22:50:34 INFO - rmtree: /builds/slave/test/build 22:50:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:50:35 INFO - Running post-action listener: _resource_record_post_action 22:50:35 INFO - ##### 22:50:35 INFO - ##### Running read-buildbot-config step. 22:50:35 INFO - ##### 22:50:35 INFO - Running pre-action listener: _resource_record_pre_action 22:50:35 INFO - Running main action method: read_buildbot_config 22:50:35 INFO - Using buildbot properties: 22:50:35 INFO - { 22:50:35 INFO - "project": "", 22:50:35 INFO - "product": "firefox", 22:50:35 INFO - "script_repo_revision": "production", 22:50:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:50:35 INFO - "repository": "", 22:50:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:50:35 INFO - "buildid": "20160424221650", 22:50:35 INFO - "pgo_build": "False", 22:50:35 INFO - "basedir": "/builds/slave/test", 22:50:35 INFO - "buildnumber": 1598, 22:50:35 INFO - "slavename": "talos-linux64-ix-039", 22:50:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:50:35 INFO - "platform": "ubuntu64_hw", 22:50:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:50:35 INFO - "branch": "fx-team", 22:50:35 INFO - "repo_path": "integration/fx-team", 22:50:35 INFO - "revision": "0225961ad7adbef25e670abf314ec67f5e6c224d", 22:50:35 INFO - "stage_platform": "linux64", 22:50:35 INFO - "builduid": "36cac20aebb0420f866366d653b76dc1", 22:50:35 INFO - "slavebuilddir": "test" 22:50:35 INFO - } 22:50:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:50:35 INFO - Running post-action listener: _resource_record_post_action 22:50:35 INFO - ##### 22:50:35 INFO - ##### Running download-and-extract step. 22:50:35 INFO - ##### 22:50:35 INFO - Running pre-action listener: _resource_record_pre_action 22:50:35 INFO - Running main action method: download_and_extract 22:50:35 INFO - mkdir: /builds/slave/test/build/tests 22:50:35 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')]} 22:50:35 INFO - https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:50:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:50:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:50:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:50:46 INFO - Downloaded 1361 bytes. 22:50:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:50:46 INFO - Using the following test package requirements: 22:50:46 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:50:46 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:50:46 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:50:46 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:46 INFO - u'jsshell-linux-x86_64.zip'], 22:50:46 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:50:46 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:50:46 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:50:46 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:50:46 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:50:46 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:50:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:46 INFO - https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:50:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:50:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:50:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:50:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:50:55 INFO - Downloaded 22285608 bytes. 22:50:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:50:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:50:56 INFO - Return code: 0 22:50:56 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:56 INFO - https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:50:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:50:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:50:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:50:58 INFO - Downloaded 22285608 bytes. 22:50:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:50:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:50:59 INFO - Return code: 0 22:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:59 INFO - https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:50:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:50:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:50:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:51:00 INFO - Downloaded 10840145 bytes. 22:51:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:51:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:51:00 INFO - Return code: 0 22:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:00 INFO - https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:51:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:51:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:51:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:51:02 INFO - Downloaded 54733026 bytes. 22:51:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:51:02 INFO - mkdir: /builds/slave/test/properties 22:51:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:51:02 INFO - Writing to file /builds/slave/test/properties/build_url 22:51:02 INFO - Contents: 22:51:02 INFO - build_url:https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:51:03 INFO - Running post-action listener: _resource_record_post_action 22:51:03 INFO - Running post-action listener: set_extra_try_arguments 22:51:03 INFO - ##### 22:51:03 INFO - ##### Running populate-webroot step. 22:51:03 INFO - ##### 22:51:03 INFO - Running pre-action listener: _resource_record_pre_action 22:51:03 INFO - Running main action method: populate_webroot 22:51:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:51:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:51:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:51:03 INFO - '--tppagecycles', 22:51:03 INFO - '7'], 22:51:03 INFO - 'tests': ['tsvgm']}}, 22:51:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:51:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:51:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:51:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:51:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:51:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:51:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:03 INFO - 'talos_options': ['--disable-e10s'], 22:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:51:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:51:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:03 INFO - 'talos_options': ['--disable-e10s'], 22:51:03 INFO - 'tests': ['damp', 'tps']}, 22:51:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:03 INFO - 'tests': ['damp', 'tps']}, 22:51:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:51:03 INFO - 'tests': ['dromaeo_dom']}, 22:51:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:51:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:51:03 INFO - 'tests': ['a11yr', 22:51:03 INFO - 'ts_paint', 22:51:03 INFO - 'tpaint', 22:51:03 INFO - 'sessionrestore', 22:51:03 INFO - 'sessionrestore_no_auto_restore', 22:51:03 INFO - 'tabpaint']}, 22:51:03 INFO - 'other-e10s': {'tests': ['a11yr', 22:51:03 INFO - 'ts_paint', 22:51:03 INFO - 'tpaint', 22:51:03 INFO - 'sessionrestore', 22:51:03 INFO - 'sessionrestore_no_auto_restore', 22:51:03 INFO - 'tabpaint']}, 22:51:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:51:03 INFO - 'ts_paint', 22:51:03 INFO - 'tpaint', 22:51:03 INFO - 'sessionrestore', 22:51:03 INFO - 'sessionrestore_no_auto_restore', 22:51:03 INFO - 'tabpaint']}, 22:51:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:51:03 INFO - 'ts_paint', 22:51:03 INFO - 'tpaint', 22:51:03 INFO - 'sessionrestore', 22:51:03 INFO - 'sessionrestore_no_auto_restore', 22:51:03 INFO - 'tabpaint']}, 22:51:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:51:03 INFO - 'tests': ['a11yr', 22:51:03 INFO - 'ts_paint', 22:51:03 INFO - 'tpaint', 22:51:03 INFO - 'sessionrestore', 22:51:03 INFO - 'sessionrestore_no_auto_restore', 22:51:03 INFO - 'tabpaint']}, 22:51:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:51:03 INFO - 'tests': ['a11yr', 22:51:03 INFO - 'ts_paint', 22:51:03 INFO - 'tpaint', 22:51:03 INFO - 'sessionrestore', 22:51:03 INFO - 'sessionrestore_no_auto_restore', 22:51:03 INFO - 'tabpaint']}, 22:51:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:51:03 INFO - 'tests': ['tsvgx', 22:51:03 INFO - 'tsvgr_opacity', 22:51:03 INFO - 'tart', 22:51:03 INFO - 'tscrollx', 22:51:03 INFO - 'cart']}, 22:51:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:51:03 INFO - 'tsvgr_opacity', 22:51:03 INFO - 'tart', 22:51:03 INFO - 'tscrollx', 22:51:03 INFO - 'cart']}, 22:51:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:03 INFO - 'talos_options': ['--disable-e10s'], 22:51:03 INFO - 'tests': ['tp5o']}, 22:51:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:03 INFO - 'tests': ['tp5o']}, 22:51:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:03 INFO - 'talos_options': ['--disable-e10s', 22:51:03 INFO - '--xperf_path', 22:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:51:03 INFO - 'tests': ['tp5n']}, 22:51:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:03 INFO - 'talos_options': ['--xperf_path', 22:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:51:03 INFO - 'tests': ['tp5n']}}, 22:51:03 INFO - 'talos.zip': {'path': '', 22:51:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:51:03 INFO - Running post-action listener: _resource_record_post_action 22:51:03 INFO - ##### 22:51:03 INFO - ##### Running create-virtualenv step. 22:51:03 INFO - ##### 22:51:03 INFO - Running pre-action listener: _resource_record_pre_action 22:51:03 INFO - Running main action method: create_virtualenv 22:51:03 INFO - Creating virtualenv /builds/slave/test/build/venv 22:51:03 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 22:51:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:51:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:51:03 INFO - Using real prefix '/usr' 22:51:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:51:04 INFO - Installing distribute.............................................................................................................................................................................................done. 22:51:06 INFO - Installing pip.................done. 22:51:06 INFO - Return code: 0 22:51:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:51:06 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')]} 22:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:06 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')]} 22:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:06 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 0x7f41f10a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177410>, '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 0x2178310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21787a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', '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 22:51:06 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 22:51:06 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 22:51:06 INFO - Using env: {'DISPLAY': ':0', 22:51:06 INFO - 'HOME': '/home/cltbld', 22:51:06 INFO - 'LANG': 'en_US.UTF-8', 22:51:06 INFO - 'LANGUAGE': 'en_US:en', 22:51:06 INFO - 'LOGNAME': 'cltbld', 22:51:06 INFO - 'MAIL': '/var/mail/cltbld', 22:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:06 INFO - 'MOZ_NO_REMOTE': '1', 22:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:06 INFO - 'NO_EM_RESTART': '1', 22:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:06 INFO - 'PWD': '/builds/slave/test', 22:51:06 INFO - 'SHELL': '/bin/bash', 22:51:06 INFO - 'SHLVL': '1', 22:51:06 INFO - 'TERM': 'linux', 22:51:06 INFO - 'TMOUT': '86400', 22:51:06 INFO - 'USER': 'cltbld', 22:51:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', 22:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:06 INFO - '_': '/tools/buildbot/bin/python'} 22:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:06 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 22:51:06 INFO - Cleaning up... 22:51:06 INFO - Return code: 0 22:51:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:51:06 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')]} 22:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:06 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')]} 22:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:06 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 0x7f41f10a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177410>, '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 0x2178310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21787a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', '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 22:51:06 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 22:51:06 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 22:51:06 INFO - Using env: {'DISPLAY': ':0', 22:51:06 INFO - 'HOME': '/home/cltbld', 22:51:06 INFO - 'LANG': 'en_US.UTF-8', 22:51:06 INFO - 'LANGUAGE': 'en_US:en', 22:51:06 INFO - 'LOGNAME': 'cltbld', 22:51:06 INFO - 'MAIL': '/var/mail/cltbld', 22:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:06 INFO - 'MOZ_NO_REMOTE': '1', 22:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:06 INFO - 'NO_EM_RESTART': '1', 22:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:06 INFO - 'PWD': '/builds/slave/test', 22:51:06 INFO - 'SHELL': '/bin/bash', 22:51:06 INFO - 'SHLVL': '1', 22:51:06 INFO - 'TERM': 'linux', 22:51:06 INFO - 'TMOUT': '86400', 22:51:06 INFO - 'USER': 'cltbld', 22:51:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', 22:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:06 INFO - '_': '/tools/buildbot/bin/python'} 22:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:06 INFO - Downloading/unpacking psutil>=0.7.1 22:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:51:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:51:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:51:08 INFO - Installing collected packages: psutil 22:51:08 INFO - Running setup.py install for psutil 22:51:08 INFO - building 'psutil._psutil_linux' extension 22:51:08 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 22:51:08 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 22:51:08 INFO - building 'psutil._psutil_posix' extension 22:51:08 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 22:51:08 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 22:51:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:51:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:51:09 INFO - Successfully installed psutil 22:51:09 INFO - Cleaning up... 22:51:09 INFO - Return code: 0 22:51:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:51: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')]} 22:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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', '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 0x7f41f10a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177410>, '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 0x2178310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21787a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', '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 22:51: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:51: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 mozsystemmonitor==0.0.0 22:51:09 INFO - Using env: {'DISPLAY': ':0', 22:51:09 INFO - 'HOME': '/home/cltbld', 22:51:09 INFO - 'LANG': 'en_US.UTF-8', 22:51:09 INFO - 'LANGUAGE': 'en_US:en', 22:51:09 INFO - 'LOGNAME': 'cltbld', 22:51:09 INFO - 'MAIL': '/var/mail/cltbld', 22:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:09 INFO - 'MOZ_NO_REMOTE': '1', 22:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:09 INFO - 'NO_EM_RESTART': '1', 22:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:09 INFO - 'PWD': '/builds/slave/test', 22:51:09 INFO - 'SHELL': '/bin/bash', 22:51:09 INFO - 'SHLVL': '1', 22:51:09 INFO - 'TERM': 'linux', 22:51:09 INFO - 'TMOUT': '86400', 22:51:09 INFO - 'USER': 'cltbld', 22:51:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', 22:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:09 INFO - '_': '/tools/buildbot/bin/python'} 22:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:51: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 22:51: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 22:51: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 22:51: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 22:51: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 22:51: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 22:51:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:51:11 INFO - Installing collected packages: mozsystemmonitor 22:51:11 INFO - Running setup.py install for mozsystemmonitor 22:51:11 INFO - Successfully installed mozsystemmonitor 22:51:11 INFO - Cleaning up... 22:51:11 INFO - Return code: 0 22:51:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:11 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 0x7f41f10a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177410>, '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 0x2178310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21787a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', '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 22:51:11 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 22:51:11 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 22:51:11 INFO - Using env: {'DISPLAY': ':0', 22:51:11 INFO - 'HOME': '/home/cltbld', 22:51:11 INFO - 'LANG': 'en_US.UTF-8', 22:51:11 INFO - 'LANGUAGE': 'en_US:en', 22:51:11 INFO - 'LOGNAME': 'cltbld', 22:51:11 INFO - 'MAIL': '/var/mail/cltbld', 22:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:11 INFO - 'MOZ_NO_REMOTE': '1', 22:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:11 INFO - 'NO_EM_RESTART': '1', 22:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:11 INFO - 'PWD': '/builds/slave/test', 22:51:11 INFO - 'SHELL': '/bin/bash', 22:51:11 INFO - 'SHLVL': '1', 22:51:11 INFO - 'TERM': 'linux', 22:51:11 INFO - 'TMOUT': '86400', 22:51:11 INFO - 'USER': 'cltbld', 22:51:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', 22:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:11 INFO - '_': '/tools/buildbot/bin/python'} 22:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:11 INFO - Downloading/unpacking blobuploader==1.2.4 22:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:13 INFO - Downloading blobuploader-1.2.4.tar.gz 22:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:51:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:51:13 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 22:51:13 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 22:51:13 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 22:51:13 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 22:51:13 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 22:51:13 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 22:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:51:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:51:13 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 22:51:13 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 22:51:13 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 22:51:13 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 22:51:13 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 22:51:13 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 22:51:14 INFO - Downloading docopt-0.6.1.tar.gz 22:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:51:14 INFO - Installing collected packages: blobuploader, requests, docopt 22:51:14 INFO - Running setup.py install for blobuploader 22:51:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:51:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:51:14 INFO - Running setup.py install for requests 22:51:14 INFO - Running setup.py install for docopt 22:51:14 INFO - Successfully installed blobuploader requests docopt 22:51:14 INFO - Cleaning up... 22:51:14 INFO - Return code: 0 22:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:51: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')]} 22:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:14 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 0x7f41f10a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177410>, '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 0x2178310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21787a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', '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 22:51:14 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 22:51:14 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 22:51:14 INFO - Using env: {'DISPLAY': ':0', 22:51:14 INFO - 'HOME': '/home/cltbld', 22:51:14 INFO - 'LANG': 'en_US.UTF-8', 22:51:14 INFO - 'LANGUAGE': 'en_US:en', 22:51:14 INFO - 'LOGNAME': 'cltbld', 22:51:14 INFO - 'MAIL': '/var/mail/cltbld', 22:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:14 INFO - 'MOZ_NO_REMOTE': '1', 22:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:14 INFO - 'NO_EM_RESTART': '1', 22:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:14 INFO - 'PWD': '/builds/slave/test', 22:51:14 INFO - 'SHELL': '/bin/bash', 22:51:14 INFO - 'SHLVL': '1', 22:51:14 INFO - 'TERM': 'linux', 22:51:14 INFO - 'TMOUT': '86400', 22:51:14 INFO - 'USER': 'cltbld', 22:51:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', 22:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:14 INFO - '_': '/tools/buildbot/bin/python'} 22:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:51:15 INFO - Running setup.py (path:/tmp/pip-2vlNfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:51:15 INFO - Running setup.py (path:/tmp/pip-8X8oSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:51:15 INFO - Running setup.py (path:/tmp/pip-Ramiza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:51:15 INFO - Running setup.py (path:/tmp/pip-gACyFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:51:15 INFO - Running setup.py (path:/tmp/pip-fCLUxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:51:15 INFO - Running setup.py (path:/tmp/pip-kP3s7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:51:15 INFO - Running setup.py (path:/tmp/pip-S_KbeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:51:15 INFO - Running setup.py (path:/tmp/pip-WXcFfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:51:15 INFO - Running setup.py (path:/tmp/pip-NV6CO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:51:15 INFO - Running setup.py (path:/tmp/pip-3uFV4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:51:15 INFO - Running setup.py (path:/tmp/pip-iVKZ5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:51:15 INFO - Running setup.py (path:/tmp/pip-Ds4Z3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:51:15 INFO - Running setup.py (path:/tmp/pip-VEMoQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:51:15 INFO - Running setup.py (path:/tmp/pip-B7jvON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:51:16 INFO - Running setup.py (path:/tmp/pip-BdWXne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:51:16 INFO - Running setup.py (path:/tmp/pip-eWi4tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:51:16 INFO - Running setup.py (path:/tmp/pip-IoRk1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:51:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:51:16 INFO - Running setup.py install for manifestparser 22:51:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:51:16 INFO - Running setup.py install for mozcrash 22:51:16 INFO - Running setup.py install for mozdebug 22:51:16 INFO - Running setup.py install for mozdevice 22:51:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:51:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:51:16 INFO - Running setup.py install for mozfile 22:51:16 INFO - Running setup.py install for mozhttpd 22:51:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:51:16 INFO - Running setup.py install for mozinfo 22:51:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:51:16 INFO - Running setup.py install for mozInstall 22:51:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:51:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:51:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:51:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:51:17 INFO - Running setup.py install for mozleak 22:51:17 INFO - Running setup.py install for mozlog 22:51:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:51:17 INFO - Running setup.py install for moznetwork 22:51:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:51:17 INFO - Running setup.py install for mozprocess 22:51:17 INFO - Running setup.py install for mozprofile 22:51:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:51:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:51:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:51:17 INFO - Running setup.py install for mozrunner 22:51:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:51:17 INFO - Running setup.py install for mozscreenshot 22:51:17 INFO - Running setup.py install for moztest 22:51:17 INFO - Running setup.py install for mozversion 22:51:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:51:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:51:18 INFO - Cleaning up... 22:51:18 INFO - Return code: 0 22:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:18 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 0x7f41f10a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177410>, '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 0x2178310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21787a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', '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 22:51:18 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 22:51:18 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 22:51:18 INFO - Using env: {'DISPLAY': ':0', 22:51:18 INFO - 'HOME': '/home/cltbld', 22:51:18 INFO - 'LANG': 'en_US.UTF-8', 22:51:18 INFO - 'LANGUAGE': 'en_US:en', 22:51:18 INFO - 'LOGNAME': 'cltbld', 22:51:18 INFO - 'MAIL': '/var/mail/cltbld', 22:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:18 INFO - 'MOZ_NO_REMOTE': '1', 22:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:18 INFO - 'NO_EM_RESTART': '1', 22:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:18 INFO - 'PWD': '/builds/slave/test', 22:51:18 INFO - 'SHELL': '/bin/bash', 22:51:18 INFO - 'SHLVL': '1', 22:51:18 INFO - 'TERM': 'linux', 22:51:18 INFO - 'TMOUT': '86400', 22:51:18 INFO - 'USER': 'cltbld', 22:51:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', 22:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:18 INFO - '_': '/tools/buildbot/bin/python'} 22:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:51:18 INFO - Running setup.py (path:/tmp/pip-erlgWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:51:18 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)) 22:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:51:18 INFO - Running setup.py (path:/tmp/pip-h6eZ7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:51:18 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)) 22:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:51:18 INFO - Running setup.py (path:/tmp/pip-bguB_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:51:18 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)) 22:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:51:18 INFO - Running setup.py (path:/tmp/pip-G4MJF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:51:18 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)) 22:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:51:18 INFO - Running setup.py (path:/tmp/pip-Bv8Wf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:51:18 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)) 22:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:51:18 INFO - Running setup.py (path:/tmp/pip-dgIPkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:51:18 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)) 22:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:51:18 INFO - Running setup.py (path:/tmp/pip-OYdXrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:51:18 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)) 22:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:51:18 INFO - Running setup.py (path:/tmp/pip-FCFn9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:51:18 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)) 22:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:51:18 INFO - Running setup.py (path:/tmp/pip-GC5P6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:51:18 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)) 22:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:51:18 INFO - Running setup.py (path:/tmp/pip-BaROsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:51:18 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)) 22:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:51:18 INFO - Running setup.py (path:/tmp/pip-JqQG64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:51:19 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)) 22:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:51:19 INFO - Running setup.py (path:/tmp/pip-nGC2gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:51:19 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)) 22:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:51:19 INFO - Running setup.py (path:/tmp/pip-FlwTKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:51:19 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)) 22:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:51:19 INFO - Running setup.py (path:/tmp/pip-EqF2qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:51:19 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)) 22:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:51:19 INFO - Running setup.py (path:/tmp/pip-ZMujUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:51:19 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)) 22:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:51:19 INFO - Running setup.py (path:/tmp/pip-XMkVy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:51:19 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)) 22:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:51:19 INFO - Running setup.py (path:/tmp/pip-XPDXRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:51:19 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)) 22:51:19 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)) 22:51:19 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)) 22:51:19 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)) 22:51:19 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)) 22:51:19 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)) 22:51:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:21 INFO - Downloading blessings-1.6.tar.gz 22:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:51:21 INFO - Installing collected packages: blessings 22:51:21 INFO - Running setup.py install for blessings 22:51:21 INFO - Successfully installed blessings 22:51:21 INFO - Cleaning up... 22:51:21 INFO - Return code: 0 22:51:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:51:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:51:21 INFO - Reading from file tmpfile_stdout 22:51:21 INFO - Current package versions: 22:51:21 INFO - argparse == 1.2.1 22:51:21 INFO - blessings == 1.6 22:51:21 INFO - blobuploader == 1.2.4 22:51:21 INFO - docopt == 0.6.1 22:51:21 INFO - manifestparser == 1.1 22:51:21 INFO - mozInstall == 1.12 22:51:21 INFO - mozcrash == 0.17 22:51:21 INFO - mozdebug == 0.1 22:51:21 INFO - mozdevice == 0.48 22:51:21 INFO - mozfile == 1.2 22:51:21 INFO - mozhttpd == 0.7 22:51:21 INFO - mozinfo == 0.9 22:51:21 INFO - mozleak == 0.1 22:51:21 INFO - mozlog == 3.1 22:51:21 INFO - moznetwork == 0.27 22:51:21 INFO - mozprocess == 0.22 22:51:21 INFO - mozprofile == 0.28 22:51:21 INFO - mozrunner == 6.11 22:51:21 INFO - mozscreenshot == 0.1 22:51:21 INFO - mozsystemmonitor == 0.0 22:51:21 INFO - moztest == 0.7 22:51:21 INFO - mozversion == 1.4 22:51:21 INFO - psutil == 3.1.1 22:51:21 INFO - requests == 1.2.3 22:51:21 INFO - wsgiref == 0.1.2 22:51:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:51: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')]} 22:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:21 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 0x7f41f10a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177410>, '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 0x2178310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21787a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', '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 22:51:21 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 22:51:21 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 22:51:21 INFO - Using env: {'DISPLAY': ':0', 22:51:21 INFO - 'HOME': '/home/cltbld', 22:51:21 INFO - 'LANG': 'en_US.UTF-8', 22:51:21 INFO - 'LANGUAGE': 'en_US:en', 22:51:21 INFO - 'LOGNAME': 'cltbld', 22:51:21 INFO - 'MAIL': '/var/mail/cltbld', 22:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:21 INFO - 'MOZ_NO_REMOTE': '1', 22:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:21 INFO - 'NO_EM_RESTART': '1', 22:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:21 INFO - 'PWD': '/builds/slave/test', 22:51:21 INFO - 'SHELL': '/bin/bash', 22:51:21 INFO - 'SHLVL': '1', 22:51:21 INFO - 'TERM': 'linux', 22:51:21 INFO - 'TMOUT': '86400', 22:51:21 INFO - 'USER': 'cltbld', 22:51:21 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', 22:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:21 INFO - '_': '/tools/buildbot/bin/python'} 22:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:22 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)) 22:51:22 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)) 22:51:22 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)) 22:51:22 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)) 22:51:22 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)) 22:51:22 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)) 22:51:22 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)) 22:51:22 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)) 22:51:22 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)) 22:51:22 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)) 22:51:22 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)) 22:51:22 INFO - Cleaning up... 22:51:22 INFO - Return code: 0 22:51:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f41f10a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177410>, '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 0x2178310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21787a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', '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 22:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:51:22 INFO - Using env: {'DISPLAY': ':0', 22:51:22 INFO - 'HOME': '/home/cltbld', 22:51:22 INFO - 'LANG': 'en_US.UTF-8', 22:51:22 INFO - 'LANGUAGE': 'en_US:en', 22:51:22 INFO - 'LOGNAME': 'cltbld', 22:51:22 INFO - 'MAIL': '/var/mail/cltbld', 22:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:22 INFO - 'MOZ_NO_REMOTE': '1', 22:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:22 INFO - 'NO_EM_RESTART': '1', 22:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:22 INFO - 'PWD': '/builds/slave/test', 22:51:22 INFO - 'SHELL': '/bin/bash', 22:51:22 INFO - 'SHLVL': '1', 22:51:22 INFO - 'TERM': 'linux', 22:51:22 INFO - 'TMOUT': '86400', 22:51:22 INFO - 'USER': 'cltbld', 22:51:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', 22:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:22 INFO - '_': '/tools/buildbot/bin/python'} 22:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:22 INFO - Downloading/unpacking jsonschema 22:51: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 22:51: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 22:51: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 22:51: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 22:51: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 22:51: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 22:51:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:51:24 INFO - Downloading/unpacking functools32 (from jsonschema) 22:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:24 INFO - Downloading functools32-3.2.3-2.tar.gz 22:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:51:24 INFO - warning: no files found matching '*.txt' 22:51:24 INFO - no previously-included directories found matching 'build' 22:51:24 INFO - no previously-included directories found matching 'dist' 22:51:24 INFO - no previously-included directories found matching '.git*' 22:51:24 INFO - Installing collected packages: jsonschema, functools32 22:51:24 INFO - Running setup.py install for functools32 22:51:24 INFO - warning: no files found matching '*.txt' 22:51:24 INFO - no previously-included directories found matching 'build' 22:51:24 INFO - no previously-included directories found matching 'dist' 22:51:24 INFO - no previously-included directories found matching '.git*' 22:51:24 INFO - Successfully installed jsonschema functools32 22:51:24 INFO - Cleaning up... 22:51:24 INFO - Return code: 0 22:51:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:51: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')]} 22:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:24 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 0x7f41f10a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2177410>, '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 0x2178310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21787a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', '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 22:51:24 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 22:51:24 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 22:51:24 INFO - Using env: {'DISPLAY': ':0', 22:51:24 INFO - 'HOME': '/home/cltbld', 22:51:24 INFO - 'LANG': 'en_US.UTF-8', 22:51:24 INFO - 'LANGUAGE': 'en_US:en', 22:51:24 INFO - 'LOGNAME': 'cltbld', 22:51:24 INFO - 'MAIL': '/var/mail/cltbld', 22:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:24 INFO - 'MOZ_NO_REMOTE': '1', 22:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:24 INFO - 'NO_EM_RESTART': '1', 22:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:24 INFO - 'PWD': '/builds/slave/test', 22:51:24 INFO - 'SHELL': '/bin/bash', 22:51:24 INFO - 'SHLVL': '1', 22:51:24 INFO - 'TERM': 'linux', 22:51:24 INFO - 'TMOUT': '86400', 22:51:24 INFO - 'USER': 'cltbld', 22:51:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', 22:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:24 INFO - '_': '/tools/buildbot/bin/python'} 22:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:24 INFO - Downloading/unpacking flake8 22:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:51:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:51:26 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 22:51:26 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 22:51:26 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 22:51:26 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 22:51:26 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 22:51:26 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 22:51:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:51:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:51:26 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 22:51:26 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 22:51:26 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 22:51:26 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 22:51:26 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 22:51:26 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 22:51:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:51: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 22:51: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 22:51: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 22:51: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 22:51: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 22:51: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 22:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:51:27 INFO - no previously-included directories found matching 'docs/_build' 22:51:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:51:27 INFO - Running setup.py install for pep8 22:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:51:27 INFO - no previously-included directories found matching 'docs/_build' 22:51:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:51:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:51:27 INFO - Cleaning up... 22:51:27 INFO - Return code: 0 22:51:27 INFO - Running post-action listener: _resource_record_post_action 22:51:27 INFO - Running post-action listener: _start_resource_monitoring 22:51:27 INFO - Starting resource monitoring. 22:51:27 INFO - ##### 22:51:27 INFO - ##### Running install step. 22:51:27 INFO - ##### 22:51:27 INFO - Running pre-action listener: _resource_record_pre_action 22:51:27 INFO - Running main action method: install 22:51:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:51:27 INFO - Reading from file tmpfile_stdout 22:51:27 INFO - Detecting whether we're running mozinstall >=1.0... 22:51:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:51:28 INFO - Reading from file tmpfile_stdout 22:51:28 INFO - Output received: 22:51:28 INFO - Usage: mozinstall [options] installer 22:51:28 INFO - Options: 22:51:28 INFO - -h, --help show this help message and exit 22:51:28 INFO - -d DEST, --destination=DEST 22:51:28 INFO - Directory to install application into. [default: 22:51:28 INFO - "/builds/slave/test"] 22:51:28 INFO - --app=APP Application being installed. [default: firefox] 22:51:28 INFO - mkdir: /builds/slave/test/build/application 22:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:51:43 INFO - Reading from file tmpfile_stdout 22:51:43 INFO - Output received: 22:51:43 INFO - /builds/slave/test/build/application/firefox/firefox 22:51:43 INFO - Running post-action listener: _resource_record_post_action 22:51:43 INFO - ##### 22:51:43 INFO - ##### Running run-tests step. 22:51:43 INFO - ##### 22:51:43 INFO - Running pre-action listener: _resource_record_pre_action 22:51:43 INFO - Running main action method: run_tests 22:51:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:51:43 INFO - Python 2.7.3 22:51:43 INFO - Return code: 0 22:51:43 INFO - grabbing minidump binary from tooltool 22:51: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')]} 22:51:43 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 0x2177410>, '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 0x2178310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21787a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:51:43 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 22:51:43 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 22:51:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:51:43 INFO - Return code: 0 22:51:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:51:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:51:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:51:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:51:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:51:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:51:44 INFO - Return code: 0 22:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 22:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 22:51:44 INFO - Using env: {'DISPLAY': ':0', 22:51:44 INFO - 'HOME': '/home/cltbld', 22:51:44 INFO - 'LANG': 'en_US.UTF-8', 22:51:44 INFO - 'LANGUAGE': 'en_US:en', 22:51:44 INFO - 'LOGNAME': 'cltbld', 22:51:44 INFO - 'MAIL': '/var/mail/cltbld', 22:51:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:51:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:44 INFO - 'MOZ_NO_REMOTE': '1', 22:51:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:44 INFO - 'NO_EM_RESTART': '1', 22:51:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:44 INFO - 'PWD': '/builds/slave/test', 22:51:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:51:44 INFO - 'SHELL': '/bin/bash', 22:51:44 INFO - 'SHLVL': '1', 22:51:44 INFO - 'TERM': 'linux', 22:51:44 INFO - 'TMOUT': '86400', 22:51:44 INFO - 'USER': 'cltbld', 22:51:44 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330', 22:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:44 INFO - '_': '/tools/buildbot/bin/python'} 22:51:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 22:51:44 INFO - mozversion application_buildid: 20160424221650 22:51:44 INFO - mozversion application_changeset: 0225961ad7adbef25e670abf314ec67f5e6c224d 22:51:44 INFO - mozversion application_display_name: Nightly 22:51:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:51:44 INFO - mozversion application_name: Firefox 22:51:44 INFO - mozversion application_remotingname: firefox 22:51:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:51:44 INFO - mozversion application_vendor: Mozilla 22:51:44 INFO - mozversion application_version: 48.0a1 22:51:44 INFO - mozversion platform_buildid: 20160424221650 22:51:44 INFO - mozversion platform_changeset: 0225961ad7adbef25e670abf314ec67f5e6c224d 22:51:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:51:44 INFO - mozversion platform_version: 48.0a1 22:51:44 INFO - using testdate: 1461563504 22:51:44 INFO - actual date: 1461563504 22:51:44 INFO - starting webserver on 'localhost:46721' 22:51:44 INFO - SUITE-START | Running 2 tests 22:51:44 INFO - TEST-START | dromaeo_css 22:51:44 INFO - operating with platform_type : linux_ 22:51:44 INFO - Initialising browser for dromaeo_css test... 22:51:44 INFO - TEST-INFO | started process 10748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJTK3pQ/profile http://localhost:46721/getInfo.html) 22:51:49 INFO - PROCESS | 10748 | __metrics Screen width/height:1600/1200 22:51:49 INFO - PROCESS | 10748 | colorDepth:24 22:51:49 INFO - PROCESS | 10748 | Browser inner width/height: 1024/697 22:51:49 INFO - PROCESS | 10748 | __metrics 22:51:51 ERROR - PROCESS | 10748 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:51:52 INFO - TEST-INFO | 10748: exit 0 22:51:52 INFO - Browser initialized. 22:51:52 INFO - Running cycle 1/1 for dromaeo_css test... 22:51:52 INFO - TEST-INFO | started process 10830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJTK3pQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:52:04 INFO - PROCESS | 10830 | RSS: Main: 155893760 22:52:04 INFO - PROCESS | 10830 | 22:52:55 INFO - PROCESS | 10830 | 1461563575597 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] 22:55:07 INFO - PROCESS | 10830 | Cycle 1(1): loaded http://localhost:46721/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46721/tests/dromaeo/cssquery-ext.html) 22:55:08 INFO - PROCESS | 10830 | RSS: Main: 259293184 22:55:08 INFO - PROCESS | 10830 | 22:58:10 INFO - PROCESS | 10830 | Cycle 1(1): loaded http://localhost:46721/tests/dromaeo/cssquery-ext.html (next: http://localhost:46721/tests/dromaeo/cssquery-jquery.html) 22:58:11 INFO - PROCESS | 10830 | RSS: Main: 233451520 22:58:11 INFO - PROCESS | 10830 | 23:01:13 INFO - PROCESS | 10830 | Cycle 1(1): loaded http://localhost:46721/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46721/tests/dromaeo/cssquery-mootools.html) 23:01:14 INFO - PROCESS | 10830 | RSS: Main: 241123328 23:01:14 INFO - PROCESS | 10830 | 23:04:16 INFO - PROCESS | 10830 | Cycle 1(1): loaded http://localhost:46721/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46721/tests/dromaeo/cssquery-prototype.html) 23:04:16 INFO - PROCESS | 10830 | RSS: Main: 235085824 23:04:16 INFO - PROCESS | 10830 | 23:07:20 INFO - PROCESS | 10830 | Cycle 1(1): loaded http://localhost:46721/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46721/tests/dromaeo/cssquery-yui.html) 23:07:20 INFO - PROCESS | 10830 | RSS: Main: 216047616 23:07:20 INFO - PROCESS | 10830 | 23:10:23 INFO - PROCESS | 10830 | Cycle 1(1): loaded http://localhost:46721/tests/dromaeo/cssquery-yui.html (next: http://localhost:46721/tests/dromaeo/cssquery-dojo.html) 23:10:23 INFO - PROCESS | 10830 | RSS: Main: 294273024 23:10:23 INFO - PROCESS | 10830 | 23:10:23 INFO - PROCESS | 10830 | __start_tp_report 23:10:23 INFO - PROCESS | 10830 | _x_x_mozilla_page_load 23:10:23 INFO - PROCESS | 10830 | _x_x_mozilla_page_load_details 23:10:23 INFO - PROCESS | 10830 | |i|pagename|runs| 23:10:23 INFO - PROCESS | 10830 | |0;dojo.html;2603.1149409200875;2679.0355472030064;2685.4494828560146;2695.6226128342023;2718.551439012563;4588.518205588415;4669.6497762667805;4677.368555245041;4680.6021488173465;4694.554017368353;4707.082118986799;4725.66920315578;4727.763611819412;4813.687110337834;4815.446223684277;4306.913861722764;4334.674899382543;4378.781060946956;4399.626031787302;4459.643228541725;4338.869833904972;4394.846180383687;4404.757738324391;4415.293553031515;4435.268180750172;4199.727017743837;4228.323468245081;4262.680298977558;4273.722208056497;4300.333448315516;4331.198728235287;4361;4363.105563359503;4373.409589705381;4382.2331092059085;4294.4202532658;4323.632491238217;4330.242207613655;4334.631556317717;4371.453568303962;4533.365328853963;4560.156371071363;4607.424071991001;4624.213883639755;4657.4876763555985;5014.473480284591;5024.899502009976;5035.597152227813;5047.041062198171;5090.465501122366;5052.873678158038;5075.4163271223915;5087.313212716273;5087.745612719349;5090.77091530882;4607.216773148572;4676.205045142266;4715.528447155291;4728.527147285244;4736.5973892219545;5133.9743301284;5146.742662866842;5153.3815942087185;5154.14956532168;5180.4560521145495;4938.333325001151;4952.083864485082;4952.306677065214;4956.405231372186;5002.299678045077;4926.679765815282;4935.432425271139;5016.272640467185;5029.647924645313;5034.320366750515;4933.703977761345;4956.702597844141;4957.454679985199;4961;5010.599152067826;4933.975330123327;4937.7777999990085;4940.061388336205;4944.9258261126115;4988.650794444354;4244.087521182961;4320.135972805451;4322.740635561876;4325.113351762881;4327.091310824699;3731.813409329577;3748.8125593720206;3781.1870447853844;3795.1081495848453;3838.05967537955;4271.017665936852;4285.971366871929;4289.970407102335;4293.506246781598;4341.218580655449;4823.662343635982;5016.372953380827;5044.54599086084;5048.596112311006;5092.9745351273;4202.348635961431;4247.787610619456;4251.489821221411;4282.1221649562385;4291.699581029298;4501;4504.189245935763;4505.5269196734525;4544.318352247189;4554.407926969473;4608.124456353282;4632.814687412533;4689.531046895283;4692.859214223578;4736.242201247784;5045.369328833895;5105.055564720538;5115.5396014358885;5149.150390185728;5155.046316431472;4689.085628302449;4745.098431298043;4746.477887432448;4755.405574303212;4800.207965685762;4749.168895443215;4884.682495637914;4937.530934561211;4959.9008019838675;5016.974915125401;5067.163917953644;5088.109580823415;5088.618353623567;5102.464241254764;5138.845834624967;4949;4956.355673762532;4958.776855041459;4960.280759289955;5004.724740139181;4809.687370320918;4890.951090489049;4939.6542242042715;4942.8764280893265;4993.001399719998;4827.468978412302;4836.105320515716;4842.903141937212;4866.343043689199;4901.607871370211;4935.284383764406;4949.876253093701;4956.653034287565;4965.950340496694;5004.799808007784;4717.245240761599;4780.904381912273;4823.27650852375;4827.131116399082;4904.901901961869 23:10:23 INFO - PROCESS | 10830 | |1;ext.html;581.1167026120297;611.9296280927693;613.4019331152127;628.1645411602569;630.7161777200259;34067.4889876652;34741;34783.30433391331;34908.301833963335;36179;36130;36913.815430922805;36943.26113477729;37242.44136337957;37367.62632373675;7295.525790823606;7638.732644357435;7829.3736501079775;7852.175521570239;9591.232701383873;9757.951210243938;9913.702588922344;9915.10764031237;9915.206783457306;9917.157041651468;9939.2545559083;10056.34633748804;10059.295849290553;10063.748406289827;10075.395476271447;9867.901320986806;9962.900370996269;9966.252531060163;9975.301728878982;9975.551100200508;9748.512574371252;9840.704778856645;9869.062439068277;9871.062249086326;10148.594056237742;36416.81791591025;36791.63208367909;36841.263174736356;36863;36932.63067369319;3193.1697758582704;3230.353929214143;3233.304839459504;3302.2734998300334;3358.3619112368574;28534.571981420297;28755.712442875512;28930;29148.562771558445;29323.85338073296;3301.224212310105;3519.771214871025;3542.256126213498;3569.39320315547;3661.2311414602964;170510;171982.1400893;172614;172810;173482;52370.73814630903;52824.735876320374;52890.47109528932;52892.73553632284;53019.734901325246;55792.44207557872;56148.71925640427;56237.437625624036;56248;56351;14157.646058848612;14358.425662973574;14371.484990126686;14376.928115359357;14378.28108594566;8847.42491738035;10605.098566621924;10955.287906286067;11007.06439952597;11013.118950483942;17412.651746965243;17442.47672569825;17496.387626433014;17524.824751752574;17561.56096097608;6603.372679595431;6809.863802723918;6845.486588505882;6852.349026842442;6915.827104322432;900.5092224737534;902.1249388093539;951.6003278622857;964.6286179820679;1007.4106647611083;27292.863535682194;28241.15276541666;28498;28733.712662873102;28796.424071518453;953.9284553658504;987.7234374375187;995.1342332170913;1002.3484734922213;1038.6894388288663;13261.668458288426;13332;13550.254735989614;13587.388567514288;14204.218767967861;376571;384638;384717;386003;386322;46312;47141.764291178326;47167.528324717;47191.5280847194;47258.5274147261;1086.326477583903;1172.7947609168532;1244.807054906491;1249.4564864284066;1300.9349532523336;25585.616215756407;27631.44737105287;27727.58408623832;27792.58311125294;27960;40683.59316406916;41258;41627.583724162374;41635.375469367376;41699.79150104352;300285;300883;301409;302888;305869;22338.21816236424;24382.87808560946;25146;25282.620760688238;25419.745802541736;33868.3226335467;36080;38556.228875422894;38704.22591548209;39577;33008;33047;33276.500852486744;33765.155871103416;34006.319873602886;32577.511337329484;33244.50133247955;33339;33565.16087097842;33601.66398335985;33000.834995824865;33706.49440258349;33814.49278260779;34191;34327.485087724206;29696.55455168131;30313.848430757706;30356.39287214199;30614.540781887845;30655;23213.651795222748;23805.761942380355;23984.640230396908;23997.400064998514;24239.394015149763 23:10:23 INFO - PROCESS | 10830 | |2;jquery.html;368.43077445346944;368.43629247251704;380.157950140439;390.72258696325605;408.3996525108094;16048.759268610966;16687;17335.046572438543;17536;17594.1202939853;15888.523344299689;16101.83898161018;17048.147592620382;17065.317387304523;17099.658006839854;4681.368015317931;4810.06203790261;4829.372181616385;4838.927416088762;4842.2736589511505;3463.861445542188;5175.534201921826;5452.672839629635;5468.863278418052;5473.75368108436;5442.020436321461;5451.809186678467;5461.69960652164;5469.699166545838;5482.0406428874985;5227.424983251839;5483.561315094823;5500.6424582402215;5504.174373843915;5510.1459273812625;3398.1164897126923;5039.269305950654;5303.787848486056;5312.946870531284;5320.920186197211;11306.37814920179;11365.090792736644;11409.087273018138;16158.75761863573;20300.898495507576;1885.5286178455385;1961.7351657526337;1991.5220347116588;2499.0929107871634;2507.109975958527;8914.28685705142;9004.954975225082;9016.23362014223;9177.678781242625;9252.491112988782;1743.7122874725655;1784.8215178482178;1785.8214178582168;1803.6122233719814;1814.7731533558306;69006;71592.28407715909;71650.13399464016;72042.27957720408;72679.27320726778;9896.802063958825;9931.801363972825;10098.798024039477;10128.746781330527;10324.845127323097;13974.860251397558;14060.296985150702;14069;14072.929635351962;14105.576832695035;7079.2920707929825;7123.394511466583;7209.134903811471;7239;7263.34629883313;6528.934710652928;6684.966575167093;6706.865862682719;6794.150731158606;6835.58986460814;4350.129974005212;4371.606555410029;4409.647228221735;4414.3157810539415;4455.353973673799;1656.403694669918;1738.8695847811464;1789.8210178981997;1796.8023517413073;1825.561865152354;816.163432481711;835.5195762436623;848.8259906719107;865.2558799432483;900.3652425040331;15564.377424902877;15940.521784346489;16020.919895400448;16149.19254037317;16155.11146886909;880.6257340630207;907.3376435202339;943.9899307740789;966.6520052780993;972.0473935543207;9410.670626528039;9465.810683786285;9541.904580954102;9712.660056897974;9785.706428807147;410021;413358;426937;427930;428924;78382.6080869592;79400.60299698464;80545.59727201327;80690;81604;946.2808265717966;949.0556895888635;965.8502932045685;965.8937516873139;969.2972594868804;14600.996634610226;14838.703225935637;14858.479953201586;15250.313542559854;15392.222971454348;26591.33521661974;28095.71904280931;30075.849620751756;30480.390392191588;33953.32093358169;46834.29748553706;48678.51321486881;48840;49015.509844902524;49098;7736.7292144774665;7754.7673569793;7758.107817601048;7784.338331241908;7830.960845195737;10161.745956351151;10663.733406664895;10856;10890.401027943539;10919.781604368027;7004.369606735215;7551.647124511507;9441.197498212729;9550.474723890253;9998.500074996076;9884.357516761387;9933.801323973625;9962.501874906371;9999.450030248407;10005.54975026111;9852.901470985198;9916.107550320507;9955.651552195639;10008.549615267184;10393.324433911772;6863;7203.459740519377;7208.675609597685;7277.818054548678;7418.998435211393;9462.574184161867;10016.699499015042;10041.899581004389;10195.818318615657;10273.640422585473 23:10:23 INFO - PROCESS | 10830 | |3;mootools.html;1276.3618190904547;1438.2449214162566;1459.3068292561034;1598.904065756054;1775.9733603995935;7448.515846469975;7777.105632852224;7779.7666070017995;7783.182765809594;7797.493162944412;7592;7751.224877512246;7759.1852855450215;7760.844783104335;7785.338246249075;2198.890055497223;2220.100859152046;2221.278084622496;2221.5445833604153;2221.7222847144108;2153.849230553862;2170.0668712453717;2211.5355775287208;2218.622834118196;2221.1670623516184;2182.519845633958;2204.217502786512;2208.149862303017;2208.845380823343;2226.309843948373;2152.87082775034;2159.222679835258;2160.686700428437;2160.935171944844;2161.5244646177816;2150.3333966470445;2183.705199798023;2186.169255682846;2188.2231807708195;2189.2228258968;7678;7776.650050747673;7799.220077992212;7810.882836757453;8024;4657.347971284023;4791.904161916742;4829.806807727687;4835.540623640749;4843.782029808632;3030.0758268728027;3059.5257735051105;3128.5463607776746;3149.7322727568185;3157.431662300785;967.4485543240356;977.5796407544752;982.0277924854414;989.0801554554262;1007.1640538353149;10563.788724225473;10771.730706732316;10821.891781082246;10837.729056773565;10854.45727713611;4427.579379958899;4481.910361792746;4531.048479819209;4561.543845615412;4561.608709343682;9372.95313523428;9391.060893910555;9400.15398614128;9403;9410.294227932933;4796.616270698336;4798.160321943646;4826.565609095198;4829.73436460991;4830.806767729251;3689.7417180797624;3784.4701741756176;4204.978975105105;4325.372820941009;4358.912821743611;3740.3267411866127;3780.1872597391693;3842.193139440749;3843.673287770515;3897.4738410314244;1238.9504419823286;1257.2770656872335;1257.7484503099417;1270.5235536673747;1272.1285919145414;717.3830505765038;745.9813504662427;800.8438354520813;845.5476320168681;866.5580553917547;5075.111855425286;5254.15933450646;5282.181261904411;5357.062514060101;5403.297571315782;421.21023081721773;430.1826529593797;433.7462584388105;441.18160811694486;443.6849836615974;3700.888973330804;3723.9069023274633;3752.1745216052423;3792.544894612609;3834.4631751554803;9390.62437502506;9746.95126524377;9851.211903047739;9866.654667086617;9898.901010989943;9658.179054780423;9746.220302375792;9755.658551950648;9826.06652368024;9831.803363932824;7109.466789990772;7207.92792072083;7235.167955685059;7309.634518274172;7355.889661655079;5233.476652334736;5333.359996800254;5441.047816632153;5459.754311056092;5511.586631002771;8932.955335223282;9094.499802510925;9131.360804743605;9202.723918282461;9249.12133347331;9288.58201380953;9464.810703785748;9468.573914173741;9506.144446999802;9510.619575216913;6219.502439804895;7126.5011449198055;7517.812054698677;7562.319391254813;7567.091948966159;7203.819904502429;7237.927620723725;7299.5620262784405;7300.634968251672;7330.523515971445;6518.902216466851;6618.735250590115;6682.599044057372;6745.561538499982;6754.290799465985;6875.7937261882225;6933.7226510939;6940.826479338057;6957.512974091967;7031.08595882532;6515.087887695631;6592.17597800275;6662.533622646368;6692;6697.598144111369;4544.522825103317;4566.8173273068705;4659.510751371057;4675.064987002545;4747.477777444409;4470.217711900339;4672.112298663243;4733.479317275166;4773.546513081252;4780.139574876555 23:10:23 INFO - PROCESS | 10830 | |4;prototype.html;309.33492990071346;310.1733879211899;312.3970736478596;314.1658895632096;315.89891234804844;5178.275041494194;5200.843974680756;5219.191025391061;5227.607929405291;5235.659682120659;5124.20574810904;5125.923111153326;5128.974355128228;5160.612954028444;5174.172132458807;3792.829322680486;3897.1815918656976;3900.2004589059175;4018.6785057195502;4036.2532931407636;3994.3409337459284;4011.558728539873;4014.919701605966;4019.5176578810438;4034.253663072341;3824.5028146340937;3996.440498330236;3999.9200015999663;4001.3197756381487;4009.719319647626;3841.481400010991;3973.4834471518516;3978.5424676162324;3985.720999530034;4006.1386801837743;3520.4510015593314;3521.9295614087573;3526.453399723047;3541.5041894134843;3547.130952916552;4909.0672772173175;4926;4929.260610908356;4929.852104436873;4942.481039490837;4418.911621767579;4626.074785043005;4638.79125439356;4674.27548729944;4698.107359601699;5427.83716488506;5434.864128396782;5437.102878025121;5441.075017247077;5445.918311225335;3951.3677811550015;3954.4661470701376;3957;3959.6832253419943;3967.4842270504937;5443.755031023614;5584.5253153482;5617.831465056055;5622.212890195376;5686.431356864322;3937;3966.900827479336;3975.821088050987;3983.6016398359934;3985.5815139410524;4016.176683779818;4016.8393264269685;4032.697547683935;4033.6571391432058;4034.374671925856;4375.2780791169735;4577.29051996941;4583.679142460062;4592.334111553872;4641.95358046422;5422.478547475364;5440.619156659075;5453.536449401766;5454.10007348791;5461.416189305057;1418.2199790115396;1443.8267407910907;1446.0745123121;1452.6005348529027;1458.0595515892403;939.4410325856105;954.7231302922214;960.8030353777459;964.62379671928;989.3173710140125;4667.113248482845;4678.672492925462;4704.200285951397;4704.717716936994;4731.834385796481;5507.5593952483705;5521.861953451115;5534.584906131976;5534.972325138348;5539.529140023063;4522.909541809146;4679.625629949596;4691.437027556647;4706.458757242961;4786.305985632064;2976.5981592484736;2998.4752668282963;3011.6687164411896;3028.7425568826898;3035.8937437190034;5298.496642819003;5309.309789727311;5310.309659744208;5311;5316;5552.361478429952;5806.535477161817;5829.854253643693;5836.970815145897;5843.18195452637;5290.9735451322495;5297.841064768063;5302.39022512416;5303.68177909319;5316.415194328621;5293.417724050274;5644.85887852807;5645.661260324394;5659.660420374791;5671.546276297969;5533.695646739468;5540.168974653834;5540.944590554042;5548.278723765885;5577.693226872561;5306.602004849575;5324.653897496651;5328.360596728262;5329.534378046068;5339.3058902342445;3734.329954082844;3932.2332145231403;3933.842646294116;3939.7439166454087;3959.683225341908;5577.916331254954;5591.440855914376;5595.216669666169;5596.244506991504;5609.102543593006;5349.224362467343;5359.866003349947;5377.354717433776;5386.59600529954;5437.40188579248;5269.1569348903995;5351.097844833952;5430.864228394164;5434.266374039612;5447;5104.668196567211;5303.76470353092;5327.9733601331745;5349.304590403378;5349.518543330963;5263.236830659456;5491.588130890119;5510.311211098613;5518.310211223597;5526.668399895858;5361.678299302054;5363.731813409392;5383.138697808332;5385.919211211756;5389.868127693228 23:10:23 INFO - PROCESS | 10830 | |5;yui.html;753.5591678867862;764.6903004283267;789.2856964447174;791.7110254757015;793.710295742054;12255.448504817283;12660.936695316534;12677.175983561063;12686.175398599085;12695.301758403284;12244.510219591206;12572.434240459179;12605.054620903424;12617.55838545651;12623;624.3631495874206;778.2256654628624;789.9407544434176;811.6875003123811;815.4454970619976;808.6724876425058;812.5206128384252;815.09524427885;815.1278132398336;815.657423881971;859.9828003439927;860.0840105287848;862.1034124510533;863.1023735315265;863.3395452478859;669.6885948034163;835.4277320035795;861.5950503263456;862.4566523090475;863.766782968595;627.8147946355836;628.0296941225818;628.1770880146977;628.3433811666773;628.8773689130621;12667.683307917283;12720.745585088247;12724.427400766988;12737.490500380067;12752.489900403973;12262.81605775914;12561.120721549496;12596.68508287291;12737.808932866015;12899.93550032244;9853.359531630422;9910.40537567741;9982;10025.498725063791;10112.595496180218;4133.751974881487;4170.35359519275;4180.958190418088;4284.271673815459;4324.524302326741;42278.57721422777;43460.78269608632;43686.56313436857;43903.78048109739;43918.56081439176;9744.805103897883;9952.850707239397;9955.950220248853;10021.549030293509;10140.340877843064;16710;16925.576860578585;16930.830691693172;16936.491905242863;16960.74558881618;6858.348456896587;6922.930770692329;6956.791296261019;6959.582425054513;7138.535995160401;3860.2665493556133;3883.37865941448;3891.20230352777;3896.649301562873;3990.900227494336;2855.5431131018936;2910.476114299404;2912.126362091364;2912.8397938113185;2913.1843083936533;485.40780248097263;486.29972839112276;486.9488703686062;488.68479830509835;491.0571702331532;625.3746253746253;647.2879832184559;658.8352911772057;659.3307792590524;661.4741280681869;7837.294643482114;7864.820276958388;7910.169432209535;7989.760307190793;8526.31789456842;531.7181893596401;592.7599322274485;640.1358166475221;642.2613993907045;647.4108561209277;3886.3198940185353;3891.3384724596885;3910.765354078764;3930.6855451563806;3969.7419667721506;50227.24659130116;51039.234411483856;51455.22817157746;51467.74266128645;51476.742616287425;39109.60890391117;41069.794651026554;41132.794336028725;41582.37626435606;42086.36870446946;40206.59793402028;40990.59009409927;41587.1682566347;41804.58195418007;43333;7848.84302313962;8040.5722443520635;8305.543195124326;8346.749597512084;8385.916140838757;28024.3568336115;28176.577351339336;28612.856935715186;28701.28246793763;29265.85367073151;38740.225195496496;39579.60420395759;39703.60296396999;39943.20113597654;40155;10953;10953.726156846142;11022.834657480305;11098.167637427065;11439.084873209957;11528.077753779846;11990.580329688768;11993.700157496132;11994.280343179436;12261.509539618315;10638.946805265925;10650.307729997525;11235.66293011211;11386.94306528462;11896.940515297714;11088.611898583511;11105.611303604335;11138.888611113785;11316.94341528287;11636;10288.845667315147;10595.682129536126;10823.945880270549;11052.613158539412;11481.598144064918;9314.813703726024;9472.336936414385;9550.997145299643;9557.139857412867;9977.700668979942;9356.345055846297;9516.571754271214;9747.951260243937;10125.240606954656;10184.490775461345 23:10:23 INFO - PROCESS | 10830 | __end_tp_report 23:10:23 INFO - PROCESS | 10830 | __start_cc_report 23:10:23 INFO - PROCESS | 10830 | _x_x_mozilla_cycle_collect,973 23:10:23 INFO - PROCESS | 10830 | __end_cc_report 23:10:23 INFO - PROCESS | 10830 | __startTimestamp1461564623659__endTimestamp 23:10:23 INFO - PROCESS | 10830 | 23:10:23 INFO - PROCESS | 10830 | ------- Summary: start ------- 23:10:23 INFO - PROCESS | 10830 | Number of tests: 6 23:10:23 INFO - PROCESS | 10830 | 23:10:23 INFO - PROCESS | 10830 | [#0] dojo.html Cycles:165 Average:4650.20 Median:4749.17 stddev:480.32 (10.1%) stddev-sans-first:454.16 23:10:23 INFO - PROCESS | 10830 | Values: 2603.1 2679.0 2685.4 2695.6 2718.6 4588.5 4669.6 4677.4 4680.6 4694.6 4707.1 4725.7 4727.8 4813.7 4815.4 4306.9 4334.7 4378.8 4399.6 4459.6 4338.9 4394.8 4404.8 4415.3 4435.3 4199.7 4228.3 4262.7 4273.7 4300.3 4331.2 4361.0 4363.1 4373.4 4382.2 4294.4 4323.6 4330.2 4334.6 4371.5 4533.4 4560.2 4607.4 4624.2 4657.5 5014.5 5024.9 5035.6 5047.0 5090.5 5052.9 5075.4 5087.3 5087.7 5090.8 4607.2 4676.2 4715.5 4728.5 4736.6 5134.0 5146.7 5153.4 5154.1 5180.5 4938.3 4952.1 4952.3 4956.4 5002.3 4926.7 4935.4 5016.3 5029.6 5034.3 4933.7 4956.7 4957.5 4961.0 5010.6 4934.0 4937.8 4940.1 4944.9 4988.7 4244.1 4320.1 4322.7 4325.1 4327.1 3731.8 3748.8 3781.2 3795.1 3838.1 4271.0 4286.0 4290.0 4293.5 4341.2 4823.7 5016.4 5044.5 5048.6 5093.0 4202.3 4247.8 4251.5 4282.1 4291.7 4501.0 4504.2 4505.5 4544.3 4554.4 4608.1 4632.8 4689.5 4692.9 4736.2 5045.4 5105.1 5115.5 5149.2 5155.0 4689.1 4745.1 4746.5 4755.4 4800.2 4749.2 4884.7 4937.5 4959.9 5017.0 5067.2 5088.1 5088.6 5102.5 5138.8 4949.0 4956.4 4958.8 4960.3 5004.7 4809.7 4891.0 4939.7 4942.9 4993.0 4827.5 4836.1 4842.9 4866.3 4901.6 4935.3 4949.9 4956.7 4966.0 5004.8 4717.2 4780.9 4823.3 4827.1 4904.9 23:10:23 INFO - PROCESS | 10830 | 23:10:23 INFO - PROCESS | 10830 | [#1] ext.html Cycles:180 Average:44065.36 Median:33937.32 stddev:78877.28 (232.4%) stddev-sans-first:79030.98 23:10:23 INFO - PROCESS | 10830 | Values: 581.1 611.9 613.4 628.2 630.7 34067.5 34741.0 34783.3 34908.3 36179.0 36130.0 36913.8 36943.3 37242.4 37367.6 7295.5 7638.7 7829.4 7852.2 9591.2 9758.0 9913.7 9915.1 9915.2 9917.2 9939.3 10056.3 10059.3 10063.7 10075.4 9867.9 9962.9 9966.3 9975.3 9975.6 9748.5 9840.7 9869.1 9871.1 10148.6 36416.8 36791.6 36841.3 36863.0 36932.6 3193.2 3230.4 3233.3 3302.3 3358.4 28534.6 28755.7 28930.0 29148.6 29323.9 3301.2 3519.8 3542.3 3569.4 3661.2 170510.0 171982.1 172614.0 172810.0 173482.0 52370.7 52824.7 52890.5 52892.7 53019.7 55792.4 56148.7 56237.4 56248.0 56351.0 14157.6 14358.4 14371.5 14376.9 14378.3 8847.4 10605.1 10955.3 11007.1 11013.1 17412.7 17442.5 17496.4 17524.8 17561.6 6603.4 6809.9 6845.5 6852.3 6915.8 900.5 902.1 951.6 964.6 1007.4 27292.9 28241.2 28498.0 28733.7 28796.4 953.9 987.7 995.1 1002.3 1038.7 13261.7 13332.0 13550.3 13587.4 14204.2 376571.0 384638.0 384717.0 386003.0 386322.0 46312.0 47141.8 47167.5 47191.5 47258.5 1086.3 1172.8 1244.8 1249.5 1300.9 25585.6 27631.4 27727.6 27792.6 27960.0 40683.6 41258.0 41627.6 41635.4 41699.8 300285.0 300883.0 301409.0 302888.0 305869.0 22338.2 24382.9 25146.0 25282.6 25419.7 33868.3 36080.0 38556.2 38704.2 39577.0 33008.0 33047.0 33276.5 33765.2 34006.3 32577.5 33244.5 33339.0 33565.2 33601.7 33000.8 33706.5 33814.5 34191.0 34327.5 29696.6 30313.8 30356.4 30614.5 30655.0 23213.7 23805.8 23984.6 23997.4 24239.4 23:10:23 INFO - PROCESS | 10830 | 23:10:23 INFO - PROCESS | 10830 | [#2] jquery.html Cycles:180 Average:24719.50 Median:49056.75 stddev:69523.78 (141.7%) stddev-sans-first:69694.77 23:10:23 INFO - PROCESS | 10830 | Values: 368.4 368.4 380.2 390.7 408.4 16048.8 16687.0 17335.0 17536.0 17594.1 15888.5 16101.8 17048.1 17065.3 17099.7 4681.4 4810.1 4829.4 4838.9 4842.3 3463.9 5175.5 5452.7 5468.9 5473.8 5442.0 5451.8 5461.7 5469.7 5482.0 5227.4 5483.6 5500.6 5504.2 5510.1 3398.1 5039.3 5303.8 5312.9 5320.9 11306.4 11365.1 11409.1 16158.8 20300.9 1885.5 1961.7 1991.5 2499.1 2507.1 8914.3 9005.0 9016.2 9177.7 9252.5 1743.7 1784.8 1785.8 1803.6 1814.8 69006.0 71592.3 71650.1 72042.3 72679.3 9896.8 9931.8 10098.8 10128.7 10324.8 13974.9 14060.3 14069.0 14072.9 14105.6 7079.3 7123.4 7209.1 7239.0 7263.3 6528.9 6685.0 6706.9 6794.2 6835.6 4350.1 4371.6 4409.6 4414.3 4455.4 1656.4 1738.9 1789.8 1796.8 1825.6 816.2 835.5 848.8 865.3 900.4 15564.4 15940.5 16020.9 16149.2 16155.1 880.6 907.3 944.0 966.7 972.0 9410.7 9465.8 9541.9 9712.7 9785.7 410021.0 413358.0 426937.0 427930.0 428924.0 78382.6 79400.6 80545.6 80690.0 81604.0 946.3 949.1 965.9 965.9 969.3 14601.0 14838.7 14858.5 15250.3 15392.2 26591.3 28095.7 30075.8 30480.4 33953.3 46834.3 48678.5 48840.0 49015.5 49098.0 7736.7 7754.8 7758.1 7784.3 7831.0 10161.7 10663.7 10856.0 10890.4 10919.8 7004.4 7551.6 9441.2 9550.5 9998.5 9884.4 9933.8 9962.5 9999.5 10005.5 9852.9 9916.1 9955.7 10008.5 10393.3 6863.0 7203.5 7208.7 7277.8 7419.0 9462.6 10016.7 10041.9 10195.8 10273.6 23:10:23 INFO - PROCESS | 10830 | 23:10:23 INFO - PROCESS | 10830 | [#3] mootools.html Cycles:180 Average:5230.25 Median:4959.45 stddev:2936.82 (59.2%) stddev-sans-first:2930.02 23:10:23 INFO - PROCESS | 10830 | Values: 1276.4 1438.2 1459.3 1598.9 1776.0 7448.5 7777.1 7779.8 7783.2 7797.5 7592.0 7751.2 7759.2 7760.8 7785.3 2198.9 2220.1 2221.3 2221.5 2221.7 2153.8 2170.1 2211.5 2218.6 2221.2 2182.5 2204.2 2208.1 2208.8 2226.3 2152.9 2159.2 2160.7 2160.9 2161.5 2150.3 2183.7 2186.2 2188.2 2189.2 7678.0 7776.7 7799.2 7810.9 8024.0 4657.3 4791.9 4829.8 4835.5 4843.8 3030.1 3059.5 3128.5 3149.7 3157.4 967.4 977.6 982.0 989.1 1007.2 10563.8 10771.7 10821.9 10837.7 10854.5 4427.6 4481.9 4531.0 4561.5 4561.6 9373.0 9391.1 9400.2 9403.0 9410.3 4796.6 4798.2 4826.6 4829.7 4830.8 3689.7 3784.5 4205.0 4325.4 4358.9 3740.3 3780.2 3842.2 3843.7 3897.5 1239.0 1257.3 1257.7 1270.5 1272.1 717.4 746.0 800.8 845.5 866.6 5075.1 5254.2 5282.2 5357.1 5403.3 421.2 430.2 433.7 441.2 443.7 3700.9 3723.9 3752.2 3792.5 3834.5 9390.6 9747.0 9851.2 9866.7 9898.9 9658.2 9746.2 9755.7 9826.1 9831.8 7109.5 7207.9 7235.2 7309.6 7355.9 5233.5 5333.4 5441.0 5459.8 5511.6 8933.0 9094.5 9131.4 9202.7 9249.1 9288.6 9464.8 9468.6 9506.1 9510.6 6219.5 7126.5 7517.8 7562.3 7567.1 7203.8 7237.9 7299.6 7300.6 7330.5 6518.9 6618.7 6682.6 6745.6 6754.3 6875.8 6933.7 6940.8 6957.5 7031.1 6515.1 6592.2 6662.5 6692.0 6697.6 4544.5 4566.8 4659.5 4675.1 4747.5 4470.2 4672.1 4733.5 4773.5 4780.1 23:10:23 INFO - PROCESS | 10830 | 23:10:23 INFO - PROCESS | 10830 | [#4] prototype.html Cycles:180 Average:4503.80 Median:5176.22 stddev:1306.71 (25.2%) stddev-sans-first:1271.88 23:10:23 INFO - PROCESS | 10830 | Values: 309.3 310.2 312.4 314.2 315.9 5178.3 5200.8 5219.2 5227.6 5235.7 5124.2 5125.9 5129.0 5160.6 5174.2 3792.8 3897.2 3900.2 4018.7 4036.3 3994.3 4011.6 4014.9 4019.5 4034.3 3824.5 3996.4 3999.9 4001.3 4009.7 3841.5 3973.5 3978.5 3985.7 4006.1 3520.5 3521.9 3526.5 3541.5 3547.1 4909.1 4926.0 4929.3 4929.9 4942.5 4418.9 4626.1 4638.8 4674.3 4698.1 5427.8 5434.9 5437.1 5441.1 5445.9 3951.4 3954.5 3957.0 3959.7 3967.5 5443.8 5584.5 5617.8 5622.2 5686.4 3937.0 3966.9 3975.8 3983.6 3985.6 4016.2 4016.8 4032.7 4033.7 4034.4 4375.3 4577.3 4583.7 4592.3 4642.0 5422.5 5440.6 5453.5 5454.1 5461.4 1418.2 1443.8 1446.1 1452.6 1458.1 939.4 954.7 960.8 964.6 989.3 4667.1 4678.7 4704.2 4704.7 4731.8 5507.6 5521.9 5534.6 5535.0 5539.5 4522.9 4679.6 4691.4 4706.5 4786.3 2976.6 2998.5 3011.7 3028.7 3035.9 5298.5 5309.3 5310.3 5311.0 5316.0 5552.4 5806.5 5829.9 5837.0 5843.2 5291.0 5297.8 5302.4 5303.7 5316.4 5293.4 5644.9 5645.7 5659.7 5671.5 5533.7 5540.2 5540.9 5548.3 5577.7 5306.6 5324.7 5328.4 5329.5 5339.3 3734.3 3932.2 3933.8 3939.7 3959.7 5577.9 5591.4 5595.2 5596.2 5609.1 5349.2 5359.9 5377.4 5386.6 5437.4 5269.2 5351.1 5430.9 5434.3 5447.0 5104.7 5303.8 5328.0 5349.3 5349.5 5263.2 5491.6 5510.3 5518.3 5526.7 5361.7 5363.7 5383.1 5385.9 5389.9 23:10:23 INFO - PROCESS | 10830 | 23:10:23 INFO - PROCESS | 10830 | [#5] yui.html Cycles:180 Average:12579.04 Median:22992.77 stddev:13772.15 (59.9%) stddev-sans-first:13782.15 23:10:23 INFO - PROCESS | 10830 | Values: 753.6 764.7 789.3 791.7 793.7 12255.4 12660.9 12677.2 12686.2 12695.3 12244.5 12572.4 12605.1 12617.6 12623.0 624.4 778.2 789.9 811.7 815.4 808.7 812.5 815.1 815.1 815.7 860.0 860.1 862.1 863.1 863.3 669.7 835.4 861.6 862.5 863.8 627.8 628.0 628.2 628.3 628.9 12667.7 12720.7 12724.4 12737.5 12752.5 12262.8 12561.1 12596.7 12737.8 12899.9 9853.4 9910.4 9982.0 10025.5 10112.6 4133.8 4170.4 4181.0 4284.3 4324.5 42278.6 43460.8 43686.6 43903.8 43918.6 9744.8 9952.9 9956.0 10021.5 10140.3 16710.0 16925.6 16930.8 16936.5 16960.7 6858.3 6922.9 6956.8 6959.6 7138.5 3860.3 3883.4 3891.2 3896.6 3990.9 2855.5 2910.5 2912.1 2912.8 2913.2 485.4 486.3 486.9 488.7 491.1 625.4 647.3 658.8 659.3 661.5 7837.3 7864.8 7910.2 7989.8 8526.3 531.7 592.8 640.1 642.3 647.4 3886.3 3891.3 3910.8 3930.7 3969.7 50227.2 51039.2 51455.2 51467.7 51476.7 39109.6 41069.8 41132.8 41582.4 42086.4 40206.6 40990.6 41587.2 41804.6 43333.0 7848.8 8040.6 8305.5 8346.7 8385.9 28024.4 28176.6 28612.9 28701.3 29265.9 38740.2 39579.6 39703.6 39943.2 40155.0 10953.0 10953.7 11022.8 11098.2 11439.1 11528.1 11990.6 11993.7 11994.3 12261.5 10638.9 10650.3 11235.7 11386.9 11896.9 11088.6 11105.6 11138.9 11316.9 11636.0 10288.8 10595.7 10823.9 11052.6 11481.6 9314.8 9472.3 9551.0 9557.1 9977.7 9356.3 9516.6 9748.0 10125.2 10184.5 23:10:23 INFO - PROCESS | 10830 | -------- Summary: end -------- 23:10:23 INFO - PROCESS | 10830 | 23:10:24 INFO - TEST-INFO | 10830: exit 0 23:10:24 INFO - TEST-OK | dromaeo_css | took 1119402ms 23:10:24 INFO - TEST-START | kraken 23:10:24 INFO - operating with platform_type : linux_ 23:10:24 INFO - Initialising browser for kraken test... 23:10:24 INFO - TEST-INFO | started process 11006 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnv02kL/profile http://localhost:46721/getInfo.html) 23:10:28 INFO - PROCESS | 11006 | __metrics Screen width/height:1600/1200 23:10:28 INFO - PROCESS | 11006 | colorDepth:24 23:10:28 INFO - PROCESS | 11006 | Browser inner width/height: 1024/697 23:10:28 INFO - PROCESS | 11006 | __metrics 23:10:29 ERROR - PROCESS | 11006 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:10:30 INFO - TEST-INFO | 11006: exit 0 23:10:30 INFO - Browser initialized. 23:10:30 INFO - Running cycle 1/1 for kraken test... 23:10:30 INFO - TEST-INFO | started process 11089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnv02kL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:42 INFO - PROCESS | 11089 | RSS: Main: 155668480 23:10:42 INFO - PROCESS | 11089 | 23:10:45 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46721/tests/kraken/driver.html?testName=audio-beat-detection) 23:10:46 INFO - PROCESS | 11089 | RSS: Main: 210309120 23:10:46 INFO - PROCESS | 11089 | 23:10:49 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46721/tests/kraken/driver.html?testName=audio-dft) 23:10:49 INFO - PROCESS | 11089 | RSS: Main: 196898816 23:10:49 INFO - PROCESS | 11089 | 23:10:53 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46721/tests/kraken/driver.html?testName=audio-fft) 23:10:53 INFO - PROCESS | 11089 | RSS: Main: 266993664 23:10:53 INFO - PROCESS | 11089 | 23:10:55 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46721/tests/kraken/driver.html?testName=audio-oscillator) 23:10:56 INFO - PROCESS | 11089 | RSS: Main: 176402432 23:10:56 INFO - PROCESS | 11089 | 23:10:58 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46721/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:10:59 INFO - PROCESS | 11089 | RSS: Main: 179970048 23:10:59 INFO - PROCESS | 11089 | 23:11:02 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46721/tests/kraken/driver.html?testName=imaging-darkroom) 23:11:02 INFO - PROCESS | 11089 | RSS: Main: 215511040 23:11:02 INFO - PROCESS | 11089 | 23:11:06 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46721/tests/kraken/driver.html?testName=imaging-desaturate) 23:11:07 INFO - PROCESS | 11089 | RSS: Main: 213188608 23:11:07 INFO - PROCESS | 11089 | 23:11:09 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46721/tests/kraken/driver.html?testName=json-parse-financial) 23:11:10 INFO - PROCESS | 11089 | RSS: Main: 214659072 23:11:10 INFO - PROCESS | 11089 | 23:11:12 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46721/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:11:12 INFO - PROCESS | 11089 | RSS: Main: 202055680 23:11:12 INFO - PROCESS | 11089 | 23:11:14 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46721/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:11:15 INFO - PROCESS | 11089 | RSS: Main: 204300288 23:11:15 INFO - PROCESS | 11089 | 23:11:17 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46721/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:11:18 INFO - PROCESS | 11089 | RSS: Main: 216588288 23:11:18 INFO - PROCESS | 11089 | 23:11:20 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46721/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:11:21 INFO - PROCESS | 11089 | RSS: Main: 222720000 23:11:21 INFO - PROCESS | 11089 | 23:11:24 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46721/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:11:25 INFO - PROCESS | 11089 | RSS: Main: 220692480 23:11:25 INFO - PROCESS | 11089 | 23:11:26 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:46721/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46721/tests/kraken/driver.html?testName=ai-astar) 23:11:27 INFO - PROCESS | 11089 | RSS: Main: 284782592 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | __start_tp_report 23:11:27 INFO - PROCESS | 11089 | _x_x_mozilla_page_load 23:11:27 INFO - PROCESS | 11089 | _x_x_mozilla_page_load_details 23:11:27 INFO - PROCESS | 11089 | |i|pagename|runs| 23:11:27 INFO - PROCESS | 11089 | |0;ai-astar;111;113;109;112;113;113;103;114;113;112 23:11:27 INFO - PROCESS | 11089 | |1;audio-beat-detection;165;136;160;177;141;151;159;132;187;132 23:11:27 INFO - PROCESS | 11089 | |2;audio-dft;162;162;162;160;161;161;160;160;160;161 23:11:27 INFO - PROCESS | 11089 | |3;audio-fft;74;73;74;175;78;75;77;74;156;74 23:11:27 INFO - PROCESS | 11089 | |4;audio-oscillator;94;95;147;95;95;94;146;94;95;152 23:11:27 INFO - PROCESS | 11089 | |5;imaging-gaussian-blur;116;118;117;116;116;117;116;117;117;117 23:11:27 INFO - PROCESS | 11089 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;176;146 23:11:27 INFO - PROCESS | 11089 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;94;95 23:11:27 INFO - PROCESS | 11089 | |8;json-parse-financial;68;68;69;68;66;68;66;81;65;64 23:11:27 INFO - PROCESS | 11089 | |9;json-stringify-tinderbox;65;64;64;64;64;65;64;64;64;63 23:11:27 INFO - PROCESS | 11089 | |10;stanford-crypto-aes;79;78;78;77;79;80;81;79;80;79 23:11:27 INFO - PROCESS | 11089 | |11;stanford-crypto-ccm;133;140;133;138;131;131;129;133;175;140 23:11:27 INFO - PROCESS | 11089 | |12;stanford-crypto-pbkdf2;184;175;174;176;177;173;174;169;170;171 23:11:27 INFO - PROCESS | 11089 | |13;stanford-crypto-sha256-iterative;72;72;79;71;73;71;71;73;72;71 23:11:27 INFO - PROCESS | 11089 | __end_tp_report 23:11:27 INFO - PROCESS | 11089 | __start_cc_report 23:11:27 INFO - PROCESS | 11089 | _x_x_mozilla_cycle_collect,1922 23:11:27 INFO - PROCESS | 11089 | __end_cc_report 23:11:27 INFO - PROCESS | 11089 | __startTimestamp1461564687203__endTimestamp 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | ------- Summary: start ------- 23:11:27 INFO - PROCESS | 11089 | Number of tests: 14 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.23 (2.9%) stddev-sans-first:3.43 23:11:27 INFO - PROCESS | 11089 | Values: 111.0 113.0 109.0 112.0 113.0 113.0 103.0 114.0 113.0 112.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:159.50 stddev:19.06 (12.0%) stddev-sans-first:19.80 23:11:27 INFO - PROCESS | 11089 | Values: 165.0 136.0 160.0 177.0 141.0 151.0 159.0 132.0 187.0 132.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 23:11:27 INFO - PROCESS | 11089 | Values: 162.0 162.0 162.0 160.0 161.0 161.0 160.0 160.0 160.0 161.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#3] audio-fft Cycles:10 Average:93.00 Median:74.00 stddev:38.50 (52.0%) stddev-sans-first:40.22 23:11:27 INFO - PROCESS | 11089 | Values: 74.0 73.0 74.0 175.0 78.0 75.0 77.0 74.0 156.0 74.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:94.50 stddev:26.02 (27.5%) stddev-sans-first:26.88 23:11:27 INFO - PROCESS | 11089 | Values: 94.0 95.0 147.0 95.0 95.0 94.0 146.0 94.0 95.0 152.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 23:11:27 INFO - PROCESS | 11089 | Values: 116.0 118.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:146.00 stddev:9.53 (6.5%) stddev-sans-first:10.05 23:11:27 INFO - PROCESS | 11089 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 176.0 146.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:11:27 INFO - PROCESS | 11089 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:68.00 stddev:4.74 (7.0%) stddev-sans-first:5.02 23:11:27 INFO - PROCESS | 11089 | Values: 68.0 68.0 69.0 68.0 66.0 68.0 66.0 81.0 65.0 64.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 23:11:27 INFO - PROCESS | 11089 | Values: 65.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 63.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:1.15 (1.5%) stddev-sans-first:1.22 23:11:27 INFO - PROCESS | 11089 | Values: 79.0 78.0 78.0 77.0 79.0 80.0 81.0 79.0 80.0 79.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:135.50 stddev:13.46 (9.9%) stddev-sans-first:14.14 23:11:27 INFO - PROCESS | 11089 | Values: 133.0 140.0 133.0 138.0 131.0 131.0 129.0 133.0 175.0 140.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:174.50 stddev:4.27 (2.4%) stddev-sans-first:2.73 23:11:27 INFO - PROCESS | 11089 | Values: 184.0 175.0 174.0 176.0 177.0 173.0 174.0 169.0 170.0 171.0 23:11:27 INFO - PROCESS | 11089 | 23:11:27 INFO - PROCESS | 11089 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.00 stddev:2.42 (3.4%) stddev-sans-first:2.55 23:11:27 INFO - PROCESS | 11089 | Values: 72.0 72.0 79.0 71.0 73.0 71.0 71.0 73.0 72.0 71.0 23:11:27 INFO - PROCESS | 11089 | -------- Summary: end -------- 23:11:27 INFO - PROCESS | 11089 | 23:11:28 INFO - TEST-INFO | 11089: exit 0 23:11:28 INFO - TEST-OK | kraken | took 63870ms 23:11:28 INFO - SUITE-END | took 1183s 23:11:28 INFO - Completed test suite (00:19:43) 23:11:28 INFO - javascript benchmark 23:11:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.1149409200875, 2679.0355472030064, 2685.4494828560146, 2695.6226128342023, 2718.551439012563, 4588.518205588415, 4669.6497762667805, 4677.368555245041, 4680.6021488173465, 4694.554017368353, 4707.082118986799, 4725.66920315578, 4727.763611819412, 4813.687110337834, 4815.446223684277, 4306.913861722764, 4334.674899382543, 4378.781060946956, 4399.626031787302, 4459.643228541725, 4338.869833904972, 4394.846180383687, 4404.757738324391, 4415.293553031515, 4435.268180750172, 4199.727017743837, 4228.323468245081, 4262.680298977558, 4273.722208056497, 4300.333448315516, 4331.198728235287, 4361.0, 4363.105563359503, 4373.409589705381, 4382.2331092059085, 4294.4202532658, 4323.632491238217, 4330.242207613655, 4334.631556317717, 4371.453568303962, 4533.365328853963, 4560.156371071363, 4607.424071991001, 4624.213883639755, 4657.4876763555985, 5014.473480284591, 5024.899502009976, 5035.597152227813, 5047.041062198171, 5090.465501122366, 5052.873678158038, 5075.4163271223915, 5087.313212716273, 5087.745612719349, 5090.77091530882, 4607.216773148572, 4676.205045142266, 4715.528447155291, 4728.527147285244, 4736.5973892219545, 5133.9743301284, 5146.742662866842, 5153.3815942087185, 5154.14956532168, 5180.4560521145495, 4938.333325001151, 4952.083864485082, 4952.306677065214, 4956.405231372186, 5002.299678045077, 4926.679765815282, 4935.432425271139, 5016.272640467185, 5029.647924645313, 5034.320366750515, 4933.703977761345, 4956.702597844141, 4957.454679985199, 4961.0, 5010.599152067826, 4933.975330123327, 4937.7777999990085, 4940.061388336205, 4944.9258261126115, 4988.650794444354, 4244.087521182961, 4320.135972805451, 4322.740635561876, 4325.113351762881, 4327.091310824699, 3731.813409329577, 3748.8125593720206, 3781.1870447853844, 3795.1081495848453, 3838.05967537955, 4271.017665936852, 4285.971366871929, 4289.970407102335, 4293.506246781598, 4341.218580655449, 4823.662343635982, 5016.372953380827, 5044.54599086084, 5048.596112311006, 5092.9745351273, 4202.348635961431, 4247.787610619456, 4251.489821221411, 4282.1221649562385, 4291.699581029298, 4501.0, 4504.189245935763, 4505.5269196734525, 4544.318352247189, 4554.407926969473, 4608.124456353282, 4632.814687412533, 4689.531046895283, 4692.859214223578, 4736.242201247784, 5045.369328833895, 5105.055564720538, 5115.5396014358885, 5149.150390185728, 5155.046316431472, 4689.085628302449, 4745.098431298043, 4746.477887432448, 4755.405574303212, 4800.207965685762, 4749.168895443215, 4884.682495637914, 4937.530934561211, 4959.9008019838675, 5016.974915125401, 5067.163917953644, 5088.109580823415, 5088.618353623567, 5102.464241254764, 5138.845834624967, 4949.0, 4956.355673762532, 4958.776855041459, 4960.280759289955, 5004.724740139181, 4809.687370320918, 4890.951090489049, 4939.6542242042715, 4942.8764280893265, 4993.001399719998, 4827.468978412302, 4836.105320515716, 4842.903141937212, 4866.343043689199, 4901.607871370211, 4935.284383764406, 4949.876253093701, 4956.653034287565, 4965.950340496694, 5004.799808007784, 4717.245240761599, 4780.904381912273, 4823.27650852375, 4827.131116399082, 4904.901901961869], "value": 4620.309517496882, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.1167026120297, 611.9296280927693, 613.4019331152127, 628.1645411602569, 630.7161777200259, 34067.4889876652, 34741.0, 34783.30433391331, 34908.301833963335, 36179.0, 36130.0, 36913.815430922805, 36943.26113477729, 37242.44136337957, 37367.62632373675, 7295.525790823606, 7638.732644357435, 7829.3736501079775, 7852.175521570239, 9591.232701383873, 9757.951210243938, 9913.702588922344, 9915.10764031237, 9915.206783457306, 9917.157041651468, 9939.2545559083, 10056.34633748804, 10059.295849290553, 10063.748406289827, 10075.395476271447, 9867.901320986806, 9962.900370996269, 9966.252531060163, 9975.301728878982, 9975.551100200508, 9748.512574371252, 9840.704778856645, 9869.062439068277, 9871.062249086326, 10148.594056237742, 36416.81791591025, 36791.63208367909, 36841.263174736356, 36863.0, 36932.63067369319, 3193.1697758582704, 3230.353929214143, 3233.304839459504, 3302.2734998300334, 3358.3619112368574, 28534.571981420297, 28755.712442875512, 28930.0, 29148.562771558445, 29323.85338073296, 3301.224212310105, 3519.771214871025, 3542.256126213498, 3569.39320315547, 3661.2311414602964, 170510.0, 171982.1400893, 172614.0, 172810.0, 173482.0, 52370.73814630903, 52824.735876320374, 52890.47109528932, 52892.73553632284, 53019.734901325246, 55792.44207557872, 56148.71925640427, 56237.437625624036, 56248.0, 56351.0, 14157.646058848612, 14358.425662973574, 14371.484990126686, 14376.928115359357, 14378.28108594566, 8847.42491738035, 10605.098566621924, 10955.287906286067, 11007.06439952597, 11013.118950483942, 17412.651746965243, 17442.47672569825, 17496.387626433014, 17524.824751752574, 17561.56096097608, 6603.372679595431, 6809.863802723918, 6845.486588505882, 6852.349026842442, 6915.827104322432, 900.5092224737534, 902.1249388093539, 951.6003278622857, 964.6286179820679, 1007.4106647611083, 27292.863535682194, 28241.15276541666, 28498.0, 28733.712662873102, 28796.424071518453, 953.9284553658504, 987.7234374375187, 995.1342332170913, 1002.3484734922213, 1038.6894388288663, 13261.668458288426, 13332.0, 13550.254735989614, 13587.388567514288, 14204.218767967861, 376571.0, 384638.0, 384717.0, 386003.0, 386322.0, 46312.0, 47141.764291178326, 47167.528324717, 47191.5280847194, 47258.5274147261, 1086.326477583903, 1172.7947609168532, 1244.807054906491, 1249.4564864284066, 1300.9349532523336, 25585.616215756407, 27631.44737105287, 27727.58408623832, 27792.58311125294, 27960.0, 40683.59316406916, 41258.0, 41627.583724162374, 41635.375469367376, 41699.79150104352, 300285.0, 300883.0, 301409.0, 302888.0, 305869.0, 22338.21816236424, 24382.87808560946, 25146.0, 25282.620760688238, 25419.745802541736, 33868.3226335467, 36080.0, 38556.228875422894, 38704.22591548209, 39577.0, 33008.0, 33047.0, 33276.500852486744, 33765.155871103416, 34006.319873602886, 32577.511337329484, 33244.50133247955, 33339.0, 33565.16087097842, 33601.66398335985, 33000.834995824865, 33706.49440258349, 33814.49278260779, 34191.0, 34327.485087724206, 29696.55455168131, 30313.848430757706, 30356.39287214199, 30614.540781887845, 30655.0, 23213.651795222748, 23805.761942380355, 23984.640230396908, 23997.400064998514, 24239.394015149763], "value": 17412.409080257316, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.43077445346944, 368.43629247251704, 380.157950140439, 390.72258696325605, 408.3996525108094, 16048.759268610966, 16687.0, 17335.046572438543, 17536.0, 17594.1202939853, 15888.523344299689, 16101.83898161018, 17048.147592620382, 17065.317387304523, 17099.658006839854, 4681.368015317931, 4810.06203790261, 4829.372181616385, 4838.927416088762, 4842.2736589511505, 3463.861445542188, 5175.534201921826, 5452.672839629635, 5468.863278418052, 5473.75368108436, 5442.020436321461, 5451.809186678467, 5461.69960652164, 5469.699166545838, 5482.0406428874985, 5227.424983251839, 5483.561315094823, 5500.6424582402215, 5504.174373843915, 5510.1459273812625, 3398.1164897126923, 5039.269305950654, 5303.787848486056, 5312.946870531284, 5320.920186197211, 11306.37814920179, 11365.090792736644, 11409.087273018138, 16158.75761863573, 20300.898495507576, 1885.5286178455385, 1961.7351657526337, 1991.5220347116588, 2499.0929107871634, 2507.109975958527, 8914.28685705142, 9004.954975225082, 9016.23362014223, 9177.678781242625, 9252.491112988782, 1743.7122874725655, 1784.8215178482178, 1785.8214178582168, 1803.6122233719814, 1814.7731533558306, 69006.0, 71592.28407715909, 71650.13399464016, 72042.27957720408, 72679.27320726778, 9896.802063958825, 9931.801363972825, 10098.798024039477, 10128.746781330527, 10324.845127323097, 13974.860251397558, 14060.296985150702, 14069.0, 14072.929635351962, 14105.576832695035, 7079.2920707929825, 7123.394511466583, 7209.134903811471, 7239.0, 7263.34629883313, 6528.934710652928, 6684.966575167093, 6706.865862682719, 6794.150731158606, 6835.58986460814, 4350.129974005212, 4371.606555410029, 4409.647228221735, 4414.3157810539415, 4455.353973673799, 1656.403694669918, 1738.8695847811464, 1789.8210178981997, 1796.8023517413073, 1825.561865152354, 816.163432481711, 835.5195762436623, 848.8259906719107, 865.2558799432483, 900.3652425040331, 15564.377424902877, 15940.521784346489, 16020.919895400448, 16149.19254037317, 16155.11146886909, 880.6257340630207, 907.3376435202339, 943.9899307740789, 966.6520052780993, 972.0473935543207, 9410.670626528039, 9465.810683786285, 9541.904580954102, 9712.660056897974, 9785.706428807147, 410021.0, 413358.0, 426937.0, 427930.0, 428924.0, 78382.6080869592, 79400.60299698464, 80545.59727201327, 80690.0, 81604.0, 946.2808265717966, 949.0556895888635, 965.8502932045685, 965.8937516873139, 969.2972594868804, 14600.996634610226, 14838.703225935637, 14858.479953201586, 15250.313542559854, 15392.222971454348, 26591.33521661974, 28095.71904280931, 30075.849620751756, 30480.390392191588, 33953.32093358169, 46834.29748553706, 48678.51321486881, 48840.0, 49015.509844902524, 49098.0, 7736.7292144774665, 7754.7673569793, 7758.107817601048, 7784.338331241908, 7830.960845195737, 10161.745956351151, 10663.733406664895, 10856.0, 10890.401027943539, 10919.781604368027, 7004.369606735215, 7551.647124511507, 9441.197498212729, 9550.474723890253, 9998.500074996076, 9884.357516761387, 9933.801323973625, 9962.501874906371, 9999.450030248407, 10005.54975026111, 9852.901470985198, 9916.107550320507, 9955.651552195639, 10008.549615267184, 10393.324433911772, 6863.0, 7203.459740519377, 7208.675609597685, 7277.818054548678, 7418.998435211393, 9462.574184161867, 10016.699499015042, 10041.899581004389, 10195.818318615657, 10273.640422585473], "value": 7995.5065997018455, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.3618190904547, 1438.2449214162566, 1459.3068292561034, 1598.904065756054, 1775.9733603995935, 7448.515846469975, 7777.105632852224, 7779.7666070017995, 7783.182765809594, 7797.493162944412, 7592.0, 7751.224877512246, 7759.1852855450215, 7760.844783104335, 7785.338246249075, 2198.890055497223, 2220.100859152046, 2221.278084622496, 2221.5445833604153, 2221.7222847144108, 2153.849230553862, 2170.0668712453717, 2211.5355775287208, 2218.622834118196, 2221.1670623516184, 2182.519845633958, 2204.217502786512, 2208.149862303017, 2208.845380823343, 2226.309843948373, 2152.87082775034, 2159.222679835258, 2160.686700428437, 2160.935171944844, 2161.5244646177816, 2150.3333966470445, 2183.705199798023, 2186.169255682846, 2188.2231807708195, 2189.2228258968, 7678.0, 7776.650050747673, 7799.220077992212, 7810.882836757453, 8024.0, 4657.347971284023, 4791.904161916742, 4829.806807727687, 4835.540623640749, 4843.782029808632, 3030.0758268728027, 3059.5257735051105, 3128.5463607776746, 3149.7322727568185, 3157.431662300785, 967.4485543240356, 977.5796407544752, 982.0277924854414, 989.0801554554262, 1007.1640538353149, 10563.788724225473, 10771.730706732316, 10821.891781082246, 10837.729056773565, 10854.45727713611, 4427.579379958899, 4481.910361792746, 4531.048479819209, 4561.543845615412, 4561.608709343682, 9372.95313523428, 9391.060893910555, 9400.15398614128, 9403.0, 9410.294227932933, 4796.616270698336, 4798.160321943646, 4826.565609095198, 4829.73436460991, 4830.806767729251, 3689.7417180797624, 3784.4701741756176, 4204.978975105105, 4325.372820941009, 4358.912821743611, 3740.3267411866127, 3780.1872597391693, 3842.193139440749, 3843.673287770515, 3897.4738410314244, 1238.9504419823286, 1257.2770656872335, 1257.7484503099417, 1270.5235536673747, 1272.1285919145414, 717.3830505765038, 745.9813504662427, 800.8438354520813, 845.5476320168681, 866.5580553917547, 5075.111855425286, 5254.15933450646, 5282.181261904411, 5357.062514060101, 5403.297571315782, 421.21023081721773, 430.1826529593797, 433.7462584388105, 441.18160811694486, 443.6849836615974, 3700.888973330804, 3723.9069023274633, 3752.1745216052423, 3792.544894612609, 3834.4631751554803, 9390.62437502506, 9746.95126524377, 9851.211903047739, 9866.654667086617, 9898.901010989943, 9658.179054780423, 9746.220302375792, 9755.658551950648, 9826.06652368024, 9831.803363932824, 7109.466789990772, 7207.92792072083, 7235.167955685059, 7309.634518274172, 7355.889661655079, 5233.476652334736, 5333.359996800254, 5441.047816632153, 5459.754311056092, 5511.586631002771, 8932.955335223282, 9094.499802510925, 9131.360804743605, 9202.723918282461, 9249.12133347331, 9288.58201380953, 9464.810703785748, 9468.573914173741, 9506.144446999802, 9510.619575216913, 6219.502439804895, 7126.5011449198055, 7517.812054698677, 7562.319391254813, 7567.091948966159, 7203.819904502429, 7237.927620723725, 7299.5620262784405, 7300.634968251672, 7330.523515971445, 6518.902216466851, 6618.735250590115, 6682.599044057372, 6745.561538499982, 6754.290799465985, 6875.7937261882225, 6933.7226510939, 6940.826479338057, 6957.512974091967, 7031.08595882532, 6515.087887695631, 6592.17597800275, 6662.533622646368, 6692.0, 6697.598144111369, 4544.522825103317, 4566.8173273068705, 4659.510751371057, 4675.064987002545, 4747.477777444409, 4470.217711900339, 4672.112298663243, 4733.479317275166, 4773.546513081252, 4780.139574876555], "value": 4146.903356071736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.33492990071346, 310.1733879211899, 312.3970736478596, 314.1658895632096, 315.89891234804844, 5178.275041494194, 5200.843974680756, 5219.191025391061, 5227.607929405291, 5235.659682120659, 5124.20574810904, 5125.923111153326, 5128.974355128228, 5160.612954028444, 5174.172132458807, 3792.829322680486, 3897.1815918656976, 3900.2004589059175, 4018.6785057195502, 4036.2532931407636, 3994.3409337459284, 4011.558728539873, 4014.919701605966, 4019.5176578810438, 4034.253663072341, 3824.5028146340937, 3996.440498330236, 3999.9200015999663, 4001.3197756381487, 4009.719319647626, 3841.481400010991, 3973.4834471518516, 3978.5424676162324, 3985.720999530034, 4006.1386801837743, 3520.4510015593314, 3521.9295614087573, 3526.453399723047, 3541.5041894134843, 3547.130952916552, 4909.0672772173175, 4926.0, 4929.260610908356, 4929.852104436873, 4942.481039490837, 4418.911621767579, 4626.074785043005, 4638.79125439356, 4674.27548729944, 4698.107359601699, 5427.83716488506, 5434.864128396782, 5437.102878025121, 5441.075017247077, 5445.918311225335, 3951.3677811550015, 3954.4661470701376, 3957.0, 3959.6832253419943, 3967.4842270504937, 5443.755031023614, 5584.5253153482, 5617.831465056055, 5622.212890195376, 5686.431356864322, 3937.0, 3966.900827479336, 3975.821088050987, 3983.6016398359934, 3985.5815139410524, 4016.176683779818, 4016.8393264269685, 4032.697547683935, 4033.6571391432058, 4034.374671925856, 4375.2780791169735, 4577.29051996941, 4583.679142460062, 4592.334111553872, 4641.95358046422, 5422.478547475364, 5440.619156659075, 5453.536449401766, 5454.10007348791, 5461.416189305057, 1418.2199790115396, 1443.8267407910907, 1446.0745123121, 1452.6005348529027, 1458.0595515892403, 939.4410325856105, 954.7231302922214, 960.8030353777459, 964.62379671928, 989.3173710140125, 4667.113248482845, 4678.672492925462, 4704.200285951397, 4704.717716936994, 4731.834385796481, 5507.5593952483705, 5521.861953451115, 5534.584906131976, 5534.972325138348, 5539.529140023063, 4522.909541809146, 4679.625629949596, 4691.437027556647, 4706.458757242961, 4786.305985632064, 2976.5981592484736, 2998.4752668282963, 3011.6687164411896, 3028.7425568826898, 3035.8937437190034, 5298.496642819003, 5309.309789727311, 5310.309659744208, 5311.0, 5316.0, 5552.361478429952, 5806.535477161817, 5829.854253643693, 5836.970815145897, 5843.18195452637, 5290.9735451322495, 5297.841064768063, 5302.39022512416, 5303.68177909319, 5316.415194328621, 5293.417724050274, 5644.85887852807, 5645.661260324394, 5659.660420374791, 5671.546276297969, 5533.695646739468, 5540.168974653834, 5540.944590554042, 5548.278723765885, 5577.693226872561, 5306.602004849575, 5324.653897496651, 5328.360596728262, 5329.534378046068, 5339.3058902342445, 3734.329954082844, 3932.2332145231403, 3933.842646294116, 3939.7439166454087, 3959.683225341908, 5577.916331254954, 5591.440855914376, 5595.216669666169, 5596.244506991504, 5609.102543593006, 5349.224362467343, 5359.866003349947, 5377.354717433776, 5386.59600529954, 5437.40188579248, 5269.1569348903995, 5351.097844833952, 5430.864228394164, 5434.266374039612, 5447.0, 5104.668196567211, 5303.76470353092, 5327.9733601331745, 5349.304590403378, 5349.518543330963, 5263.236830659456, 5491.588130890119, 5510.311211098613, 5518.310211223597, 5526.668399895858, 5361.678299302054, 5363.731813409392, 5383.138697808332, 5385.919211211756, 5389.868127693228], "value": 4091.307284033392, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.5591678867862, 764.6903004283267, 789.2856964447174, 791.7110254757015, 793.710295742054, 12255.448504817283, 12660.936695316534, 12677.175983561063, 12686.175398599085, 12695.301758403284, 12244.510219591206, 12572.434240459179, 12605.054620903424, 12617.55838545651, 12623.0, 624.3631495874206, 778.2256654628624, 789.9407544434176, 811.6875003123811, 815.4454970619976, 808.6724876425058, 812.5206128384252, 815.09524427885, 815.1278132398336, 815.657423881971, 859.9828003439927, 860.0840105287848, 862.1034124510533, 863.1023735315265, 863.3395452478859, 669.6885948034163, 835.4277320035795, 861.5950503263456, 862.4566523090475, 863.766782968595, 627.8147946355836, 628.0296941225818, 628.1770880146977, 628.3433811666773, 628.8773689130621, 12667.683307917283, 12720.745585088247, 12724.427400766988, 12737.490500380067, 12752.489900403973, 12262.81605775914, 12561.120721549496, 12596.68508287291, 12737.808932866015, 12899.93550032244, 9853.359531630422, 9910.40537567741, 9982.0, 10025.498725063791, 10112.595496180218, 4133.751974881487, 4170.35359519275, 4180.958190418088, 4284.271673815459, 4324.524302326741, 42278.57721422777, 43460.78269608632, 43686.56313436857, 43903.78048109739, 43918.56081439176, 9744.805103897883, 9952.850707239397, 9955.950220248853, 10021.549030293509, 10140.340877843064, 16710.0, 16925.576860578585, 16930.830691693172, 16936.491905242863, 16960.74558881618, 6858.348456896587, 6922.930770692329, 6956.791296261019, 6959.582425054513, 7138.535995160401, 3860.2665493556133, 3883.37865941448, 3891.20230352777, 3896.649301562873, 3990.900227494336, 2855.5431131018936, 2910.476114299404, 2912.126362091364, 2912.8397938113185, 2913.1843083936533, 485.40780248097263, 486.29972839112276, 486.9488703686062, 488.68479830509835, 491.0571702331532, 625.3746253746253, 647.2879832184559, 658.8352911772057, 659.3307792590524, 661.4741280681869, 7837.294643482114, 7864.820276958388, 7910.169432209535, 7989.760307190793, 8526.31789456842, 531.7181893596401, 592.7599322274485, 640.1358166475221, 642.2613993907045, 647.4108561209277, 3886.3198940185353, 3891.3384724596885, 3910.765354078764, 3930.6855451563806, 3969.7419667721506, 50227.24659130116, 51039.234411483856, 51455.22817157746, 51467.74266128645, 51476.742616287425, 39109.60890391117, 41069.794651026554, 41132.794336028725, 41582.37626435606, 42086.36870446946, 40206.59793402028, 40990.59009409927, 41587.1682566347, 41804.58195418007, 43333.0, 7848.84302313962, 8040.5722443520635, 8305.543195124326, 8346.749597512084, 8385.916140838757, 28024.3568336115, 28176.577351339336, 28612.856935715186, 28701.28246793763, 29265.85367073151, 38740.225195496496, 39579.60420395759, 39703.60296396999, 39943.20113597654, 40155.0, 10953.0, 10953.726156846142, 11022.834657480305, 11098.167637427065, 11439.084873209957, 11528.077753779846, 11990.580329688768, 11993.700157496132, 11994.280343179436, 12261.509539618315, 10638.946805265925, 10650.307729997525, 11235.66293011211, 11386.94306528462, 11896.940515297714, 11088.611898583511, 11105.611303604335, 11138.888611113785, 11316.94341528287, 11636.0, 10288.845667315147, 10595.682129536126, 10823.945880270549, 11052.613158539412, 11481.598144064918, 9314.813703726024, 9472.336936414385, 9550.997145299643, 9557.139857412867, 9977.700668979942, 9356.345055846297, 9516.571754271214, 9747.951260243937, 10125.240606954656, 10184.490775461345], "value": 6012.192377511294, "unit": "score"}], "name": "dromaeo_css", "value": 6350.97120385208, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 109.0, 112.0, 113.0, 113.0, 103.0, 114.0, 113.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 136.0, 160.0, 177.0, 141.0, 151.0, 159.0, 132.0, 187.0, 132.0], "value": 154.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 161.0, 161.0, 160.0, 160.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 175.0, 78.0, 75.0, 77.0, 74.0, 156.0, 74.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 147.0, 95.0, 95.0, 94.0, 146.0, 94.0, 95.0, 152.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 176.0, 146.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 68.0, 66.0, 68.0, 66.0, 81.0, 65.0, 64.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 63.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 77.0, 79.0, 80.0, 81.0, 79.0, 80.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 140.0, 133.0, 138.0, 131.0, 131.0, 129.0, 133.0, 175.0, 140.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 175.0, 174.0, 176.0, 177.0, 173.0, 174.0, 169.0, 170.0, 171.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 79.0, 71.0, 73.0, 71.0, 71.0, 73.0, 72.0, 71.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1586.8, "alertThreshold": 2.0}]} 23:11:28 INFO - Return code: 0 23:11:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:11:28 ERROR - # TBPL SUCCESS # 23:11:28 INFO - Running post-action listener: _resource_record_post_action 23:11:28 INFO - Running post-run listener: _resource_record_post_run 23:11:29 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 147456; Write bytes: 519065600; Read time: 820; Write time: 713480 23:11:29 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 94208; Write bytes: 234827776; Read time: 548; Write time: 425212 23:11:29 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 53248; Write bytes: 284237824; Read time: 272; Write time: 288268 23:11:29 INFO - Running post-run listener: _upload_blobber_files 23:11:29 INFO - Blob upload gear active. 23:11:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:11:29 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 23:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:11:30 INFO - (blobuploader) - INFO - Open directory for files ... 23:11:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:11:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:11:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:11:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:11:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:11:30 INFO - (blobuploader) - INFO - Done attempting. 23:11:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:11:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:11:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:11:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:11:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:11:31 INFO - (blobuploader) - INFO - Done attempting. 23:11:31 INFO - (blobuploader) - INFO - Iteration through files over. 23:11:31 INFO - Return code: 0 23:11:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:11:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:11:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f42fabc5e3dd18c79b6566feac85889a3836b4bba19c2e33848d5b01057759bbc9eb26dff6caca16572ba381fb6b506b39cd94caff13fe0e0c8d9a9ca4bc1a8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a462dea150325f793760a18a50fd550d30c25b64dc605290fae77d11f2334fe0c8a95626fa35aa07f8f61bf2cfd84f842e4a80b62fc9788e5bd0c7c1d050b650"} 23:11:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:11:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:11:31 INFO - Contents: 23:11:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f42fabc5e3dd18c79b6566feac85889a3836b4bba19c2e33848d5b01057759bbc9eb26dff6caca16572ba381fb6b506b39cd94caff13fe0e0c8d9a9ca4bc1a8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a462dea150325f793760a18a50fd550d30c25b64dc605290fae77d11f2334fe0c8a95626fa35aa07f8f61bf2cfd84f842e4a80b62fc9788e5bd0c7c1d050b650"} 23:11:31 INFO - Running post-run listener: copy_logs_to_upload_dir 23:11:31 INFO - Copying logs to upload dir... 23:11:31 INFO - mkdir: /builds/slave/test/build/upload/logs 23:11:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.723846 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-24 23:11:31.843709) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 23:11:31.847394) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f42fabc5e3dd18c79b6566feac85889a3836b4bba19c2e33848d5b01057759bbc9eb26dff6caca16572ba381fb6b506b39cd94caff13fe0e0c8d9a9ca4bc1a8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a462dea150325f793760a18a50fd550d30c25b64dc605290fae77d11f2334fe0c8a95626fa35aa07f8f61bf2cfd84f842e4a80b62fc9788e5bd0c7c1d050b650"} build_url:https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/DeDprnjxQJi4WkfaUHQQsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f42fabc5e3dd18c79b6566feac85889a3836b4bba19c2e33848d5b01057759bbc9eb26dff6caca16572ba381fb6b506b39cd94caff13fe0e0c8d9a9ca4bc1a8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a462dea150325f793760a18a50fd550d30c25b64dc605290fae77d11f2334fe0c8a95626fa35aa07f8f61bf2cfd84f842e4a80b62fc9788e5bd0c7c1d050b650"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 23:11:31.871722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 23:11:31.872046) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461562246.644441-2124529330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 23:11:31.953711) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 23:11:31.954069) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 23:11:31.954352) ========= ========= Total master_lag: 0.17 =========