builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1462479606.99 results: success (0) buildid: 20160505115745 builduid: 317faf2ddeb94033bbcea6223f4d075d revision: 0177462aac74605f426ab9c92e39bb467b7ce2d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:06.991101) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:06.991716) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:06.992140) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:07.008738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:07.009014) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 13:20:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-05 13:20:08 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.065038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:07.087637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:07.088055) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014789 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:07.201526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:07.201963) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0177462aac74605f426ab9c92e39bb467b7ce2d1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0177462aac74605f426ab9c92e39bb467b7ce2d1 --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=5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 13:20:08,769 truncating revision to first 12 chars 2016-05-05 13:20:08,769 Setting DEBUG logging. 2016-05-05 13:20:08,769 attempt 1/10 2016-05-05 13:20:08,769 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0177462aac74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 13:20:09,000 unpacking tar archive at: mozilla-central-0177462aac74/testing/mozharness/ program finished with exit code 0 elapsedTime=0.492122 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:07.707413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:07.707731) ========= script_repo_revision: 0177462aac74605f426ab9c92e39bb467b7ce2d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:07.708119) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:07.708394) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 13:20:07.718423) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-05 13:20:07.718740) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:20:09 INFO - MultiFileLogger online at 20160505 13:20:09 in /builds/slave/test 13:20:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:20:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:20:09 INFO - {'append_to_log': False, 13:20:09 INFO - 'base_work_dir': '/builds/slave/test', 13:20:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:20:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:20:09 INFO - 'branch': 'Firefox-Non-PGO', 13:20:09 INFO - 'buildbot_json_path': 'buildprops.json', 13:20:09 INFO - 'config_files': ('talos/linux_config.py',), 13:20:09 INFO - 'default_actions': ('clobber', 13:20:09 INFO - 'read-buildbot-config', 13:20:09 INFO - 'download-and-extract', 13:20:09 INFO - 'populate-webroot', 13:20:09 INFO - 'create-virtualenv', 13:20:09 INFO - 'install', 13:20:09 INFO - 'run-tests'), 13:20:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:20:09 INFO - 'download_minidump_stackwalk': True, 13:20:09 INFO - 'download_symbols': 'ondemand', 13:20:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:20:09 INFO - 'tooltool.py': '/tools/tooltool.py', 13:20:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:20:09 INFO - '/tools/misc-python/virtualenv.py')}, 13:20:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:20:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:20:09 INFO - 'installer_path': 'installer.exe', 13:20:09 INFO - 'log_level': 'info', 13:20:09 INFO - 'log_name': 'talos', 13:20:09 INFO - 'log_to_console': True, 13:20:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:20:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:20:09 INFO - 'opt_config_files': (), 13:20:09 INFO - 'pip_index': False, 13:20:09 INFO - 'sps_profile': False, 13:20:09 INFO - 'sps_profile_interval': 0, 13:20:09 INFO - 'suite': 'dromaeojs', 13:20:09 INFO - 'system_bits': '32', 13:20:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:20:09 INFO - 'title': 'talos-linux64-ix-051', 13:20:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:20:09 INFO - 'use_talos_json': True, 13:20:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:20:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:20:09 INFO - 'work_dir': 'build'} 13:20:09 INFO - ##### 13:20:09 INFO - ##### Running clobber step. 13:20:09 INFO - ##### 13:20:09 INFO - Running pre-action listener: _resource_record_pre_action 13:20:09 INFO - Running main action method: clobber 13:20:09 INFO - rmtree: /builds/slave/test/build 13:20:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:20:09 INFO - Running post-action listener: _resource_record_post_action 13:20:09 INFO - ##### 13:20:09 INFO - ##### Running read-buildbot-config step. 13:20:09 INFO - ##### 13:20:09 INFO - Running pre-action listener: _resource_record_pre_action 13:20:09 INFO - Running main action method: read_buildbot_config 13:20:09 INFO - Using buildbot properties: 13:20:09 INFO - { 13:20:09 INFO - "project": "", 13:20:09 INFO - "product": "firefox", 13:20:09 INFO - "script_repo_revision": "production", 13:20:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:20:09 INFO - "repository": "", 13:20:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 13:20:09 INFO - "buildid": "20160505115745", 13:20:09 INFO - "pgo_build": "False", 13:20:09 INFO - "basedir": "/builds/slave/test", 13:20:09 INFO - "buildnumber": 81, 13:20:09 INFO - "slavename": "talos-linux64-ix-051", 13:20:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:20:09 INFO - "platform": "ubuntu64_hw", 13:20:09 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 13:20:09 INFO - "branch": "mozilla-central", 13:20:09 INFO - "repo_path": "mozilla-central", 13:20:09 INFO - "revision": "0177462aac74605f426ab9c92e39bb467b7ce2d1", 13:20:09 INFO - "stage_platform": "linux64", 13:20:09 INFO - "builduid": "317faf2ddeb94033bbcea6223f4d075d", 13:20:09 INFO - "slavebuilddir": "test" 13:20:09 INFO - } 13:20:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:20:09 INFO - Running post-action listener: _resource_record_post_action 13:20:09 INFO - ##### 13:20:09 INFO - ##### Running download-and-extract step. 13:20:09 INFO - ##### 13:20:09 INFO - Running pre-action listener: _resource_record_pre_action 13:20:09 INFO - Running main action method: download_and_extract 13:20:09 INFO - mkdir: /builds/slave/test/build/tests 13:20: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')]} 13:20:09 INFO - https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:20:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:20:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:20:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:20:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:20:10 INFO - Downloaded 1361 bytes. 13:20:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:20:10 INFO - Using the following test package requirements: 13:20:10 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:20:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:20:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:20:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:10 INFO - u'jsshell-linux-x86_64.zip'], 13:20:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:20:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:20:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:20:10 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:20:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:20:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:20:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:20:10 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')]} 13:20:10 INFO - https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:20:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:20:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:20:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:20:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:20:11 INFO - Downloaded 22308863 bytes. 13:20:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:20:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:20:12 INFO - Return code: 0 13:20:12 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:12 INFO - https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:20:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:20:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:20:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:20:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:20:13 INFO - Downloaded 22308863 bytes. 13:20:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:20:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:20:15 INFO - Return code: 0 13:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:15 INFO - https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:20:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:20:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:20:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:20:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:20:16 INFO - Downloaded 10840152 bytes. 13:20:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:20:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:20:16 INFO - Return code: 0 13:20:16 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')]} 13:20:16 INFO - https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:20:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:20:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:20:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:20:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:20:17 INFO - Downloaded 54832400 bytes. 13:20:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:20:17 INFO - mkdir: /builds/slave/test/properties 13:20:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:20:17 INFO - Writing to file /builds/slave/test/properties/build_url 13:20:17 INFO - Contents: 13:20:17 INFO - build_url:https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:20:18 INFO - Running post-action listener: _resource_record_post_action 13:20:18 INFO - Running post-action listener: set_extra_try_arguments 13:20:18 INFO - ##### 13:20:18 INFO - ##### Running populate-webroot step. 13:20:18 INFO - ##### 13:20:18 INFO - Running pre-action listener: _resource_record_pre_action 13:20:18 INFO - Running main action method: populate_webroot 13:20:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:20:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:20:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:20:18 INFO - '--tppagecycles', 13:20:18 INFO - '7'], 13:20:18 INFO - 'tests': ['tsvgm']}}, 13:20:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:20:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:20:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:20:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:20:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:20:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:20:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:18 INFO - 'talos_options': ['--disable-e10s'], 13:20:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:20:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:20:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:18 INFO - 'talos_options': ['--disable-e10s'], 13:20:18 INFO - 'tests': ['damp', 'tps']}, 13:20:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:18 INFO - 'tests': ['damp', 'tps']}, 13:20:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:20:18 INFO - 'tests': ['dromaeo_dom']}, 13:20:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:20:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:20:18 INFO - 'tests': ['a11yr', 13:20:18 INFO - 'ts_paint', 13:20:18 INFO - 'tpaint', 13:20:18 INFO - 'sessionrestore', 13:20:18 INFO - 'sessionrestore_no_auto_restore', 13:20:18 INFO - 'tabpaint']}, 13:20:18 INFO - 'other-e10s': {'tests': ['a11yr', 13:20:18 INFO - 'ts_paint', 13:20:18 INFO - 'tpaint', 13:20:18 INFO - 'sessionrestore', 13:20:18 INFO - 'sessionrestore_no_auto_restore', 13:20:18 INFO - 'tabpaint']}, 13:20:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:20:18 INFO - 'ts_paint', 13:20:18 INFO - 'tpaint', 13:20:18 INFO - 'sessionrestore', 13:20:18 INFO - 'sessionrestore_no_auto_restore', 13:20:18 INFO - 'tabpaint']}, 13:20:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:20:18 INFO - 'ts_paint', 13:20:18 INFO - 'tpaint', 13:20:18 INFO - 'sessionrestore', 13:20:18 INFO - 'sessionrestore_no_auto_restore', 13:20:18 INFO - 'tabpaint']}, 13:20:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:20:18 INFO - 'tests': ['a11yr', 13:20:18 INFO - 'ts_paint', 13:20:18 INFO - 'tpaint', 13:20:18 INFO - 'sessionrestore', 13:20:18 INFO - 'sessionrestore_no_auto_restore', 13:20:18 INFO - 'tabpaint']}, 13:20:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:20:18 INFO - 'tests': ['a11yr', 13:20:18 INFO - 'ts_paint', 13:20:18 INFO - 'tpaint', 13:20:18 INFO - 'sessionrestore', 13:20:18 INFO - 'sessionrestore_no_auto_restore', 13:20:18 INFO - 'tabpaint']}, 13:20:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:20:18 INFO - 'tests': ['tsvgx', 13:20:18 INFO - 'tsvgr_opacity', 13:20:18 INFO - 'tart', 13:20:18 INFO - 'tscrollx', 13:20:18 INFO - 'cart']}, 13:20:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:20:18 INFO - 'tsvgr_opacity', 13:20:18 INFO - 'tart', 13:20:18 INFO - 'tscrollx', 13:20:18 INFO - 'cart']}, 13:20:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:18 INFO - 'talos_options': ['--disable-e10s'], 13:20:18 INFO - 'tests': ['tp5o']}, 13:20:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:18 INFO - 'tests': ['tp5o']}, 13:20:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:18 INFO - 'talos_options': ['--disable-e10s', 13:20:18 INFO - '--xperf_path', 13:20:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:20:18 INFO - 'tests': ['tp5n']}, 13:20:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:18 INFO - 'talos_options': ['--xperf_path', 13:20:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:20:18 INFO - 'tests': ['tp5n']}}, 13:20:18 INFO - 'talos.zip': {'path': '', 13:20:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:20:18 INFO - Running post-action listener: _resource_record_post_action 13:20:18 INFO - ##### 13:20:18 INFO - ##### Running create-virtualenv step. 13:20:18 INFO - ##### 13:20:18 INFO - Running pre-action listener: _resource_record_pre_action 13:20:18 INFO - Running main action method: create_virtualenv 13:20:18 INFO - Creating virtualenv /builds/slave/test/build/venv 13:20:18 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 13:20:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:20:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:20:18 INFO - Using real prefix '/usr' 13:20:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:20:19 INFO - Installing distribute.............................................................................................................................................................................................done. 13:20:20 INFO - Installing pip.................done. 13:20:20 INFO - Return code: 0 13:20:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:20:20 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')]} 13:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:20 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')]} 13:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:20 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 0x7fb6fbca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8410>, '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 0x1de9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de97a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', '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 13:20:20 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 13:20:20 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 13:20:20 INFO - Using env: {'DISPLAY': ':0', 13:20:20 INFO - 'HOME': '/home/cltbld', 13:20:20 INFO - 'LANG': 'en_US.UTF-8', 13:20:20 INFO - 'LANGUAGE': 'en_US:en', 13:20:20 INFO - 'LOGNAME': 'cltbld', 13:20:20 INFO - 'MAIL': '/var/mail/cltbld', 13:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:20 INFO - 'MOZ_NO_REMOTE': '1', 13:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:20 INFO - 'NO_EM_RESTART': '1', 13:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:20 INFO - 'PWD': '/builds/slave/test', 13:20:20 INFO - 'SHELL': '/bin/bash', 13:20:20 INFO - 'SHLVL': '1', 13:20:20 INFO - 'TERM': 'linux', 13:20:20 INFO - 'TMOUT': '86400', 13:20:20 INFO - 'USER': 'cltbld', 13:20:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', 13:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:20 INFO - '_': '/tools/buildbot/bin/python'} 13:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:21 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 13:20:21 INFO - Cleaning up... 13:20:21 INFO - Return code: 0 13:20:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:20: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')]} 13:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20: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')]} 13:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:21 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 0x7fb6fbca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8410>, '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 0x1de9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de97a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', '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 13:20:21 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 13:20:21 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 13:20:21 INFO - Using env: {'DISPLAY': ':0', 13:20:21 INFO - 'HOME': '/home/cltbld', 13:20:21 INFO - 'LANG': 'en_US.UTF-8', 13:20:21 INFO - 'LANGUAGE': 'en_US:en', 13:20:21 INFO - 'LOGNAME': 'cltbld', 13:20:21 INFO - 'MAIL': '/var/mail/cltbld', 13:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:21 INFO - 'MOZ_NO_REMOTE': '1', 13:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:21 INFO - 'NO_EM_RESTART': '1', 13:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:21 INFO - 'PWD': '/builds/slave/test', 13:20:21 INFO - 'SHELL': '/bin/bash', 13:20:21 INFO - 'SHLVL': '1', 13:20:21 INFO - 'TERM': 'linux', 13:20:21 INFO - 'TMOUT': '86400', 13:20:21 INFO - 'USER': 'cltbld', 13:20:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', 13:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:21 INFO - '_': '/tools/buildbot/bin/python'} 13:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:21 INFO - Downloading/unpacking psutil>=0.7.1 13:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:20:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:20:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:20:23 INFO - Installing collected packages: psutil 13:20:23 INFO - Running setup.py install for psutil 13:20:23 INFO - building 'psutil._psutil_linux' extension 13:20:23 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 13:20:23 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 13:20:23 INFO - building 'psutil._psutil_posix' extension 13:20:23 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 13:20:23 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 13:20:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:20:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:20:23 INFO - Successfully installed psutil 13:20:23 INFO - Cleaning up... 13:20:23 INFO - Return code: 0 13:20:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:20:23 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')]} 13:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:23 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')]} 13:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:23 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 0x7fb6fbca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8410>, '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 0x1de9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de97a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', '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 13:20:23 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 13:20:23 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 13:20:23 INFO - Using env: {'DISPLAY': ':0', 13:20:23 INFO - 'HOME': '/home/cltbld', 13:20:23 INFO - 'LANG': 'en_US.UTF-8', 13:20:23 INFO - 'LANGUAGE': 'en_US:en', 13:20:23 INFO - 'LOGNAME': 'cltbld', 13:20:23 INFO - 'MAIL': '/var/mail/cltbld', 13:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:23 INFO - 'MOZ_NO_REMOTE': '1', 13:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:23 INFO - 'NO_EM_RESTART': '1', 13:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:23 INFO - 'PWD': '/builds/slave/test', 13:20:23 INFO - 'SHELL': '/bin/bash', 13:20:23 INFO - 'SHLVL': '1', 13:20:23 INFO - 'TERM': 'linux', 13:20:23 INFO - 'TMOUT': '86400', 13:20:23 INFO - 'USER': 'cltbld', 13:20:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', 13:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:23 INFO - '_': '/tools/buildbot/bin/python'} 13:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:20: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 13:20: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 13:20: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 13:20: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 13:20: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 13:20: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 13:20:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:20:26 INFO - Installing collected packages: mozsystemmonitor 13:20:26 INFO - Running setup.py install for mozsystemmonitor 13:20:26 INFO - Successfully installed mozsystemmonitor 13:20:26 INFO - Cleaning up... 13:20:26 INFO - Return code: 0 13:20:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:20:26 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')]} 13:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:26 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')]} 13:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:26 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 0x7fb6fbca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8410>, '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 0x1de9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de97a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', '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 13:20:26 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 13:20:26 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 13:20:26 INFO - Using env: {'DISPLAY': ':0', 13:20:26 INFO - 'HOME': '/home/cltbld', 13:20:26 INFO - 'LANG': 'en_US.UTF-8', 13:20:26 INFO - 'LANGUAGE': 'en_US:en', 13:20:26 INFO - 'LOGNAME': 'cltbld', 13:20:26 INFO - 'MAIL': '/var/mail/cltbld', 13:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:26 INFO - 'MOZ_NO_REMOTE': '1', 13:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:26 INFO - 'NO_EM_RESTART': '1', 13:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:26 INFO - 'PWD': '/builds/slave/test', 13:20:26 INFO - 'SHELL': '/bin/bash', 13:20:26 INFO - 'SHLVL': '1', 13:20:26 INFO - 'TERM': 'linux', 13:20:26 INFO - 'TMOUT': '86400', 13:20:26 INFO - 'USER': 'cltbld', 13:20:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', 13:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:26 INFO - '_': '/tools/buildbot/bin/python'} 13:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:26 INFO - Downloading/unpacking blobuploader==1.2.4 13:20: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 13:20: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 13:20: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 13:20: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 13:20: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 13:20: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 13:20:28 INFO - Downloading blobuploader-1.2.4.tar.gz 13:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:20:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:20:28 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 13:20:28 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 13:20:28 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 13:20:28 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 13:20:28 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 13:20:28 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 13:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:20:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:20:28 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 13:20:28 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 13:20:28 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 13:20:28 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 13:20:28 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 13:20:28 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 13:20:28 INFO - Downloading docopt-0.6.1.tar.gz 13:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:20:29 INFO - Installing collected packages: blobuploader, requests, docopt 13:20:29 INFO - Running setup.py install for blobuploader 13:20:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:20:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:20:29 INFO - Running setup.py install for requests 13:20:29 INFO - Running setup.py install for docopt 13:20:29 INFO - Successfully installed blobuploader requests docopt 13:20:29 INFO - Cleaning up... 13:20:29 INFO - Return code: 0 13:20:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20:29 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')]} 13:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:29 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')]} 13:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:29 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 0x7fb6fbca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8410>, '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 0x1de9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de97a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', '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 13:20:29 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 13:20:29 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 13:20:29 INFO - Using env: {'DISPLAY': ':0', 13:20:29 INFO - 'HOME': '/home/cltbld', 13:20:29 INFO - 'LANG': 'en_US.UTF-8', 13:20:29 INFO - 'LANGUAGE': 'en_US:en', 13:20:29 INFO - 'LOGNAME': 'cltbld', 13:20:29 INFO - 'MAIL': '/var/mail/cltbld', 13:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:29 INFO - 'MOZ_NO_REMOTE': '1', 13:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:29 INFO - 'NO_EM_RESTART': '1', 13:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:29 INFO - 'PWD': '/builds/slave/test', 13:20:29 INFO - 'SHELL': '/bin/bash', 13:20:29 INFO - 'SHLVL': '1', 13:20:29 INFO - 'TERM': 'linux', 13:20:29 INFO - 'TMOUT': '86400', 13:20:29 INFO - 'USER': 'cltbld', 13:20:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', 13:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:29 INFO - '_': '/tools/buildbot/bin/python'} 13:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:20:29 INFO - Running setup.py (path:/tmp/pip-7hyntc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:20:29 INFO - Running setup.py (path:/tmp/pip-lC2XvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:20:29 INFO - Running setup.py (path:/tmp/pip-xRVbEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:20:30 INFO - Running setup.py (path:/tmp/pip-wNWaiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:20:30 INFO - Running setup.py (path:/tmp/pip-coUkY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:20:30 INFO - Running setup.py (path:/tmp/pip-ozqQj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:20:30 INFO - Running setup.py (path:/tmp/pip-RGurls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:20:30 INFO - Running setup.py (path:/tmp/pip-7E01xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:20:30 INFO - Running setup.py (path:/tmp/pip-SqiXMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:20:30 INFO - Running setup.py (path:/tmp/pip-e9qQLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:20:30 INFO - Running setup.py (path:/tmp/pip-j9sxny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:20:30 INFO - Running setup.py (path:/tmp/pip-APdACH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:20:30 INFO - Running setup.py (path:/tmp/pip-2LeqKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:20:30 INFO - Running setup.py (path:/tmp/pip-Ms2phz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:30 INFO - Running setup.py (path:/tmp/pip-iLzlG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:20:30 INFO - Running setup.py (path:/tmp/pip-NZoE8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:20:30 INFO - Running setup.py (path:/tmp/pip-m4XZr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:20:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:20:31 INFO - Running setup.py install for manifestparser 13:20:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:20:31 INFO - Running setup.py install for mozcrash 13:20:31 INFO - Running setup.py install for mozdebug 13:20:31 INFO - Running setup.py install for mozdevice 13:20:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:20:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:20:31 INFO - Running setup.py install for mozfile 13:20:31 INFO - Running setup.py install for mozhttpd 13:20:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:20:31 INFO - Running setup.py install for mozinfo 13:20:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:20:31 INFO - Running setup.py install for mozInstall 13:20:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:20:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:20:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:20:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:20:31 INFO - Running setup.py install for mozleak 13:20:31 INFO - Running setup.py install for mozlog 13:20:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Running setup.py install for moznetwork 13:20:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Running setup.py install for mozprocess 13:20:32 INFO - Running setup.py install for mozprofile 13:20:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Running setup.py install for mozrunner 13:20:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Running setup.py install for mozscreenshot 13:20:32 INFO - Running setup.py install for moztest 13:20:32 INFO - Running setup.py install for mozversion 13:20:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:20:32 INFO - Cleaning up... 13:20:32 INFO - Return code: 0 13:20:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20:32 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')]} 13:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:32 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')]} 13:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:32 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 0x7fb6fbca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8410>, '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 0x1de9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de97a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', '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 13:20:32 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 13:20:32 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 13:20:32 INFO - Using env: {'DISPLAY': ':0', 13:20:32 INFO - 'HOME': '/home/cltbld', 13:20:32 INFO - 'LANG': 'en_US.UTF-8', 13:20:32 INFO - 'LANGUAGE': 'en_US:en', 13:20:32 INFO - 'LOGNAME': 'cltbld', 13:20:32 INFO - 'MAIL': '/var/mail/cltbld', 13:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:32 INFO - 'MOZ_NO_REMOTE': '1', 13:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:32 INFO - 'NO_EM_RESTART': '1', 13:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:32 INFO - 'PWD': '/builds/slave/test', 13:20:32 INFO - 'SHELL': '/bin/bash', 13:20:32 INFO - 'SHLVL': '1', 13:20:32 INFO - 'TERM': 'linux', 13:20:32 INFO - 'TMOUT': '86400', 13:20:32 INFO - 'USER': 'cltbld', 13:20:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', 13:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:32 INFO - '_': '/tools/buildbot/bin/python'} 13:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:20:33 INFO - Running setup.py (path:/tmp/pip-oxi_iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:20:33 INFO - Running setup.py (path:/tmp/pip-IKZoNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:20:33 INFO - Running setup.py (path:/tmp/pip-Z02Blb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:20:33 INFO - Running setup.py (path:/tmp/pip-Qgpz9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:20:33 INFO - Running setup.py (path:/tmp/pip-uaYJR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:20:33 INFO - Running setup.py (path:/tmp/pip-2fHnYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:20:33 INFO - Running setup.py (path:/tmp/pip-dOlVQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:20:33 INFO - Running setup.py (path:/tmp/pip-rCDCrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:20:33 INFO - Running setup.py (path:/tmp/pip-AsLWYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:20:33 INFO - Running setup.py (path:/tmp/pip-gdP32E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:20:33 INFO - Running setup.py (path:/tmp/pip-VTXc6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:20:33 INFO - Running setup.py (path:/tmp/pip-rTs2Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:20:33 INFO - Running setup.py (path:/tmp/pip-GF1_K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:20:33 INFO - Running setup.py (path:/tmp/pip-TY5K2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:34 INFO - Running setup.py (path:/tmp/pip-a4stq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:20:34 INFO - Running setup.py (path:/tmp/pip-631K0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:20:34 INFO - Running setup.py (path:/tmp/pip-BDErVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:20:34 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)) 13:20:34 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)) 13:20:34 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)) 13:20:34 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)) 13:20:34 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)) 13:20:34 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)) 13:20:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:20:34 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 13:20:34 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 13:20:34 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 13:20:34 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 13:20:34 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 13:20:34 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 13:20:36 INFO - Downloading blessings-1.6.tar.gz 13:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:20:36 INFO - Installing collected packages: blessings 13:20:36 INFO - Running setup.py install for blessings 13:20:36 INFO - Successfully installed blessings 13:20:36 INFO - Cleaning up... 13:20:36 INFO - Return code: 0 13:20:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:20:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:20:36 INFO - Reading from file tmpfile_stdout 13:20:36 INFO - Current package versions: 13:20:36 INFO - argparse == 1.2.1 13:20:36 INFO - blessings == 1.6 13:20:36 INFO - blobuploader == 1.2.4 13:20:36 INFO - docopt == 0.6.1 13:20:36 INFO - manifestparser == 1.1 13:20:36 INFO - mozInstall == 1.12 13:20:36 INFO - mozcrash == 0.17 13:20:36 INFO - mozdebug == 0.1 13:20:36 INFO - mozdevice == 0.48 13:20:36 INFO - mozfile == 1.2 13:20:36 INFO - mozhttpd == 0.7 13:20:36 INFO - mozinfo == 0.9 13:20:36 INFO - mozleak == 0.1 13:20:36 INFO - mozlog == 3.1 13:20:36 INFO - moznetwork == 0.27 13:20:36 INFO - mozprocess == 0.22 13:20:36 INFO - mozprofile == 0.28 13:20:36 INFO - mozrunner == 6.11 13:20:36 INFO - mozscreenshot == 0.1 13:20:36 INFO - mozsystemmonitor == 0.0 13:20:36 INFO - moztest == 0.7 13:20:36 INFO - mozversion == 1.4 13:20:36 INFO - psutil == 3.1.1 13:20:36 INFO - requests == 1.2.3 13:20:36 INFO - wsgiref == 0.1.2 13:20:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20:36 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')]} 13:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:36 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')]} 13:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:36 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 0x7fb6fbca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8410>, '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 0x1de9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de97a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', '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 13:20:36 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 13:20:36 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 13:20:36 INFO - Using env: {'DISPLAY': ':0', 13:20:36 INFO - 'HOME': '/home/cltbld', 13:20:36 INFO - 'LANG': 'en_US.UTF-8', 13:20:36 INFO - 'LANGUAGE': 'en_US:en', 13:20:36 INFO - 'LOGNAME': 'cltbld', 13:20:36 INFO - 'MAIL': '/var/mail/cltbld', 13:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:36 INFO - 'MOZ_NO_REMOTE': '1', 13:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:36 INFO - 'NO_EM_RESTART': '1', 13:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:36 INFO - 'PWD': '/builds/slave/test', 13:20:36 INFO - 'SHELL': '/bin/bash', 13:20:36 INFO - 'SHLVL': '1', 13:20:36 INFO - 'TERM': 'linux', 13:20:36 INFO - 'TMOUT': '86400', 13:20:36 INFO - 'USER': 'cltbld', 13:20:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', 13:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:36 INFO - '_': '/tools/buildbot/bin/python'} 13:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:36 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)) 13:20:36 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)) 13:20:36 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)) 13:20:36 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)) 13:20:36 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)) 13:20:36 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)) 13:20:36 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)) 13:20:36 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)) 13:20:36 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)) 13:20:36 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)) 13:20:36 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)) 13:20:36 INFO - Cleaning up... 13:20:36 INFO - Return code: 0 13:20:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:20:36 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')]} 13:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:36 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')]} 13:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:36 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 0x7fb6fbca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8410>, '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 0x1de9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de97a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', '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 13:20:36 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 13:20:36 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 13:20:36 INFO - Using env: {'DISPLAY': ':0', 13:20:36 INFO - 'HOME': '/home/cltbld', 13:20:36 INFO - 'LANG': 'en_US.UTF-8', 13:20:36 INFO - 'LANGUAGE': 'en_US:en', 13:20:36 INFO - 'LOGNAME': 'cltbld', 13:20:36 INFO - 'MAIL': '/var/mail/cltbld', 13:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:36 INFO - 'MOZ_NO_REMOTE': '1', 13:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:36 INFO - 'NO_EM_RESTART': '1', 13:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:36 INFO - 'PWD': '/builds/slave/test', 13:20:36 INFO - 'SHELL': '/bin/bash', 13:20:36 INFO - 'SHLVL': '1', 13:20:36 INFO - 'TERM': 'linux', 13:20:36 INFO - 'TMOUT': '86400', 13:20:36 INFO - 'USER': 'cltbld', 13:20:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', 13:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:36 INFO - '_': '/tools/buildbot/bin/python'} 13:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:37 INFO - Downloading/unpacking jsonschema 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:20:38 INFO - Downloading/unpacking functools32 (from jsonschema) 13:20:38 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 13:20:38 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 13:20:38 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 13:20:38 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 13:20:38 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 13:20:38 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 13:20:39 INFO - Downloading functools32-3.2.3-2.tar.gz 13:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:20:39 INFO - warning: no files found matching '*.txt' 13:20:39 INFO - no previously-included directories found matching 'build' 13:20:39 INFO - no previously-included directories found matching 'dist' 13:20:39 INFO - no previously-included directories found matching '.git*' 13:20:39 INFO - Installing collected packages: jsonschema, functools32 13:20:39 INFO - Running setup.py install for functools32 13:20:39 INFO - warning: no files found matching '*.txt' 13:20:39 INFO - no previously-included directories found matching 'build' 13:20:39 INFO - no previously-included directories found matching 'dist' 13:20:39 INFO - no previously-included directories found matching '.git*' 13:20:39 INFO - Successfully installed jsonschema functools32 13:20:39 INFO - Cleaning up... 13:20:39 INFO - Return code: 0 13:20:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:20:39 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')]} 13:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:39 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')]} 13:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:39 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 0x7fb6fbca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8410>, '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 0x1de9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de97a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', '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 13:20:39 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 13:20:39 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 13:20:39 INFO - Using env: {'DISPLAY': ':0', 13:20:39 INFO - 'HOME': '/home/cltbld', 13:20:39 INFO - 'LANG': 'en_US.UTF-8', 13:20:39 INFO - 'LANGUAGE': 'en_US:en', 13:20:39 INFO - 'LOGNAME': 'cltbld', 13:20:39 INFO - 'MAIL': '/var/mail/cltbld', 13:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:39 INFO - 'MOZ_NO_REMOTE': '1', 13:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:39 INFO - 'NO_EM_RESTART': '1', 13:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:39 INFO - 'PWD': '/builds/slave/test', 13:20:39 INFO - 'SHELL': '/bin/bash', 13:20:39 INFO - 'SHLVL': '1', 13:20:39 INFO - 'TERM': 'linux', 13:20:39 INFO - 'TMOUT': '86400', 13:20:39 INFO - 'USER': 'cltbld', 13:20:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', 13:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:39 INFO - '_': '/tools/buildbot/bin/python'} 13:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:39 INFO - Downloading/unpacking flake8 13:20:39 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 13:20:39 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 13:20:39 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 13:20:39 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 13:20:39 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 13:20:39 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 13:20:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:20:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:20:41 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 13:20:41 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 13:20:41 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 13:20:41 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 13:20:41 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 13:20:41 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 13:20:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:20:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:20:41 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 13:20:41 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 13:20:41 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 13:20:41 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 13:20:41 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 13:20:41 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 13:20:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:20:41 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 13:20:41 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 13:20:41 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 13:20:41 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 13:20:41 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 13:20:41 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 13:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:20:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:20:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:20:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:20:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:20:42 INFO - no previously-included directories found matching 'docs/_build' 13:20:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:20:42 INFO - Running setup.py install for pep8 13:20:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:20:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:20:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:20:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:20:42 INFO - no previously-included directories found matching 'docs/_build' 13:20:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:20:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:20:42 INFO - Cleaning up... 13:20:42 INFO - Return code: 0 13:20:42 INFO - Running post-action listener: _resource_record_post_action 13:20:42 INFO - Running post-action listener: _start_resource_monitoring 13:20:42 INFO - Starting resource monitoring. 13:20:42 INFO - ##### 13:20:42 INFO - ##### Running install step. 13:20:42 INFO - ##### 13:20:42 INFO - Running pre-action listener: _resource_record_pre_action 13:20:42 INFO - Running main action method: install 13:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:20:42 INFO - Reading from file tmpfile_stdout 13:20:42 INFO - Detecting whether we're running mozinstall >=1.0... 13:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:20:42 INFO - Reading from file tmpfile_stdout 13:20:42 INFO - Output received: 13:20:42 INFO - Usage: mozinstall [options] installer 13:20:42 INFO - Options: 13:20:42 INFO - -h, --help show this help message and exit 13:20:42 INFO - -d DEST, --destination=DEST 13:20:42 INFO - Directory to install application into. [default: 13:20:42 INFO - "/builds/slave/test"] 13:20:42 INFO - --app=APP Application being installed. [default: firefox] 13:20:42 INFO - mkdir: /builds/slave/test/build/application 13:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:20:58 INFO - Reading from file tmpfile_stdout 13:20:58 INFO - Output received: 13:20:58 INFO - /builds/slave/test/build/application/firefox/firefox 13:20:58 INFO - Running post-action listener: _resource_record_post_action 13:20:58 INFO - ##### 13:20:58 INFO - ##### Running run-tests step. 13:20:58 INFO - ##### 13:20:58 INFO - Running pre-action listener: _resource_record_pre_action 13:20:58 INFO - Running main action method: run_tests 13:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:20:58 INFO - Python 2.7.3 13:20:58 INFO - Return code: 0 13:20:58 INFO - grabbing minidump binary from tooltool 13:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:58 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 0x1de8410>, '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 0x1de9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:20:58 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 13:20:58 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 13:20:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:20:58 INFO - Return code: 0 13:20:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:20:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:20:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:20:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:20:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:20:59 INFO - Return code: 0 13:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 13:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 13:20:59 INFO - Using env: {'DISPLAY': ':0', 13:20:59 INFO - 'HOME': '/home/cltbld', 13:20:59 INFO - 'LANG': 'en_US.UTF-8', 13:20:59 INFO - 'LANGUAGE': 'en_US:en', 13:20:59 INFO - 'LOGNAME': 'cltbld', 13:20:59 INFO - 'MAIL': '/var/mail/cltbld', 13:20:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:20:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:59 INFO - 'MOZ_NO_REMOTE': '1', 13:20:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:59 INFO - 'NO_EM_RESTART': '1', 13:20:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:59 INFO - 'PWD': '/builds/slave/test', 13:20:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:20:59 INFO - 'SHELL': '/bin/bash', 13:20:59 INFO - 'SHLVL': '1', 13:20:59 INFO - 'TERM': 'linux', 13:20:59 INFO - 'TMOUT': '86400', 13:20:59 INFO - 'USER': 'cltbld', 13:20:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620', 13:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:59 INFO - '_': '/tools/buildbot/bin/python'} 13:20:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 13:20:59 INFO - mozversion application_buildid: 20160505115745 13:20:59 INFO - mozversion application_changeset: 0177462aac74605f426ab9c92e39bb467b7ce2d1 13:20:59 INFO - mozversion application_display_name: Nightly 13:20:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:20:59 INFO - mozversion application_name: Firefox 13:20:59 INFO - mozversion application_remotingname: firefox 13:20:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:20:59 INFO - mozversion application_vendor: Mozilla 13:20:59 INFO - mozversion application_version: 49.0a1 13:20:59 INFO - mozversion platform_buildid: 20160505115745 13:20:59 INFO - mozversion platform_changeset: 0177462aac74605f426ab9c92e39bb467b7ce2d1 13:20:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:20:59 INFO - mozversion platform_version: 49.0a1 13:20:59 INFO - using testdate: 1462479659 13:20:59 INFO - actual date: 1462479659 13:20:59 INFO - starting webserver on 'localhost:42409' 13:20:59 INFO - SUITE-START | Running 2 tests 13:20:59 INFO - TEST-START | dromaeo_css 13:20:59 INFO - operating with platform_type : linux_ 13:20:59 INFO - Initialising browser for dromaeo_css test... 13:20:59 INFO - TEST-INFO | started process 25916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprXEyRg/profile http://localhost:42409/getInfo.html) 13:21:03 INFO - PROCESS | 25916 | __metrics Screen width/height:1600/1200 13:21:03 INFO - PROCESS | 25916 | colorDepth:24 13:21:03 INFO - PROCESS | 25916 | Browser inner width/height: 1024/697 13:21:03 INFO - PROCESS | 25916 | __metrics 13:21:04 ERROR - PROCESS | 25916 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:21:05 INFO - TEST-INFO | 25916: exit 0 13:21:05 INFO - Browser initialized. 13:21:05 INFO - Running cycle 1/1 for dromaeo_css test... 13:21:05 INFO - TEST-INFO | started process 25997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprXEyRg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:21:17 INFO - PROCESS | 25997 | RSS: Main: 154537984 13:21:17 INFO - PROCESS | 25997 | 13:22:09 INFO - PROCESS | 25997 | 1462479729340 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] 13:24:20 INFO - PROCESS | 25997 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42409/tests/dromaeo/cssquery-ext.html) 13:24:21 INFO - PROCESS | 25997 | RSS: Main: 229109760 13:24:21 INFO - PROCESS | 25997 | 13:27:24 INFO - PROCESS | 25997 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-ext.html (next: http://localhost:42409/tests/dromaeo/cssquery-jquery.html) 13:27:25 INFO - PROCESS | 25997 | RSS: Main: 236576768 13:27:25 INFO - PROCESS | 25997 | 13:30:27 INFO - PROCESS | 25997 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42409/tests/dromaeo/cssquery-mootools.html) 13:30:27 INFO - PROCESS | 25997 | RSS: Main: 239796224 13:30:27 INFO - PROCESS | 25997 | 13:33:29 INFO - PROCESS | 25997 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42409/tests/dromaeo/cssquery-prototype.html) 13:33:30 INFO - PROCESS | 25997 | RSS: Main: 231350272 13:33:30 INFO - PROCESS | 25997 | 13:36:33 INFO - PROCESS | 25997 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42409/tests/dromaeo/cssquery-yui.html) 13:36:34 INFO - PROCESS | 25997 | RSS: Main: 213430272 13:36:34 INFO - PROCESS | 25997 | 13:39:37 INFO - PROCESS | 25997 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-yui.html (next: http://localhost:42409/tests/dromaeo/cssquery-dojo.html) 13:39:37 INFO - PROCESS | 25997 | RSS: Main: 275472384 13:39:37 INFO - PROCESS | 25997 | 13:39:37 INFO - PROCESS | 25997 | __start_tp_report 13:39:37 INFO - PROCESS | 25997 | _x_x_mozilla_page_load 13:39:37 INFO - PROCESS | 25997 | _x_x_mozilla_page_load_details 13:39:37 INFO - PROCESS | 25997 | |i|pagename|runs| 13:39:37 INFO - PROCESS | 25997 | |0;dojo.html;2676.8527730974797;2701.8513981731;2724.2177581958035;2744.149313712749;2767.6678798544167;4648.721076735398;4723.0317784854105;4727.9834835510355;4818.27725841124;4866.489018653044;4748.738819364934;4755.785989630466;4800.8319708810195;4828.73441960692;4879.585235254999;4336.566343365654;4372.781360931948;4420.602145806877;4482.03636218213;4541.523140070294;4428.313611390224;4466.665000124987;4487.932681009787;4493.662975276851;4501.549845015505;4258.42511260982;4314.525402205755;4349.043210493686;4349.69552131351;4417.1607394595085;4327.285997810358;4330.826766929319;4353;4434.911301773978;4452.666050046227;4362.149380870732;4371.235033869092;4386.210482113218;4392.3191905254735;4424.38058671783;4526.072155208174;4551.8634440966825;4617.5151609080895;4643.16423043852;4729.4797572267025;5070;5109.565686916617;5117.5650069744115;5128.71792051437;5131.307273518065;5111.361079865017;5120.84637460873;5136.691798492065;5160.019596276696;5164.070467315882;4619.445666520039;4752.857414277577;4800.879978000543;4810.927836082462;4812.326274321597;5337.973310133424;5340.893182136413;5344.4922732340365;5355.678659280456;5357.892842143213;5083;5092.490750924952;5141.485851414904;5145;5147.176451767774;4788.832390866303;5068.239764035424;5116.641835071509;5121.641485096082;5168.121419358643;5087.821926232564;5113.437521872591;5117.950820081875;5118.283440318359;5170.37955445349;4949.48030456804;5097.057044446789;5106.617003724736;5109.6678715883345;5110.872228194251;4353;4378.715383500063;4386.846460373871;4398.47218333802;4399.252127138394;3799.7530160539477;3809.904752381213;3819.236152769457;3823.789691566935;3855.5373355196994;4272.764997925144;4320.956790432118;4398.428204333416;4400.427944367212;4432.534583868712;5061.721605311744;5092.872678183001;5102.183650615883;5130.7947682093045;5132.178851383761;4356.6514678825615;4381.18947994622;4382.364557139197;4382.430284063052;4427.712198707074;4527.320901864681;4577.702449340783;4639.628829693616;4640.234361330343;4663.370444989951;4785.95214047862;4816.638752093537;4834.226523756182;4840.1529732296;4886.853394398245;5122.513361230677;5126.487351264844;5127.717975511383;5131.307273518028;5157.07172708916;4678.76606169697;4800.279958006187;4811.903761924812;4824.565789079;4836.226203807374;5061.291419201389;5083.364579427572;5085.898282034413;5088.720120393414;5116.258142569381;5163.09645811989;5167.431582525844;5168.741562921764;5172.637915345889;5204.141316682856;4855.1260773061185;4966.255061740768;4983.825566105169;4991;5004.874878128076;4986.501349864984;4992.8751781205765;5001.374828146481;5008.474110218521;5046.394432667957;4926.5073492650445;4945.826896058621;4945.901081978413;4994.076095922266;4999.45006049327;4724.740139292372;4852.490488498798;4880.267959806058;4945.4807245238735;5080.7205603692155;4830;4858.052679727561;4858.6356023297685;4859.635527335535;4905.656604037683 13:39:37 INFO - PROCESS | 25997 | |1;ext.html;574.4083593898287;600.3576173494362;610.6793933185079;617.0928734759901;632.44976870123;28222.435551288963;28769.712302876964;30783.538246926313;30858.99999999997;40938;41694.58305416945;42214.7889260554;42239.78880105603;42274.15451690964;42334;7841.882371764428;7989.440739148262;7990.960045199766;7992.560409177493;7992.800179995488;7686.923130768705;7768.223177682215;7780.183080776522;7780.8832867507035;7782.105057918327;7840;7869.016372953381;7873.055233371975;7874.055113386402;7875.4487185897015;7747.186545412735;7772.922270777276;7773.144954055049;7782.377409807202;7794.259545343183;7861.371090312761;7924.524528528307;7925.445218834684;7926;7927.841443171104;38113;38437.80781096077;38471.230575388334;38492.615073849185;38535;3290.3583801158784;3370.6629337066342;3371.342588195303;3394.372041172391;3421.81180035098;29436;29755.553666695017;30082.398352033055;30094;30139.397212055854;3012.698730126992;3032.969670303313;3120.375924815046;3149.165471150147;3154.794938329001;246959;248163;248579;248881;249447;48457;52092.47907520952;52979;53588.1961770566;55119.173212401045;58533.41466585365;58593.84764599741;58669.70665146647;58747.70626146928;58761.706191468766;15351.539453816404;15599.922000390152;15687.607809804618;15729.370825166865;15732.606684832741;10177.389356638625;10436.37381757097;10439.269251152346;11430.142739294586;11784.821517848319;15903;16258.51224463268;16410.343586256415;16429.342826286815;16558.337666493204;5929.229200203946;6016.308124565643;6020.698965051817;6029.879402411927;6120.234970628671;849.587949844325;978.188103873783;1006.7483129217695;1017.8473229015707;1044.6448207609296;28737.71262287392;28987.42025159485;29118.27204319909;29427.705722942497;29480.115596532138;989.6272767879328;1042.9009244121796;1047.0524175621076;1078.5038882114316;1134.9841891507056;15421.845781542266;15434.922825385802;15477.458288959833;15534.922325388301;15615.453459128876;346875;348606;350022;350686;350777;50969.23546146811;51975.74012129991;51985.220221696705;52130.47869521332;52209.47790522122;1174.506707182985;1285;1300.8894243989178;1301.8112373705949;1305.9804102938463;28785.280367990967;29411.558826618046;29880.70119298779;30310.54534181945;30437.695623043484;42421.787891061584;42882.57117428911;42929.35605965851;42943.35584966165;42979.785101074296;271891;272800;273198;273490;273587;30395;36066.8196659015;38521.799557059436;40959;41806.37290440585;42678.359824602034;42708.5729142717;43335.34996975111;44080.559194407644;44255.557444426435;36665.81667091754;36906.8154659225;36921.81539092287;37349.43975840419;37517.24965500729;35427;35919.461208081375;36401.817990909876;36520.63479365173;36799;35749.46375804417;36303.81848090742;36396.45405318975;36599.26801464009;36684.26631467303;31569.21076973094;31945.6805431952;32416;32625.74391433269;32748.672513275516;25241.87379063093;25290;25376.85804138781;25432.491350173263;25618.359541011625 13:39:37 INFO - PROCESS | 25997 | |2;jquery.html;370.2243799240592;377.95842457329707;378.86550274652495;384.87876318959525;390.9218156368727;16050;16212.513624591267;17218.655626887485;17258.48224553262;17259.48221553354;11186.105111591074;15853.52439426819;16620.33518659252;16627.168641567903;17112.82887171128;3407.7784943978686;4571.3600095986585;4726.90546189076;4731.90536189276;4740.07568524138;3555.3244883472057;5138.743062846861;5419.105847535152;5423.105187644034;5506.366767821712;5399.055165346068;5479.342478902538;5486.451354864522;5488.490665067118;5502.862428439301;5301.761420736057;5416.133418652997;5434.076207044792;5439.156930675752;5439.156930675752;5069.605858388935;5239.5546378557865;5249.4750524947585;5249.895002099936;5250.6324557281005;12169.087318451151;12177.695557611041;12227.69430764229;12314.81527777084;12317.692057698629;1773.4768243368237;1887.1036257777582;1981.9207231710714;2457.2751038443703;2464.2237695125978;8822;8967.641294348217;9275.536223188814;10798.676039718743;13036.41336139876;1641.359869650837;1702.8807983441163;1767.4432553745658;1841.7145342471938;1932.1884808380514;68320;70381;72227.2777272231;73720.26279737242;73784.2621573788;10032.598696052077;10115.595376185018;10145;10249.231307651957;10251.794964100676;13869.37587808551;13967.301634918213;13970.860291397159;13983.02118851691;13987.720245595032;7117.82205444868;7168.032315637322;7169.211386747454;7270.854582908312;7288.817779555554;6614.338566143347;6681.699323530453;6744.224414192333;6825.146856642919;6826.829329266808;4335.523092459827;4371.9344209836245;4375.606195442362;4415.735055896656;4450.955490445054;1664.1346499820268;1734.7744793176805;1856.7029275315886;1868.5328667833041;1873.2413372584126;802.2699343597299;849.8993803025097;902.251131560803;946.6071580294239;1049.4700176411015;16425.425110121087;17082.402115925885;17145.828541714673;17176.742348864776;17266.568335791453;884;888.3470649072926;901.3195037746459;903.3947255338938;903.4172958441768;6266.874662506724;9545.761355966017;9747.074027967332;9761.902380976242;9901.801963960681;379161;380834;385627;386634;387592;47402;52493.47506524962;74429.6278518604;74907.13743659414;75600;927.9257659387233;945.163530275711;956.8373376526007;958.4919992404037;983.5623147699205;14885.404583816526;14979.101253924799;15166.10423697038;15225.390984360502;15379;33261.16847078746;33397.49903751397;33721.32557348888;34398.656013440544;35183.29633407369;45534.772326138154;45921.77039114917;48021.75989120172;48092;48290.75854620704;7725.84112383147;7747.57388343624;7755.146933837386;7804.804879877821;7840.3727701784865;8157.8368432632205;10583.788324233627;11231.38227397501;11341.659750207507;11430.428478576205;9838.114569688762;9893.703188904345;9916.710827592367;9932;10226;9997.700068997941;10020.69937901864;10070.949645251727;10272.383656980604;10513.894861051598;9739.41563506192;10085.596576137166;10232.948835256075;10406.235946634748;10483.79032419332;7310.793719036512;7699.30706236419;7719.807004824925;7739.87771773101;7828.2954534092205;7581;9858.654947077104;10075.395476271447;10212.183025357805;10292.433916134685 13:39:37 INFO - PROCESS | 25997 | |3;mootools.html;1283.3390803736083;1480.1415179196065;1527.2211172302125;1673.2386764022372;1855.4155441036064;7219.855602887946;7549.811254718628;7557.3198412142965;7741.187175346592;7749.225077492262;7516.511426757257;7671.6547755351;7671.6547755351;7676.884846727304;7677.769666909988;2129.659254519281;2157.5361297321074;2157.600843843894;2160.621891169047;2161.7838216178416;2139.60417322795;2163.3293678959494;2167.5231449081257;2189.1899997001133;2191.495955930137;2092.665173572229;2095.224766836265;2121.8832964186963;2124.75565309989;2124.936251912445;2114.984807292493;2117.5023869390757;2118.766935637079;2120.151939224307;2136.6154092263387;2057.845661575388;2094.3507512670967;2095.9266425675182;2101.7162683037745;2105.3473423238843;7388.593627350494;7598.506097103671;7618.200088990687;7641.350485208708;7650;4549;4664.370310008139;4667.883302917454;4669.719816811003;4688.976555117237;2883.3944871576996;2912.3010477485464;2912.3301640622776;2949.572312014746;2952.70472952703;905.8414777413992;909.6725178935578;910.0899100899101;919.4253591505309;922.6955104815395;9948.900510994943;9970.700878973643;9983.101520863158;9997;10022.849657255147;3893.357595996629;3928.862489812843;4055.168690418457;4073.2668119738732;4105.2405305018665;8194.30348420379;8293.792655183548;8298.875516867252;8299.709510167115;8301.086880443147;4555.020670555847;4578;4578.45058592971;4582.587567118975;4584.97707511467;3517.577890653138;3976.76139431635;4136.069384388548;4137.234611596864;4200.978995105005;3482.164280572644;3490.424080026767;3553.6091029986683;3568.1793187567005;3597.352476554245;1071.346478648024;1082.7509672775307;1084.5607528950788;1095.9397233152254;1102.1238115698038;842.9199226073636;853.4196746212511;864.8842992539679;902.3052249767642;906.089380172922;5168.9224661630105;5320.52115309624;5340.439253878365;5476.397596264408;5592.664440133605;891.0777345447431;905.3933864310927;936.9531523423801;937.6718148648055;943.7168849345169;3583.8028908409765;3595.17311018462;3637.781733096023;3643.8178091095338;3738.140227747633;9002;9294;9376.109269619375;9419.105185007413;9445;9235.261179105655;9254.305927055499;9272.072792720674;9310.674126405678;9336.346455748168;7214.314640109181;7217.097862767154;7255.238199988925;7256;7268.96365518169;5092.287079808903;5258.447862974485;5275.182346736262;5314.441983591667;5362.51737343641;8467.66129354819;8478.321734261368;8711;8725.476471411735;8756.036835948167;8375.706850260456;8534.957325213334;8545.786355341166;8568.228859402683;8616.655333786579;6285.371462853678;7038.859222815413;7093.290670932865;7208.531445456028;7296.635168241673;7402.481826272109;7407.740729074457;7446.367058800062;7455.440841936768;7464.253574642492;6529.640869752209;6691.297413771484;6717.932820671731;6745.494087943522;6878.3465570770695;6716.966415167893;6732.158480189976;6806.897896531655;6816.454683625398;6889.586624802528;6280.120783090462;6312.242530896322;6418.55070145104;6428.839279018062;6436.066770318372;4429.114177164515;4469.955300447084;4539.296409056601;4580.748058856795;4633.745144017112;4611.769411529477;4625.768711564341;4652.604528615106;4693.202155633482;4696.671233013656 13:39:37 INFO - PROCESS | 25997 | |4;prototype.html;295.48732948334634;298.24097671426216;304.4124839060612;307.1078516908382;310.9751219902408;4748.786304616292;4750.857474275768;4771.165046116933;4813.085513752389;4816.109019831334;4452.39892614497;4525.2080885844925;4683.789229484672;4699.436067671884;4744.857654270369;3720.7209459290525;3750.79370634615;3758.774473531597;3760.6239376062313;3780.8109594520233;3767.60440153784;3768.698504119664;3773.584905660375;3773.716971227169;3778.6396897117015;3472.7569070164973;3574.392353299945;3701.1117331840433;3706.166112624665;3736.7010639148803;3688.5942546319884;3711.2020915503026;3711.6659500645073;3730.2725968436166;3733.5706393764794;3319.13702437368;3323.717484013862;3326.8688645860525;3332.6835899819434;3338.282269312085;4391.780410979471;4461.643068554507;4535.229011068126;4573.382593349888;4580.244259697146;4227.217964676544;4231.97884010581;4236.809343579546;4242.384854196124;4253.595908388698;4874.366332376804;4878.414590249157;4886.584640305543;4897.730624815634;4905.533974272438;3615.313090512794;3625.873094441682;3626.9455958160647;3645.343838109139;3650.142216579102;4950.480199579064;5090.389153301628;5096.541311282002;5118.2578526113875;5134.2812006319145;3658.4512323151207;3664.8167591620313;3680.392735198662;3686.576043754949;3701.722370822199;3745.1198968242443;3746.4567637692926;3747.194353214072;3751.118487155516;3752.1671138290963;4053.43251944728;4201.752062646469;4220.78896055196;4239.894002649897;4249.617534421917;4870.391201099863;4909.386326709161;4916.918277978839;4917.852464426073;4926.852194434173;1190.2501424102934;1237.9133460657667;1255.9811602825964;1268.5369840008516;1279.2004996876951;866.787637028932;875.940112463913;881.4843316659698;885.583775625455;887.7558671365297;4222.767747773902;4236.68224883135;4247.214265360918;4248.366013071915;4262.893427664271;4784.569388754959;4814.459373000606;4865.635077369211;4919.483454237254;4932.432770231398;4162.5629308922735;4175.640762968913;4189.287821070426;4191.874243772691;4198.328267477189;2471.530409222242;2555.5783295756364;2654.9601755973677;2656.574948008348;2663.880125394362;4735.2186889163595;4740.3882679889;4747.430308363018;4757.452892917289;4775.904481910342;5110.693358398508;5119.69447790811;5135.35808023997;5137.51193636604;5192.766325515286;4542.227821270392;4696.812127514998;4719.882002949954;4731.645126615517;4755.476897541268;4944.678595891256;4953.603711703127;4958.181899986462;4990.575801056951;5018.673786203885;4913.950860491349;4916.729579873141;4924.803007879645;4928;4940.851774446773;4513.571210734975;4794.664373493962;4801.68789028712;4808.028708229609;4825.420949486084;3532.9646703532635;3542.6457354264367;3568.4468907319406;3578.1949061460964;3589.6410358963894;4916.92624610624;5001.124353496827;5015.623828212826;5015.648904576645;5026.296318515338;4779.972305954237;4874.90250194987;4939.259111133215;4939.901201976012;4963.5780958618925;4919.139150648693;4942.308076869169;4942.4316203637045;4945.208766597327;4949.307097006494;4594.747288899142;4818.542238487338;4828.66199366041;4856.417229932431;4869.561739443326;5018.29743835856;5031.471695471922;5044.772985215601;5045.571126454292;5057.190849464215;4921.089598424303;4943.307936888767;4949.653524253412;4960.47914968923;4964.900701986012 13:39:37 INFO - PROCESS | 25997 | |5;yui.html;691.6921969723473;752.9021227240457;775.3796962430058;787.8384931089128;801.3989507869098;12514.749705005906;12835.165714228591;12875.678108047303;12967.221966682006;12977.545785897495;13695.383707733152;13799.931000344985;13857.030007899426;13871;13888.652783680387;684.4011489946297;887.29460079237;894.0880302091863;894.7226359828442;895.5208963204686;849.218718778722;894.1952242981304;895.3911340288602;898.0974121008377;898.4025622960723;919.3977944446399;925.5326060339519;927.4898805656895;929.3866048408051;930.7533503621512;720.4020662849822;902.3728508686465;926.5274709897933;927.5779520318273;928.6563971330584;674.8987651852212;677.018323431022;677.1535580524345;678.6572780745742;679.2969276798539;13150.736985260337;13232.536861209812;13260.734785304336;13274.070815042951;13295.468181272834;13100.148490348098;13560.11859229147;13614.455421783216;13694.794578081337;14069.85930140706;9973.601055957753;9977.251706121997;10037.79924401508;10359.119474844647;11069.723256918642;3403;3418.1454636340914;3444.844981975817;3472.6527347265323;3528.400171970771;47592.52407475915;48317.75841120807;48465;49118.26322605164;49157.75421122943;10031.799364012679;10261.435621040766;10376.740581485523;10599.89400105989;10675.25273230882;17125.14374281281;18056.18747156381;19364.128614212394;19416.320428785206;19445.22219111248;7085.92914070863;7127.251638577978;7158.2841715828;7432.962835185897;7442.330190282901;3602.297551977392;3668.5047518585184;3689.1883785567134;3699.8150092495266;3794.981025094912;2847.5443928971267;2907.7964542482246;2912.606798082274;2917;2921.8977335793147;531.2880739808597;537.5323468582359;538.9757460914268;566.7138095261867;600.2017316968421;584.961977471463;590.9822705318848;599.232981783318;620.9099680546295;639.2616527910271;7908.762737117896;7916.525008499509;8039.919600804034;8045.155258697752;8049.3962952778775;481.40306020534285;534.2680527677107;558.6033915919661;608.3976862905691;611.4435863364406;3667.9816600916824;3672;3696.685781708531;3709.3879509880567;3724.1434470071495;54203.45796541984;54697.1795423069;55035;55617.72191139018;56184.15723764147;38470.42294365587;49508.50491495111;49719;50249.74875125601;51661.22508162381;46559.76720116445;46959.76520117446;47180;47185.29222061603;47189.76405118021;7449.962750186214;7533.472656913963;7551.471397002157;7563;7575.659095340613;30433.543496847124;30877.536836947915;31123;31582.36835263328;31645.525317120722;36401.45397818982;38514.422283666325;38972.220555589294;39230.41154382744;39731;10371.740706482398;10476.895231047592;10496.842547361948;10547.314424562379;10716.517756701123;10367.429791361548;10591.258611897094;10595;10738.892611073788;11302.43487825589;10138.79722405533;10220.744481388025;10246.948765256126;10594.364338139736;10660.62687805923;10142.746431339276;10493.790124197625;10762.08522275584;10876.510557024794;10877.347359158475;10266.948665256627;10533.210009249184;10573.101286390744;10638.73403164927;10681.51933163025;8232.83534329322;8406.537640429591;8654.610542525726;8667.454889224759;8940.597673104856;7726.304632583095;7770.417218708506;8173.305269052197;8223.794405139919;8432.662693492191 13:39:37 INFO - PROCESS | 25997 | __end_tp_report 13:39:37 INFO - PROCESS | 25997 | __start_cc_report 13:39:37 INFO - PROCESS | 25997 | _x_x_mozilla_cycle_collect,1067 13:39:37 INFO - PROCESS | 25997 | __end_cc_report 13:39:37 INFO - PROCESS | 25997 | __startTimestamp1462480777275__endTimestamp 13:39:37 INFO - PROCESS | 25997 | 13:39:37 INFO - PROCESS | 25997 | ------- Summary: start ------- 13:39:37 INFO - PROCESS | 25997 | Number of tests: 6 13:39:37 INFO - PROCESS | 25997 | 13:39:37 INFO - PROCESS | 25997 | [#0] dojo.html Cycles:165 Average:4727.63 Median:4834.23 stddev:493.58 (10.2%) stddev-sans-first:468.14 13:39:37 INFO - PROCESS | 25997 | Values: 2676.9 2701.9 2724.2 2744.1 2767.7 4648.7 4723.0 4728.0 4818.3 4866.5 4748.7 4755.8 4800.8 4828.7 4879.6 4336.6 4372.8 4420.6 4482.0 4541.5 4428.3 4466.7 4487.9 4493.7 4501.5 4258.4 4314.5 4349.0 4349.7 4417.2 4327.3 4330.8 4353.0 4434.9 4452.7 4362.1 4371.2 4386.2 4392.3 4424.4 4526.1 4551.9 4617.5 4643.2 4729.5 5070.0 5109.6 5117.6 5128.7 5131.3 5111.4 5120.8 5136.7 5160.0 5164.1 4619.4 4752.9 4800.9 4810.9 4812.3 5338.0 5340.9 5344.5 5355.7 5357.9 5083.0 5092.5 5141.5 5145.0 5147.2 4788.8 5068.2 5116.6 5121.6 5168.1 5087.8 5113.4 5118.0 5118.3 5170.4 4949.5 5097.1 5106.6 5109.7 5110.9 4353.0 4378.7 4386.8 4398.5 4399.3 3799.8 3809.9 3819.2 3823.8 3855.5 4272.8 4321.0 4398.4 4400.4 4432.5 5061.7 5092.9 5102.2 5130.8 5132.2 4356.7 4381.2 4382.4 4382.4 4427.7 4527.3 4577.7 4639.6 4640.2 4663.4 4786.0 4816.6 4834.2 4840.2 4886.9 5122.5 5126.5 5127.7 5131.3 5157.1 4678.8 4800.3 4811.9 4824.6 4836.2 5061.3 5083.4 5085.9 5088.7 5116.3 5163.1 5167.4 5168.7 5172.6 5204.1 4855.1 4966.3 4983.8 4991.0 5004.9 4986.5 4992.9 5001.4 5008.5 5046.4 4926.5 4945.8 4945.9 4994.1 4999.5 4724.7 4852.5 4880.3 4945.5 5080.7 4830.0 4858.1 4858.6 4859.6 4905.7 13:39:37 INFO - PROCESS | 25997 | 13:39:37 INFO - PROCESS | 25997 | [#1] ext.html Cycles:180 Average:45558.02 Median:36185.32 stddev:76858.08 (212.4%) stddev-sans-first:76999.48 13:39:37 INFO - PROCESS | 25997 | Values: 574.4 600.4 610.7 617.1 632.4 28222.4 28769.7 30783.5 30859.0 40938.0 41694.6 42214.8 42239.8 42274.2 42334.0 7841.9 7989.4 7991.0 7992.6 7992.8 7686.9 7768.2 7780.2 7780.9 7782.1 7840.0 7869.0 7873.1 7874.1 7875.4 7747.2 7772.9 7773.1 7782.4 7794.3 7861.4 7924.5 7925.4 7926.0 7927.8 38113.0 38437.8 38471.2 38492.6 38535.0 3290.4 3370.7 3371.3 3394.4 3421.8 29436.0 29755.6 30082.4 30094.0 30139.4 3012.7 3033.0 3120.4 3149.2 3154.8 246959.0 248163.0 248579.0 248881.0 249447.0 48457.0 52092.5 52979.0 53588.2 55119.2 58533.4 58593.8 58669.7 58747.7 58761.7 15351.5 15599.9 15687.6 15729.4 15732.6 10177.4 10436.4 10439.3 11430.1 11784.8 15903.0 16258.5 16410.3 16429.3 16558.3 5929.2 6016.3 6020.7 6029.9 6120.2 849.6 978.2 1006.7 1017.8 1044.6 28737.7 28987.4 29118.3 29427.7 29480.1 989.6 1042.9 1047.1 1078.5 1135.0 15421.8 15434.9 15477.5 15534.9 15615.5 346875.0 348606.0 350022.0 350686.0 350777.0 50969.2 51975.7 51985.2 52130.5 52209.5 1174.5 1285.0 1300.9 1301.8 1306.0 28785.3 29411.6 29880.7 30310.5 30437.7 42421.8 42882.6 42929.4 42943.4 42979.8 271891.0 272800.0 273198.0 273490.0 273587.0 30395.0 36066.8 38521.8 40959.0 41806.4 42678.4 42708.6 43335.3 44080.6 44255.6 36665.8 36906.8 36921.8 37349.4 37517.2 35427.0 35919.5 36401.8 36520.6 36799.0 35749.5 36303.8 36396.5 36599.3 36684.3 31569.2 31945.7 32416.0 32625.7 32748.7 25241.9 25290.0 25376.9 25432.5 25618.4 13:39:37 INFO - PROCESS | 25997 | 13:39:37 INFO - PROCESS | 25997 | [#2] jquery.html Cycles:180 Average:23344.52 Median:24992.86 stddev:63268.10 (253.1%) stddev-sans-first:63422.07 13:39:37 INFO - PROCESS | 25997 | Values: 370.2 378.0 378.9 384.9 390.9 16050.0 16212.5 17218.7 17258.5 17259.5 11186.1 15853.5 16620.3 16627.2 17112.8 3407.8 4571.4 4726.9 4731.9 4740.1 3555.3 5138.7 5419.1 5423.1 5506.4 5399.1 5479.3 5486.5 5488.5 5502.9 5301.8 5416.1 5434.1 5439.2 5439.2 5069.6 5239.6 5249.5 5249.9 5250.6 12169.1 12177.7 12227.7 12314.8 12317.7 1773.5 1887.1 1981.9 2457.3 2464.2 8822.0 8967.6 9275.5 10798.7 13036.4 1641.4 1702.9 1767.4 1841.7 1932.2 68320.0 70381.0 72227.3 73720.3 73784.3 10032.6 10115.6 10145.0 10249.2 10251.8 13869.4 13967.3 13970.9 13983.0 13987.7 7117.8 7168.0 7169.2 7270.9 7288.8 6614.3 6681.7 6744.2 6825.1 6826.8 4335.5 4371.9 4375.6 4415.7 4451.0 1664.1 1734.8 1856.7 1868.5 1873.2 802.3 849.9 902.3 946.6 1049.5 16425.4 17082.4 17145.8 17176.7 17266.6 884.0 888.3 901.3 903.4 903.4 6266.9 9545.8 9747.1 9761.9 9901.8 379161.0 380834.0 385627.0 386634.0 387592.0 47402.0 52493.5 74429.6 74907.1 75600.0 927.9 945.2 956.8 958.5 983.6 14885.4 14979.1 15166.1 15225.4 15379.0 33261.2 33397.5 33721.3 34398.7 35183.3 45534.8 45921.8 48021.8 48092.0 48290.8 7725.8 7747.6 7755.1 7804.8 7840.4 8157.8 10583.8 11231.4 11341.7 11430.4 9838.1 9893.7 9916.7 9932.0 10226.0 9997.7 10020.7 10070.9 10272.4 10513.9 9739.4 10085.6 10232.9 10406.2 10483.8 7310.8 7699.3 7719.8 7739.9 7828.3 7581.0 9858.7 10075.4 10212.2 10292.4 13:39:37 INFO - PROCESS | 25997 | 13:39:37 INFO - PROCESS | 25997 | [#3] mootools.html Cycles:180 Average:5041.68 Median:5936.39 stddev:2753.26 (46.4%) stddev-sans-first:2746.49 13:39:37 INFO - PROCESS | 25997 | Values: 1283.3 1480.1 1527.2 1673.2 1855.4 7219.9 7549.8 7557.3 7741.2 7749.2 7516.5 7671.7 7671.7 7676.9 7677.8 2129.7 2157.5 2157.6 2160.6 2161.8 2139.6 2163.3 2167.5 2189.2 2191.5 2092.7 2095.2 2121.9 2124.8 2124.9 2115.0 2117.5 2118.8 2120.2 2136.6 2057.8 2094.4 2095.9 2101.7 2105.3 7388.6 7598.5 7618.2 7641.4 7650.0 4549.0 4664.4 4667.9 4669.7 4689.0 2883.4 2912.3 2912.3 2949.6 2952.7 905.8 909.7 910.1 919.4 922.7 9948.9 9970.7 9983.1 9997.0 10022.8 3893.4 3928.9 4055.2 4073.3 4105.2 8194.3 8293.8 8298.9 8299.7 8301.1 4555.0 4578.0 4578.5 4582.6 4585.0 3517.6 3976.8 4136.1 4137.2 4201.0 3482.2 3490.4 3553.6 3568.2 3597.4 1071.3 1082.8 1084.6 1095.9 1102.1 842.9 853.4 864.9 902.3 906.1 5168.9 5320.5 5340.4 5476.4 5592.7 891.1 905.4 937.0 937.7 943.7 3583.8 3595.2 3637.8 3643.8 3738.1 9002.0 9294.0 9376.1 9419.1 9445.0 9235.3 9254.3 9272.1 9310.7 9336.3 7214.3 7217.1 7255.2 7256.0 7269.0 5092.3 5258.4 5275.2 5314.4 5362.5 8467.7 8478.3 8711.0 8725.5 8756.0 8375.7 8535.0 8545.8 8568.2 8616.7 6285.4 7038.9 7093.3 7208.5 7296.6 7402.5 7407.7 7446.4 7455.4 7464.3 6529.6 6691.3 6717.9 6745.5 6878.3 6717.0 6732.2 6806.9 6816.5 6889.6 6280.1 6312.2 6418.6 6428.8 6436.1 4429.1 4470.0 4539.3 4580.7 4633.7 4611.8 4625.8 4652.6 4693.2 4696.7 13:39:37 INFO - PROCESS | 25997 | 13:39:37 INFO - PROCESS | 25997 | [#4] prototype.html Cycles:180 Average:4089.10 Median:4690.30 stddev:1169.56 (24.9%) stddev-sans-first:1137.65 13:39:37 INFO - PROCESS | 25997 | Values: 295.5 298.2 304.4 307.1 311.0 4748.8 4750.9 4771.2 4813.1 4816.1 4452.4 4525.2 4683.8 4699.4 4744.9 3720.7 3750.8 3758.8 3760.6 3780.8 3767.6 3768.7 3773.6 3773.7 3778.6 3472.8 3574.4 3701.1 3706.2 3736.7 3688.6 3711.2 3711.7 3730.3 3733.6 3319.1 3323.7 3326.9 3332.7 3338.3 4391.8 4461.6 4535.2 4573.4 4580.2 4227.2 4232.0 4236.8 4242.4 4253.6 4874.4 4878.4 4886.6 4897.7 4905.5 3615.3 3625.9 3626.9 3645.3 3650.1 4950.5 5090.4 5096.5 5118.3 5134.3 3658.5 3664.8 3680.4 3686.6 3701.7 3745.1 3746.5 3747.2 3751.1 3752.2 4053.4 4201.8 4220.8 4239.9 4249.6 4870.4 4909.4 4916.9 4917.9 4926.9 1190.3 1237.9 1256.0 1268.5 1279.2 866.8 875.9 881.5 885.6 887.8 4222.8 4236.7 4247.2 4248.4 4262.9 4784.6 4814.5 4865.6 4919.5 4932.4 4162.6 4175.6 4189.3 4191.9 4198.3 2471.5 2555.6 2655.0 2656.6 2663.9 4735.2 4740.4 4747.4 4757.5 4775.9 5110.7 5119.7 5135.4 5137.5 5192.8 4542.2 4696.8 4719.9 4731.6 4755.5 4944.7 4953.6 4958.2 4990.6 5018.7 4914.0 4916.7 4924.8 4928.0 4940.9 4513.6 4794.7 4801.7 4808.0 4825.4 3533.0 3542.6 3568.4 3578.2 3589.6 4916.9 5001.1 5015.6 5015.6 5026.3 4780.0 4874.9 4939.3 4939.9 4963.6 4919.1 4942.3 4942.4 4945.2 4949.3 4594.7 4818.5 4828.7 4856.4 4869.6 5018.3 5031.5 5044.8 5045.6 5057.2 4921.1 4943.3 4949.7 4960.5 4964.9 13:39:37 INFO - PROCESS | 25997 | 13:39:37 INFO - PROCESS | 25997 | [#5] yui.html Cycles:180 Average:13161.88 Median:47069.88 stddev:15273.70 (32.4%) stddev-sans-first:15287.84 13:39:37 INFO - PROCESS | 25997 | Values: 691.7 752.9 775.4 787.8 801.4 12514.7 12835.2 12875.7 12967.2 12977.5 13695.4 13799.9 13857.0 13871.0 13888.7 684.4 887.3 894.1 894.7 895.5 849.2 894.2 895.4 898.1 898.4 919.4 925.5 927.5 929.4 930.8 720.4 902.4 926.5 927.6 928.7 674.9 677.0 677.2 678.7 679.3 13150.7 13232.5 13260.7 13274.1 13295.5 13100.1 13560.1 13614.5 13694.8 14069.9 9973.6 9977.3 10037.8 10359.1 11069.7 3403.0 3418.1 3444.8 3472.7 3528.4 47592.5 48317.8 48465.0 49118.3 49157.8 10031.8 10261.4 10376.7 10599.9 10675.3 17125.1 18056.2 19364.1 19416.3 19445.2 7085.9 7127.3 7158.3 7433.0 7442.3 3602.3 3668.5 3689.2 3699.8 3795.0 2847.5 2907.8 2912.6 2917.0 2921.9 531.3 537.5 539.0 566.7 600.2 585.0 591.0 599.2 620.9 639.3 7908.8 7916.5 8039.9 8045.2 8049.4 481.4 534.3 558.6 608.4 611.4 3668.0 3672.0 3696.7 3709.4 3724.1 54203.5 54697.2 55035.0 55617.7 56184.2 38470.4 49508.5 49719.0 50249.7 51661.2 46559.8 46959.8 47180.0 47185.3 47189.8 7450.0 7533.5 7551.5 7563.0 7575.7 30433.5 30877.5 31123.0 31582.4 31645.5 36401.5 38514.4 38972.2 39230.4 39731.0 10371.7 10476.9 10496.8 10547.3 10716.5 10367.4 10591.3 10595.0 10738.9 11302.4 10138.8 10220.7 10246.9 10594.4 10660.6 10142.7 10493.8 10762.1 10876.5 10877.3 10266.9 10533.2 10573.1 10638.7 10681.5 8232.8 8406.5 8654.6 8667.5 8940.6 7726.3 7770.4 8173.3 8223.8 8432.7 13:39:37 INFO - PROCESS | 25997 | -------- Summary: end -------- 13:39:37 INFO - PROCESS | 25997 | 13:39:38 INFO - TEST-INFO | 25997: exit 0 13:39:38 INFO - TEST-OK | dromaeo_css | took 1118273ms 13:39:38 INFO - TEST-START | kraken 13:39:38 INFO - operating with platform_type : linux_ 13:39:38 INFO - Initialising browser for kraken test... 13:39:38 INFO - TEST-INFO | started process 26173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzd53Ps/profile http://localhost:42409/getInfo.html) 13:39:42 INFO - PROCESS | 26173 | __metrics Screen width/height:1600/1200 13:39:42 INFO - PROCESS | 26173 | colorDepth:24 13:39:42 INFO - PROCESS | 26173 | Browser inner width/height: 1024/697 13:39:42 INFO - PROCESS | 26173 | __metrics 13:39:42 ERROR - PROCESS | 26173 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:39:43 INFO - TEST-INFO | 26173: exit 0 13:39:43 INFO - Browser initialized. 13:39:43 INFO - Running cycle 1/1 for kraken test... 13:39:43 INFO - TEST-INFO | started process 26253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzd53Ps/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:39:55 INFO - PROCESS | 26253 | RSS: Main: 154009600 13:39:55 INFO - PROCESS | 26253 | 13:39:58 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42409/tests/kraken/driver.html?testName=audio-beat-detection) 13:39:59 INFO - PROCESS | 26253 | RSS: Main: 209911808 13:39:59 INFO - PROCESS | 26253 | 13:40:02 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42409/tests/kraken/driver.html?testName=audio-dft) 13:40:02 INFO - PROCESS | 26253 | RSS: Main: 197865472 13:40:02 INFO - PROCESS | 26253 | 13:40:06 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42409/tests/kraken/driver.html?testName=audio-fft) 13:40:06 INFO - PROCESS | 26253 | RSS: Main: 267190272 13:40:06 INFO - PROCESS | 26253 | 13:40:08 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42409/tests/kraken/driver.html?testName=audio-oscillator) 13:40:09 INFO - PROCESS | 26253 | RSS: Main: 176652288 13:40:09 INFO - PROCESS | 26253 | 13:40:11 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:40:12 INFO - PROCESS | 26253 | RSS: Main: 180011008 13:40:12 INFO - PROCESS | 26253 | 13:40:15 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42409/tests/kraken/driver.html?testName=imaging-darkroom) 13:40:16 INFO - PROCESS | 26253 | RSS: Main: 216240128 13:40:16 INFO - PROCESS | 26253 | 13:40:19 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42409/tests/kraken/driver.html?testName=imaging-desaturate) 13:40:20 INFO - PROCESS | 26253 | RSS: Main: 217366528 13:40:20 INFO - PROCESS | 26253 | 13:40:22 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42409/tests/kraken/driver.html?testName=json-parse-financial) 13:40:23 INFO - PROCESS | 26253 | RSS: Main: 216965120 13:40:23 INFO - PROCESS | 26253 | 13:40:25 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:40:25 INFO - PROCESS | 26253 | RSS: Main: 202792960 13:40:25 INFO - PROCESS | 26253 | 13:40:27 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:40:28 INFO - PROCESS | 26253 | RSS: Main: 207171584 13:40:28 INFO - PROCESS | 26253 | 13:40:30 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:40:31 INFO - PROCESS | 26253 | RSS: Main: 217489408 13:40:31 INFO - PROCESS | 26253 | 13:40:34 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:40:34 INFO - PROCESS | 26253 | RSS: Main: 225435648 13:40:34 INFO - PROCESS | 26253 | 13:40:37 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:40:38 INFO - PROCESS | 26253 | RSS: Main: 221306880 13:40:38 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42409/tests/kraken/driver.html?testName=ai-astar) 13:40:40 INFO - PROCESS | 26253 | RSS: Main: 265809920 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | __start_tp_report 13:40:40 INFO - PROCESS | 26253 | _x_x_mozilla_page_load 13:40:40 INFO - PROCESS | 26253 | _x_x_mozilla_page_load_details 13:40:40 INFO - PROCESS | 26253 | |i|pagename|runs| 13:40:40 INFO - PROCESS | 26253 | |0;ai-astar;114;110;114;113;113;115;113;114;115;115 13:40:40 INFO - PROCESS | 26253 | |1;audio-beat-detection;164;138;157;188;136;154;155;138;193;135 13:40:40 INFO - PROCESS | 26253 | |2;audio-dft;162;163;162;162;162;161;162;162;163;161 13:40:40 INFO - PROCESS | 26253 | |3;audio-fft;77;76;76;126;76;77;77;75;135;76 13:40:40 INFO - PROCESS | 26253 | |4;audio-oscillator;93;94;122;93;94;93;127;93;94;123 13:40:40 INFO - PROCESS | 26253 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 13:40:40 INFO - PROCESS | 26253 | |6;imaging-darkroom;146;146;146;146;146;147;148;146;147;146 13:40:40 INFO - PROCESS | 26253 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;94;95 13:40:40 INFO - PROCESS | 26253 | |8;json-parse-financial;68;66;68;73;66;67;67;83;66;64 13:40:40 INFO - PROCESS | 26253 | |9;json-stringify-tinderbox;63;64;64;63;64;64;64;65;63;63 13:40:40 INFO - PROCESS | 26253 | |10;stanford-crypto-aes;89;86;83;82;83;84;83;83;82;84 13:40:40 INFO - PROCESS | 26253 | |11;stanford-crypto-ccm;142;133;134;138;132;137;133;133;165;141 13:40:40 INFO - PROCESS | 26253 | |12;stanford-crypto-pbkdf2;179;177;179;179;177;178;179;176;176;177 13:40:40 INFO - PROCESS | 26253 | |13;stanford-crypto-sha256-iterative;71;69;68;68;66;68;68;67;68;67 13:40:40 INFO - PROCESS | 26253 | __end_tp_report 13:40:40 INFO - PROCESS | 26253 | __start_cc_report 13:40:40 INFO - PROCESS | 26253 | _x_x_mozilla_cycle_collect,1904 13:40:40 INFO - PROCESS | 26253 | __end_cc_report 13:40:40 INFO - PROCESS | 26253 | __startTimestamp1462480840263__endTimestamp 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | ------- Summary: start ------- 13:40:40 INFO - PROCESS | 26253 | Number of tests: 14 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.51 (1.3%) stddev-sans-first:1.59 13:40:40 INFO - PROCESS | 26253 | Values: 114.0 110.0 114.0 113.0 113.0 115.0 113.0 114.0 115.0 115.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:156.00 stddev:20.95 (13.4%) stddev-sans-first:22.01 13:40:40 INFO - PROCESS | 26253 | Values: 164.0 138.0 157.0 188.0 136.0 154.0 155.0 138.0 193.0 135.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 13:40:40 INFO - PROCESS | 26253 | Values: 162.0 163.0 162.0 162.0 162.0 161.0 162.0 162.0 163.0 161.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#3] audio-fft Cycles:10 Average:87.10 Median:76.00 stddev:22.98 (30.2%) stddev-sans-first:24.08 13:40:40 INFO - PROCESS | 26253 | Values: 77.0 76.0 76.0 126.0 76.0 77.0 77.0 75.0 135.0 76.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:93.00 stddev:14.83 (15.9%) stddev-sans-first:15.31 13:40:40 INFO - PROCESS | 26253 | Values: 93.0 94.0 122.0 93.0 94.0 93.0 127.0 93.0 94.0 123.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:40:40 INFO - PROCESS | 26253 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 13:40:40 INFO - PROCESS | 26253 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 148.0 146.0 147.0 146.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:40:40 INFO - PROCESS | 26253 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:67.50 stddev:5.51 (8.2%) stddev-sans-first:5.84 13:40:40 INFO - PROCESS | 26253 | Values: 68.0 66.0 68.0 73.0 66.0 67.0 67.0 83.0 66.0 64.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 13:40:40 INFO - PROCESS | 26253 | Values: 63.0 64.0 64.0 63.0 64.0 64.0 64.0 65.0 63.0 63.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:2.13 (2.6%) stddev-sans-first:1.22 13:40:40 INFO - PROCESS | 26253 | Values: 89.0 86.0 83.0 82.0 83.0 84.0 83.0 83.0 82.0 84.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:137.50 stddev:9.86 (7.2%) stddev-sans-first:10.39 13:40:40 INFO - PROCESS | 26253 | Values: 142.0 133.0 134.0 138.0 132.0 137.0 133.0 133.0 165.0 141.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:178.50 stddev:1.25 (0.7%) stddev-sans-first:1.24 13:40:40 INFO - PROCESS | 26253 | Values: 179.0 177.0 179.0 179.0 177.0 178.0 179.0 176.0 176.0 177.0 13:40:40 INFO - PROCESS | 26253 | 13:40:40 INFO - PROCESS | 26253 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.33 (2.0%) stddev-sans-first:0.87 13:40:40 INFO - PROCESS | 26253 | Values: 71.0 69.0 68.0 68.0 66.0 68.0 68.0 67.0 68.0 67.0 13:40:40 INFO - PROCESS | 26253 | -------- Summary: end -------- 13:40:40 INFO - PROCESS | 26253 | 13:40:41 INFO - TEST-INFO | 26253: exit 0 13:40:41 INFO - TEST-OK | kraken | took 63284ms 13:40:41 INFO - SUITE-END | took 1181s 13:40:41 INFO - Completed test suite (00:19:41) 13:40:41 INFO - javascript benchmark 13:40:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.8527730974797, 2701.8513981731, 2724.2177581958035, 2744.149313712749, 2767.6678798544167, 4648.721076735398, 4723.0317784854105, 4727.9834835510355, 4818.27725841124, 4866.489018653044, 4748.738819364934, 4755.785989630466, 4800.8319708810195, 4828.73441960692, 4879.585235254999, 4336.566343365654, 4372.781360931948, 4420.602145806877, 4482.03636218213, 4541.523140070294, 4428.313611390224, 4466.665000124987, 4487.932681009787, 4493.662975276851, 4501.549845015505, 4258.42511260982, 4314.525402205755, 4349.043210493686, 4349.69552131351, 4417.1607394595085, 4327.285997810358, 4330.826766929319, 4353.0, 4434.911301773978, 4452.666050046227, 4362.149380870732, 4371.235033869092, 4386.210482113218, 4392.3191905254735, 4424.38058671783, 4526.072155208174, 4551.8634440966825, 4617.5151609080895, 4643.16423043852, 4729.4797572267025, 5070.0, 5109.565686916617, 5117.5650069744115, 5128.71792051437, 5131.307273518065, 5111.361079865017, 5120.84637460873, 5136.691798492065, 5160.019596276696, 5164.070467315882, 4619.445666520039, 4752.857414277577, 4800.879978000543, 4810.927836082462, 4812.326274321597, 5337.973310133424, 5340.893182136413, 5344.4922732340365, 5355.678659280456, 5357.892842143213, 5083.0, 5092.490750924952, 5141.485851414904, 5145.0, 5147.176451767774, 4788.832390866303, 5068.239764035424, 5116.641835071509, 5121.641485096082, 5168.121419358643, 5087.821926232564, 5113.437521872591, 5117.950820081875, 5118.283440318359, 5170.37955445349, 4949.48030456804, 5097.057044446789, 5106.617003724736, 5109.6678715883345, 5110.872228194251, 4353.0, 4378.715383500063, 4386.846460373871, 4398.47218333802, 4399.252127138394, 3799.7530160539477, 3809.904752381213, 3819.236152769457, 3823.789691566935, 3855.5373355196994, 4272.764997925144, 4320.956790432118, 4398.428204333416, 4400.427944367212, 4432.534583868712, 5061.721605311744, 5092.872678183001, 5102.183650615883, 5130.7947682093045, 5132.178851383761, 4356.6514678825615, 4381.18947994622, 4382.364557139197, 4382.430284063052, 4427.712198707074, 4527.320901864681, 4577.702449340783, 4639.628829693616, 4640.234361330343, 4663.370444989951, 4785.95214047862, 4816.638752093537, 4834.226523756182, 4840.1529732296, 4886.853394398245, 5122.513361230677, 5126.487351264844, 5127.717975511383, 5131.307273518028, 5157.07172708916, 4678.76606169697, 4800.279958006187, 4811.903761924812, 4824.565789079, 4836.226203807374, 5061.291419201389, 5083.364579427572, 5085.898282034413, 5088.720120393414, 5116.258142569381, 5163.09645811989, 5167.431582525844, 5168.741562921764, 5172.637915345889, 5204.141316682856, 4855.1260773061185, 4966.255061740768, 4983.825566105169, 4991.0, 5004.874878128076, 4986.501349864984, 4992.8751781205765, 5001.374828146481, 5008.474110218521, 5046.394432667957, 4926.5073492650445, 4945.826896058621, 4945.901081978413, 4994.076095922266, 4999.45006049327, 4724.740139292372, 4852.490488498798, 4880.267959806058, 4945.4807245238735, 5080.7205603692155, 4830.0, 4858.052679727561, 4858.6356023297685, 4859.635527335535, 4905.656604037683], "value": 4696.823953729919, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.4083593898287, 600.3576173494362, 610.6793933185079, 617.0928734759901, 632.44976870123, 28222.435551288963, 28769.712302876964, 30783.538246926313, 30858.99999999997, 40938.0, 41694.58305416945, 42214.7889260554, 42239.78880105603, 42274.15451690964, 42334.0, 7841.882371764428, 7989.440739148262, 7990.960045199766, 7992.560409177493, 7992.800179995488, 7686.923130768705, 7768.223177682215, 7780.183080776522, 7780.8832867507035, 7782.105057918327, 7840.0, 7869.016372953381, 7873.055233371975, 7874.055113386402, 7875.4487185897015, 7747.186545412735, 7772.922270777276, 7773.144954055049, 7782.377409807202, 7794.259545343183, 7861.371090312761, 7924.524528528307, 7925.445218834684, 7926.0, 7927.841443171104, 38113.0, 38437.80781096077, 38471.230575388334, 38492.615073849185, 38535.0, 3290.3583801158784, 3370.6629337066342, 3371.342588195303, 3394.372041172391, 3421.81180035098, 29436.0, 29755.553666695017, 30082.398352033055, 30094.0, 30139.397212055854, 3012.698730126992, 3032.969670303313, 3120.375924815046, 3149.165471150147, 3154.794938329001, 246959.0, 248163.0, 248579.0, 248881.0, 249447.0, 48457.0, 52092.47907520952, 52979.0, 53588.1961770566, 55119.173212401045, 58533.41466585365, 58593.84764599741, 58669.70665146647, 58747.70626146928, 58761.706191468766, 15351.539453816404, 15599.922000390152, 15687.607809804618, 15729.370825166865, 15732.606684832741, 10177.389356638625, 10436.37381757097, 10439.269251152346, 11430.142739294586, 11784.821517848319, 15903.0, 16258.51224463268, 16410.343586256415, 16429.342826286815, 16558.337666493204, 5929.229200203946, 6016.308124565643, 6020.698965051817, 6029.879402411927, 6120.234970628671, 849.587949844325, 978.188103873783, 1006.7483129217695, 1017.8473229015707, 1044.6448207609296, 28737.71262287392, 28987.42025159485, 29118.27204319909, 29427.705722942497, 29480.115596532138, 989.6272767879328, 1042.9009244121796, 1047.0524175621076, 1078.5038882114316, 1134.9841891507056, 15421.845781542266, 15434.922825385802, 15477.458288959833, 15534.922325388301, 15615.453459128876, 346875.0, 348606.0, 350022.0, 350686.0, 350777.0, 50969.23546146811, 51975.74012129991, 51985.220221696705, 52130.47869521332, 52209.47790522122, 1174.506707182985, 1285.0, 1300.8894243989178, 1301.8112373705949, 1305.9804102938463, 28785.280367990967, 29411.558826618046, 29880.70119298779, 30310.54534181945, 30437.695623043484, 42421.787891061584, 42882.57117428911, 42929.35605965851, 42943.35584966165, 42979.785101074296, 271891.0, 272800.0, 273198.0, 273490.0, 273587.0, 30395.0, 36066.8196659015, 38521.799557059436, 40959.0, 41806.37290440585, 42678.359824602034, 42708.5729142717, 43335.34996975111, 44080.559194407644, 44255.557444426435, 36665.81667091754, 36906.8154659225, 36921.81539092287, 37349.43975840419, 37517.24965500729, 35427.0, 35919.461208081375, 36401.817990909876, 36520.63479365173, 36799.0, 35749.46375804417, 36303.81848090742, 36396.45405318975, 36599.26801464009, 36684.26631467303, 31569.21076973094, 31945.6805431952, 32416.0, 32625.74391433269, 32748.672513275516, 25241.87379063093, 25290.0, 25376.85804138781, 25432.491350173263, 25618.359541011625], "value": 17739.58625769771, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2243799240592, 377.95842457329707, 378.86550274652495, 384.87876318959525, 390.9218156368727, 16050.0, 16212.513624591267, 17218.655626887485, 17258.48224553262, 17259.48221553354, 11186.105111591074, 15853.52439426819, 16620.33518659252, 16627.168641567903, 17112.82887171128, 3407.7784943978686, 4571.3600095986585, 4726.90546189076, 4731.90536189276, 4740.07568524138, 3555.3244883472057, 5138.743062846861, 5419.105847535152, 5423.105187644034, 5506.366767821712, 5399.055165346068, 5479.342478902538, 5486.451354864522, 5488.490665067118, 5502.862428439301, 5301.761420736057, 5416.133418652997, 5434.076207044792, 5439.156930675752, 5439.156930675752, 5069.605858388935, 5239.5546378557865, 5249.4750524947585, 5249.895002099936, 5250.6324557281005, 12169.087318451151, 12177.695557611041, 12227.69430764229, 12314.81527777084, 12317.692057698629, 1773.4768243368237, 1887.1036257777582, 1981.9207231710714, 2457.2751038443703, 2464.2237695125978, 8822.0, 8967.641294348217, 9275.536223188814, 10798.676039718743, 13036.41336139876, 1641.359869650837, 1702.8807983441163, 1767.4432553745658, 1841.7145342471938, 1932.1884808380514, 68320.0, 70381.0, 72227.2777272231, 73720.26279737242, 73784.2621573788, 10032.598696052077, 10115.595376185018, 10145.0, 10249.231307651957, 10251.794964100676, 13869.37587808551, 13967.301634918213, 13970.860291397159, 13983.02118851691, 13987.720245595032, 7117.82205444868, 7168.032315637322, 7169.211386747454, 7270.854582908312, 7288.817779555554, 6614.338566143347, 6681.699323530453, 6744.224414192333, 6825.146856642919, 6826.829329266808, 4335.523092459827, 4371.9344209836245, 4375.606195442362, 4415.735055896656, 4450.955490445054, 1664.1346499820268, 1734.7744793176805, 1856.7029275315886, 1868.5328667833041, 1873.2413372584126, 802.2699343597299, 849.8993803025097, 902.251131560803, 946.6071580294239, 1049.4700176411015, 16425.425110121087, 17082.402115925885, 17145.828541714673, 17176.742348864776, 17266.568335791453, 884.0, 888.3470649072926, 901.3195037746459, 903.3947255338938, 903.4172958441768, 6266.874662506724, 9545.761355966017, 9747.074027967332, 9761.902380976242, 9901.801963960681, 379161.0, 380834.0, 385627.0, 386634.0, 387592.0, 47402.0, 52493.47506524962, 74429.6278518604, 74907.13743659414, 75600.0, 927.9257659387233, 945.163530275711, 956.8373376526007, 958.4919992404037, 983.5623147699205, 14885.404583816526, 14979.101253924799, 15166.10423697038, 15225.390984360502, 15379.0, 33261.16847078746, 33397.49903751397, 33721.32557348888, 34398.656013440544, 35183.29633407369, 45534.772326138154, 45921.77039114917, 48021.75989120172, 48092.0, 48290.75854620704, 7725.84112383147, 7747.57388343624, 7755.146933837386, 7804.804879877821, 7840.3727701784865, 8157.8368432632205, 10583.788324233627, 11231.38227397501, 11341.659750207507, 11430.428478576205, 9838.114569688762, 9893.703188904345, 9916.710827592367, 9932.0, 10226.0, 9997.700068997941, 10020.69937901864, 10070.949645251727, 10272.383656980604, 10513.894861051598, 9739.41563506192, 10085.596576137166, 10232.948835256075, 10406.235946634748, 10483.79032419332, 7310.793719036512, 7699.30706236419, 7719.807004824925, 7739.87771773101, 7828.2954534092205, 7581.0, 9858.654947077104, 10075.395476271447, 10212.183025357805, 10292.433916134685], "value": 7967.953984223383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.3390803736083, 1480.1415179196065, 1527.2211172302125, 1673.2386764022372, 1855.4155441036064, 7219.855602887946, 7549.811254718628, 7557.3198412142965, 7741.187175346592, 7749.225077492262, 7516.511426757257, 7671.6547755351, 7671.6547755351, 7676.884846727304, 7677.769666909988, 2129.659254519281, 2157.5361297321074, 2157.600843843894, 2160.621891169047, 2161.7838216178416, 2139.60417322795, 2163.3293678959494, 2167.5231449081257, 2189.1899997001133, 2191.495955930137, 2092.665173572229, 2095.224766836265, 2121.8832964186963, 2124.75565309989, 2124.936251912445, 2114.984807292493, 2117.5023869390757, 2118.766935637079, 2120.151939224307, 2136.6154092263387, 2057.845661575388, 2094.3507512670967, 2095.9266425675182, 2101.7162683037745, 2105.3473423238843, 7388.593627350494, 7598.506097103671, 7618.200088990687, 7641.350485208708, 7650.0, 4549.0, 4664.370310008139, 4667.883302917454, 4669.719816811003, 4688.976555117237, 2883.3944871576996, 2912.3010477485464, 2912.3301640622776, 2949.572312014746, 2952.70472952703, 905.8414777413992, 909.6725178935578, 910.0899100899101, 919.4253591505309, 922.6955104815395, 9948.900510994943, 9970.700878973643, 9983.101520863158, 9997.0, 10022.849657255147, 3893.357595996629, 3928.862489812843, 4055.168690418457, 4073.2668119738732, 4105.2405305018665, 8194.30348420379, 8293.792655183548, 8298.875516867252, 8299.709510167115, 8301.086880443147, 4555.020670555847, 4578.0, 4578.45058592971, 4582.587567118975, 4584.97707511467, 3517.577890653138, 3976.76139431635, 4136.069384388548, 4137.234611596864, 4200.978995105005, 3482.164280572644, 3490.424080026767, 3553.6091029986683, 3568.1793187567005, 3597.352476554245, 1071.346478648024, 1082.7509672775307, 1084.5607528950788, 1095.9397233152254, 1102.1238115698038, 842.9199226073636, 853.4196746212511, 864.8842992539679, 902.3052249767642, 906.089380172922, 5168.9224661630105, 5320.52115309624, 5340.439253878365, 5476.397596264408, 5592.664440133605, 891.0777345447431, 905.3933864310927, 936.9531523423801, 937.6718148648055, 943.7168849345169, 3583.8028908409765, 3595.17311018462, 3637.781733096023, 3643.8178091095338, 3738.140227747633, 9002.0, 9294.0, 9376.109269619375, 9419.105185007413, 9445.0, 9235.261179105655, 9254.305927055499, 9272.072792720674, 9310.674126405678, 9336.346455748168, 7214.314640109181, 7217.097862767154, 7255.238199988925, 7256.0, 7268.96365518169, 5092.287079808903, 5258.447862974485, 5275.182346736262, 5314.441983591667, 5362.51737343641, 8467.66129354819, 8478.321734261368, 8711.0, 8725.476471411735, 8756.036835948167, 8375.706850260456, 8534.957325213334, 8545.786355341166, 8568.228859402683, 8616.655333786579, 6285.371462853678, 7038.859222815413, 7093.290670932865, 7208.531445456028, 7296.635168241673, 7402.481826272109, 7407.740729074457, 7446.367058800062, 7455.440841936768, 7464.253574642492, 6529.640869752209, 6691.297413771484, 6717.932820671731, 6745.494087943522, 6878.3465570770695, 6716.966415167893, 6732.158480189976, 6806.897896531655, 6816.454683625398, 6889.586624802528, 6280.120783090462, 6312.242530896322, 6418.55070145104, 6428.839279018062, 6436.066770318372, 4429.114177164515, 4469.955300447084, 4539.296409056601, 4580.748058856795, 4633.745144017112, 4611.769411529477, 4625.768711564341, 4652.604528615106, 4693.202155633482, 4696.671233013656], "value": 4090.8437310120626, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.48732948334634, 298.24097671426216, 304.4124839060612, 307.1078516908382, 310.9751219902408, 4748.786304616292, 4750.857474275768, 4771.165046116933, 4813.085513752389, 4816.109019831334, 4452.39892614497, 4525.2080885844925, 4683.789229484672, 4699.436067671884, 4744.857654270369, 3720.7209459290525, 3750.79370634615, 3758.774473531597, 3760.6239376062313, 3780.8109594520233, 3767.60440153784, 3768.698504119664, 3773.584905660375, 3773.716971227169, 3778.6396897117015, 3472.7569070164973, 3574.392353299945, 3701.1117331840433, 3706.166112624665, 3736.7010639148803, 3688.5942546319884, 3711.2020915503026, 3711.6659500645073, 3730.2725968436166, 3733.5706393764794, 3319.13702437368, 3323.717484013862, 3326.8688645860525, 3332.6835899819434, 3338.282269312085, 4391.780410979471, 4461.643068554507, 4535.229011068126, 4573.382593349888, 4580.244259697146, 4227.217964676544, 4231.97884010581, 4236.809343579546, 4242.384854196124, 4253.595908388698, 4874.366332376804, 4878.414590249157, 4886.584640305543, 4897.730624815634, 4905.533974272438, 3615.313090512794, 3625.873094441682, 3626.9455958160647, 3645.343838109139, 3650.142216579102, 4950.480199579064, 5090.389153301628, 5096.541311282002, 5118.2578526113875, 5134.2812006319145, 3658.4512323151207, 3664.8167591620313, 3680.392735198662, 3686.576043754949, 3701.722370822199, 3745.1198968242443, 3746.4567637692926, 3747.194353214072, 3751.118487155516, 3752.1671138290963, 4053.43251944728, 4201.752062646469, 4220.78896055196, 4239.894002649897, 4249.617534421917, 4870.391201099863, 4909.386326709161, 4916.918277978839, 4917.852464426073, 4926.852194434173, 1190.2501424102934, 1237.9133460657667, 1255.9811602825964, 1268.5369840008516, 1279.2004996876951, 866.787637028932, 875.940112463913, 881.4843316659698, 885.583775625455, 887.7558671365297, 4222.767747773902, 4236.68224883135, 4247.214265360918, 4248.366013071915, 4262.893427664271, 4784.569388754959, 4814.459373000606, 4865.635077369211, 4919.483454237254, 4932.432770231398, 4162.5629308922735, 4175.640762968913, 4189.287821070426, 4191.874243772691, 4198.328267477189, 2471.530409222242, 2555.5783295756364, 2654.9601755973677, 2656.574948008348, 2663.880125394362, 4735.2186889163595, 4740.3882679889, 4747.430308363018, 4757.452892917289, 4775.904481910342, 5110.693358398508, 5119.69447790811, 5135.35808023997, 5137.51193636604, 5192.766325515286, 4542.227821270392, 4696.812127514998, 4719.882002949954, 4731.645126615517, 4755.476897541268, 4944.678595891256, 4953.603711703127, 4958.181899986462, 4990.575801056951, 5018.673786203885, 4913.950860491349, 4916.729579873141, 4924.803007879645, 4928.0, 4940.851774446773, 4513.571210734975, 4794.664373493962, 4801.68789028712, 4808.028708229609, 4825.420949486084, 3532.9646703532635, 3542.6457354264367, 3568.4468907319406, 3578.1949061460964, 3589.6410358963894, 4916.92624610624, 5001.124353496827, 5015.623828212826, 5015.648904576645, 5026.296318515338, 4779.972305954237, 4874.90250194987, 4939.259111133215, 4939.901201976012, 4963.5780958618925, 4919.139150648693, 4942.308076869169, 4942.4316203637045, 4945.208766597327, 4949.307097006494, 4594.747288899142, 4818.542238487338, 4828.66199366041, 4856.417229932431, 4869.561739443326, 5018.29743835856, 5031.471695471922, 5044.772985215601, 5045.571126454292, 5057.190849464215, 4921.089598424303, 4943.307936888767, 4949.653524253412, 4960.47914968923, 4964.900701986012], "value": 3722.0287310229787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.6921969723473, 752.9021227240457, 775.3796962430058, 787.8384931089128, 801.3989507869098, 12514.749705005906, 12835.165714228591, 12875.678108047303, 12967.221966682006, 12977.545785897495, 13695.383707733152, 13799.931000344985, 13857.030007899426, 13871.0, 13888.652783680387, 684.4011489946297, 887.29460079237, 894.0880302091863, 894.7226359828442, 895.5208963204686, 849.218718778722, 894.1952242981304, 895.3911340288602, 898.0974121008377, 898.4025622960723, 919.3977944446399, 925.5326060339519, 927.4898805656895, 929.3866048408051, 930.7533503621512, 720.4020662849822, 902.3728508686465, 926.5274709897933, 927.5779520318273, 928.6563971330584, 674.8987651852212, 677.018323431022, 677.1535580524345, 678.6572780745742, 679.2969276798539, 13150.736985260337, 13232.536861209812, 13260.734785304336, 13274.070815042951, 13295.468181272834, 13100.148490348098, 13560.11859229147, 13614.455421783216, 13694.794578081337, 14069.85930140706, 9973.601055957753, 9977.251706121997, 10037.79924401508, 10359.119474844647, 11069.723256918642, 3403.0, 3418.1454636340914, 3444.844981975817, 3472.6527347265323, 3528.400171970771, 47592.52407475915, 48317.75841120807, 48465.0, 49118.26322605164, 49157.75421122943, 10031.799364012679, 10261.435621040766, 10376.740581485523, 10599.89400105989, 10675.25273230882, 17125.14374281281, 18056.18747156381, 19364.128614212394, 19416.320428785206, 19445.22219111248, 7085.92914070863, 7127.251638577978, 7158.2841715828, 7432.962835185897, 7442.330190282901, 3602.297551977392, 3668.5047518585184, 3689.1883785567134, 3699.8150092495266, 3794.981025094912, 2847.5443928971267, 2907.7964542482246, 2912.606798082274, 2917.0, 2921.8977335793147, 531.2880739808597, 537.5323468582359, 538.9757460914268, 566.7138095261867, 600.2017316968421, 584.961977471463, 590.9822705318848, 599.232981783318, 620.9099680546295, 639.2616527910271, 7908.762737117896, 7916.525008499509, 8039.919600804034, 8045.155258697752, 8049.3962952778775, 481.40306020534285, 534.2680527677107, 558.6033915919661, 608.3976862905691, 611.4435863364406, 3667.9816600916824, 3672.0, 3696.685781708531, 3709.3879509880567, 3724.1434470071495, 54203.45796541984, 54697.1795423069, 55035.0, 55617.72191139018, 56184.15723764147, 38470.42294365587, 49508.50491495111, 49719.0, 50249.74875125601, 51661.22508162381, 46559.76720116445, 46959.76520117446, 47180.0, 47185.29222061603, 47189.76405118021, 7449.962750186214, 7533.472656913963, 7551.471397002157, 7563.0, 7575.659095340613, 30433.543496847124, 30877.536836947915, 31123.0, 31582.36835263328, 31645.525317120722, 36401.45397818982, 38514.422283666325, 38972.220555589294, 39230.41154382744, 39731.0, 10371.740706482398, 10476.895231047592, 10496.842547361948, 10547.314424562379, 10716.517756701123, 10367.429791361548, 10591.258611897094, 10595.0, 10738.892611073788, 11302.43487825589, 10138.79722405533, 10220.744481388025, 10246.948765256126, 10594.364338139736, 10660.62687805923, 10142.746431339276, 10493.790124197625, 10762.08522275584, 10876.510557024794, 10877.347359158475, 10266.948665256627, 10533.210009249184, 10573.101286390744, 10638.73403164927, 10681.51933163025, 8232.83534329322, 8406.537640429591, 8654.610542525726, 8667.454889224759, 8940.597673104856, 7726.304632583095, 7770.417218708506, 8173.305269052197, 8223.794405139919, 8432.662693492191], "value": 6063.952155357926, "unit": "score"}], "name": "dromaeo_css", "value": 6279.363850576367, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 114.0, 113.0, 113.0, 115.0, 113.0, 114.0, 115.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 138.0, 157.0, 188.0, 136.0, 154.0, 155.0, 138.0, 193.0, 135.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 163.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 126.0, 76.0, 77.0, 77.0, 75.0, 135.0, 76.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 122.0, 93.0, 94.0, 93.0, 127.0, 93.0, 94.0, 123.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 73.0, 66.0, 67.0, 67.0, 83.0, 66.0, 64.0], "value": 68.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 65.0, 63.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 83.0, 82.0, 83.0, 84.0, 83.0, 83.0, 82.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 134.0, 138.0, 132.0, 137.0, 133.0, 133.0, 165.0, 141.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 179.0, 179.0, 177.0, 178.0, 179.0, 176.0, 176.0, 177.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 68.0, 68.0, 66.0, 68.0, 68.0, 67.0, 68.0, 67.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1580.3000000000002, "alertThreshold": 2.0}]} 13:40:41 INFO - Return code: 0 13:40:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:40:41 ERROR - # TBPL SUCCESS # 13:40:41 INFO - Running post-action listener: _resource_record_post_action 13:40:41 INFO - Running post-run listener: _resource_record_post_run 13:40:42 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 531673088; Read time: 8; Write time: 500396 13:40:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248467456; Read time: 0; Write time: 267232 13:40:42 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283033600; Read time: 8; Write time: 233140 13:40:42 INFO - Running post-run listener: _upload_blobber_files 13:40:42 INFO - Blob upload gear active. 13:40:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:40:42 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 13:40:42 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:40:42 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:40:43 INFO - (blobuploader) - INFO - Open directory for files ... 13:40:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:40:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:40:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:40:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:40:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:40:43 INFO - (blobuploader) - INFO - Done attempting. 13:40:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:40:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:40:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:40:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:40:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:40:44 INFO - (blobuploader) - INFO - Done attempting. 13:40:44 INFO - (blobuploader) - INFO - Iteration through files over. 13:40:44 INFO - Return code: 0 13:40:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:40:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:40:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e2bbb897812bb823e7d46dfadf903157aa9f6cd246abe7daf14f33ac5884c6966606614171a06cc9e67cd8197d788bfba10ea83f97b3e5950c49dd446242e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/446882cf934829d7492b8183dd4ef1572cd03a752dfba93647656097bc20e1718ae11e9ce081d41a86fc6897e0ff12285ee38cf57a535fd44c404e3564b32f05"} 13:40:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:40:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:40:44 INFO - Contents: 13:40:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e2bbb897812bb823e7d46dfadf903157aa9f6cd246abe7daf14f33ac5884c6966606614171a06cc9e67cd8197d788bfba10ea83f97b3e5950c49dd446242e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/446882cf934829d7492b8183dd4ef1572cd03a752dfba93647656097bc20e1718ae11e9ce081d41a86fc6897e0ff12285ee38cf57a535fd44c404e3564b32f05"} 13:40:44 INFO - Running post-run listener: copy_logs_to_upload_dir 13:40:44 INFO - Copying logs to upload dir... 13:40:44 INFO - mkdir: /builds/slave/test/build/upload/logs 13:40:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.475480 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-05 13:40:43.202504) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 13:40:43.205993) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e2bbb897812bb823e7d46dfadf903157aa9f6cd246abe7daf14f33ac5884c6966606614171a06cc9e67cd8197d788bfba10ea83f97b3e5950c49dd446242e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/446882cf934829d7492b8183dd4ef1572cd03a752dfba93647656097bc20e1718ae11e9ce081d41a86fc6897e0ff12285ee38cf57a535fd44c404e3564b32f05"} build_url:https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/LXxjTkDiSoSB7-LVgeWxGw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e2bbb897812bb823e7d46dfadf903157aa9f6cd246abe7daf14f33ac5884c6966606614171a06cc9e67cd8197d788bfba10ea83f97b3e5950c49dd446242e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/446882cf934829d7492b8183dd4ef1572cd03a752dfba93647656097bc20e1718ae11e9ce081d41a86fc6897e0ff12285ee38cf57a535fd44c404e3564b32f05"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 13:40:43.230513) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:40:43.230842) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462477021.294747-170368620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:40:43.316718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 13:40:43.317033) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 13:40:43.317431) ========= ========= Total master_lag: 0.23 =========