builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1461650973.25 results: success (0) buildid: 20160425203053 builduid: 0cafa517e15e4d64873bcd11c128b6d5 revision: f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:33.250941) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:33.252006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:33.252668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:33.271194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:33.271644) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 23:09:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-04-25 23:09:33 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077810 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:33.366564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:33.367021) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015099 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:33.418803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:33.419161) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 23:09:33,816 truncating revision to first 12 chars 2016-04-25 23:09:33,816 Setting DEBUG logging. 2016-04-25 23:09:33,816 attempt 1/10 2016-04-25 23:09:33,816 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f4fd92a0496f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 23:09:34,161 unpacking tar archive at: fx-team-f4fd92a0496f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:34.067778) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:34.068474) ========= script_repo_revision: f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:34.069428) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:34.070075) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 23:09:34.080792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-25 23:09:34.081490) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:09:34 INFO - MultiFileLogger online at 20160425 23:09:34 in /builds/slave/test 23:09:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:09:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:09:34 INFO - {'append_to_log': False, 23:09:34 INFO - 'base_work_dir': '/builds/slave/test', 23:09:34 INFO - 'blob_upload_branch': 'Fx-Team', 23:09:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:09:34 INFO - 'branch': 'Fx-Team', 23:09:34 INFO - 'buildbot_json_path': 'buildprops.json', 23:09:34 INFO - 'config_files': ('talos/linux_config.py',), 23:09:34 INFO - 'default_actions': ('clobber', 23:09:34 INFO - 'read-buildbot-config', 23:09:34 INFO - 'download-and-extract', 23:09:34 INFO - 'populate-webroot', 23:09:34 INFO - 'create-virtualenv', 23:09:34 INFO - 'install', 23:09:34 INFO - 'run-tests'), 23:09:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:09:34 INFO - 'download_minidump_stackwalk': True, 23:09:34 INFO - 'download_symbols': 'ondemand', 23:09:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:09:34 INFO - 'tooltool.py': '/tools/tooltool.py', 23:09:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:09:34 INFO - '/tools/misc-python/virtualenv.py')}, 23:09:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:09:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:09:34 INFO - 'installer_path': 'installer.exe', 23:09:34 INFO - 'log_level': 'info', 23:09:34 INFO - 'log_name': 'talos', 23:09:34 INFO - 'log_to_console': True, 23:09:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:09:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:09:34 INFO - 'opt_config_files': (), 23:09:34 INFO - 'pip_index': False, 23:09:34 INFO - 'sps_profile': False, 23:09:34 INFO - 'sps_profile_interval': 0, 23:09:34 INFO - 'suite': 'dromaeojs', 23:09:34 INFO - 'system_bits': '32', 23:09:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:09:34 INFO - 'title': 'talos-linux64-ix-041', 23:09:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:09:34 INFO - 'use_talos_json': True, 23:09:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:09:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:09:34 INFO - 'work_dir': 'build'} 23:09:34 INFO - ##### 23:09:34 INFO - ##### Running clobber step. 23:09:34 INFO - ##### 23:09:34 INFO - Running pre-action listener: _resource_record_pre_action 23:09:34 INFO - Running main action method: clobber 23:09:34 INFO - rmtree: /builds/slave/test/build 23:09:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:09:35 INFO - Running post-action listener: _resource_record_post_action 23:09:35 INFO - ##### 23:09:35 INFO - ##### Running read-buildbot-config step. 23:09:35 INFO - ##### 23:09:35 INFO - Running pre-action listener: _resource_record_pre_action 23:09:35 INFO - Running main action method: read_buildbot_config 23:09:35 INFO - Using buildbot properties: 23:09:35 INFO - { 23:09:35 INFO - "project": "", 23:09:35 INFO - "product": "firefox", 23:09:35 INFO - "script_repo_revision": "production", 23:09:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:09:35 INFO - "repository": "", 23:09:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:09:35 INFO - "buildid": "20160425203053", 23:09:35 INFO - "pgo_build": "True", 23:09:35 INFO - "basedir": "/builds/slave/test", 23:09:35 INFO - "buildnumber": 609, 23:09:35 INFO - "slavename": "talos-linux64-ix-041", 23:09:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:09:35 INFO - "platform": "ubuntu64_hw", 23:09:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:09:35 INFO - "branch": "fx-team", 23:09:35 INFO - "repo_path": "integration/fx-team", 23:09:35 INFO - "revision": "f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3", 23:09:35 INFO - "stage_platform": "linux64-pgo", 23:09:35 INFO - "builduid": "0cafa517e15e4d64873bcd11c128b6d5", 23:09:35 INFO - "slavebuilddir": "test" 23:09:35 INFO - } 23:09:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:09:35 INFO - Running post-action listener: _resource_record_post_action 23:09:35 INFO - ##### 23:09:35 INFO - ##### Running download-and-extract step. 23:09:35 INFO - ##### 23:09:35 INFO - Running pre-action listener: _resource_record_pre_action 23:09:35 INFO - Running main action method: download_and_extract 23:09:35 INFO - mkdir: /builds/slave/test/build/tests 23:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:35 INFO - https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:09:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/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 23:09:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/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 23:09:45 INFO - Downloaded 1361 bytes. 23:09:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:45 INFO - Using the following test package requirements: 23:09:45 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:09:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:09:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:45 INFO - u'jsshell-linux-x86_64.zip'], 23:09:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:09:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:09:45 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:09:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:09:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:09:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:45 INFO - https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/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 23:09:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/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 23:09:52 INFO - Downloaded 23862722 bytes. 23:09:52 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'] 23:09:52 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 23:09:54 INFO - Return code: 0 23:09:54 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 23:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:54 INFO - https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/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 23:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/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 23:10:03 INFO - Downloaded 23862722 bytes. 23:10:03 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'] 23:10:03 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 23:10:05 INFO - Return code: 0 23:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:05 INFO - https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:10:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:10:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:10:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/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 23:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/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 23:10:06 INFO - Downloaded 10840145 bytes. 23:10:06 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'] 23:10:06 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 23:10:07 INFO - Return code: 0 23:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:07 INFO - https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:10:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:10:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:10:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/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 23:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QdBbKkMpR1O_ZnovATjDOw/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 23:10:14 INFO - Downloaded 58368137 bytes. 23:10:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:10:14 INFO - mkdir: /builds/slave/test/properties 23:10:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:10:14 INFO - Writing to file /builds/slave/test/properties/build_url 23:10:14 INFO - Contents: 23:10:14 INFO - build_url:https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:10:15 INFO - Running post-action listener: _resource_record_post_action 23:10:15 INFO - Running post-action listener: set_extra_try_arguments 23:10:15 INFO - ##### 23:10:15 INFO - ##### Running populate-webroot step. 23:10:15 INFO - ##### 23:10:15 INFO - Running pre-action listener: _resource_record_pre_action 23:10:15 INFO - Running main action method: populate_webroot 23:10:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:10:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:10:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:10:15 INFO - '--tppagecycles', 23:10:15 INFO - '7'], 23:10:15 INFO - 'tests': ['tsvgm']}}, 23:10:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:10:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:10:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:10:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:10:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:10:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:10:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:15 INFO - 'talos_options': ['--disable-e10s'], 23:10:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:10:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:10:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:15 INFO - 'talos_options': ['--disable-e10s'], 23:10:15 INFO - 'tests': ['damp', 'tps']}, 23:10:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:15 INFO - 'tests': ['damp', 'tps']}, 23:10:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:10:15 INFO - 'tests': ['dromaeo_dom']}, 23:10:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:10:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:10:15 INFO - 'tests': ['a11yr', 23:10:15 INFO - 'ts_paint', 23:10:15 INFO - 'tpaint', 23:10:15 INFO - 'sessionrestore', 23:10:15 INFO - 'sessionrestore_no_auto_restore', 23:10:15 INFO - 'tabpaint']}, 23:10:15 INFO - 'other-e10s': {'tests': ['a11yr', 23:10:15 INFO - 'ts_paint', 23:10:15 INFO - 'tpaint', 23:10:15 INFO - 'sessionrestore', 23:10:15 INFO - 'sessionrestore_no_auto_restore', 23:10:15 INFO - 'tabpaint']}, 23:10:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:10:15 INFO - 'ts_paint', 23:10:15 INFO - 'tpaint', 23:10:15 INFO - 'sessionrestore', 23:10:15 INFO - 'sessionrestore_no_auto_restore', 23:10:15 INFO - 'tabpaint']}, 23:10:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:10:15 INFO - 'ts_paint', 23:10:15 INFO - 'tpaint', 23:10:15 INFO - 'sessionrestore', 23:10:15 INFO - 'sessionrestore_no_auto_restore', 23:10:15 INFO - 'tabpaint']}, 23:10:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:10:15 INFO - 'tests': ['a11yr', 23:10:15 INFO - 'ts_paint', 23:10:15 INFO - 'tpaint', 23:10:15 INFO - 'sessionrestore', 23:10:15 INFO - 'sessionrestore_no_auto_restore', 23:10:15 INFO - 'tabpaint']}, 23:10:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:10:15 INFO - 'tests': ['a11yr', 23:10:15 INFO - 'ts_paint', 23:10:15 INFO - 'tpaint', 23:10:15 INFO - 'sessionrestore', 23:10:15 INFO - 'sessionrestore_no_auto_restore', 23:10:15 INFO - 'tabpaint']}, 23:10:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:10:15 INFO - 'tests': ['tsvgx', 23:10:15 INFO - 'tsvgr_opacity', 23:10:15 INFO - 'tart', 23:10:15 INFO - 'tscrollx', 23:10:15 INFO - 'cart']}, 23:10:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:10:15 INFO - 'tsvgr_opacity', 23:10:15 INFO - 'tart', 23:10:15 INFO - 'tscrollx', 23:10:15 INFO - 'cart']}, 23:10:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:15 INFO - 'talos_options': ['--disable-e10s'], 23:10:15 INFO - 'tests': ['tp5o']}, 23:10:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:15 INFO - 'tests': ['tp5o']}, 23:10:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:15 INFO - 'talos_options': ['--disable-e10s', 23:10:15 INFO - '--xperf_path', 23:10:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:10:15 INFO - 'tests': ['tp5n']}, 23:10:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:15 INFO - 'talos_options': ['--xperf_path', 23:10:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:10:15 INFO - 'tests': ['tp5n']}}, 23:10:15 INFO - 'talos.zip': {'path': '', 23:10:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:10:15 INFO - Running post-action listener: _resource_record_post_action 23:10:15 INFO - ##### 23:10:15 INFO - ##### Running create-virtualenv step. 23:10:15 INFO - ##### 23:10:15 INFO - Running pre-action listener: _resource_record_pre_action 23:10:15 INFO - Running main action method: create_virtualenv 23:10:15 INFO - Creating virtualenv /builds/slave/test/build/venv 23:10:15 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 23:10:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:10:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:10:15 INFO - Using real prefix '/usr' 23:10:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:10:15 INFO - Installing distribute.............................................................................................................................................................................................done. 23:10:17 INFO - Installing pip.................done. 23:10:17 INFO - Return code: 0 23:10:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:17 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 0x7fd9284a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26699a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f8810>, '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 0x26f9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f9ba0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', '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 23:10:17 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 23:10:17 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 23:10:17 INFO - Using env: {'DISPLAY': ':0', 23:10:17 INFO - 'HOME': '/home/cltbld', 23:10:17 INFO - 'LANG': 'en_US.UTF-8', 23:10:17 INFO - 'LANGUAGE': 'en_US:en', 23:10:17 INFO - 'LOGNAME': 'cltbld', 23:10:17 INFO - 'MAIL': '/var/mail/cltbld', 23:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:17 INFO - 'MOZ_NO_REMOTE': '1', 23:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:17 INFO - 'NO_EM_RESTART': '1', 23:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:17 INFO - 'PWD': '/builds/slave/test', 23:10:17 INFO - 'SHELL': '/bin/bash', 23:10:17 INFO - 'SHLVL': '1', 23:10:17 INFO - 'TERM': 'linux', 23:10:17 INFO - 'TMOUT': '86400', 23:10:17 INFO - 'USER': 'cltbld', 23:10:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', 23:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:17 INFO - '_': '/tools/buildbot/bin/python'} 23:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:17 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 23:10:17 INFO - Cleaning up... 23:10:17 INFO - Return code: 0 23:10:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:17 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 0x7fd9284a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26699a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f8810>, '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 0x26f9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f9ba0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', '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 23:10:17 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 23:10:17 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 23:10:17 INFO - Using env: {'DISPLAY': ':0', 23:10:17 INFO - 'HOME': '/home/cltbld', 23:10:17 INFO - 'LANG': 'en_US.UTF-8', 23:10:17 INFO - 'LANGUAGE': 'en_US:en', 23:10:17 INFO - 'LOGNAME': 'cltbld', 23:10:17 INFO - 'MAIL': '/var/mail/cltbld', 23:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:17 INFO - 'MOZ_NO_REMOTE': '1', 23:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:17 INFO - 'NO_EM_RESTART': '1', 23:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:17 INFO - 'PWD': '/builds/slave/test', 23:10:17 INFO - 'SHELL': '/bin/bash', 23:10:17 INFO - 'SHLVL': '1', 23:10:17 INFO - 'TERM': 'linux', 23:10:17 INFO - 'TMOUT': '86400', 23:10:17 INFO - 'USER': 'cltbld', 23:10:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', 23:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:17 INFO - '_': '/tools/buildbot/bin/python'} 23:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:18 INFO - Downloading/unpacking psutil>=0.7.1 23:10:18 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 23:10:18 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 23:10:18 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 23:10:18 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 23:10:18 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 23:10:18 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 23:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:10:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:10:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:10:20 INFO - Installing collected packages: psutil 23:10:20 INFO - Running setup.py install for psutil 23:10:20 INFO - building 'psutil._psutil_linux' extension 23:10:20 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 23:10:20 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 23:10:20 INFO - building 'psutil._psutil_posix' extension 23:10:20 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 23:10:20 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 23:10:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:10:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:10:20 INFO - Successfully installed psutil 23:10:20 INFO - Cleaning up... 23:10:20 INFO - Return code: 0 23:10:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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', '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 0x7fd9284a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26699a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f8810>, '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 0x26f9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f9ba0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', '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 23:10: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:10: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 mozsystemmonitor==0.0.0 23:10:20 INFO - Using env: {'DISPLAY': ':0', 23:10:20 INFO - 'HOME': '/home/cltbld', 23:10:20 INFO - 'LANG': 'en_US.UTF-8', 23:10:20 INFO - 'LANGUAGE': 'en_US:en', 23:10:20 INFO - 'LOGNAME': 'cltbld', 23:10:20 INFO - 'MAIL': '/var/mail/cltbld', 23:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:20 INFO - 'MOZ_NO_REMOTE': '1', 23:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:20 INFO - 'NO_EM_RESTART': '1', 23:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:20 INFO - 'PWD': '/builds/slave/test', 23:10:20 INFO - 'SHELL': '/bin/bash', 23:10:20 INFO - 'SHLVL': '1', 23:10:20 INFO - 'TERM': 'linux', 23:10:20 INFO - 'TMOUT': '86400', 23:10:20 INFO - 'USER': 'cltbld', 23:10:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', 23:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:20 INFO - '_': '/tools/buildbot/bin/python'} 23:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:10:20 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 23:10:20 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 23:10:20 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 23:10:20 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 23:10:20 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 23:10:20 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 23:10:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:10:22 INFO - Installing collected packages: mozsystemmonitor 23:10:22 INFO - Running setup.py install for mozsystemmonitor 23:10:22 INFO - Successfully installed mozsystemmonitor 23:10:22 INFO - Cleaning up... 23:10:22 INFO - Return code: 0 23:10:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd9284a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26699a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f8810>, '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 0x26f9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f9ba0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', '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 23:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:10:22 INFO - Using env: {'DISPLAY': ':0', 23:10:22 INFO - 'HOME': '/home/cltbld', 23:10:22 INFO - 'LANG': 'en_US.UTF-8', 23:10:22 INFO - 'LANGUAGE': 'en_US:en', 23:10:22 INFO - 'LOGNAME': 'cltbld', 23:10:22 INFO - 'MAIL': '/var/mail/cltbld', 23:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:22 INFO - 'MOZ_NO_REMOTE': '1', 23:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:22 INFO - 'NO_EM_RESTART': '1', 23:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:22 INFO - 'PWD': '/builds/slave/test', 23:10:22 INFO - 'SHELL': '/bin/bash', 23:10:22 INFO - 'SHLVL': '1', 23:10:22 INFO - 'TERM': 'linux', 23:10:22 INFO - 'TMOUT': '86400', 23:10:22 INFO - 'USER': 'cltbld', 23:10:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', 23:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:22 INFO - '_': '/tools/buildbot/bin/python'} 23:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:23 INFO - Downloading/unpacking blobuploader==1.2.4 23:10:23 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 23:10:23 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 23:10:23 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 23:10:23 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 23:10:23 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 23:10:23 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 23:10:25 INFO - Downloading blobuploader-1.2.4.tar.gz 23:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:10:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:10:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:25 INFO - Downloading docopt-0.6.1.tar.gz 23:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:10:25 INFO - Installing collected packages: blobuploader, requests, docopt 23:10:25 INFO - Running setup.py install for blobuploader 23:10:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:10:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:10:25 INFO - Running setup.py install for requests 23:10:26 INFO - Running setup.py install for docopt 23:10:26 INFO - Successfully installed blobuploader requests docopt 23:10:26 INFO - Cleaning up... 23:10:26 INFO - Return code: 0 23:10:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:26 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 0x7fd9284a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26699a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f8810>, '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 0x26f9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f9ba0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', '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 23:10:26 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 23:10:26 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 23:10:26 INFO - Using env: {'DISPLAY': ':0', 23:10:26 INFO - 'HOME': '/home/cltbld', 23:10:26 INFO - 'LANG': 'en_US.UTF-8', 23:10:26 INFO - 'LANGUAGE': 'en_US:en', 23:10:26 INFO - 'LOGNAME': 'cltbld', 23:10:26 INFO - 'MAIL': '/var/mail/cltbld', 23:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:26 INFO - 'MOZ_NO_REMOTE': '1', 23:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:26 INFO - 'NO_EM_RESTART': '1', 23:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:26 INFO - 'PWD': '/builds/slave/test', 23:10:26 INFO - 'SHELL': '/bin/bash', 23:10:26 INFO - 'SHLVL': '1', 23:10:26 INFO - 'TERM': 'linux', 23:10:26 INFO - 'TMOUT': '86400', 23:10:26 INFO - 'USER': 'cltbld', 23:10:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', 23:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:26 INFO - '_': '/tools/buildbot/bin/python'} 23:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:10:26 INFO - Running setup.py (path:/tmp/pip-4aAJes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:10:26 INFO - Running setup.py (path:/tmp/pip-t_xnTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:10:26 INFO - Running setup.py (path:/tmp/pip-GUftrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:10:26 INFO - Running setup.py (path:/tmp/pip-A_TuW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:26 INFO - Running setup.py (path:/tmp/pip-sk5GmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:26 INFO - Running setup.py (path:/tmp/pip-2_VQwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:27 INFO - Running setup.py (path:/tmp/pip-udAQVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:27 INFO - Running setup.py (path:/tmp/pip-tPKSKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:27 INFO - Running setup.py (path:/tmp/pip-PQn3Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:27 INFO - Running setup.py (path:/tmp/pip-L6nKSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:27 INFO - Running setup.py (path:/tmp/pip-n2Q0xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:27 INFO - Running setup.py (path:/tmp/pip-zThB_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:27 INFO - Running setup.py (path:/tmp/pip-Ymlh6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:27 INFO - Running setup.py (path:/tmp/pip-_1VYas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:27 INFO - Running setup.py (path:/tmp/pip-yQTnp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:27 INFO - Running setup.py (path:/tmp/pip-d_1JKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:27 INFO - Running setup.py (path:/tmp/pip-H78ior-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:10:27 INFO - Running setup.py install for manifestparser 23:10:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:10:27 INFO - Running setup.py install for mozcrash 23:10:28 INFO - Running setup.py install for mozdebug 23:10:28 INFO - Running setup.py install for mozdevice 23:10:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:10:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:10:28 INFO - Running setup.py install for mozfile 23:10:28 INFO - Running setup.py install for mozhttpd 23:10:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:10:28 INFO - Running setup.py install for mozinfo 23:10:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:10:28 INFO - Running setup.py install for mozInstall 23:10:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:10:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:10:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:10:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:10:28 INFO - Running setup.py install for mozleak 23:10:28 INFO - Running setup.py install for mozlog 23:10:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:10:28 INFO - Running setup.py install for moznetwork 23:10:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:10:28 INFO - Running setup.py install for mozprocess 23:10:29 INFO - Running setup.py install for mozprofile 23:10:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:10:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:10:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:10:29 INFO - Running setup.py install for mozrunner 23:10:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:10:29 INFO - Running setup.py install for mozscreenshot 23:10:29 INFO - Running setup.py install for moztest 23:10:29 INFO - Running setup.py install for mozversion 23:10:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:10:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:10:29 INFO - Cleaning up... 23:10:29 INFO - Return code: 0 23:10:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:29 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 0x7fd9284a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26699a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f8810>, '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 0x26f9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f9ba0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', '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 23:10:29 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 23:10:29 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 23:10:29 INFO - Using env: {'DISPLAY': ':0', 23:10:29 INFO - 'HOME': '/home/cltbld', 23:10:29 INFO - 'LANG': 'en_US.UTF-8', 23:10:29 INFO - 'LANGUAGE': 'en_US:en', 23:10:29 INFO - 'LOGNAME': 'cltbld', 23:10:29 INFO - 'MAIL': '/var/mail/cltbld', 23:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:29 INFO - 'MOZ_NO_REMOTE': '1', 23:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:29 INFO - 'NO_EM_RESTART': '1', 23:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:29 INFO - 'PWD': '/builds/slave/test', 23:10:29 INFO - 'SHELL': '/bin/bash', 23:10:29 INFO - 'SHLVL': '1', 23:10:29 INFO - 'TERM': 'linux', 23:10:29 INFO - 'TMOUT': '86400', 23:10:29 INFO - 'USER': 'cltbld', 23:10:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', 23:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:29 INFO - '_': '/tools/buildbot/bin/python'} 23:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:10:29 INFO - Running setup.py (path:/tmp/pip-kWOGFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:10:29 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)) 23:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:10:29 INFO - Running setup.py (path:/tmp/pip-Epgp02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:10:30 INFO - Running setup.py (path:/tmp/pip-IMEWBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:10:30 INFO - Running setup.py (path:/tmp/pip-zXrY25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:30 INFO - Running setup.py (path:/tmp/pip-W8QjII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:30 INFO - Running setup.py (path:/tmp/pip-GuDh5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:30 INFO - Running setup.py (path:/tmp/pip-OWmCCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:30 INFO - Running setup.py (path:/tmp/pip-VuMzR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:30 INFO - Running setup.py (path:/tmp/pip-zTqctC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:30 INFO - Running setup.py (path:/tmp/pip-JZEprh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:30 INFO - Running setup.py (path:/tmp/pip-XOuVn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:30 INFO - Running setup.py (path:/tmp/pip-qryMsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:30 INFO - Running setup.py (path:/tmp/pip-mfa8ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:30 INFO - Running setup.py (path:/tmp/pip-72Sibt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:30 INFO - Running setup.py (path:/tmp/pip-MUERHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:30 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)) 23:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:30 INFO - Running setup.py (path:/tmp/pip-iG_usb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:31 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)) 23:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:31 INFO - Running setup.py (path:/tmp/pip-wePEa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:31 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)) 23:10:31 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)) 23:10:31 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)) 23:10:31 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)) 23:10:31 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)) 23:10:31 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)) 23:10:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:10:31 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 23:10:31 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 23:10:31 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 23:10:31 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 23:10:31 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 23:10:31 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 23:10:32 INFO - Downloading blessings-1.6.tar.gz 23:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:10:33 INFO - Installing collected packages: blessings 23:10:33 INFO - Running setup.py install for blessings 23:10:33 INFO - Successfully installed blessings 23:10:33 INFO - Cleaning up... 23:10:33 INFO - Return code: 0 23:10:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:10:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:33 INFO - Reading from file tmpfile_stdout 23:10:33 INFO - Current package versions: 23:10:33 INFO - argparse == 1.2.1 23:10:33 INFO - blessings == 1.6 23:10:33 INFO - blobuploader == 1.2.4 23:10:33 INFO - docopt == 0.6.1 23:10:33 INFO - manifestparser == 1.1 23:10:33 INFO - mozInstall == 1.12 23:10:33 INFO - mozcrash == 0.17 23:10:33 INFO - mozdebug == 0.1 23:10:33 INFO - mozdevice == 0.48 23:10:33 INFO - mozfile == 1.2 23:10:33 INFO - mozhttpd == 0.7 23:10:33 INFO - mozinfo == 0.9 23:10:33 INFO - mozleak == 0.1 23:10:33 INFO - mozlog == 3.1 23:10:33 INFO - moznetwork == 0.27 23:10:33 INFO - mozprocess == 0.22 23:10:33 INFO - mozprofile == 0.28 23:10:33 INFO - mozrunner == 6.11 23:10:33 INFO - mozscreenshot == 0.1 23:10:33 INFO - mozsystemmonitor == 0.0 23:10:33 INFO - moztest == 0.7 23:10:33 INFO - mozversion == 1.4 23:10:33 INFO - psutil == 3.1.1 23:10:33 INFO - requests == 1.2.3 23:10:33 INFO - wsgiref == 0.1.2 23:10:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:33 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')]} 23:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:33 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')]} 23:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:33 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 0x7fd9284a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26699a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f8810>, '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 0x26f9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f9ba0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', '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 23:10:33 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 23:10:33 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 23:10:33 INFO - Using env: {'DISPLAY': ':0', 23:10:33 INFO - 'HOME': '/home/cltbld', 23:10:33 INFO - 'LANG': 'en_US.UTF-8', 23:10:33 INFO - 'LANGUAGE': 'en_US:en', 23:10:33 INFO - 'LOGNAME': 'cltbld', 23:10:33 INFO - 'MAIL': '/var/mail/cltbld', 23:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:33 INFO - 'MOZ_NO_REMOTE': '1', 23:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:33 INFO - 'NO_EM_RESTART': '1', 23:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:33 INFO - 'PWD': '/builds/slave/test', 23:10:33 INFO - 'SHELL': '/bin/bash', 23:10:33 INFO - 'SHLVL': '1', 23:10:33 INFO - 'TERM': 'linux', 23:10:33 INFO - 'TMOUT': '86400', 23:10:33 INFO - 'USER': 'cltbld', 23:10:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', 23:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:33 INFO - '_': '/tools/buildbot/bin/python'} 23:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:33 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)) 23:10:33 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)) 23:10:33 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)) 23:10:33 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)) 23:10:33 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)) 23:10:33 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)) 23:10:33 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)) 23:10:33 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)) 23:10:33 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)) 23:10:33 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)) 23:10:33 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)) 23:10:33 INFO - Cleaning up... 23:10:33 INFO - Return code: 0 23:10:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:10:33 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')]} 23:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:33 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')]} 23:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:33 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 0x7fd9284a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26699a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f8810>, '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 0x26f9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f9ba0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', '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 23:10:33 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 23:10:33 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 23:10:33 INFO - Using env: {'DISPLAY': ':0', 23:10:33 INFO - 'HOME': '/home/cltbld', 23:10:33 INFO - 'LANG': 'en_US.UTF-8', 23:10:33 INFO - 'LANGUAGE': 'en_US:en', 23:10:33 INFO - 'LOGNAME': 'cltbld', 23:10:33 INFO - 'MAIL': '/var/mail/cltbld', 23:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:33 INFO - 'MOZ_NO_REMOTE': '1', 23:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:33 INFO - 'NO_EM_RESTART': '1', 23:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:33 INFO - 'PWD': '/builds/slave/test', 23:10:33 INFO - 'SHELL': '/bin/bash', 23:10:33 INFO - 'SHLVL': '1', 23:10:33 INFO - 'TERM': 'linux', 23:10:33 INFO - 'TMOUT': '86400', 23:10:33 INFO - 'USER': 'cltbld', 23:10:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', 23:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:33 INFO - '_': '/tools/buildbot/bin/python'} 23:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:33 INFO - Downloading/unpacking jsonschema 23:10:33 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 23:10:33 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 23:10:33 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 23:10:33 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 23:10:33 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 23:10:33 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 23:10:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:10:35 INFO - Downloading/unpacking functools32 (from jsonschema) 23:10:35 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 23:10:35 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 23:10:35 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 23:10:35 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 23:10:35 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 23:10:35 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 23:10:35 INFO - Downloading functools32-3.2.3-2.tar.gz 23:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:10:35 INFO - warning: no files found matching '*.txt' 23:10:35 INFO - no previously-included directories found matching 'build' 23:10:35 INFO - no previously-included directories found matching 'dist' 23:10:35 INFO - no previously-included directories found matching '.git*' 23:10:36 INFO - Installing collected packages: jsonschema, functools32 23:10:36 INFO - Running setup.py install for functools32 23:10:36 INFO - warning: no files found matching '*.txt' 23:10:36 INFO - no previously-included directories found matching 'build' 23:10:36 INFO - no previously-included directories found matching 'dist' 23:10:36 INFO - no previously-included directories found matching '.git*' 23:10:36 INFO - Successfully installed jsonschema functools32 23:10:36 INFO - Cleaning up... 23:10:36 INFO - Return code: 0 23:10:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9284a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26699a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f8810>, '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 0x26f9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f9ba0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', '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 23:10: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', 'flake8'] in /builds/slave/test/build 23:10: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 flake8 23:10:36 INFO - Using env: {'DISPLAY': ':0', 23:10:36 INFO - 'HOME': '/home/cltbld', 23:10:36 INFO - 'LANG': 'en_US.UTF-8', 23:10:36 INFO - 'LANGUAGE': 'en_US:en', 23:10:36 INFO - 'LOGNAME': 'cltbld', 23:10:36 INFO - 'MAIL': '/var/mail/cltbld', 23:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:36 INFO - 'MOZ_NO_REMOTE': '1', 23:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:36 INFO - 'NO_EM_RESTART': '1', 23:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:36 INFO - 'PWD': '/builds/slave/test', 23:10:36 INFO - 'SHELL': '/bin/bash', 23:10:36 INFO - 'SHLVL': '1', 23:10:36 INFO - 'TERM': 'linux', 23:10:36 INFO - 'TMOUT': '86400', 23:10:36 INFO - 'USER': 'cltbld', 23:10:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', 23:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:36 INFO - '_': '/tools/buildbot/bin/python'} 23:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:36 INFO - Downloading/unpacking flake8 23:10:36 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 23:10:36 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 23:10:36 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 23:10:36 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 23:10:36 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 23:10:36 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 23:10:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:10:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:10:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:10:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:39 INFO - no previously-included directories found matching 'docs/_build' 23:10:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:10:39 INFO - Running setup.py install for pep8 23:10:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:39 INFO - no previously-included directories found matching 'docs/_build' 23:10:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:10:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:10:39 INFO - Cleaning up... 23:10:40 INFO - Return code: 0 23:10:40 INFO - Running post-action listener: _resource_record_post_action 23:10:40 INFO - Running post-action listener: _start_resource_monitoring 23:10:40 INFO - Starting resource monitoring. 23:10:40 INFO - ##### 23:10:40 INFO - ##### Running install step. 23:10:40 INFO - ##### 23:10:40 INFO - Running pre-action listener: _resource_record_pre_action 23:10:40 INFO - Running main action method: install 23:10:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:40 INFO - Reading from file tmpfile_stdout 23:10:40 INFO - Detecting whether we're running mozinstall >=1.0... 23:10:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:10:40 INFO - Reading from file tmpfile_stdout 23:10:40 INFO - Output received: 23:10:40 INFO - Usage: mozinstall [options] installer 23:10:40 INFO - Options: 23:10:40 INFO - -h, --help show this help message and exit 23:10:40 INFO - -d DEST, --destination=DEST 23:10:40 INFO - Directory to install application into. [default: 23:10:40 INFO - "/builds/slave/test"] 23:10:40 INFO - --app=APP Application being installed. [default: firefox] 23:10:40 INFO - mkdir: /builds/slave/test/build/application 23:10:40 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'] 23:10:40 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 23:10:56 INFO - Reading from file tmpfile_stdout 23:10:56 INFO - Output received: 23:10:56 INFO - /builds/slave/test/build/application/firefox/firefox 23:10:56 INFO - Running post-action listener: _resource_record_post_action 23:10:56 INFO - ##### 23:10:56 INFO - ##### Running run-tests step. 23:10:56 INFO - ##### 23:10:56 INFO - Running pre-action listener: _resource_record_pre_action 23:10:56 INFO - Running main action method: run_tests 23:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:10:57 INFO - Python 2.7.3 23:10:57 INFO - Return code: 0 23:10:57 INFO - grabbing minidump binary from tooltool 23:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:57 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 0x26f8810>, '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 0x26f9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f9ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:10:57 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 23:10:57 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 23:10:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:10:57 INFO - Return code: 0 23:10:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:10:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:10:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:10:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:10:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:10:57 INFO - Return code: 0 23:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 23:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 23:10:57 INFO - Using env: {'DISPLAY': ':0', 23:10:57 INFO - 'HOME': '/home/cltbld', 23:10:57 INFO - 'LANG': 'en_US.UTF-8', 23:10:57 INFO - 'LANGUAGE': 'en_US:en', 23:10:57 INFO - 'LOGNAME': 'cltbld', 23:10:57 INFO - 'MAIL': '/var/mail/cltbld', 23:10:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:10:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:57 INFO - 'MOZ_NO_REMOTE': '1', 23:10:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:57 INFO - 'NO_EM_RESTART': '1', 23:10:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:57 INFO - 'PWD': '/builds/slave/test', 23:10:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:10:57 INFO - 'SHELL': '/bin/bash', 23:10:57 INFO - 'SHLVL': '1', 23:10:57 INFO - 'TERM': 'linux', 23:10:57 INFO - 'TMOUT': '86400', 23:10:57 INFO - 'USER': 'cltbld', 23:10:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892', 23:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:57 INFO - '_': '/tools/buildbot/bin/python'} 23:10:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 23:10:58 INFO - mozversion application_buildid: 20160425203053 23:10:58 INFO - mozversion application_changeset: f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 23:10:58 INFO - mozversion application_display_name: Nightly 23:10:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:10:58 INFO - mozversion application_name: Firefox 23:10:58 INFO - mozversion application_remotingname: firefox 23:10:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:10:58 INFO - mozversion application_vendor: Mozilla 23:10:58 INFO - mozversion application_version: 49.0a1 23:10:58 INFO - mozversion platform_buildid: 20160425203053 23:10:58 INFO - mozversion platform_changeset: f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 23:10:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:10:58 INFO - mozversion platform_version: 49.0a1 23:10:58 INFO - using testdate: 1461651058 23:10:58 INFO - actual date: 1461651058 23:10:58 INFO - starting webserver on 'localhost:46907' 23:10:58 INFO - SUITE-START | Running 2 tests 23:10:58 INFO - TEST-START | dromaeo_css 23:10:58 INFO - operating with platform_type : linux_ 23:10:58 INFO - Initialising browser for dromaeo_css test... 23:10:58 INFO - TEST-INFO | started process 12296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7tpp8R/profile http://localhost:46907/getInfo.html) 23:11:02 INFO - PROCESS | 12296 | __metrics Screen width/height:1600/1200 23:11:02 INFO - PROCESS | 12296 | colorDepth:24 23:11:02 INFO - PROCESS | 12296 | Browser inner width/height: 1024/697 23:11:02 INFO - PROCESS | 12296 | __metrics 23:11:03 ERROR - PROCESS | 12296 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:11:04 INFO - TEST-INFO | 12296: exit 0 23:11:04 INFO - Browser initialized. 23:11:04 INFO - Running cycle 1/1 for dromaeo_css test... 23:11:04 INFO - TEST-INFO | started process 12377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7tpp8R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:11:16 INFO - PROCESS | 12377 | RSS: Main: 154755072 23:11:16 INFO - PROCESS | 12377 | 23:12:06 INFO - PROCESS | 12377 | 1461651126980 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] 23:14:14 INFO - PROCESS | 12377 | Cycle 1(1): loaded http://localhost:46907/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46907/tests/dromaeo/cssquery-ext.html) 23:14:15 INFO - PROCESS | 12377 | RSS: Main: 255533056 23:14:15 INFO - PROCESS | 12377 | 23:17:17 INFO - PROCESS | 12377 | Cycle 1(1): loaded http://localhost:46907/tests/dromaeo/cssquery-ext.html (next: http://localhost:46907/tests/dromaeo/cssquery-jquery.html) 23:17:18 INFO - PROCESS | 12377 | RSS: Main: 238112768 23:17:18 INFO - PROCESS | 12377 | 23:20:20 INFO - PROCESS | 12377 | Cycle 1(1): loaded http://localhost:46907/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46907/tests/dromaeo/cssquery-mootools.html) 23:20:21 INFO - PROCESS | 12377 | RSS: Main: 237936640 23:20:21 INFO - PROCESS | 12377 | 23:23:23 INFO - PROCESS | 12377 | Cycle 1(1): loaded http://localhost:46907/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46907/tests/dromaeo/cssquery-prototype.html) 23:23:23 INFO - PROCESS | 12377 | RSS: Main: 243208192 23:23:23 INFO - PROCESS | 12377 | 23:26:26 INFO - PROCESS | 12377 | Cycle 1(1): loaded http://localhost:46907/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46907/tests/dromaeo/cssquery-yui.html) 23:26:26 INFO - PROCESS | 12377 | RSS: Main: 222625792 23:26:26 INFO - PROCESS | 12377 | 23:29:29 INFO - PROCESS | 12377 | Cycle 1(1): loaded http://localhost:46907/tests/dromaeo/cssquery-yui.html (next: http://localhost:46907/tests/dromaeo/cssquery-dojo.html) 23:29:29 INFO - PROCESS | 12377 | RSS: Main: 269148160 23:29:29 INFO - PROCESS | 12377 | 23:29:29 INFO - PROCESS | 12377 | __start_tp_report 23:29:29 INFO - PROCESS | 12377 | _x_x_mozilla_page_load 23:29:29 INFO - PROCESS | 12377 | _x_x_mozilla_page_load_details 23:29:29 INFO - PROCESS | 12377 | |i|pagename|runs| 23:29:29 INFO - PROCESS | 12377 | |0;dojo.html;3111.859966301516;3161.920951976199;3199.8080115193075;3204.6474887762342;3227.4351988402022;5180.974095129529;5257.631965762398;5287.629865909388;5323.60072994525;5357.196420536917;5208.244804503354;5222.399424066233;5223.921641175385;5289.021531016755;5322.467753224676;4710.97644511777;4728.314394412817;4749.667523273372;4813.205821039542;4884.072026314989;4755.096531658991;4812.711237325771;4820.686655367407;4839.104765618372;4847.684900481458;4773.928391074137;4791.4250289965075;4801.759912004421;4815.15734746418;4852.053849499349;4785.712857228577;4794.448638406593;4794.616430685537;4801.7118972861745;4807.038592281523;4651.5813576778255;4694.95305046952;4782.7130372177435;4790.640701947368;4832.251001094836;5197.428282888879;5235.240890070956;5235.240890070956;5239.1093514102695;5242.659227150261;5650.208970744099;5650.886982260373;5651.519620832193;5654.180143879155;5654.406287339812;5496.945030549723;5695.829125126253;5750.942490575083;5767.106098554689;5780.942190578125;5284.841454756363;5303.575713942875;5306.151015837448;5309.4425085365865;5320.707361095138;5720.799772007959;5735.541156707453;5745.971270143623;5750.712464376848;5751.4536119068625;5463.016657001698;5463.672179669233;5513.117901135879;5546.750396232179;5554.1391084381985;5622.550195984311;5633.183188437653;5636.577256705764;5637.746301416364;5639.407862174495;5514.696691681916;5612.102063669793;5623.493885550321;5628.71856407178;5629.408912064257;5590.888182236333;5607.691576963306;5641.464060914206;5642.633228840113;5647.491725744702;4235.449391579136;4249.575042495788;4298.032942587893;4301.849435269751;4338.891527711832;3788.4885540452237;3830.693544516432;3884.436756670267;3885.4366116913457;3897.3569361055675;5373.2208829719475;5390.649607775482;5400.297961265089;5413.756380962787;5448.45515448452;5643.604947653707;5644.238027866186;5648.774049038075;5651.519620832193;5655.434456554394;5265.21021846726;5382.596305277119;5397.892042159135;5436.266104075979;5453.918191227135;4862.197737373293;4863.902721945612;4871.780769865364;4907.607391408679;4913.041956818458;5875.177475153482;5877.970610146922;5880.588358814842;5882.411758824083;5898.911516327258;5531.944680553143;5550.278463799842;5594.916076258778;5618.690971996416;5623.690697011703;5854.180414742024;5854.356020837789;5868.677222752619;5902.911456328245;5910.911336330045;5518.944810551843;5526.226328313959;5526.530244929226;5531.059719847555;5537.2524709163745;5530;5611.859703507445;5623.690697011703;5637.267155269788;5750.971245143747;5492.340919089735;5526.47498487643;5530.281063461724;5533.170024496358;5569.944300556943;5485.917711234414;5492.670439773627;5533.806316778893;5541.085720856175;5592.2170896075395;5339.813106541253;5355.169948657965;5409.6213265071065;5432.049391356418;5468.3437987440175;5492.5331346835965;5504.339479262514;5516.200150978166;5519.31008623922;5529.004779139794;5402.054640437829;5404.432534583812;5406.0809662356705;5407.161889907071;5446.128619420873 23:29:29 INFO - PROCESS | 12377 | |1;ext.html;597.2653636027686;649.912261844651;653.555582204101;653.9999999999999;671.0839703804309;31840;37836.43245351318;38612.42081368778;38638.806805966;38690.613093869055;41485.58514414855;42302;42313.365299520454;42339.576604233946;42349.15301693964;8486.745397638066;8598.05421403645;8605.655773769073;8606.31149508041;8702.347323950697;8477.897873276466;8610.56947152643;8612.784680382978;8613.880195574566;8675.262602678747;8892.510911899843;8935.463872167691;8967.641294348217;8968.865467017968;8972.192502674758;8838.204561589455;8913.777155571097;8914.821703565893;8916.375853690244;8919.866202006975;8831;8934.73195804127;8956.238719708832;8956.8656470153;8968;41764.582354176375;42311.153776924286;42365.36451953223;42372.78813605943;42396.1520769586;3311.93376132476;3370.932581348384;3431.1765176357744;3515.59570649376;3782.659560639528;31850;32301;32533;32627.51058734121;33552;4294.4202532658;4327.545607711177;4367.2575662137515;4371.27873900806;4398.912021759579;311375;311594;312086;312160;312325.438372809;46189.30716039262;57100.42899570951;58216.4178358211;58243.417565824646;58277.125843112386;54612.453875461535;55682.44317556854;55728.442715572324;55732.72133639306;55733;16446.6710665786;16704.665906682043;16726.16369181536;16758.24587893548;16758.497245082668;11686.76626467466;12564.623061308175;12747;12763.489460421479;12904.354782261038;16454.917725411535;17069.40257090996;17405;17408.5647858802;17461.7380739289;6086.847828804227;6277.2153480814895;6286.371362863769;6311.526635502356;6392.105105285264;1032.2155162076876;1036.7874585709912;1051.831706926888;1080.443571560647;1119.9664010079712;33719.494207586904;33772;33821.32357352888;33838.15404614855;33888;1116.2744216259334;1146.2377518949972;1153.5558809858096;1174.518447436564;1182.810750279951;15587.766183507256;15747.842521574867;15901.681966360607;16131.354745810037;16418.6716265674;474706;475245;481709;481884;484473;56932.715336423054;57116.428835711115;57336;57339.42660573425;57486.7125664369;1380.0684537936852;1381.9101758385673;1416.0670684515562;1469.3461409672593;1552.3945661192145;29818.850905745334;31096.533551996286;31949.20126996844;32355.676443235265;32409.189770255933;45771;45956.7702161487;45973.77013114913;46185.307220392395;46199;278077;281751;283840;283922.58038709674;287487;23109.306720798402;40922.38616420697;41015;42391.7880410596;42946.78526607347;47293;47493.28760068671;47558;47697;48588.2711759331;41163.38254926239;42295.36556951587;42637.14725705531;42872.571274286856;43657.78171109251;41382.79308603438;41530;42038;42262.57737422586;42996.140077197655;43138.40992821429;43760.56239437565;44226;44322;44741.77629111834;36193.45709814408;38468.53783159529;38505;39314.80342598269;39478;29491.705082949753;29798.851005744833;29992.25019374533;30158.84920575471;30351.24121896882 23:29:29 INFO - PROCESS | 12377 | |2;jquery.html;379.85565485115654;381.7556763671249;396.9801509924503;408.2284482328399;417.14485305124487;14266.857331426683;16479.752803707954;18439.815601843977;18871.905640471796;18885.62228755426;14746.631334216623;17251;17816.287348506045;18172.27310907562;18559.25762969483;5491.972540137293;5626.859328516779;5643.520300774439;5661.830145095653;5674.063779476382;4025.1144748155507;5579.442055794429;5629.296337957755;5949;6247.656378899159;6157.1995640566665;6186.505079593621;6213;6214.40963108504;6216.471599914013;6111.236095488064;6171.783987560414;6185.969070154643;6189.845253868644;6193.380661933793;5238.947610523884;5317.574594032468;5433.8369848904595;5441.483059109379;5442.2380866678695;11946.342951137683;12733.87266127336;22133.225337113287;22323;22325.665115023286;2128.957420851574;2177.8911054447212;2275.8520696154696;2307.3308740465245;2874.4825931332352;8964.14840590143;9381.202597779196;9427.905720942772;9455.716328510156;9585.137337639577;1911.6559019376507;1938.5444420561157;1967.6753335699736;1992.471994921347;2026.5642886779265;78937.60531197365;81606;81740.59129704373;81851.59074204651;82535.587322063;10004.899951000543;10387.220958427997;10447.268691191544;10536;10561.366318020944;13828.101173423694;13985.58043258704;14033.087849289763;14046.227457489731;14053.086549374259;7918.683252669944;7927.484713493604;8139.674413023531;8237.258646721824;8252.711155109542;7151.89272160918;8097.109317975018;8129.593520323961;8150.7773833925385;8233.217844304781;4390;4635.768211589407;4656.580907718321;4761.262004389325;4766.261229509431;1936.7482227310359;1952.9707054394196;1967.281942091155;1998.4504261328252;2001.698895717795;913.2465715784372;968.6173961285253;1003.9749006274901;1030.6341248856697;1117.07841031148;16726.74909876353;18462.81537184638;19287.807121928883;19479.370285011624;19672.409827705193;979.8824141103113;1014.1227837920146;1014.8071866345371;1030.2543720983494;1070.2829104500004;10304.124149447382;10472.476376181161;10506.527206275736;10516.316439431412;10615.84076238857;484604;489350;493926;511659;512322;80212;88449.55775221082;89177.85276840394;92948.53525732328;93701;1088.820344643125;1096.309325125166;1099.4228030284164;1100.878903320634;1103.4979084516526;15706.136162511171;15746.842531574537;15861.127637980022;16041.759373609639;16050.438234661731;40833;41069.794651026554;41295.58704412918;41891.162176755686;42542.78728606337;56021.71989140028;56466.71766641141;57695.13457298228;57744.422555773905;57813.71093144507;7961.800954976172;8079;8171.83656326882;8328.500289982621;8391.118932512243;10664.200184986312;12289.754204916031;12711.364431778558;12768.553100641433;12907.934730443085;10757.386392040944;11249.212555121063;11278.436078196222;11413.771724565628;11654.94172529166;10828.675139745821;10958.890411095786;11373.943130284295;11453.141014423785;11548.769024619292;10693.732656683645;10726.039890558606;11506.252093613888;11703.122265829927;11718.23831450953;8193.83612327762;8258.545779982158;8290.170982901904;8301.916980830114;8523.232909038215;10135;10690.518926648476;10739.838902416626;10770.892291076989;10807.621733239614 23:29:29 INFO - PROCESS | 12377 | |3;mootools.html;1341.8926485881132;1499.4976682811255;1541.7841502189694;1688.3331084221734;1843.4008947092198;7836;8032;8045.839083218332;8050;8143;7884.802879928005;8009;8013.639386227619;8043.235892590209;8093.028836539609;2079.61527117483;2267.30847091637;2333.684952531412;2340.8244381671443;2369.7156341239074;2334.2763743239652;2340.496793189464;2342.3090188394463;2343.8593684378907;2349.0721165139757;2288.8397812153157;2356.06935260572;2359.681443005198;2363.9054437822465;2365.4677697518005;2031.7460317460318;2211.1929145861727;2277.5672622201896;2281.349815302639;2281.498070424504;2259.141526220042;2260.3219034289646;2268.319504148749;2269.5574362999055;2307.227078928544;8069.757907262791;8172.6322315495945;8177.79555511111;8180.427370084097;8191.836163276761;4931.21100623902;5129.871753206163;5161.896762064737;5171.198464238049;5200.557952574036;3314.486254630536;3366.1248075500303;3366.663333666638;3586.8385922633543;3591.425371940477;1138.9829152562718;1141.9429028548539;1157.5080590748983;1168.6727716239466;1187.827764974074;11368.886311136948;11376.033037191848;11402.543898244061;11415.200935934488;11446.542138314457;4598.954010459853;4648.070385922829;4711.505291944365;4747.525247475294;4753.691010084333;9701.854472182922;9725.270604704676;9727.464989425507;9744;9744.415335079917;4727.929081063787;5264.9736751315995;5276.762545685453;5284.260203571503;5284.365876094893;4662;4799.208130658472;4803.18345881201;4804.807807687654;4826.517348265215;3836.175222327213;3926.8232929517667;3935.940960885589;3967.1867267210155;4015.5783642717092;1270.4664041102758;1288.8840004399462;1289.5164313382481;1301.557470460048;1306.9803952940713;834.5284914023557;838.9622466989;900.8783814185132;940.1820416237916;984.7144328144758;5593.552515798808;5732;5819.82540523785;5850.64896106235;5855.531557475391;993.3443927008284;1005.2762011351815;1009.399407352624;1024.8975102489692;1038.3458421194598;4236.110416812442;4341.435613370305;4385.51759306476;4430.601245887886;4479.888002799956;9704.417734935927;9997.45014024221;10002.149817265468;10022.548985295532;10051.798964020825;9772.12050915421;9937.254705897087;9975.850362244571;10060.446675432922;10071.24465665078;7446.73936412223;7596.582187979714;7726;7769.72805951789;7799.649015794303;5810.331811841524;5830.154627579062;5839.153322768259;5870.26621672291;5950.018246989198;8977.775555611162;8981.955090224506;9268.397554158959;9282.953585232031;9356.06439356059;9296.95351523238;9451.669191578261;9470.57382417779;9507.334486586149;9508.85736713936;6812.080369150101;7062.3996960258955;7066.717331306896;7273.672684729094;7409.296116868889;7590.0891892973195;7829.530228186327;7969.6015199240965;8052.476589021695;8065.072516660424;7133.5719856808755;7337.889931650922;7343.192248852729;7440.2931721486375;7471.775846724607;7200.171980222132;7202.567845929261;7261.745838895825;7291.6354182289615;7339.559626422431;6521.7065232065615;6605.141331626858;6613.470922326106;6719.731210751711;6747.2915343890145;4985.875353116201;5010.549050585465;5105.157648987875;5169.327987361619;5180.430152683277;4944.48082951285;5021.598272138147;5101.311322971352;5153.819616313411;5263.447338029605 23:29:29 INFO - PROCESS | 12377 | |4;prototype.html;316.54101552748506;328.6352149114483;333.66466700965526;334.67468823459103;336.8703049326009;5237.738113094344;5296;5297.576193904488;5321.095413779657;5329.25390445338;4952.405711314638;5005.949940500603;5169.6898186108765;5190.091733946554;5230.73846307684;4051.7163798534116;4084.550699423061;4108.589141085898;4113.362428823522;4122.876313710586;4083.2854250506193;4099.323611604082;4104.651104656093;4104.8768536943935;4118.752874827505;3826.65560099591;3917.5103112110987;4060.533038700543;4078.3678529827926;4084.7957602119923;4027.536833264183;4041.5952508257833;4048.67610591152;4054.8986275343204;4055.4119652650497;3603.6396360364015;3610.584782749991;3632.273545290926;3641.1625326174862;3671.6511931366745;4823.638227132979;5019.84940451787;5020.548150666457;5039.672421292641;5100.857639791297;4587.449506059294;4587.747673877935;4589.128065667546;4619.14545809023;4623.468301145344;5420.756065977041;5429.104197807357;5430.4748292044;5449.291592093003;5454.154606036071;3731.2910546996254;3899.941500877489;3911.413288006793;3931.842726290945;3943.5267767867754;5645.379008309083;5680.602357834953;5689.431056894277;5694.5159661428415;5714.51426628737;4011.7793521356607;4012.4382586437923;4013.4180543821567;4033.253848038122;4034.2738307105;3852;4045.4538637284177;4055.614716601918;4064.5935406459116;4078.877633670935;4605.424321959755;4623.491415944243;4654.25531914892;4654.674172807939;4658.67389282747;5458.426865179099;5481.588880833953;5498.560115190775;5501.779928802883;5513.61404701667;1346.5892902664586;1348.373006551958;1448.203488081572;1451.0930668332292;1455.1487379882888;960.2030314838668;969.2149359019216;983.4541829284673;986.1371300112402;989.2728844299434;5625.8312250631725;5625.915611265835;5665.603407761417;5666.4900158985065;5668.461496157858;5912.408759124053;5928.851778705481;5960.135780311831;5966.671833049137;5974.522038236931;5479.397266300703;5638.9436105638415;5643.181738647873;5647.407022262685;5665.5467562594895;3146.5437511560694;3158.652548219694;3166.73082787961;3169.700422826676;3173.904782856518;5670.603057785998;6213.130161777355;6237.251529816361;6241.812745617639;6261.812145635638;5707.200991861143;5737.454941780524;5754.280714910637;5769.221155144086;5800.767969281182;5886.764529418861;5894.263217097863;5925.229720136354;5925.9407405925385;5933.465988061095;5495.477929596682;5549.417311182429;5629.802956896489;5671.716414179357;5683.147527870852;5521.984475666433;5535.142052981794;5564.721763911707;5583.469570390806;5584.106542953108;5667.659940403589;5852.678102704393;5898.675572843535;5910.349861515316;5926.644401335933;3930.3514920037874;3942.1865941667156;3966.504186976628;3967.8809635710977;3990.620891015349;5383.16560933056;5631.436856314336;5652.576056795675;5654.236678048575;5669.688167150846;5408.405075441777;5522.30971128609;5527.944720552743;5548.583856210881;5553.805931724537;5478.178273258884;5515.145152501369;5524.210273811699;5526.309211348582;5532.834014979557;5238.449962753856;5377.741348633505;5407.053765591085;5412.972935135299;5415.4313797050745;5505.587080968863;5515.166958963482;5529.502344788988;5557.44425557441;5559.916601251065;5366.436524164907;5386.522199787984;5407.810726624707;5448.918266225931;5462.6995515247045 23:29:29 INFO - PROCESS | 12377 | |5;yui.html;740.4594645908484;800.0958916424441;829.1418381974657;841.5960339037262;847.140152744964;13627.523036693718;13723.794143087849;13753.58739237822;13857.514986975459;13910.30448477576;14307.78538321926;14921.552353429415;14954.850451495482;14982.550523484286;14990.700185996273;702.975395861145;807.6930766308794;834.5743670727942;837.9329653627725;845.4420082745389;848.465466755946;848.7114381110421;850.4047166983106;850.706506255341;850.9914900850974;889.6886089868526;890.6526454682646;892.0276898180981;892.0989800301677;892.5046599137476;721.4084450750387;801.7514570483169;822.2722890242119;823.8599438095569;824.056455358617;603.1676286724336;603.4448307557014;603.4538742438101;603.5051257968468;604.4680681000735;13794.517191898336;13840.93079534606;13847.307634618228;13875.375608097558;13885.305734713224;12515.123941324111;12840.61478155657;12918.418671159727;12968.286744229064;13511.527096551672;11051.502682379312;11053;11096.55613775448;11121.55513779456;11373.886261137366;3749.9250014999548;3767.6232376762377;3816.217675376541;3837.098281903778;3876.8836934891997;49125.26312105321;51022.74488627533;56290.43709562893;56934.71532642352;57058.429415706145;10708;10764.946175269073;10830.133589312836;10902.236843420884;11010.944945275383;18269.269229230682;18269.54326141857;18304.725429118575;18305.63388732218;18327.083645817656;8058.435909486279;8064.354851611857;8120.878186827203;8273.710420135267;8276.379271554657;4638.2115040443205;4685.320628508915;4727.550882666142;4754.405699287589;4904.60763138948;3311.519829624739;3337.93324133516;3348.8995330140133;3369.882054128094;3376.0547046826928;520.0301437818517;603.7343568829701;623.7504998000745;634.1439057272645;636.7675798333668;557.2950217974266;601.6750954484529;606.3330336629672;677.8508728079814;713.3971793834305;9290.767730806783;9480.099390557885;9481.431114133175;9528.95235523818;9554.952225238829;620.3827191944044;685.85939882324;715.3204455767042;764.2166779051516;779.8557266905641;4408.118376324684;4550.340200670884;4586.449626044896;4593.173228818778;4663.114008338405;68004;68084;69209.65395172992;69340.65329673319;69824.30175698177;59163;59490.10764838531;61042.69478652578;62151;62551.6872415635;56082.158767618515;56575.71712141413;56720;57093.71453142791;57428.425715742305;8914.687985920462;9000.774980625536;9009.414388064755;9018.458892466473;9300.39547429415;35676.82161589279;35851;35955.82022089873;36662.266754664226;36811.447828282064;45696.54303456923;49351.50648493613;49769;49913;50598.74700626473;11415.543378265109;11540.422978851191;11594.304341739522;11613.883861161281;11675.182737208313;12218.20581662189;12542.623721288375;12597.87402125967;12837.358132093172;12879.420426080662;10939;11302;13203.471861125447;13219.339033048502;13288;12320.81518777237;12408.81386779181;12640.241585504898;12699.301538415475;12787.80818287745;12556.686082848002;12571;12748.872511274769;12797.232166070065;12908.096433249582;10444;10609.363438193424;10863.348199108079;11069.889301106887;11130.16523760705;11038.227324087236;11092.778144436905;11171.832422513506;11237.157213208879;11287.661370158909 23:29:29 INFO - PROCESS | 12377 | __end_tp_report 23:29:29 INFO - PROCESS | 12377 | __start_cc_report 23:29:29 INFO - PROCESS | 12377 | _x_x_mozilla_cycle_collect,871 23:29:29 INFO - PROCESS | 12377 | __end_cc_report 23:29:29 INFO - PROCESS | 12377 | __startTimestamp1461652169540__endTimestamp 23:29:29 INFO - PROCESS | 12377 | 23:29:29 INFO - PROCESS | 12377 | ------- Summary: start ------- 23:29:29 INFO - PROCESS | 12377 | Number of tests: 6 23:29:29 INFO - PROCESS | 12377 | 23:29:29 INFO - PROCESS | 12377 | [#0] dojo.html Cycles:165 Average:5242.88 Median:5448.46 stddev:581.60 (10.7%) stddev-sans-first:558.84 23:29:29 INFO - PROCESS | 12377 | Values: 3111.9 3161.9 3199.8 3204.6 3227.4 5181.0 5257.6 5287.6 5323.6 5357.2 5208.2 5222.4 5223.9 5289.0 5322.5 4711.0 4728.3 4749.7 4813.2 4884.1 4755.1 4812.7 4820.7 4839.1 4847.7 4773.9 4791.4 4801.8 4815.2 4852.1 4785.7 4794.4 4794.6 4801.7 4807.0 4651.6 4695.0 4782.7 4790.6 4832.3 5197.4 5235.2 5235.2 5239.1 5242.7 5650.2 5650.9 5651.5 5654.2 5654.4 5496.9 5695.8 5750.9 5767.1 5780.9 5284.8 5303.6 5306.2 5309.4 5320.7 5720.8 5735.5 5746.0 5750.7 5751.5 5463.0 5463.7 5513.1 5546.8 5554.1 5622.6 5633.2 5636.6 5637.7 5639.4 5514.7 5612.1 5623.5 5628.7 5629.4 5590.9 5607.7 5641.5 5642.6 5647.5 4235.4 4249.6 4298.0 4301.8 4338.9 3788.5 3830.7 3884.4 3885.4 3897.4 5373.2 5390.6 5400.3 5413.8 5448.5 5643.6 5644.2 5648.8 5651.5 5655.4 5265.2 5382.6 5397.9 5436.3 5453.9 4862.2 4863.9 4871.8 4907.6 4913.0 5875.2 5878.0 5880.6 5882.4 5898.9 5531.9 5550.3 5594.9 5618.7 5623.7 5854.2 5854.4 5868.7 5902.9 5910.9 5518.9 5526.2 5526.5 5531.1 5537.3 5530.0 5611.9 5623.7 5637.3 5751.0 5492.3 5526.5 5530.3 5533.2 5569.9 5485.9 5492.7 5533.8 5541.1 5592.2 5339.8 5355.2 5409.6 5432.0 5468.3 5492.5 5504.3 5516.2 5519.3 5529.0 5402.1 5404.4 5406.1 5407.2 5446.1 23:29:29 INFO - PROCESS | 12377 | 23:29:29 INFO - PROCESS | 12377 | [#1] ext.html Cycles:180 Average:53216.44 Median:42298.68 stddev:97214.44 (229.8%) stddev-sans-first:97406.87 23:29:29 INFO - PROCESS | 12377 | Values: 597.3 649.9 653.6 654.0 671.1 31840.0 37836.4 38612.4 38638.8 38690.6 41485.6 42302.0 42313.4 42339.6 42349.2 8486.7 8598.1 8605.7 8606.3 8702.3 8477.9 8610.6 8612.8 8613.9 8675.3 8892.5 8935.5 8967.6 8968.9 8972.2 8838.2 8913.8 8914.8 8916.4 8919.9 8831.0 8934.7 8956.2 8956.9 8968.0 41764.6 42311.2 42365.4 42372.8 42396.2 3311.9 3370.9 3431.2 3515.6 3782.7 31850.0 32301.0 32533.0 32627.5 33552.0 4294.4 4327.5 4367.3 4371.3 4398.9 311375.0 311594.0 312086.0 312160.0 312325.4 46189.3 57100.4 58216.4 58243.4 58277.1 54612.5 55682.4 55728.4 55732.7 55733.0 16446.7 16704.7 16726.2 16758.2 16758.5 11686.8 12564.6 12747.0 12763.5 12904.4 16454.9 17069.4 17405.0 17408.6 17461.7 6086.8 6277.2 6286.4 6311.5 6392.1 1032.2 1036.8 1051.8 1080.4 1120.0 33719.5 33772.0 33821.3 33838.2 33888.0 1116.3 1146.2 1153.6 1174.5 1182.8 15587.8 15747.8 15901.7 16131.4 16418.7 474706.0 475245.0 481709.0 481884.0 484473.0 56932.7 57116.4 57336.0 57339.4 57486.7 1380.1 1381.9 1416.1 1469.3 1552.4 29818.9 31096.5 31949.2 32355.7 32409.2 45771.0 45956.8 45973.8 46185.3 46199.0 278077.0 281751.0 283840.0 283922.6 287487.0 23109.3 40922.4 41015.0 42391.8 42946.8 47293.0 47493.3 47558.0 47697.0 48588.3 41163.4 42295.4 42637.1 42872.6 43657.8 41382.8 41530.0 42038.0 42262.6 42996.1 43138.4 43760.6 44226.0 44322.0 44741.8 36193.5 38468.5 38505.0 39314.8 39478.0 29491.7 29798.9 29992.3 30158.8 30351.2 23:29:29 INFO - PROCESS | 12377 | 23:29:29 INFO - PROCESS | 12377 | [#2] jquery.html Cycles:180 Average:28656.17 Median:2590.91 stddev:82161.02 (3171.1%) stddev-sans-first:82364.07 23:29:29 INFO - PROCESS | 12377 | Values: 379.9 381.8 397.0 408.2 417.1 14266.9 16479.8 18439.8 18871.9 18885.6 14746.6 17251.0 17816.3 18172.3 18559.3 5492.0 5626.9 5643.5 5661.8 5674.1 4025.1 5579.4 5629.3 5949.0 6247.7 6157.2 6186.5 6213.0 6214.4 6216.5 6111.2 6171.8 6186.0 6189.8 6193.4 5238.9 5317.6 5433.8 5441.5 5442.2 11946.3 12733.9 22133.2 22323.0 22325.7 2129.0 2177.9 2275.9 2307.3 2874.5 8964.1 9381.2 9427.9 9455.7 9585.1 1911.7 1938.5 1967.7 1992.5 2026.6 78937.6 81606.0 81740.6 81851.6 82535.6 10004.9 10387.2 10447.3 10536.0 10561.4 13828.1 13985.6 14033.1 14046.2 14053.1 7918.7 7927.5 8139.7 8237.3 8252.7 7151.9 8097.1 8129.6 8150.8 8233.2 4390.0 4635.8 4656.6 4761.3 4766.3 1936.7 1953.0 1967.3 1998.5 2001.7 913.2 968.6 1004.0 1030.6 1117.1 16726.7 18462.8 19287.8 19479.4 19672.4 979.9 1014.1 1014.8 1030.3 1070.3 10304.1 10472.5 10506.5 10516.3 10615.8 484604.0 489350.0 493926.0 511659.0 512322.0 80212.0 88449.6 89177.9 92948.5 93701.0 1088.8 1096.3 1099.4 1100.9 1103.5 15706.1 15746.8 15861.1 16041.8 16050.4 40833.0 41069.8 41295.6 41891.2 42542.8 56021.7 56466.7 57695.1 57744.4 57813.7 7961.8 8079.0 8171.8 8328.5 8391.1 10664.2 12289.8 12711.4 12768.6 12907.9 10757.4 11249.2 11278.4 11413.8 11654.9 10828.7 10958.9 11373.9 11453.1 11548.8 10693.7 10726.0 11506.3 11703.1 11718.2 8193.8 8258.5 8290.2 8301.9 8523.2 10135.0 10690.5 10739.8 10770.9 10807.6 23:29:29 INFO - PROCESS | 12377 | 23:29:29 INFO - PROCESS | 12377 | [#3] mootools.html Cycles:180 Average:5514.83 Median:5170.26 stddev:2976.23 (57.6%) stddev-sans-first:2968.05 23:29:29 INFO - PROCESS | 12377 | Values: 1341.9 1499.5 1541.8 1688.3 1843.4 7836.0 8032.0 8045.8 8050.0 8143.0 7884.8 8009.0 8013.6 8043.2 8093.0 2079.6 2267.3 2333.7 2340.8 2369.7 2334.3 2340.5 2342.3 2343.9 2349.1 2288.8 2356.1 2359.7 2363.9 2365.5 2031.7 2211.2 2277.6 2281.3 2281.5 2259.1 2260.3 2268.3 2269.6 2307.2 8069.8 8172.6 8177.8 8180.4 8191.8 4931.2 5129.9 5161.9 5171.2 5200.6 3314.5 3366.1 3366.7 3586.8 3591.4 1139.0 1141.9 1157.5 1168.7 1187.8 11368.9 11376.0 11402.5 11415.2 11446.5 4599.0 4648.1 4711.5 4747.5 4753.7 9701.9 9725.3 9727.5 9744.0 9744.4 4727.9 5265.0 5276.8 5284.3 5284.4 4662.0 4799.2 4803.2 4804.8 4826.5 3836.2 3926.8 3935.9 3967.2 4015.6 1270.5 1288.9 1289.5 1301.6 1307.0 834.5 839.0 900.9 940.2 984.7 5593.6 5732.0 5819.8 5850.6 5855.5 993.3 1005.3 1009.4 1024.9 1038.3 4236.1 4341.4 4385.5 4430.6 4479.9 9704.4 9997.5 10002.1 10022.5 10051.8 9772.1 9937.3 9975.9 10060.4 10071.2 7446.7 7596.6 7726.0 7769.7 7799.6 5810.3 5830.2 5839.2 5870.3 5950.0 8977.8 8982.0 9268.4 9283.0 9356.1 9297.0 9451.7 9470.6 9507.3 9508.9 6812.1 7062.4 7066.7 7273.7 7409.3 7590.1 7829.5 7969.6 8052.5 8065.1 7133.6 7337.9 7343.2 7440.3 7471.8 7200.2 7202.6 7261.7 7291.6 7339.6 6521.7 6605.1 6613.5 6719.7 6747.3 4985.9 5010.5 5105.2 5169.3 5180.4 4944.5 5021.6 5101.3 5153.8 5263.4 23:29:29 INFO - PROCESS | 12377 | 23:29:29 INFO - PROCESS | 12377 | [#4] prototype.html Cycles:180 Average:4662.74 Median:5407.43 stddev:1383.37 (25.6%) stddev-sans-first:1348.24 23:29:29 INFO - PROCESS | 12377 | Values: 316.5 328.6 333.7 334.7 336.9 5237.7 5296.0 5297.6 5321.1 5329.3 4952.4 5005.9 5169.7 5190.1 5230.7 4051.7 4084.6 4108.6 4113.4 4122.9 4083.3 4099.3 4104.7 4104.9 4118.8 3826.7 3917.5 4060.5 4078.4 4084.8 4027.5 4041.6 4048.7 4054.9 4055.4 3603.6 3610.6 3632.3 3641.2 3671.7 4823.6 5019.8 5020.5 5039.7 5100.9 4587.4 4587.7 4589.1 4619.1 4623.5 5420.8 5429.1 5430.5 5449.3 5454.2 3731.3 3899.9 3911.4 3931.8 3943.5 5645.4 5680.6 5689.4 5694.5 5714.5 4011.8 4012.4 4013.4 4033.3 4034.3 3852.0 4045.5 4055.6 4064.6 4078.9 4605.4 4623.5 4654.3 4654.7 4658.7 5458.4 5481.6 5498.6 5501.8 5513.6 1346.6 1348.4 1448.2 1451.1 1455.1 960.2 969.2 983.5 986.1 989.3 5625.8 5625.9 5665.6 5666.5 5668.5 5912.4 5928.9 5960.1 5966.7 5974.5 5479.4 5638.9 5643.2 5647.4 5665.5 3146.5 3158.7 3166.7 3169.7 3173.9 5670.6 6213.1 6237.3 6241.8 6261.8 5707.2 5737.5 5754.3 5769.2 5800.8 5886.8 5894.3 5925.2 5925.9 5933.5 5495.5 5549.4 5629.8 5671.7 5683.1 5522.0 5535.1 5564.7 5583.5 5584.1 5667.7 5852.7 5898.7 5910.3 5926.6 3930.4 3942.2 3966.5 3967.9 3990.6 5383.2 5631.4 5652.6 5654.2 5669.7 5408.4 5522.3 5527.9 5548.6 5553.8 5478.2 5515.1 5524.2 5526.3 5532.8 5238.4 5377.7 5407.1 5413.0 5415.4 5505.6 5515.2 5529.5 5557.4 5559.9 5366.4 5386.5 5407.8 5448.9 5462.7 23:29:29 INFO - PROCESS | 12377 | 23:29:29 INFO - PROCESS | 12377 | [#5] yui.html Cycles:180 Average:15424.26 Median:4650.66 stddev:18640.03 (400.8%) stddev-sans-first:18659.71 23:29:29 INFO - PROCESS | 12377 | Values: 740.5 800.1 829.1 841.6 847.1 13627.5 13723.8 13753.6 13857.5 13910.3 14307.8 14921.6 14954.9 14982.6 14990.7 703.0 807.7 834.6 837.9 845.4 848.5 848.7 850.4 850.7 851.0 889.7 890.7 892.0 892.1 892.5 721.4 801.8 822.3 823.9 824.1 603.2 603.4 603.5 603.5 604.5 13794.5 13840.9 13847.3 13875.4 13885.3 12515.1 12840.6 12918.4 12968.3 13511.5 11051.5 11053.0 11096.6 11121.6 11373.9 3749.9 3767.6 3816.2 3837.1 3876.9 49125.3 51022.7 56290.4 56934.7 57058.4 10708.0 10764.9 10830.1 10902.2 11010.9 18269.3 18269.5 18304.7 18305.6 18327.1 8058.4 8064.4 8120.9 8273.7 8276.4 4638.2 4685.3 4727.6 4754.4 4904.6 3311.5 3337.9 3348.9 3369.9 3376.1 520.0 603.7 623.8 634.1 636.8 557.3 601.7 606.3 677.9 713.4 9290.8 9480.1 9481.4 9529.0 9555.0 620.4 685.9 715.3 764.2 779.9 4408.1 4550.3 4586.4 4593.2 4663.1 68004.0 68084.0 69209.7 69340.7 69824.3 59163.0 59490.1 61042.7 62151.0 62551.7 56082.2 56575.7 56720.0 57093.7 57428.4 8914.7 9000.8 9009.4 9018.5 9300.4 35676.8 35851.0 35955.8 36662.3 36811.4 45696.5 49351.5 49769.0 49913.0 50598.7 11415.5 11540.4 11594.3 11613.9 11675.2 12218.2 12542.6 12597.9 12837.4 12879.4 10939.0 11302.0 13203.5 13219.3 13288.0 12320.8 12408.8 12640.2 12699.3 12787.8 12556.7 12571.0 12748.9 12797.2 12908.1 10444.0 10609.4 10863.3 11069.9 11130.2 11038.2 11092.8 11171.8 11237.2 11287.7 23:29:29 INFO - PROCESS | 12377 | -------- Summary: end -------- 23:29:29 INFO - PROCESS | 12377 | 23:29:30 INFO - TEST-INFO | 12377: exit 0 23:29:30 INFO - TEST-OK | dromaeo_css | took 1112129ms 23:29:30 INFO - TEST-START | kraken 23:29:30 INFO - operating with platform_type : linux_ 23:29:30 INFO - Initialising browser for kraken test... 23:29:30 INFO - TEST-INFO | started process 12567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFljGWb/profile http://localhost:46907/getInfo.html) 23:29:34 INFO - PROCESS | 12567 | __metrics Screen width/height:1600/1200 23:29:34 INFO - PROCESS | 12567 | colorDepth:24 23:29:34 INFO - PROCESS | 12567 | Browser inner width/height: 1024/697 23:29:34 INFO - PROCESS | 12567 | __metrics 23:29:35 ERROR - PROCESS | 12567 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:29:36 INFO - TEST-INFO | 12567: exit 0 23:29:36 INFO - Browser initialized. 23:29:36 INFO - Running cycle 1/1 for kraken test... 23:29:36 INFO - TEST-INFO | started process 12653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFljGWb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:29:47 INFO - PROCESS | 12653 | RSS: Main: 154296320 23:29:47 INFO - PROCESS | 12653 | 23:29:50 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46907/tests/kraken/driver.html?testName=audio-beat-detection) 23:29:51 INFO - PROCESS | 12653 | RSS: Main: 209166336 23:29:51 INFO - PROCESS | 12653 | 23:29:54 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46907/tests/kraken/driver.html?testName=audio-dft) 23:29:54 INFO - PROCESS | 12653 | RSS: Main: 195563520 23:29:54 INFO - PROCESS | 12653 | 23:29:57 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46907/tests/kraken/driver.html?testName=audio-fft) 23:29:58 INFO - PROCESS | 12653 | RSS: Main: 266326016 23:29:58 INFO - PROCESS | 12653 | 23:30:00 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46907/tests/kraken/driver.html?testName=audio-oscillator) 23:30:01 INFO - PROCESS | 12653 | RSS: Main: 174305280 23:30:01 INFO - PROCESS | 12653 | 23:30:03 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46907/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:30:03 INFO - PROCESS | 12653 | RSS: Main: 178307072 23:30:03 INFO - PROCESS | 12653 | 23:30:06 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46907/tests/kraken/driver.html?testName=imaging-darkroom) 23:30:07 INFO - PROCESS | 12653 | RSS: Main: 213868544 23:30:07 INFO - PROCESS | 12653 | 23:30:10 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46907/tests/kraken/driver.html?testName=imaging-desaturate) 23:30:11 INFO - PROCESS | 12653 | RSS: Main: 215425024 23:30:11 INFO - PROCESS | 12653 | 23:30:14 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46907/tests/kraken/driver.html?testName=json-parse-financial) 23:30:14 INFO - PROCESS | 12653 | RSS: Main: 215322624 23:30:14 INFO - PROCESS | 12653 | 23:30:16 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46907/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:30:16 INFO - PROCESS | 12653 | RSS: Main: 203517952 23:30:16 INFO - PROCESS | 12653 | 23:30:18 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46907/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:30:19 INFO - PROCESS | 12653 | RSS: Main: 205004800 23:30:19 INFO - PROCESS | 12653 | 23:30:21 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46907/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:30:21 INFO - PROCESS | 12653 | RSS: Main: 215773184 23:30:21 INFO - PROCESS | 12653 | 23:30:24 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:30:25 INFO - PROCESS | 12653 | RSS: Main: 223649792 23:30:25 INFO - PROCESS | 12653 | 23:30:27 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:30:28 INFO - PROCESS | 12653 | RSS: Main: 221184000 23:30:28 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:46907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46907/tests/kraken/driver.html?testName=ai-astar) 23:30:30 INFO - PROCESS | 12653 | RSS: Main: 284905472 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | __start_tp_report 23:30:30 INFO - PROCESS | 12653 | _x_x_mozilla_page_load 23:30:30 INFO - PROCESS | 12653 | _x_x_mozilla_page_load_details 23:30:30 INFO - PROCESS | 12653 | |i|pagename|runs| 23:30:30 INFO - PROCESS | 12653 | |0;ai-astar;112;112;106;115;114;110;103;112;110;109 23:30:30 INFO - PROCESS | 12653 | |1;audio-beat-detection;165;127;159;190;131;152;170;127;178;129 23:30:30 INFO - PROCESS | 12653 | |2;audio-dft;160;160;161;160;159;160;163;161;162;161 23:30:30 INFO - PROCESS | 12653 | |3;audio-fft;77;75;121;112;75;72;75;136;106;76 23:30:30 INFO - PROCESS | 12653 | |4;audio-oscillator;93;92;160;94;93;94;147;92;94;156 23:30:30 INFO - PROCESS | 12653 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 23:30:30 INFO - PROCESS | 12653 | |6;imaging-darkroom;145;146;146;145;145;144;145;146;145;145 23:30:30 INFO - PROCESS | 12653 | |7;imaging-desaturate;95;95;94;95;94;94;95;95;94;95 23:30:30 INFO - PROCESS | 12653 | |8;json-parse-financial;58;59;59;57;57;58;65;80;56;55 23:30:30 INFO - PROCESS | 12653 | |9;json-stringify-tinderbox;61;62;61;62;61;61;61;62;62;62 23:30:30 INFO - PROCESS | 12653 | |10;stanford-crypto-aes;75;75;84;74;76;76;76;78;77;77 23:30:30 INFO - PROCESS | 12653 | |11;stanford-crypto-ccm;125;120;123;120;120;126;121;130;171;123 23:30:30 INFO - PROCESS | 12653 | |12;stanford-crypto-pbkdf2;174;174;166;167;163;165;172;167;167;164 23:30:30 INFO - PROCESS | 12653 | |13;stanford-crypto-sha256-iterative;70;70;71;70;69;68;73;69;67;67 23:30:30 INFO - PROCESS | 12653 | __end_tp_report 23:30:30 INFO - PROCESS | 12653 | __start_cc_report 23:30:30 INFO - PROCESS | 12653 | _x_x_mozilla_cycle_collect,1641 23:30:30 INFO - PROCESS | 12653 | __end_cc_report 23:30:30 INFO - PROCESS | 12653 | __startTimestamp1461652230388__endTimestamp 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | ------- Summary: start ------- 23:30:30 INFO - PROCESS | 12653 | Number of tests: 14 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.62 (3.2%) stddev-sans-first:3.79 23:30:30 INFO - PROCESS | 12653 | Values: 112.0 112.0 106.0 115.0 114.0 110.0 103.0 112.0 110.0 109.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:162.00 stddev:23.28 (14.4%) stddev-sans-first:24.26 23:30:30 INFO - PROCESS | 12653 | Values: 165.0 127.0 159.0 190.0 131.0 152.0 170.0 127.0 178.0 129.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 23:30:30 INFO - PROCESS | 12653 | Values: 160.0 160.0 161.0 160.0 159.0 160.0 163.0 161.0 162.0 161.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:23.85 (31.8%) stddev-sans-first:24.63 23:30:30 INFO - PROCESS | 12653 | Values: 77.0 75.0 121.0 112.0 75.0 72.0 75.0 136.0 106.0 76.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:93.00 stddev:29.73 (32.0%) stddev-sans-first:30.77 23:30:30 INFO - PROCESS | 12653 | Values: 93.0 92.0 160.0 94.0 93.0 94.0 147.0 92.0 94.0 156.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:30:30 INFO - PROCESS | 12653 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 23:30:30 INFO - PROCESS | 12653 | Values: 145.0 146.0 146.0 145.0 145.0 144.0 145.0 146.0 145.0 145.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:30:30 INFO - PROCESS | 12653 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:58.50 stddev:7.40 (12.6%) stddev-sans-first:7.79 23:30:30 INFO - PROCESS | 12653 | Values: 58.0 59.0 59.0 57.0 57.0 58.0 65.0 80.0 56.0 55.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 23:30:30 INFO - PROCESS | 12653 | Values: 61.0 62.0 61.0 62.0 61.0 61.0 61.0 62.0 62.0 62.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.50 stddev:2.78 (3.6%) stddev-sans-first:2.87 23:30:30 INFO - PROCESS | 12653 | Values: 75.0 75.0 84.0 74.0 76.0 76.0 76.0 78.0 77.0 77.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:124.00 stddev:15.48 (12.5%) stddev-sans-first:16.38 23:30:30 INFO - PROCESS | 12653 | Values: 125.0 120.0 123.0 120.0 120.0 126.0 121.0 130.0 171.0 123.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:167.00 stddev:4.01 (2.4%) stddev-sans-first:3.60 23:30:30 INFO - PROCESS | 12653 | Values: 174.0 174.0 166.0 167.0 163.0 165.0 172.0 167.0 167.0 164.0 23:30:30 INFO - PROCESS | 12653 | 23:30:30 INFO - PROCESS | 12653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.84 (2.6%) stddev-sans-first:1.94 23:30:30 INFO - PROCESS | 12653 | Values: 70.0 70.0 71.0 70.0 69.0 68.0 73.0 69.0 67.0 67.0 23:30:30 INFO - PROCESS | 12653 | -------- Summary: end -------- 23:30:30 INFO - PROCESS | 12653 | 23:30:31 INFO - TEST-INFO | 12653: exit 0 23:30:31 INFO - TEST-OK | kraken | took 61103ms 23:30:31 INFO - SUITE-END | took 1173s 23:30:31 INFO - Completed test suite (00:19:33) 23:30:31 INFO - javascript benchmark 23:30:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.859966301516, 3161.920951976199, 3199.8080115193075, 3204.6474887762342, 3227.4351988402022, 5180.974095129529, 5257.631965762398, 5287.629865909388, 5323.60072994525, 5357.196420536917, 5208.244804503354, 5222.399424066233, 5223.921641175385, 5289.021531016755, 5322.467753224676, 4710.97644511777, 4728.314394412817, 4749.667523273372, 4813.205821039542, 4884.072026314989, 4755.096531658991, 4812.711237325771, 4820.686655367407, 4839.104765618372, 4847.684900481458, 4773.928391074137, 4791.4250289965075, 4801.759912004421, 4815.15734746418, 4852.053849499349, 4785.712857228577, 4794.448638406593, 4794.616430685537, 4801.7118972861745, 4807.038592281523, 4651.5813576778255, 4694.95305046952, 4782.7130372177435, 4790.640701947368, 4832.251001094836, 5197.428282888879, 5235.240890070956, 5235.240890070956, 5239.1093514102695, 5242.659227150261, 5650.208970744099, 5650.886982260373, 5651.519620832193, 5654.180143879155, 5654.406287339812, 5496.945030549723, 5695.829125126253, 5750.942490575083, 5767.106098554689, 5780.942190578125, 5284.841454756363, 5303.575713942875, 5306.151015837448, 5309.4425085365865, 5320.707361095138, 5720.799772007959, 5735.541156707453, 5745.971270143623, 5750.712464376848, 5751.4536119068625, 5463.016657001698, 5463.672179669233, 5513.117901135879, 5546.750396232179, 5554.1391084381985, 5622.550195984311, 5633.183188437653, 5636.577256705764, 5637.746301416364, 5639.407862174495, 5514.696691681916, 5612.102063669793, 5623.493885550321, 5628.71856407178, 5629.408912064257, 5590.888182236333, 5607.691576963306, 5641.464060914206, 5642.633228840113, 5647.491725744702, 4235.449391579136, 4249.575042495788, 4298.032942587893, 4301.849435269751, 4338.891527711832, 3788.4885540452237, 3830.693544516432, 3884.436756670267, 3885.4366116913457, 3897.3569361055675, 5373.2208829719475, 5390.649607775482, 5400.297961265089, 5413.756380962787, 5448.45515448452, 5643.604947653707, 5644.238027866186, 5648.774049038075, 5651.519620832193, 5655.434456554394, 5265.21021846726, 5382.596305277119, 5397.892042159135, 5436.266104075979, 5453.918191227135, 4862.197737373293, 4863.902721945612, 4871.780769865364, 4907.607391408679, 4913.041956818458, 5875.177475153482, 5877.970610146922, 5880.588358814842, 5882.411758824083, 5898.911516327258, 5531.944680553143, 5550.278463799842, 5594.916076258778, 5618.690971996416, 5623.690697011703, 5854.180414742024, 5854.356020837789, 5868.677222752619, 5902.911456328245, 5910.911336330045, 5518.944810551843, 5526.226328313959, 5526.530244929226, 5531.059719847555, 5537.2524709163745, 5530.0, 5611.859703507445, 5623.690697011703, 5637.267155269788, 5750.971245143747, 5492.340919089735, 5526.47498487643, 5530.281063461724, 5533.170024496358, 5569.944300556943, 5485.917711234414, 5492.670439773627, 5533.806316778893, 5541.085720856175, 5592.2170896075395, 5339.813106541253, 5355.169948657965, 5409.6213265071065, 5432.049391356418, 5468.3437987440175, 5492.5331346835965, 5504.339479262514, 5516.200150978166, 5519.31008623922, 5529.004779139794, 5402.054640437829, 5404.432534583812, 5406.0809662356705, 5407.161889907071, 5446.128619420873], "value": 5205.128061619032, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.2653636027686, 649.912261844651, 653.555582204101, 653.9999999999999, 671.0839703804309, 31840.0, 37836.43245351318, 38612.42081368778, 38638.806805966, 38690.613093869055, 41485.58514414855, 42302.0, 42313.365299520454, 42339.576604233946, 42349.15301693964, 8486.745397638066, 8598.05421403645, 8605.655773769073, 8606.31149508041, 8702.347323950697, 8477.897873276466, 8610.56947152643, 8612.784680382978, 8613.880195574566, 8675.262602678747, 8892.510911899843, 8935.463872167691, 8967.641294348217, 8968.865467017968, 8972.192502674758, 8838.204561589455, 8913.777155571097, 8914.821703565893, 8916.375853690244, 8919.866202006975, 8831.0, 8934.73195804127, 8956.238719708832, 8956.8656470153, 8968.0, 41764.582354176375, 42311.153776924286, 42365.36451953223, 42372.78813605943, 42396.1520769586, 3311.93376132476, 3370.932581348384, 3431.1765176357744, 3515.59570649376, 3782.659560639528, 31850.0, 32301.0, 32533.0, 32627.51058734121, 33552.0, 4294.4202532658, 4327.545607711177, 4367.2575662137515, 4371.27873900806, 4398.912021759579, 311375.0, 311594.0, 312086.0, 312160.0, 312325.438372809, 46189.30716039262, 57100.42899570951, 58216.4178358211, 58243.417565824646, 58277.125843112386, 54612.453875461535, 55682.44317556854, 55728.442715572324, 55732.72133639306, 55733.0, 16446.6710665786, 16704.665906682043, 16726.16369181536, 16758.24587893548, 16758.497245082668, 11686.76626467466, 12564.623061308175, 12747.0, 12763.489460421479, 12904.354782261038, 16454.917725411535, 17069.40257090996, 17405.0, 17408.5647858802, 17461.7380739289, 6086.847828804227, 6277.2153480814895, 6286.371362863769, 6311.526635502356, 6392.105105285264, 1032.2155162076876, 1036.7874585709912, 1051.831706926888, 1080.443571560647, 1119.9664010079712, 33719.494207586904, 33772.0, 33821.32357352888, 33838.15404614855, 33888.0, 1116.2744216259334, 1146.2377518949972, 1153.5558809858096, 1174.518447436564, 1182.810750279951, 15587.766183507256, 15747.842521574867, 15901.681966360607, 16131.354745810037, 16418.6716265674, 474706.0, 475245.0, 481709.0, 481884.0, 484473.0, 56932.715336423054, 57116.428835711115, 57336.0, 57339.42660573425, 57486.7125664369, 1380.0684537936852, 1381.9101758385673, 1416.0670684515562, 1469.3461409672593, 1552.3945661192145, 29818.850905745334, 31096.533551996286, 31949.20126996844, 32355.676443235265, 32409.189770255933, 45771.0, 45956.7702161487, 45973.77013114913, 46185.307220392395, 46199.0, 278077.0, 281751.0, 283840.0, 283922.58038709674, 287487.0, 23109.306720798402, 40922.38616420697, 41015.0, 42391.7880410596, 42946.78526607347, 47293.0, 47493.28760068671, 47558.0, 47697.0, 48588.2711759331, 41163.38254926239, 42295.36556951587, 42637.14725705531, 42872.571274286856, 43657.78171109251, 41382.79308603438, 41530.0, 42038.0, 42262.57737422586, 42996.140077197655, 43138.40992821429, 43760.56239437565, 44226.0, 44322.0, 44741.77629111834, 36193.45709814408, 38468.53783159529, 38505.0, 39314.80342598269, 39478.0, 29491.705082949753, 29798.851005744833, 29992.25019374533, 30158.84920575471, 30351.24121896882], "value": 19736.398277711378, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.85565485115654, 381.7556763671249, 396.9801509924503, 408.2284482328399, 417.14485305124487, 14266.857331426683, 16479.752803707954, 18439.815601843977, 18871.905640471796, 18885.62228755426, 14746.631334216623, 17251.0, 17816.287348506045, 18172.27310907562, 18559.25762969483, 5491.972540137293, 5626.859328516779, 5643.520300774439, 5661.830145095653, 5674.063779476382, 4025.1144748155507, 5579.442055794429, 5629.296337957755, 5949.0, 6247.656378899159, 6157.1995640566665, 6186.505079593621, 6213.0, 6214.40963108504, 6216.471599914013, 6111.236095488064, 6171.783987560414, 6185.969070154643, 6189.845253868644, 6193.380661933793, 5238.947610523884, 5317.574594032468, 5433.8369848904595, 5441.483059109379, 5442.2380866678695, 11946.342951137683, 12733.87266127336, 22133.225337113287, 22323.0, 22325.665115023286, 2128.957420851574, 2177.8911054447212, 2275.8520696154696, 2307.3308740465245, 2874.4825931332352, 8964.14840590143, 9381.202597779196, 9427.905720942772, 9455.716328510156, 9585.137337639577, 1911.6559019376507, 1938.5444420561157, 1967.6753335699736, 1992.471994921347, 2026.5642886779265, 78937.60531197365, 81606.0, 81740.59129704373, 81851.59074204651, 82535.587322063, 10004.899951000543, 10387.220958427997, 10447.268691191544, 10536.0, 10561.366318020944, 13828.101173423694, 13985.58043258704, 14033.087849289763, 14046.227457489731, 14053.086549374259, 7918.683252669944, 7927.484713493604, 8139.674413023531, 8237.258646721824, 8252.711155109542, 7151.89272160918, 8097.109317975018, 8129.593520323961, 8150.7773833925385, 8233.217844304781, 4390.0, 4635.768211589407, 4656.580907718321, 4761.262004389325, 4766.261229509431, 1936.7482227310359, 1952.9707054394196, 1967.281942091155, 1998.4504261328252, 2001.698895717795, 913.2465715784372, 968.6173961285253, 1003.9749006274901, 1030.6341248856697, 1117.07841031148, 16726.74909876353, 18462.81537184638, 19287.807121928883, 19479.370285011624, 19672.409827705193, 979.8824141103113, 1014.1227837920146, 1014.8071866345371, 1030.2543720983494, 1070.2829104500004, 10304.124149447382, 10472.476376181161, 10506.527206275736, 10516.316439431412, 10615.84076238857, 484604.0, 489350.0, 493926.0, 511659.0, 512322.0, 80212.0, 88449.55775221082, 89177.85276840394, 92948.53525732328, 93701.0, 1088.820344643125, 1096.309325125166, 1099.4228030284164, 1100.878903320634, 1103.4979084516526, 15706.136162511171, 15746.842531574537, 15861.127637980022, 16041.759373609639, 16050.438234661731, 40833.0, 41069.794651026554, 41295.58704412918, 41891.162176755686, 42542.78728606337, 56021.71989140028, 56466.71766641141, 57695.13457298228, 57744.422555773905, 57813.71093144507, 7961.800954976172, 8079.0, 8171.83656326882, 8328.500289982621, 8391.118932512243, 10664.200184986312, 12289.754204916031, 12711.364431778558, 12768.553100641433, 12907.934730443085, 10757.386392040944, 11249.212555121063, 11278.436078196222, 11413.771724565628, 11654.94172529166, 10828.675139745821, 10958.890411095786, 11373.943130284295, 11453.141014423785, 11548.769024619292, 10693.732656683645, 10726.039890558606, 11506.252093613888, 11703.122265829927, 11718.23831450953, 8193.83612327762, 8258.545779982158, 8290.170982901904, 8301.916980830114, 8523.232909038215, 10135.0, 10690.518926648476, 10739.838902416626, 10770.892291076989, 10807.621733239614], "value": 8966.398454178972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.8926485881132, 1499.4976682811255, 1541.7841502189694, 1688.3331084221734, 1843.4008947092198, 7836.0, 8032.0, 8045.839083218332, 8050.0, 8143.0, 7884.802879928005, 8009.0, 8013.639386227619, 8043.235892590209, 8093.028836539609, 2079.61527117483, 2267.30847091637, 2333.684952531412, 2340.8244381671443, 2369.7156341239074, 2334.2763743239652, 2340.496793189464, 2342.3090188394463, 2343.8593684378907, 2349.0721165139757, 2288.8397812153157, 2356.06935260572, 2359.681443005198, 2363.9054437822465, 2365.4677697518005, 2031.7460317460318, 2211.1929145861727, 2277.5672622201896, 2281.349815302639, 2281.498070424504, 2259.141526220042, 2260.3219034289646, 2268.319504148749, 2269.5574362999055, 2307.227078928544, 8069.757907262791, 8172.6322315495945, 8177.79555511111, 8180.427370084097, 8191.836163276761, 4931.21100623902, 5129.871753206163, 5161.896762064737, 5171.198464238049, 5200.557952574036, 3314.486254630536, 3366.1248075500303, 3366.663333666638, 3586.8385922633543, 3591.425371940477, 1138.9829152562718, 1141.9429028548539, 1157.5080590748983, 1168.6727716239466, 1187.827764974074, 11368.886311136948, 11376.033037191848, 11402.543898244061, 11415.200935934488, 11446.542138314457, 4598.954010459853, 4648.070385922829, 4711.505291944365, 4747.525247475294, 4753.691010084333, 9701.854472182922, 9725.270604704676, 9727.464989425507, 9744.0, 9744.415335079917, 4727.929081063787, 5264.9736751315995, 5276.762545685453, 5284.260203571503, 5284.365876094893, 4662.0, 4799.208130658472, 4803.18345881201, 4804.807807687654, 4826.517348265215, 3836.175222327213, 3926.8232929517667, 3935.940960885589, 3967.1867267210155, 4015.5783642717092, 1270.4664041102758, 1288.8840004399462, 1289.5164313382481, 1301.557470460048, 1306.9803952940713, 834.5284914023557, 838.9622466989, 900.8783814185132, 940.1820416237916, 984.7144328144758, 5593.552515798808, 5732.0, 5819.82540523785, 5850.64896106235, 5855.531557475391, 993.3443927008284, 1005.2762011351815, 1009.399407352624, 1024.8975102489692, 1038.3458421194598, 4236.110416812442, 4341.435613370305, 4385.51759306476, 4430.601245887886, 4479.888002799956, 9704.417734935927, 9997.45014024221, 10002.149817265468, 10022.548985295532, 10051.798964020825, 9772.12050915421, 9937.254705897087, 9975.850362244571, 10060.446675432922, 10071.24465665078, 7446.73936412223, 7596.582187979714, 7726.0, 7769.72805951789, 7799.649015794303, 5810.331811841524, 5830.154627579062, 5839.153322768259, 5870.26621672291, 5950.018246989198, 8977.775555611162, 8981.955090224506, 9268.397554158959, 9282.953585232031, 9356.06439356059, 9296.95351523238, 9451.669191578261, 9470.57382417779, 9507.334486586149, 9508.85736713936, 6812.080369150101, 7062.3996960258955, 7066.717331306896, 7273.672684729094, 7409.296116868889, 7590.0891892973195, 7829.530228186327, 7969.6015199240965, 8052.476589021695, 8065.072516660424, 7133.5719856808755, 7337.889931650922, 7343.192248852729, 7440.2931721486375, 7471.775846724607, 7200.171980222132, 7202.567845929261, 7261.745838895825, 7291.6354182289615, 7339.559626422431, 6521.7065232065615, 6605.141331626858, 6613.470922326106, 6719.731210751711, 6747.2915343890145, 4985.875353116201, 5010.549050585465, 5105.157648987875, 5169.327987361619, 5180.430152683277, 4944.48082951285, 5021.598272138147, 5101.311322971352, 5153.819616313411, 5263.447338029605], "value": 4497.996577268373, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.54101552748506, 328.6352149114483, 333.66466700965526, 334.67468823459103, 336.8703049326009, 5237.738113094344, 5296.0, 5297.576193904488, 5321.095413779657, 5329.25390445338, 4952.405711314638, 5005.949940500603, 5169.6898186108765, 5190.091733946554, 5230.73846307684, 4051.7163798534116, 4084.550699423061, 4108.589141085898, 4113.362428823522, 4122.876313710586, 4083.2854250506193, 4099.323611604082, 4104.651104656093, 4104.8768536943935, 4118.752874827505, 3826.65560099591, 3917.5103112110987, 4060.533038700543, 4078.3678529827926, 4084.7957602119923, 4027.536833264183, 4041.5952508257833, 4048.67610591152, 4054.8986275343204, 4055.4119652650497, 3603.6396360364015, 3610.584782749991, 3632.273545290926, 3641.1625326174862, 3671.6511931366745, 4823.638227132979, 5019.84940451787, 5020.548150666457, 5039.672421292641, 5100.857639791297, 4587.449506059294, 4587.747673877935, 4589.128065667546, 4619.14545809023, 4623.468301145344, 5420.756065977041, 5429.104197807357, 5430.4748292044, 5449.291592093003, 5454.154606036071, 3731.2910546996254, 3899.941500877489, 3911.413288006793, 3931.842726290945, 3943.5267767867754, 5645.379008309083, 5680.602357834953, 5689.431056894277, 5694.5159661428415, 5714.51426628737, 4011.7793521356607, 4012.4382586437923, 4013.4180543821567, 4033.253848038122, 4034.2738307105, 3852.0, 4045.4538637284177, 4055.614716601918, 4064.5935406459116, 4078.877633670935, 4605.424321959755, 4623.491415944243, 4654.25531914892, 4654.674172807939, 4658.67389282747, 5458.426865179099, 5481.588880833953, 5498.560115190775, 5501.779928802883, 5513.61404701667, 1346.5892902664586, 1348.373006551958, 1448.203488081572, 1451.0930668332292, 1455.1487379882888, 960.2030314838668, 969.2149359019216, 983.4541829284673, 986.1371300112402, 989.2728844299434, 5625.8312250631725, 5625.915611265835, 5665.603407761417, 5666.4900158985065, 5668.461496157858, 5912.408759124053, 5928.851778705481, 5960.135780311831, 5966.671833049137, 5974.522038236931, 5479.397266300703, 5638.9436105638415, 5643.181738647873, 5647.407022262685, 5665.5467562594895, 3146.5437511560694, 3158.652548219694, 3166.73082787961, 3169.700422826676, 3173.904782856518, 5670.603057785998, 6213.130161777355, 6237.251529816361, 6241.812745617639, 6261.812145635638, 5707.200991861143, 5737.454941780524, 5754.280714910637, 5769.221155144086, 5800.767969281182, 5886.764529418861, 5894.263217097863, 5925.229720136354, 5925.9407405925385, 5933.465988061095, 5495.477929596682, 5549.417311182429, 5629.802956896489, 5671.716414179357, 5683.147527870852, 5521.984475666433, 5535.142052981794, 5564.721763911707, 5583.469570390806, 5584.106542953108, 5667.659940403589, 5852.678102704393, 5898.675572843535, 5910.349861515316, 5926.644401335933, 3930.3514920037874, 3942.1865941667156, 3966.504186976628, 3967.8809635710977, 3990.620891015349, 5383.16560933056, 5631.436856314336, 5652.576056795675, 5654.236678048575, 5669.688167150846, 5408.405075441777, 5522.30971128609, 5527.944720552743, 5548.583856210881, 5553.805931724537, 5478.178273258884, 5515.145152501369, 5524.210273811699, 5526.309211348582, 5532.834014979557, 5238.449962753856, 5377.741348633505, 5407.053765591085, 5412.972935135299, 5415.4313797050745, 5505.587080968863, 5515.166958963482, 5529.502344788988, 5557.44425557441, 5559.916601251065, 5366.436524164907, 5386.522199787984, 5407.810726624707, 5448.918266225931, 5462.6995515247045], "value": 4225.640950905164, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.4594645908484, 800.0958916424441, 829.1418381974657, 841.5960339037262, 847.140152744964, 13627.523036693718, 13723.794143087849, 13753.58739237822, 13857.514986975459, 13910.30448477576, 14307.78538321926, 14921.552353429415, 14954.850451495482, 14982.550523484286, 14990.700185996273, 702.975395861145, 807.6930766308794, 834.5743670727942, 837.9329653627725, 845.4420082745389, 848.465466755946, 848.7114381110421, 850.4047166983106, 850.706506255341, 850.9914900850974, 889.6886089868526, 890.6526454682646, 892.0276898180981, 892.0989800301677, 892.5046599137476, 721.4084450750387, 801.7514570483169, 822.2722890242119, 823.8599438095569, 824.056455358617, 603.1676286724336, 603.4448307557014, 603.4538742438101, 603.5051257968468, 604.4680681000735, 13794.517191898336, 13840.93079534606, 13847.307634618228, 13875.375608097558, 13885.305734713224, 12515.123941324111, 12840.61478155657, 12918.418671159727, 12968.286744229064, 13511.527096551672, 11051.502682379312, 11053.0, 11096.55613775448, 11121.55513779456, 11373.886261137366, 3749.9250014999548, 3767.6232376762377, 3816.217675376541, 3837.098281903778, 3876.8836934891997, 49125.26312105321, 51022.74488627533, 56290.43709562893, 56934.71532642352, 57058.429415706145, 10708.0, 10764.946175269073, 10830.133589312836, 10902.236843420884, 11010.944945275383, 18269.269229230682, 18269.54326141857, 18304.725429118575, 18305.63388732218, 18327.083645817656, 8058.435909486279, 8064.354851611857, 8120.878186827203, 8273.710420135267, 8276.379271554657, 4638.2115040443205, 4685.320628508915, 4727.550882666142, 4754.405699287589, 4904.60763138948, 3311.519829624739, 3337.93324133516, 3348.8995330140133, 3369.882054128094, 3376.0547046826928, 520.0301437818517, 603.7343568829701, 623.7504998000745, 634.1439057272645, 636.7675798333668, 557.2950217974266, 601.6750954484529, 606.3330336629672, 677.8508728079814, 713.3971793834305, 9290.767730806783, 9480.099390557885, 9481.431114133175, 9528.95235523818, 9554.952225238829, 620.3827191944044, 685.85939882324, 715.3204455767042, 764.2166779051516, 779.8557266905641, 4408.118376324684, 4550.340200670884, 4586.449626044896, 4593.173228818778, 4663.114008338405, 68004.0, 68084.0, 69209.65395172992, 69340.65329673319, 69824.30175698177, 59163.0, 59490.10764838531, 61042.69478652578, 62151.0, 62551.6872415635, 56082.158767618515, 56575.71712141413, 56720.0, 57093.71453142791, 57428.425715742305, 8914.687985920462, 9000.774980625536, 9009.414388064755, 9018.458892466473, 9300.39547429415, 35676.82161589279, 35851.0, 35955.82022089873, 36662.266754664226, 36811.447828282064, 45696.54303456923, 49351.50648493613, 49769.0, 49913.0, 50598.74700626473, 11415.543378265109, 11540.422978851191, 11594.304341739522, 11613.883861161281, 11675.182737208313, 12218.20581662189, 12542.623721288375, 12597.87402125967, 12837.358132093172, 12879.420426080662, 10939.0, 11302.0, 13203.471861125447, 13219.339033048502, 13288.0, 12320.81518777237, 12408.81386779181, 12640.241585504898, 12699.301538415475, 12787.80818287745, 12556.686082848002, 12571.0, 12748.872511274769, 12797.232166070065, 12908.096433249582, 10444.0, 10609.363438193424, 10863.348199108079, 11069.889301106887, 11130.16523760705, 11038.227324087236, 11092.778144436905, 11171.832422513506, 11237.157213208879, 11287.661370158909], "value": 6774.894508466034, "unit": "score"}], "name": "dromaeo_css", "value": 7009.647736758524, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 106.0, 115.0, 114.0, 110.0, 103.0, 112.0, 110.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 127.0, 159.0, 190.0, 131.0, 152.0, 170.0, 127.0, 178.0, 129.0], "value": 152.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 159.0, 160.0, 163.0, 161.0, 162.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 121.0, 112.0, 75.0, 72.0, 75.0, 136.0, 106.0, 76.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 160.0, 94.0, 93.0, 94.0, 147.0, 92.0, 94.0, 156.0], "value": 111.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 144.0, 145.0, 146.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 57.0, 57.0, 58.0, 65.0, 80.0, 56.0, 55.0], "value": 60.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 84.0, 74.0, 76.0, 76.0, 76.0, 78.0, 77.0, 77.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 120.0, 123.0, 120.0, 120.0, 126.0, 121.0, 130.0, 171.0, 123.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 166.0, 167.0, 163.0, 165.0, 172.0, 167.0, 167.0, 164.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 70.0, 69.0, 68.0, 73.0, 69.0, 67.0, 67.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1548.3000000000002, "alertThreshold": 2.0}]} 23:30:31 INFO - Return code: 0 23:30:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:30:31 ERROR - # TBPL SUCCESS # 23:30:31 INFO - Running post-action listener: _resource_record_post_action 23:30:31 INFO - Running post-run listener: _resource_record_post_run 23:30:32 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 358473728; Read time: 12; Write time: 346940 23:30:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 25083904; Read time: 0; Write time: 32692 23:30:32 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284979200; Read time: 12; Write time: 261560 23:30:32 INFO - Running post-run listener: _upload_blobber_files 23:30:32 INFO - Blob upload gear active. 23:30:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:30:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:30:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:30:33 INFO - (blobuploader) - INFO - Open directory for files ... 23:30:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:30:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:30:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:33 INFO - (blobuploader) - INFO - Done attempting. 23:30:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:30:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:30:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:34 INFO - (blobuploader) - INFO - Done attempting. 23:30:34 INFO - (blobuploader) - INFO - Iteration through files over. 23:30:34 INFO - Return code: 0 23:30:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:30:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:30:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cd6f4edc2f4e3e9f6ea525b3d27405369f7357e7eb8dee052d4930aa9967af75f0213cec3ea86de08c34a0bff97e4d3bc3e1e9b1ec2a6d0a70c1acdd8a502ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5014846df716af2bf836625ccbeeadfd579d83ca957a13afe0d88e11429667dbdc9ff8ef87c110f32dce6e9f9f117f2863c8b645740ccbee7a93ea3a1ba435ce"} 23:30:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:30:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:30:34 INFO - Contents: 23:30:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cd6f4edc2f4e3e9f6ea525b3d27405369f7357e7eb8dee052d4930aa9967af75f0213cec3ea86de08c34a0bff97e4d3bc3e1e9b1ec2a6d0a70c1acdd8a502ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5014846df716af2bf836625ccbeeadfd579d83ca957a13afe0d88e11429667dbdc9ff8ef87c110f32dce6e9f9f117f2863c8b645740ccbee7a93ea3a1ba435ce"} 23:30:34 INFO - Running post-run listener: copy_logs_to_upload_dir 23:30:34 INFO - Copying logs to upload dir... 23:30:34 INFO - mkdir: /builds/slave/test/build/upload/logs 23:30:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.437752 ========= master_lag: 3.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-25 23:30:37.600712) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 23:30:37.604440) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cd6f4edc2f4e3e9f6ea525b3d27405369f7357e7eb8dee052d4930aa9967af75f0213cec3ea86de08c34a0bff97e4d3bc3e1e9b1ec2a6d0a70c1acdd8a502ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5014846df716af2bf836625ccbeeadfd579d83ca957a13afe0d88e11429667dbdc9ff8ef87c110f32dce6e9f9f117f2863c8b645740ccbee7a93ea3a1ba435ce"} build_url:https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/QdBbKkMpR1O_ZnovATjDOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cd6f4edc2f4e3e9f6ea525b3d27405369f7357e7eb8dee052d4930aa9967af75f0213cec3ea86de08c34a0bff97e4d3bc3e1e9b1ec2a6d0a70c1acdd8a502ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5014846df716af2bf836625ccbeeadfd579d83ca957a13afe0d88e11429667dbdc9ff8ef87c110f32dce6e9f9f117f2863c8b645740ccbee7a93ea3a1ba435ce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 23:30:37.629377) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:30:37.629700) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461650278.466619-240912892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:30:37.679304) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 23:30:37.679652) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 23:30:37.679944) ========= ========= Total master_lag: 3.21 =========