builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1465201435.46 results: success (0) buildid: 20160605222917 builduid: 249ac4edb00748ec80a4e9677a872098 revision: 824355c9efe2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.461318) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.461763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.462067) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.533817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.534075) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 01:23:55-- 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% 225M=0s 2016-06-06 01:23:55 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098240 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.662480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.662778) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018835 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.734861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-06 01:23:55.735161) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 824355c9efe2 --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 824355c9efe2 --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=9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 01:23:55,951 Setting DEBUG logging. 2016-06-06 01:23:55,951 attempt 1/10 2016-06-06 01:23:55,951 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/824355c9efe2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 01:23:57,212 unpacking tar archive at: fx-team-824355c9efe2/testing/mozharness/ program finished with exit code 0 elapsedTime=2.891777 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-06 01:23:58.644259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:58.644591) ========= script_repo_revision: 824355c9efe2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:58.645123) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:58.645409) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:58.654906) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-06 01:23:58.655180) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:23:58 INFO - MultiFileLogger online at 20160606 01:23:58 in /builds/slave/test 01:23:58 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 01:23:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:23:58 INFO - {'append_to_log': False, 01:23:58 INFO - 'base_work_dir': '/builds/slave/test', 01:23:58 INFO - 'blob_upload_branch': 'Fx-Team', 01:23:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:23:58 INFO - 'branch': 'Fx-Team', 01:23:58 INFO - 'buildbot_json_path': 'buildprops.json', 01:23:58 INFO - 'config_files': ('talos/linux_config.py',), 01:23:58 INFO - 'default_actions': ('clobber', 01:23:58 INFO - 'read-buildbot-config', 01:23:58 INFO - 'download-and-extract', 01:23:58 INFO - 'populate-webroot', 01:23:58 INFO - 'create-virtualenv', 01:23:58 INFO - 'install', 01:23:58 INFO - 'run-tests'), 01:23:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:23:58 INFO - 'download_minidump_stackwalk': True, 01:23:58 INFO - 'download_symbols': 'ondemand', 01:23:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:23:58 INFO - 'tooltool.py': '/tools/tooltool.py', 01:23:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:23:58 INFO - '/tools/misc-python/virtualenv.py')}, 01:23:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:23:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:23:58 INFO - 'installer_path': 'installer.exe', 01:23:58 INFO - 'log_level': 'info', 01:23:58 INFO - 'log_name': 'talos', 01:23:58 INFO - 'log_to_console': True, 01:23:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:23:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:23:58 INFO - 'opt_config_files': (), 01:23:58 INFO - 'pip_index': False, 01:23:58 INFO - 'sps_profile': False, 01:23:58 INFO - 'sps_profile_interval': 0, 01:23:58 INFO - 'suite': 'dromaeojs', 01:23:58 INFO - 'system_bits': '32', 01:23:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:23:58 INFO - 'title': 'talos-linux64-ix-022', 01:23:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:23:58 INFO - 'use_talos_json': True, 01:23:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:23:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:23:58 INFO - 'work_dir': 'build'} 01:23:58 INFO - ##### 01:23:58 INFO - ##### Running clobber step. 01:23:58 INFO - ##### 01:23:58 INFO - Running pre-action listener: _resource_record_pre_action 01:23:58 INFO - Running main action method: clobber 01:23:58 INFO - rmtree: /builds/slave/test/build 01:23:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:23:59 INFO - Running post-action listener: _resource_record_post_action 01:23:59 INFO - ##### 01:23:59 INFO - ##### Finished clobber step (success) 01:23:59 INFO - ##### 01:23:59 INFO - ##### 01:23:59 INFO - ##### Running read-buildbot-config step. 01:23:59 INFO - ##### 01:23:59 INFO - Running pre-action listener: _resource_record_pre_action 01:23:59 INFO - Running main action method: read_buildbot_config 01:23:59 INFO - Using buildbot properties: 01:23:59 INFO - { 01:23:59 INFO - "project": "", 01:23:59 INFO - "product": "firefox", 01:23:59 INFO - "script_repo_revision": "production", 01:23:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:23:59 INFO - "repository": "", 01:23:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:23:59 INFO - "buildid": "20160605222917", 01:23:59 INFO - "pgo_build": "True", 01:23:59 INFO - "basedir": "/builds/slave/test", 01:23:59 INFO - "buildnumber": 159, 01:23:59 INFO - "slavename": "talos-linux64-ix-022", 01:23:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:23:59 INFO - "platform": "ubuntu64_hw", 01:23:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:23:59 INFO - "branch": "fx-team", 01:23:59 INFO - "repo_path": "integration/fx-team", 01:23:59 INFO - "revision": "824355c9efe2", 01:23:59 INFO - "stage_platform": "linux64-pgo", 01:23:59 INFO - "builduid": "249ac4edb00748ec80a4e9677a872098", 01:23:59 INFO - "slavebuilddir": "test" 01:23:59 INFO - } 01:23:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:23:59 INFO - Running post-action listener: _resource_record_post_action 01:23:59 INFO - ##### 01:23:59 INFO - ##### Finished read-buildbot-config step (success) 01:23:59 INFO - ##### 01:23:59 INFO - ##### 01:23:59 INFO - ##### Running download-and-extract step. 01:23:59 INFO - ##### 01:23:59 INFO - Running pre-action listener: _resource_record_pre_action 01:23:59 INFO - Running main action method: download_and_extract 01:23:59 INFO - mkdir: /builds/slave/test/build/tests 01:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:59 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:23:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:23:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:23:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:23:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:00 INFO - Downloaded 1361 bytes. 01:24:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:24:00 INFO - Using the following test package requirements: 01:24:00 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:00 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:24:00 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:24:00 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'jsshell-linux-x86_64.zip'], 01:24:00 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:24:00 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:00 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:24:00 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:24:00 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:24:00 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:24:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:00 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:24:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:01 INFO - Downloaded 24441139 bytes. 01:24:01 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'] 01:24:01 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 01:24:02 INFO - Return code: 0 01:24:02 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 01:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:02 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:24:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:03 INFO - Downloaded 24441139 bytes. 01:24: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'] 01:24: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 01:24:05 INFO - Return code: 0 01:24: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')]} 01:24:05 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:24:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:24:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:24:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:06 INFO - Downloaded 10833369 bytes. 01:24: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'] 01:24: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 01:24:06 INFO - Return code: 0 01:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:06 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:24:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:24:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:24:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:08 INFO - Downloaded 59156993 bytes. 01:24:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:24:08 INFO - mkdir: /builds/slave/test/properties 01:24:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:24:08 INFO - Writing to file /builds/slave/test/properties/build_url 01:24:08 INFO - Contents: 01:24:08 INFO - build_url:https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:24:08 INFO - Running post-action listener: _resource_record_post_action 01:24:08 INFO - Running post-action listener: set_extra_try_arguments 01:24:08 INFO - ##### 01:24:08 INFO - ##### Finished download-and-extract step (success) 01:24:08 INFO - ##### 01:24:08 INFO - ##### 01:24:08 INFO - ##### Running populate-webroot step. 01:24:08 INFO - ##### 01:24:08 INFO - Running pre-action listener: _resource_record_pre_action 01:24:08 INFO - Running main action method: populate_webroot 01:24:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:24:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:24:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:24:08 INFO - '--tppagecycles', 01:24:08 INFO - '7'], 01:24:08 INFO - 'tests': ['tsvgm']}}, 01:24:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:24:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:24:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:24:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:24:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:24:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:24:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:08 INFO - 'talos_options': ['--disable-e10s'], 01:24:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:08 INFO - 'talos_options': ['--disable-e10s'], 01:24:08 INFO - 'tests': ['damp', 'tps']}, 01:24:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:08 INFO - 'tests': ['damp', 'tps']}, 01:24:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:24:08 INFO - 'tests': ['dromaeo_dom']}, 01:24:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:24:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:24:08 INFO - 'tests': ['a11yr', 01:24:08 INFO - 'ts_paint', 01:24:08 INFO - 'tpaint', 01:24:08 INFO - 'sessionrestore', 01:24:08 INFO - 'sessionrestore_no_auto_restore', 01:24:08 INFO - 'tabpaint']}, 01:24:08 INFO - 'other-e10s': {'tests': ['a11yr', 01:24:08 INFO - 'ts_paint', 01:24:08 INFO - 'tpaint', 01:24:08 INFO - 'sessionrestore', 01:24:08 INFO - 'sessionrestore_no_auto_restore', 01:24:08 INFO - 'tabpaint']}, 01:24:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:24:08 INFO - 'ts_paint', 01:24:08 INFO - 'tpaint', 01:24:08 INFO - 'sessionrestore', 01:24:08 INFO - 'sessionrestore_no_auto_restore', 01:24:08 INFO - 'tabpaint']}, 01:24:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:24:08 INFO - 'ts_paint', 01:24:08 INFO - 'tpaint', 01:24:08 INFO - 'sessionrestore', 01:24:08 INFO - 'sessionrestore_no_auto_restore', 01:24:08 INFO - 'tabpaint']}, 01:24:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:24:08 INFO - 'tests': ['a11yr', 01:24:08 INFO - 'ts_paint', 01:24:08 INFO - 'tpaint', 01:24:08 INFO - 'sessionrestore', 01:24:08 INFO - 'sessionrestore_no_auto_restore', 01:24:08 INFO - 'tabpaint']}, 01:24:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:24:08 INFO - 'tests': ['a11yr', 01:24:08 INFO - 'ts_paint', 01:24:08 INFO - 'tpaint', 01:24:08 INFO - 'sessionrestore', 01:24:08 INFO - 'sessionrestore_no_auto_restore', 01:24:08 INFO - 'tabpaint']}, 01:24:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:24:08 INFO - 'tests': ['tsvgx', 01:24:08 INFO - 'tsvgr_opacity', 01:24:08 INFO - 'tart', 01:24:08 INFO - 'tscrollx', 01:24:08 INFO - 'cart']}, 01:24:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:24:08 INFO - 'tsvgr_opacity', 01:24:08 INFO - 'tart', 01:24:08 INFO - 'tscrollx', 01:24:08 INFO - 'cart']}, 01:24:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:08 INFO - 'talos_options': ['--disable-e10s'], 01:24:08 INFO - 'tests': ['tp5o']}, 01:24:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:08 INFO - 'tests': ['tp5o']}, 01:24:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:08 INFO - 'talos_options': ['--disable-e10s', 01:24:08 INFO - '--xperf_path', 01:24:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:08 INFO - 'tests': ['tp5n']}, 01:24:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:08 INFO - 'talos_options': ['--xperf_path', 01:24:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:08 INFO - 'tests': ['tp5n']}}, 01:24:08 INFO - 'talos.zip': {'path': '', 01:24:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:24:08 INFO - Running post-action listener: _resource_record_post_action 01:24:08 INFO - ##### 01:24:08 INFO - ##### Finished populate-webroot step (success) 01:24:08 INFO - ##### 01:24:08 INFO - ##### 01:24:08 INFO - ##### Running create-virtualenv step. 01:24:08 INFO - ##### 01:24:08 INFO - Running pre-action listener: _resource_record_pre_action 01:24:08 INFO - Running main action method: create_virtualenv 01:24:08 INFO - Creating virtualenv /builds/slave/test/build/venv 01:24:08 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 01:24:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:24:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:24:09 INFO - Using real prefix '/usr' 01:24:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:24:09 INFO - Installing distribute.............................................................................................................................................................................................done. 01:24:11 INFO - Installing pip.................done. 01:24:11 INFO - Return code: 0 01:24:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e3f19bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe460f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8050>, '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 0xe44170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe44620>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', '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 01:24:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:24:11 INFO - Using env: {'DISPLAY': ':0', 01:24:11 INFO - 'HOME': '/home/cltbld', 01:24:11 INFO - 'LANG': 'en_US.UTF-8', 01:24:11 INFO - 'LANGUAGE': 'en_US:en', 01:24:11 INFO - 'LOGNAME': 'cltbld', 01:24:11 INFO - 'MAIL': '/var/mail/cltbld', 01:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:11 INFO - 'MOZ_NO_REMOTE': '1', 01:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:11 INFO - 'NO_EM_RESTART': '1', 01:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:11 INFO - 'PWD': '/builds/slave/test', 01:24:11 INFO - 'SHELL': '/bin/bash', 01:24:11 INFO - 'SHLVL': '1', 01:24:11 INFO - 'TERM': 'linux', 01:24:11 INFO - 'TMOUT': '86400', 01:24:11 INFO - 'USER': 'cltbld', 01:24:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', 01:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:11 INFO - '_': '/tools/buildbot/bin/python'} 01:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:11 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 01:24:11 INFO - Cleaning up... 01:24:11 INFO - Return code: 0 01:24:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e3f19bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe460f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8050>, '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 0xe44170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe44620>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', '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 01:24:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:24:11 INFO - Using env: {'DISPLAY': ':0', 01:24:11 INFO - 'HOME': '/home/cltbld', 01:24:11 INFO - 'LANG': 'en_US.UTF-8', 01:24:11 INFO - 'LANGUAGE': 'en_US:en', 01:24:11 INFO - 'LOGNAME': 'cltbld', 01:24:11 INFO - 'MAIL': '/var/mail/cltbld', 01:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:11 INFO - 'MOZ_NO_REMOTE': '1', 01:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:11 INFO - 'NO_EM_RESTART': '1', 01:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:11 INFO - 'PWD': '/builds/slave/test', 01:24:11 INFO - 'SHELL': '/bin/bash', 01:24:11 INFO - 'SHLVL': '1', 01:24:11 INFO - 'TERM': 'linux', 01:24:11 INFO - 'TMOUT': '86400', 01:24:11 INFO - 'USER': 'cltbld', 01:24:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', 01:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:11 INFO - '_': '/tools/buildbot/bin/python'} 01:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:11 INFO - Downloading/unpacking psutil>=3.1.1 01:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:24:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:13 INFO - Installing collected packages: psutil 01:24:13 INFO - Running setup.py install for psutil 01:24:14 INFO - building 'psutil._psutil_linux' extension 01:24:14 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 01:24:14 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 01:24:14 INFO - building 'psutil._psutil_posix' extension 01:24:14 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 01:24:14 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 01:24:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:14 INFO - Successfully installed psutil 01:24:14 INFO - Cleaning up... 01:24:14 INFO - Return code: 0 01:24:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e3f19bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe460f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8050>, '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 0xe44170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe44620>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', '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 01:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:24:14 INFO - Using env: {'DISPLAY': ':0', 01:24:14 INFO - 'HOME': '/home/cltbld', 01:24:14 INFO - 'LANG': 'en_US.UTF-8', 01:24:14 INFO - 'LANGUAGE': 'en_US:en', 01:24:14 INFO - 'LOGNAME': 'cltbld', 01:24:14 INFO - 'MAIL': '/var/mail/cltbld', 01:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:14 INFO - 'MOZ_NO_REMOTE': '1', 01:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:14 INFO - 'NO_EM_RESTART': '1', 01:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:14 INFO - 'PWD': '/builds/slave/test', 01:24:14 INFO - 'SHELL': '/bin/bash', 01:24:14 INFO - 'SHLVL': '1', 01:24:14 INFO - 'TERM': 'linux', 01:24:14 INFO - 'TMOUT': '86400', 01:24:14 INFO - 'USER': 'cltbld', 01:24:14 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', 01:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:14 INFO - '_': '/tools/buildbot/bin/python'} 01:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:24:16 INFO - Installing collected packages: mozsystemmonitor 01:24:16 INFO - Running setup.py install for mozsystemmonitor 01:24:16 INFO - Successfully installed mozsystemmonitor 01:24:16 INFO - Cleaning up... 01:24:16 INFO - Return code: 0 01:24:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:16 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e3f19bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe460f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8050>, '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 0xe44170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe44620>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', '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 01:24:16 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==2.5.1'] in /builds/slave/test/build 01:24:16 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==2.5.1 01:24:16 INFO - Using env: {'DISPLAY': ':0', 01:24:16 INFO - 'HOME': '/home/cltbld', 01:24:16 INFO - 'LANG': 'en_US.UTF-8', 01:24:16 INFO - 'LANGUAGE': 'en_US:en', 01:24:16 INFO - 'LOGNAME': 'cltbld', 01:24:16 INFO - 'MAIL': '/var/mail/cltbld', 01:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:16 INFO - 'MOZ_NO_REMOTE': '1', 01:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:16 INFO - 'NO_EM_RESTART': '1', 01:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:16 INFO - 'PWD': '/builds/slave/test', 01:24:16 INFO - 'SHELL': '/bin/bash', 01:24:16 INFO - 'SHLVL': '1', 01:24:16 INFO - 'TERM': 'linux', 01:24:16 INFO - 'TMOUT': '86400', 01:24:16 INFO - 'USER': 'cltbld', 01:24:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', 01:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:16 INFO - '_': '/tools/buildbot/bin/python'} 01:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:17 INFO - Downloading/unpacking jsonschema==2.5.1 01:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:24:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24:19 INFO - Downloading functools32-3.2.3-2.tar.gz 01:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:24:19 INFO - warning: no files found matching '*.txt' 01:24:19 INFO - no previously-included directories found matching 'build' 01:24:19 INFO - no previously-included directories found matching 'dist' 01:24:19 INFO - no previously-included directories found matching '.git*' 01:24:19 INFO - Installing collected packages: jsonschema, functools32 01:24:19 INFO - Running setup.py install for functools32 01:24:19 INFO - warning: no files found matching '*.txt' 01:24:19 INFO - no previously-included directories found matching 'build' 01:24:19 INFO - no previously-included directories found matching 'dist' 01:24:19 INFO - no previously-included directories found matching '.git*' 01:24:19 INFO - Successfully installed jsonschema functools32 01:24:19 INFO - Cleaning up... 01:24:19 INFO - Return code: 0 01:24:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:24:19 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')]} 01:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:19 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')]} 01:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:19 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 0x7f7e3f19bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe460f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8050>, '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 0xe44170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe44620>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', '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 01:24:19 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 01:24:19 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 01:24:19 INFO - Using env: {'DISPLAY': ':0', 01:24:19 INFO - 'HOME': '/home/cltbld', 01:24:19 INFO - 'LANG': 'en_US.UTF-8', 01:24:19 INFO - 'LANGUAGE': 'en_US:en', 01:24:19 INFO - 'LOGNAME': 'cltbld', 01:24:19 INFO - 'MAIL': '/var/mail/cltbld', 01:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:19 INFO - 'MOZ_NO_REMOTE': '1', 01:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:19 INFO - 'NO_EM_RESTART': '1', 01:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:19 INFO - 'PWD': '/builds/slave/test', 01:24:19 INFO - 'SHELL': '/bin/bash', 01:24:19 INFO - 'SHLVL': '1', 01:24:19 INFO - 'TERM': 'linux', 01:24:19 INFO - 'TMOUT': '86400', 01:24:19 INFO - 'USER': 'cltbld', 01:24:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', 01:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:19 INFO - '_': '/tools/buildbot/bin/python'} 01:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:19 INFO - Downloading/unpacking blobuploader==1.2.4 01:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:21 INFO - Downloading blobuploader-1.2.4.tar.gz 01:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:24:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:24:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:22 INFO - Downloading docopt-0.6.1.tar.gz 01:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:24:22 INFO - Installing collected packages: blobuploader, requests, docopt 01:24:22 INFO - Running setup.py install for blobuploader 01:24:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:24:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:24:22 INFO - Running setup.py install for requests 01:24:22 INFO - Running setup.py install for docopt 01:24:22 INFO - Successfully installed blobuploader requests docopt 01:24:22 INFO - Cleaning up... 01:24:22 INFO - Return code: 0 01:24:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24: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')]} 01:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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')]} 01:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:22 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 0x7f7e3f19bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe460f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8050>, '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 0xe44170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe44620>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', '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 01:24:22 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 01:24:22 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 01:24:22 INFO - Using env: {'DISPLAY': ':0', 01:24:22 INFO - 'HOME': '/home/cltbld', 01:24:22 INFO - 'LANG': 'en_US.UTF-8', 01:24:22 INFO - 'LANGUAGE': 'en_US:en', 01:24:22 INFO - 'LOGNAME': 'cltbld', 01:24:22 INFO - 'MAIL': '/var/mail/cltbld', 01:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:22 INFO - 'MOZ_NO_REMOTE': '1', 01:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:22 INFO - 'NO_EM_RESTART': '1', 01:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:22 INFO - 'PWD': '/builds/slave/test', 01:24:22 INFO - 'SHELL': '/bin/bash', 01:24:22 INFO - 'SHLVL': '1', 01:24:22 INFO - 'TERM': 'linux', 01:24:22 INFO - 'TMOUT': '86400', 01:24:22 INFO - 'USER': 'cltbld', 01:24:22 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', 01:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:22 INFO - '_': '/tools/buildbot/bin/python'} 01:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:23 INFO - Running setup.py (path:/tmp/pip-aFFqzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:23 INFO - Running setup.py (path:/tmp/pip-mnq_0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:23 INFO - Running setup.py (path:/tmp/pip-Hj7UHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:23 INFO - Running setup.py (path:/tmp/pip-5T2wt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:23 INFO - Running setup.py (path:/tmp/pip-RJB31x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:23 INFO - Running setup.py (path:/tmp/pip-mng2Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:23 INFO - Running setup.py (path:/tmp/pip-Gc4GFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:23 INFO - Running setup.py (path:/tmp/pip-nMvMsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:23 INFO - Running setup.py (path:/tmp/pip-QDp0dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:23 INFO - Running setup.py (path:/tmp/pip-xEG7CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:23 INFO - Running setup.py (path:/tmp/pip-dEPc54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:23 INFO - Running setup.py (path:/tmp/pip-kHoiEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:24 INFO - Running setup.py (path:/tmp/pip-a9hUUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:24 INFO - Running setup.py (path:/tmp/pip-efA2_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:24 INFO - Running setup.py (path:/tmp/pip-8Cpekt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:24 INFO - Running setup.py (path:/tmp/pip-KCv8L_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:24 INFO - Running setup.py (path:/tmp/pip-Jqyjkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:24:24 INFO - Running setup.py install for manifestparser 01:24:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:24:24 INFO - Running setup.py install for mozcrash 01:24:24 INFO - Running setup.py install for mozdebug 01:24:24 INFO - Running setup.py install for mozdevice 01:24:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:24:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:24:24 INFO - Running setup.py install for mozfile 01:24:24 INFO - Running setup.py install for mozhttpd 01:24:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:24:24 INFO - Running setup.py install for mozinfo 01:24:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:24:25 INFO - Running setup.py install for mozInstall 01:24:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:24:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:24:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:24:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:24:25 INFO - Running setup.py install for mozleak 01:24:25 INFO - Running setup.py install for mozlog 01:24:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:24:25 INFO - Running setup.py install for moznetwork 01:24:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:24:25 INFO - Running setup.py install for mozprocess 01:24:25 INFO - Running setup.py install for mozprofile 01:24:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:24:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:24:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:24:25 INFO - Running setup.py install for mozrunner 01:24:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:24:25 INFO - Running setup.py install for mozscreenshot 01:24:25 INFO - Running setup.py install for moztest 01:24:26 INFO - Running setup.py install for mozversion 01:24:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:24:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:24:26 INFO - Cleaning up... 01:24:26 INFO - Return code: 0 01:24:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24: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')]} 01:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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')]} 01:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:26 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 0x7f7e3f19bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe460f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8050>, '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 0xe44170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe44620>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', '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 01:24:26 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 01:24:26 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 01:24:26 INFO - Using env: {'DISPLAY': ':0', 01:24:26 INFO - 'HOME': '/home/cltbld', 01:24:26 INFO - 'LANG': 'en_US.UTF-8', 01:24:26 INFO - 'LANGUAGE': 'en_US:en', 01:24:26 INFO - 'LOGNAME': 'cltbld', 01:24:26 INFO - 'MAIL': '/var/mail/cltbld', 01:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:26 INFO - 'MOZ_NO_REMOTE': '1', 01:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:26 INFO - 'NO_EM_RESTART': '1', 01:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:26 INFO - 'PWD': '/builds/slave/test', 01:24:26 INFO - 'SHELL': '/bin/bash', 01:24:26 INFO - 'SHLVL': '1', 01:24:26 INFO - 'TERM': 'linux', 01:24:26 INFO - 'TMOUT': '86400', 01:24:26 INFO - 'USER': 'cltbld', 01:24:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', 01:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:26 INFO - '_': '/tools/buildbot/bin/python'} 01:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:26 INFO - Running setup.py (path:/tmp/pip-48EgZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:26 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)) 01:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:26 INFO - Running setup.py (path:/tmp/pip-bg7bKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:26 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)) 01:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:26 INFO - Running setup.py (path:/tmp/pip-nrkRen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:26 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)) 01:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:26 INFO - Running setup.py (path:/tmp/pip-TLwit_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:26 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)) 01:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:26 INFO - Running setup.py (path:/tmp/pip-Elrfnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:26 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)) 01:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:26 INFO - Running setup.py (path:/tmp/pip-fGPkzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:26 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)) 01:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:26 INFO - Running setup.py (path:/tmp/pip-_Xi6t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:26 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)) 01:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:26 INFO - Running setup.py (path:/tmp/pip-2ANWbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:26 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)) 01:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:26 INFO - Running setup.py (path:/tmp/pip-Rfi7ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:27 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)) 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:27 INFO - Running setup.py (path:/tmp/pip-2j92_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:27 INFO - Running setup.py (path:/tmp/pip-70Pu78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:27 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)) 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:27 INFO - Running setup.py (path:/tmp/pip-58nyUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:27 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)) 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:27 INFO - Running setup.py (path:/tmp/pip-jwVnFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:27 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)) 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:27 INFO - Running setup.py (path:/tmp/pip-PPZCGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:27 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)) 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:27 INFO - Running setup.py (path:/tmp/pip-53w1eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:27 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)) 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:27 INFO - Running setup.py (path:/tmp/pip-XoJ1Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:27 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)) 01:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:27 INFO - Running setup.py (path:/tmp/pip-2ZrjYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:27 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)) 01:24:27 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)) 01:24:27 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)) 01:24:27 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)) 01:24:27 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)) 01:24:27 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)) 01:24:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:29 INFO - Downloading blessings-1.6.tar.gz 01:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:24:29 INFO - Installing collected packages: blessings 01:24:29 INFO - Running setup.py install for blessings 01:24:29 INFO - Successfully installed blessings 01:24:29 INFO - Cleaning up... 01:24:29 INFO - Return code: 0 01:24:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:29 INFO - Reading from file tmpfile_stdout 01:24:29 INFO - Current package versions: 01:24:29 INFO - argparse == 1.2.1 01:24:29 INFO - blessings == 1.6 01:24:29 INFO - blobuploader == 1.2.4 01:24:29 INFO - docopt == 0.6.1 01:24:29 INFO - functools32 == 3.2.3-2 01:24:29 INFO - jsonschema == 2.5.1 01:24:29 INFO - manifestparser == 1.1 01:24:29 INFO - mozInstall == 1.12 01:24:29 INFO - mozcrash == 0.17 01:24:29 INFO - mozdebug == 0.1 01:24:29 INFO - mozdevice == 0.48 01:24:29 INFO - mozfile == 1.2 01:24:29 INFO - mozhttpd == 0.7 01:24:29 INFO - mozinfo == 0.9 01:24:29 INFO - mozleak == 0.1 01:24:29 INFO - mozlog == 3.2 01:24:29 INFO - moznetwork == 0.27 01:24:29 INFO - mozprocess == 0.22 01:24:29 INFO - mozprofile == 0.28 01:24:29 INFO - mozrunner == 6.11 01:24:29 INFO - mozscreenshot == 0.1 01:24:29 INFO - mozsystemmonitor == 0.3 01:24:29 INFO - moztest == 0.7 01:24:29 INFO - mozversion == 1.4 01:24:29 INFO - psutil == 3.1.1 01:24:29 INFO - requests == 1.2.3 01:24:29 INFO - wsgiref == 0.1.2 01:24:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24: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')]} 01:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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')]} 01:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:29 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 0x7f7e3f19bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe460f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8050>, '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 0xe44170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe44620>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', '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 01:24:29 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 01:24:29 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 01:24:29 INFO - Using env: {'DISPLAY': ':0', 01:24:29 INFO - 'HOME': '/home/cltbld', 01:24:29 INFO - 'LANG': 'en_US.UTF-8', 01:24:29 INFO - 'LANGUAGE': 'en_US:en', 01:24:29 INFO - 'LOGNAME': 'cltbld', 01:24:29 INFO - 'MAIL': '/var/mail/cltbld', 01:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:29 INFO - 'MOZ_NO_REMOTE': '1', 01:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:29 INFO - 'NO_EM_RESTART': '1', 01:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:29 INFO - 'PWD': '/builds/slave/test', 01:24:29 INFO - 'SHELL': '/bin/bash', 01:24:29 INFO - 'SHLVL': '1', 01:24:29 INFO - 'TERM': 'linux', 01:24:29 INFO - 'TMOUT': '86400', 01:24:29 INFO - 'USER': 'cltbld', 01:24:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', 01:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:29 INFO - '_': '/tools/buildbot/bin/python'} 01:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:30 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)) 01:24:30 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)) 01:24:30 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)) 01:24:30 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)) 01:24:30 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)) 01:24:30 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)) 01:24:30 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)) 01:24:30 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)) 01:24:30 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)) 01:24:30 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)) 01:24:30 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)) 01:24:30 INFO - Cleaning up... 01:24:30 INFO - Return code: 0 01:24:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:24:30 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')]} 01:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:30 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')]} 01:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:30 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 0x7f7e3f19bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe460f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8050>, '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 0xe44170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe44620>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', '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 01:24:30 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 01:24:30 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 01:24:30 INFO - Using env: {'DISPLAY': ':0', 01:24:30 INFO - 'HOME': '/home/cltbld', 01:24:30 INFO - 'LANG': 'en_US.UTF-8', 01:24:30 INFO - 'LANGUAGE': 'en_US:en', 01:24:30 INFO - 'LOGNAME': 'cltbld', 01:24:30 INFO - 'MAIL': '/var/mail/cltbld', 01:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:30 INFO - 'MOZ_NO_REMOTE': '1', 01:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:30 INFO - 'NO_EM_RESTART': '1', 01:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:30 INFO - 'PWD': '/builds/slave/test', 01:24:30 INFO - 'SHELL': '/bin/bash', 01:24:30 INFO - 'SHLVL': '1', 01:24:30 INFO - 'TERM': 'linux', 01:24:30 INFO - 'TMOUT': '86400', 01:24:30 INFO - 'USER': 'cltbld', 01:24:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', 01:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:30 INFO - '_': '/tools/buildbot/bin/python'} 01:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:24:30 INFO - Cleaning up... 01:24:30 INFO - Return code: 0 01:24:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:24:30 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')]} 01:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:30 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')]} 01:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:30 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 0x7f7e3f19bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe460f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8050>, '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 0xe44170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe44620>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', '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 01:24:30 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 01:24:30 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 01:24:30 INFO - Using env: {'DISPLAY': ':0', 01:24:30 INFO - 'HOME': '/home/cltbld', 01:24:30 INFO - 'LANG': 'en_US.UTF-8', 01:24:30 INFO - 'LANGUAGE': 'en_US:en', 01:24:30 INFO - 'LOGNAME': 'cltbld', 01:24:30 INFO - 'MAIL': '/var/mail/cltbld', 01:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:30 INFO - 'MOZ_NO_REMOTE': '1', 01:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:30 INFO - 'NO_EM_RESTART': '1', 01:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:30 INFO - 'PWD': '/builds/slave/test', 01:24:30 INFO - 'SHELL': '/bin/bash', 01:24:30 INFO - 'SHLVL': '1', 01:24:30 INFO - 'TERM': 'linux', 01:24:30 INFO - 'TMOUT': '86400', 01:24:30 INFO - 'USER': 'cltbld', 01:24:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', 01:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:30 INFO - '_': '/tools/buildbot/bin/python'} 01:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:30 INFO - Downloading/unpacking flake8 01:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:24:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:24:32 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 01:24:32 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 01:24:32 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 01:24:32 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 01:24:32 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 01:24:32 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 01:24:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:24:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:24:32 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 01:24:32 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 01:24:32 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 01:24:32 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 01:24:32 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 01:24:32 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 01:24:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:24:32 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 01:24:32 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 01:24:32 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 01:24:32 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 01:24:32 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 01:24:32 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 01:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:24:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:24:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:24:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:24:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:24:33 INFO - no previously-included directories found matching 'docs/_build' 01:24:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:24:33 INFO - Running setup.py install for pep8 01:24:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:24:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:24:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:24:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:24:33 INFO - no previously-included directories found matching 'docs/_build' 01:24:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:24:33 INFO - Cleaning up... 01:24:33 INFO - Return code: 0 01:24:33 INFO - Running post-action listener: _resource_record_post_action 01:24:33 INFO - Running post-action listener: _start_resource_monitoring 01:24:33 INFO - Starting resource monitoring. 01:24:33 INFO - ##### 01:24:33 INFO - ##### Finished create-virtualenv step (success) 01:24:33 INFO - ##### 01:24:33 INFO - ##### 01:24:33 INFO - ##### Running install step. 01:24:33 INFO - ##### 01:24:33 INFO - Running pre-action listener: _resource_record_pre_action 01:24:33 INFO - Running main action method: install 01:24:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:33 INFO - Reading from file tmpfile_stdout 01:24:33 INFO - Detecting whether we're running mozinstall >=1.0... 01:24:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:24:33 INFO - Reading from file tmpfile_stdout 01:24:33 INFO - Output received: 01:24:33 INFO - Usage: mozinstall [options] installer 01:24:33 INFO - Options: 01:24:33 INFO - -h, --help show this help message and exit 01:24:33 INFO - -d DEST, --destination=DEST 01:24:33 INFO - Directory to install application into. [default: 01:24:33 INFO - "/builds/slave/test"] 01:24:33 INFO - --app=APP Application being installed. [default: firefox] 01:24:33 INFO - mkdir: /builds/slave/test/build/application 01:24:33 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'] 01:24:33 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 01:24:50 INFO - Reading from file tmpfile_stdout 01:24:50 INFO - Output received: 01:24:50 INFO - /builds/slave/test/build/application/firefox/firefox 01:24:50 INFO - Running post-action listener: _resource_record_post_action 01:24:50 INFO - ##### 01:24:50 INFO - ##### Finished install step (success) 01:24:50 INFO - ##### 01:24:50 INFO - ##### 01:24:50 INFO - ##### Running run-tests step. 01:24:50 INFO - ##### 01:24:50 INFO - Running pre-action listener: _resource_record_pre_action 01:24:50 INFO - Running main action method: run_tests 01:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:24:50 INFO - Python 2.7.3 01:24:50 INFO - Return code: 0 01:24:50 INFO - grabbing minidump binary from tooltool 01:24:50 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')]} 01:24:50 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8050>, '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 0xe44170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe44620>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:24:50 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 01:24:50 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 01:24:50 INFO - Calling ['/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'] with output_timeout 600 01:24:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:24:50 INFO - Return code: 0 01:24:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:24:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:24:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:24:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:24:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:24:51 INFO - Return code: 0 01:24:51 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/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 01:24:51 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/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 01:24:51 INFO - Using env: {'DISPLAY': ':0', 01:24:51 INFO - 'HOME': '/home/cltbld', 01:24:51 INFO - 'LANG': 'en_US.UTF-8', 01:24:51 INFO - 'LANGUAGE': 'en_US:en', 01:24:51 INFO - 'LOGNAME': 'cltbld', 01:24:51 INFO - 'MAIL': '/var/mail/cltbld', 01:24:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:24:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:51 INFO - 'MOZ_NO_REMOTE': '1', 01:24:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:51 INFO - 'NO_EM_RESTART': '1', 01:24:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:51 INFO - 'PWD': '/builds/slave/test', 01:24:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:24:51 INFO - 'SHELL': '/bin/bash', 01:24:51 INFO - 'SHLVL': '1', 01:24:51 INFO - 'TERM': 'linux', 01:24:51 INFO - 'TMOUT': '86400', 01:24:51 INFO - 'USER': 'cltbld', 01:24:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380', 01:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:51 INFO - '_': '/tools/buildbot/bin/python'} 01:24:51 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/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 01:24:51 INFO - mozversion application_buildid: 20160605222917 01:24:51 INFO - mozversion application_changeset: 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 01:24:51 INFO - mozversion application_display_name: Nightly 01:24:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:24:51 INFO - mozversion application_name: Firefox 01:24:51 INFO - mozversion application_remotingname: firefox 01:24:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:24:51 INFO - mozversion application_vendor: Mozilla 01:24:51 INFO - mozversion application_version: 49.0a1 01:24:51 INFO - mozversion platform_buildid: 20160605222917 01:24:51 INFO - mozversion platform_changeset: 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 01:24:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:24:51 INFO - mozversion platform_version: 49.0a1 01:24:51 INFO - using testdate: 1465201491 01:24:51 INFO - actual date: 1465201491 01:24:51 INFO - starting webserver on 'localhost:43768' 01:24:51 INFO - SUITE-START | Running 2 tests 01:24:51 INFO - TEST-START | dromaeo_css 01:24:51 INFO - operating with platform_type : linux_ 01:24:51 INFO - Initialising browser for dromaeo_css test... 01:24:51 INFO - TEST-INFO | started process 15985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwfdDM7/profile http://localhost:43768/getInfo.html) 01:24:55 INFO - PROCESS | 15985 | __metrics Screen width/height:1600/1200 01:24:55 INFO - PROCESS | 15985 | colorDepth:24 01:24:55 INFO - PROCESS | 15985 | Browser inner width/height: 1024/697 01:24:55 INFO - PROCESS | 15985 | __metrics 01:24:56 ERROR - PROCESS | 15985 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:24:57 INFO - TEST-INFO | 15985: exit 0 01:24:57 INFO - Browser initialized. 01:24:57 INFO - Running cycle 1/1 for dromaeo_css test... 01:24:57 INFO - TEST-INFO | started process 16066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwfdDM7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:25:09 INFO - PROCESS | 16066 | RSS: Main: 156475392 01:25:09 INFO - PROCESS | 16066 | 01:26:00 INFO - PROCESS | 16066 | 1465201560515 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] 01:28:08 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:43768/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43768/tests/dromaeo/cssquery-ext.html) 01:28:09 INFO - PROCESS | 16066 | RSS: Main: 260485120 01:28:09 INFO - PROCESS | 16066 | 01:31:11 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:43768/tests/dromaeo/cssquery-ext.html (next: http://localhost:43768/tests/dromaeo/cssquery-jquery.html) 01:31:12 INFO - PROCESS | 16066 | RSS: Main: 244805632 01:31:12 INFO - PROCESS | 16066 | 01:34:14 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:43768/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43768/tests/dromaeo/cssquery-mootools.html) 01:34:15 INFO - PROCESS | 16066 | RSS: Main: 239607808 01:34:15 INFO - PROCESS | 16066 | 01:37:17 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:43768/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43768/tests/dromaeo/cssquery-prototype.html) 01:37:17 INFO - PROCESS | 16066 | RSS: Main: 244031488 01:37:17 INFO - PROCESS | 16066 | 01:40:20 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:43768/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43768/tests/dromaeo/cssquery-yui.html) 01:40:21 INFO - PROCESS | 16066 | RSS: Main: 206774272 01:40:21 INFO - PROCESS | 16066 | 01:43:24 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:43768/tests/dromaeo/cssquery-yui.html (next: http://localhost:43768/tests/dromaeo/cssquery-dojo.html) 01:43:24 INFO - PROCESS | 16066 | RSS: Main: 275808256 01:43:24 INFO - PROCESS | 16066 | 01:43:24 INFO - PROCESS | 16066 | __start_tp_report 01:43:24 INFO - PROCESS | 16066 | _x_x_mozilla_page_load 01:43:24 INFO - PROCESS | 16066 | _x_x_mozilla_page_load_details 01:43:24 INFO - PROCESS | 16066 | |i|pagename|runs| 01:43:24 INFO - PROCESS | 16066 | |0;dojo.html;3079.4610943084963;3080.8151510909333;3086.6913308669136;3104.9379012419754;3105.549695294184;5256.185291279858;5288.259643649887;5341.946580534193;5354.250404943311;5371.006363822696;5324.54741346986;5324.946750532494;5437.34751829781;5456.345238571377;5492.203630473579;4765.8570242892765;4839.637027222972;4858.635602329822;4863.076015557051;5058.038972595214;4965.875853103666;4982.626303027269;5022.924656130161;5029.547340739351;5035.043341765071;4789.592884604813;4810;4836.37127173467;4881.8779530511665;4891.5353041461;4881.267809828519;4899.118158731427;4967.3294105296045;4971.552560269593;5022.874428139289;4781.760911954389;4930.80276788928;4940.530649588283;4942.159832828428;4966.5778408835295;5239.266502689627;5322.175062865262;5333.49331813481;5373.785048598091;5410.810621628224;5841.678707671076;5855.4144585541535;5861.150133230701;5869.471747542699;5872.853178670567;5661.46216109469;5741.540676745851;5751.654900705971;5799.3620701722775;5852.619579727304;5454.727263636882;5480.506754392084;5486.039943009957;5500.1749737539685;5500.642458240201;5985.820425387158;6004.639721616717;6010.218671572755;6015.54883383748;6022.247219097613;5506.229127922014;5616.297962754656;5644.57665675076;5664.49019588239;5762.1068734346245;5779.624324418899;5829.88340233193;5836.241288632451;5838.591298609056;5840.941590584125;5756.30924289088;5769.6538207706835;5771.0477771168125;5771.942280577225;5772.826815195551;5583.832485025456;5791.276090488689;5812.360640329561;5849.707514624251;5865.618734782225;4414.911701765946;4418.2047231498;4421.182081314967;4422.380866678667;4463.799129039201;3836.961630383716;3927.0771368728324;3951.249262640089;3969.3649016157856;3980.24375368679;5523.502884740312;5575.804846830422;5578.219049333096;5582.91625625616;5607.66354018752;5902.527797776168;5903.527717782567;5906.49794767441;5918.348981612019;5962.791302304486;5326.573874090141;5453.672779633234;5592.748326325325;5600.467955544217;5602.215689803431;4990.850274491771;5017.37282839645;5032.396112466454;5039.294498770175;5062.038212739568;5999.490043346277;6011.368806275365;6011.428914253139;6012.338642749294;6014.849628759229;5613.831585052455;5736.4550367715;5799.956007918615;5819.098039803837;5858.297004359504;5941.821745347646;5993.910091348546;5994.970025150021;6027.879442411039;6037.728302226323;5674.319081710221;5697.715114244188;5722.055860782924;5722.113072473773;5727.914081288701;5683.943160568507;5753.367129615655;5817.534597232296;5818.185454036354;5828.125781132864;5747.51146152565;5751.511121554715;5752.568557358131;5754.108113242454;5786.9131963019745;5649.491545760901;5679.886402271849;5715.8571035724435;5717.285339332583;5727.570432217683;5432.56539476833;5531.612787104864;5579.079451890392;5605.691686957257;5627.240322556566;5766.192733017297;5768.625039372428;5799.391063938226;5813.476787089182;5816.41835816415;5595.440455954372;5630.634008789416;5632.408597097409;5643.068893632505;5664.688442135557 01:43:24 INFO - PROCESS | 16066 | |1;ext.html;594.4501336263954;612.2224774536339;626.3016736338981;642.5052709413751;646.1696719715167;30081.24796880079;30973.22566935828;33608.15979600505;33647.66352336476;33683.32633347331;41338.17323653525;42127.36808947861;42155.78922105385;45621.85945351368;45627.315590266175;8736.956315218415;8946.64213431462;8948.64205431782;8948.910510894873;8951;8708.17272359125;8848.867266991001;8851.070637583058;8852.8672069919;8859.689910853122;8807.779805504882;8863.822723545525;8863.95568022159;8865.202131808135;8872.245859101984;8824.911750882473;8877.245434138105;8878;8885.289176865868;8889.111088891124;8771.517566533837;8832.558372081434;8859.202671759573;8865.822683546294;8878.511681857495;39876.60123398758;40022.199556008716;40099.19801603952;40155.39766903499;40157.79921100405;3492.9650703492894;3561.3767590671787;3617.5478065241846;3638.8362523686233;3672.706183505313;31303.53044704331;31414.371712565848;31483.212919677193;31866.522002169753;32988.84539041122;4099.877003689894;4167.416561681367;4208.642265407413;4258.212230737324;4371.956280437187;329860;331904;332075.33962330275;332273;332340;56466.15300770492;56627.43372566304;56955.43700533486;56981.71509142428;56985;48368.27447588289;49276.75361623169;49383.50616493861;54197.45802542003;57174.42825571774;15455.149966751937;15535.145566993924;15645.217739112999;15653.452129175424;15682.451114211177;12097.153199275966;12276.447559859827;12285.1400401971;12306.692332691575;12307.4461649226;14074.648133796736;15093;15312.617184570252;15538.300776465087;15955.840441595436;5927.496162826122;5928.940710592925;5950.553708471795;5951.5238780897425;6052.54605904559;997.910188083076;1060.9310394824465;1074.2265568790458;1095.5453486802887;1111.127764704703;31676;31728.841355793073;31752.206194845312;31824.84087579547;31890.681093189236;1143.4797167288864;1147.4205526209212;1173.5423184957874;1185.3599056509388;1225.332193954297;16750.74873876893;16819.91590042042;16881.40915067967;16908.661826763397;16988.49034528966;477171;478873;478974;479968;480027;55077.72461137669;56050.43949560534;56054.71972640192;56145.999999999185;56258;1248.7689777391213;1350.8311461067367;1396.322783450026;1402.1657114017144;1405.6556143744847;31092.689073109883;32841.50737738983;32877.34245315128;32961.79376312164;33431.49852752162;48270.27594586154;48748.5125148744;48861.75569122132;48926;49001.754991224814;406624;418091;418174;418518;418914;34460.13849653779;38527.807360963016;39275.803620981715;40281.395779063925;42441.575584243765;45537.31694024526;46213;46294.30558541692;46446.53553464422;47051.52948470609;38375.61624383832;39430.60569394269;40079;40128.1974360517;40522.59477405188;39056.21887562289;39406;39890;39956.40283381571;40067.198656026136;39509.80245098756;39534.80232598819;39855.601443985186;40037.39943900786;40521;34214.486782698776;35132.473012905335;35979.64020359763;36167.81916090403;36171;27500.724992749816;27842.16473505798;27905.44189116247;27962.44075118527;28032.719672803825 01:43:24 INFO - PROCESS | 16066 | |2;jquery.html;393.4786408009388;394.9427333036708;396.6965271567253;396.9325214713499;407.03938704657;14080.436782528712;15957.361705531794;17783;19281.421557353267;19401.708974365378;14613.123212607225;15015.249237538106;17513.47459576215;17683.204255808487;18100;5469.644473109235;5600.131979543157;5645.2096706461125;5651.886962260753;5656.095024796034;5328.573714102882;5448.509634132927;5475.151351540518;5496.395396506381;5505.614606977493;4033.5764744701823;5884.941150588504;6249.2813326467585;6255.843603909916;6257.342978987209;6119.571629985903;6139.201903752506;6153.907691384633;6240.843978900519;6260.15487909131;5474.644148130359;5569.470900264469;5611.8877622447735;5614;5614.719264036823;22029.228976985727;22445.775542244533;23166.53666926669;23223.767762322328;23253.302400927998;2340.754220806825;2368.928932132039;2481.3424442522746;2500.0749722602573;2636.762691357768;14980.932722247508;15167.62080947974;15193.6201594961;15663.765043524356;16001.279942402503;2014.717939488473;2014.8589598728095;2034.4201902457876;2040.5816807554563;2220.9000594973263;91101;94640.52679736626;95636;96054.51972740161;96439;16231.594210144605;17480.91259543694;17590.91204543969;17595.384161554284;17619;31044.22389440237;31243;31284.53073203904;31325.530117048263;31379.215519611735;8527.74416767498;9047.90952090484;9366.531673416439;9578.56896439662;9801.656942006995;7900.328472079823;7916.722914697958;7962.08436029864;8003.319717823933;8036.879446808302;8588.613512391958;8780.78048048804;8795.472271663593;8820.77948051291;8996;3421.8194722820585;3514.683678468899;3519.1729943463265;3567.3757092509227;3570.178858862424;931.5202670624499;1021.7088129882948;1032.767627283855;1032.9431881246603;1074.4896174317137;18395.983011153872;18758.624827503372;18781.0609469526;18813;19180;984.5569493727708;1038.5015192707392;1040.4705083527203;1051.6371851711147;1087.2063393722626;10096.293259471766;10438.582456701799;10445.68662940113;10507.684769456928;10551.314164579278;481969;515064;515215;520062.5956183107;525911;94304;100270;100917;102149;102573.48713256385;1008.702432782331;1048.826943554305;1069.727219559023;1084.7830433913248;1087.6410784441116;16488.83511164873;16630.669546436497;16778.24497897573;16830.495085147464;16900.239489222768;42117.78941105275;43441.48377743364;43705.56294437015;45361.319580205665;45458.09083818239;59861.70069149626;60035.39964600298;60668.39331606627;60701.39298606957;62263;8206.343492520704;8234.341252699889;8362.414630975773;8387.329013679013;8456.704015359433;12081.818772718241;12636.747265054832;13100.672483187996;13163.60509184726;13203.273819939996;11409.714757131138;11420.257683250562;11568.595099171489;11659.407839533453;11814.881851181723;11218;11400.71498212518;11527.538898444303;11541.711457213636;11591.478383472595;11486;11500.079993600659;11643.650690479299;11649.359285239394;11775.823362649397;8303.169683031649;8316.708915187939;8318.792030199293;8331.583420829056;8512.531810750468;10489.527971241465;10812.405317707602;10962.177836662442;11021.779564408507;11041.171912106463 01:43:24 INFO - PROCESS | 16066 | |3;mootools.html;1298.649364671538;1407.7817938219575;1476.0258229568483;1572.7065112243574;1772.3442326339248;8198.344132469403;8542.572871356431;8544.615492302846;8785.912140878589;8809.427387219826;8518.787030324245;8714.128587141282;8718.302535797136;8735.91264087359;8754.3871928965;2306.181305636496;2328.8020518255967;2332.4402143485613;2334.031376978552;2335.100986120339;2288.1533832482005;2329.534093181362;2354.5173239485866;2363.3737059679197;2364.101641376283;2341.6019276722914;2343.1447521654645;2366.9053237870467;2373.181252467896;2378.965150159686;2196.4442318424567;2212.7455342635562;2226.922057727988;2228.665700144975;2252.3918541993735;2237.5455953630108;2241.1483636218295;2243.4727838957833;2245.3937436891947;2247.685324054634;8027.598620069031;8191.017077950624;8559.914400855974;8608.440451370641;8624.65501379944;5070.783012077111;5236.502532259467;5238.68567885928;5238.895222095537;5241.31862857826;3216.694414030663;3246.4318744219904;3262.151840521458;3285.671432856719;3290.8683652653867;1041.271110222847;1042.5985995391752;1047.8271085270922;1061.47987486132;1070.0797314309686;12179.451924663323;12186;12224.572139975147;12258.387080645844;12266.448009839578;4433.423654924839;4461.263891457873;4540.977295113569;4569.520200378913;4575.725456472623;9666.323357364918;9678.854817177747;9680.951595241979;9682.370645907993;9687.467189304656;5119.6416250862085;5120.206368012964;5121.231815227746;5124.077666020152;5128.205128205134;4262.147570485915;4460.330950357472;4542.704724192917;4579.22153233951;4687.578117969331;3839.1937693084205;3839.865604703878;3927.626875446828;3957.168994511185;3966.8809935701975;1132.767782604564;1134.3364131982717;1141.3551343490901;1145.9656210313703;1160.3733983648735;777.6034222546542;966.1304825656824;1000.0849222961054;1000.6947880896397;1009.3287963504188;5909;5932.762689492458;5943.071317852567;6008.549358798107;6199.752009919643;476.81642567611027;477.6489280378919;480.8773762690561;494.06868053719;666.9333066693292;3920.9019774505296;4090.5909409058854;4140.0891803803115;4180.979095104566;4212.810423530948;10668.466576671135;10965.177611678997;11086.390248536247;11086.667399978014;11101.611443599435;10811.567537298577;10920;10923.945380273048;10945.507452164671;10954.56181752721;7625.1231108422135;7962.761117166494;7975.7607271781935;8179.182081791773;8186.754397367969;5978.372270911492;6081.01749815507;6175.44421002112;6291.307956124914;6359.96820015897;9952.502374881371;10056.69829905104;10125.848112278469;10245.795084098425;10341.793164136525;10331.431771252654;10430.322029068086;10461.110805581306;10461.529231184768;10464.267501274837;6648.268690444144;6957.022561169512;7463.962680186564;7655.846883062419;7780.183080776437;8216.46592971455;8288.21261980111;8296.170382961656;8311.709090181814;8322.334213263046;7105.928940710527;7362.9631851840395;7398.038255026812;7446.441516886147;7572.659230334538;7156.534825236343;7165.319294666998;7193.640317984185;7292.854142917218;7301.561906285639;6845.4865885057825;6983.266756990442;6990.335918087773;6999.0551275577145;7000.824979375557;4898.951010489849;4914.410270767531;4923.803047878045;4938.604911607134;4996.200607902718;4748.477667456508;4789.664723469324;4824.372831531879;4865.1242776300605;4941.33292005589 01:43:24 INFO - PROCESS | 16066 | |4;prototype.html;321.6895695653694;324.9333886553257;328.25649902969775;337.0780914199662;340.74614412262883;5322.361316642004;5401.378841433237;5417.972910135444;5423.620346575742;5446.700431476267;5329.680219186852;5337.572994160468;5390.434004429537;5403.162509810976;5406.432324605918;3955.1101002274545;4008.0581063450068;4124.484439445069;4138.8965275868195;4191.476065491814;4065.410515475254;4123.97938010311;4127.772972486512;4164.458620379346;4187.560306167854;3927.0378757204526;4078.8572399966006;4098.303288440972;4107.650849677781;4125.9174816503655;3830.291396091704;3994.320965435883;4000.159966407058;4116.423700681907;4146.357314616239;3681.9815900920325;3705.962940370589;3712.3874560697454;3726.142987112979;3730.8321125549414;5154.20109882965;5166.793328266865;5176.844694659167;5178.40448348441;5180.274761533388;4557.263044303672;4748.881277968044;4759.214729569617;4771;4775.188218002948;5434.2935418395755;5492.697901615409;5503.862403439906;5519.889602207973;5573.637713548606;4029.657479114279;4046.190761847642;4048.858289959867;4075.572064933169;4081.510218773766;5554.055810512223;5741.224934633813;5749.367569567386;5754.367019627837;5761.078227483625;4151.211269858717;4170.708050436501;4174.770387628649;4193.266178418765;4197.202531519001;4269.807858646368;4278.422412974209;4301.419308393327;4304.418903448057;4307.138572285556;4545.795439205178;4765.880852978703;4769.713817170981;4784.492884741296;4834.613230941516;5561.888762224733;5573.600103936596;5576.219329293902;5594.300712410949;5597.949117730846;1460.1677044084981;1478.8595083467053;1479.807625008742;1482.5033613739517;1484.1021182184838;913.6939125393068;916.7295647783919;950.021477877787;959.4243453927587;967.5355829202023;5183.403908550489;5426.8914621707345;5428.348598168166;5430.506610682015;5458.208559758892;5702.287214098238;5710.2869139258055;5733.913991290134;5754.769809207669;5758.337791154071;5268.394134674485;5300.867478313073;5364.678119312854;5435.809746658848;5458.317710286215;2976.895808646687;2995.4009198160456;3031.8484075796123;3036.69633036699;3037.9645637422977;5884.852878678067;5905.970470147622;5914.231149950565;5919.733611987471;5920.934231838224;5575.358833734173;5741.770329186786;5792;5817.767289308465;5857.121431785266;5862.824115276549;5883.528917854512;5924.851878703067;5931.169636250928;5932.161030080689;5452.263944367618;5703.971480142573;5755.53955683536;5756.971215143897;5787.56593255516;5675.772969081356;5705.088795253637;5705.657660540215;5708.543316534584;5716.942830571641;5914.704264786829;5935.376785437639;5947.9702601486715;5968.746563221772;5976.6712830792985;3898.2398432305426;4029.979850100848;4036.2936486114227;4055.797210139422;4064.6138616831354;5724.656520608777;5781.253904395378;5782.277215348082;5789.710514474175;5792.768289268382;5468.3711373191;5661.886762264649;5669.603127781016;5685.545156387562;5714.200011998407;5508.375029366427;5531.1426728857095;5557.305336832896;5570.136628822539;5570.972145139248;5283.709395983258;5441.183822426668;5456.7544460498575;5461.863453413696;5534.142207957773;5163.8192663256605;5437.646552974044;5523.171524271392;5537.640053396516;5538.972305138448;5410.3507579090765;5439.619226654255;5440.483154100354;5458.2904222450825;5473.917891231555 01:43:24 INFO - PROCESS | 16066 | |5;yui.html;756.3722110648163;794.992050079499;805.919408059194;817.5585184000639;829.1376967953329;15064.623384415381;16103.83896161038;16687.99872007679;17192.742108868377;17208.655826883456;15619.297131629075;15718.607034824136;15734.763978540332;15738.921305393456;15741.84258157421;682.6996121706434;808.4340961327065;814.6944895664126;814.9674013039471;816.4407380944043;801.4470015689185;828.0146625515647;829.8340331933607;832.8084540555645;833.2375876073386;843.4011851585382;844.2190973349658;846.5428668518992;850.1923172985657;850.7235148576707;694.1808665774385;821.7206149909;845.602566793606;845.8392905347964;846.0397448895517;617.7405489694294;618.1778234947509;621.940915613016;622.0047923322693;622.8660837919869;15776.921115394465;15843;15862.36550537977;15867.444639437565;15874.36502539897;13999.230042347666;14382;14428.278586070655;14439.92780036093;14653.12081275127;13833.861661383358;13872.583822485341;13883.583492495241;14145.151290922578;14419.423223071064;4460.933086003713;4490.169318676056;4515.525869783658;4563.201439748031;4605.746683932382;83674;84393.15606843976;85232.57383713042;85490;85509;11536.884631153749;11582.247153934968;11660.416979151008;11807.763844723057;12105.87894121065;21265.149394024065;21390.251341202984;21417.46456338604;21448.24931127403;21895.781042189374;8549.487030778173;8571.314294856522;8611.354148438766;8689.261412779859;8886.688965886164;4735.763211839394;4774.761261936958;4893.657443978958;4897.14299997499;4950.25746138075;3513.0690367052753;3603.22530655905;3609.711223102198;3610.205754733954;3634.727395445352;650.6291413894035;688.2051230828401;693.1543516909362;696.0742212856889;711.79713781572;687.2405991379553;690.2131570010092;709.9964500177466;792.8295416485483;794.2295972906271;10257.17942564593;10490.73773155662;10536.367817930948;10753.892461075446;10760.892391076146;753.9811504712317;782.6243403166512;783.4946459533569;793.4921650143913;800.9078955920028;5095.847124586268;5100.821471248489;5182.274481572583;5197.792088316501;5209.583233341324;76340.23659763331;78421;89282;115213;125512.37243813905;89440.5527972369;102982.48508757558;103018.48490757498;105676.47161764142;106076.99999999846;93204.53397732967;93344;95436;96220;96369.5181524102;9766.316357854881;9836.508174591385;9932.304738668512;9950.502474876372;10017.14854237398;53098;54884.114194768365;55000.17499737427;57006.71496642656;57185.42814571968;81002;81183;84216.15783842083;84314;85506;11791.174617776673;11952.297870653314;12163.2702037878;12539.059570532429;13039.022073344348;13499.325033748077;13793.931030345186;14134.646633834236;14289.64275893111;14388.624933597172;13494.797578036141;13648.24934628605;13951;14054.508092216724;14376.209308488134;13069.934650326688;13159;13577;14021.29893505341;14133.010689252065;13241.80137297922;13521.121127126706;13621.863781362455;13692.246926419142;14129.646758831112;9967.50162491887;10580.047795698423;10607.893921060691;10701.19741019411;10757.784844302914;10410.375377477376;10444.791104178026;10498.842517362398;10566.26036177491;10631.574737010433 01:43:24 INFO - PROCESS | 16066 | __end_tp_report 01:43:24 INFO - PROCESS | 16066 | __start_cc_report 01:43:24 INFO - PROCESS | 16066 | _x_x_mozilla_cycle_collect,908 01:43:24 INFO - PROCESS | 16066 | __end_cc_report 01:43:24 INFO - PROCESS | 16066 | __startTimestamp1465202604475__endTimestamp 01:43:24 INFO - PROCESS | 16066 | 01:43:24 INFO - PROCESS | 16066 | ------- Summary: start ------- 01:43:24 INFO - PROCESS | 16066 | Number of tests: 6 01:43:24 INFO - PROCESS | 16066 | 01:43:24 INFO - PROCESS | 16066 | [#0] dojo.html Cycles:165 Average:5392.99 Median:5613.83 stddev:628.21 (11.2%) stddev-sans-first:603.35 01:43:24 INFO - PROCESS | 16066 | Values: 3079.5 3080.8 3086.7 3104.9 3105.5 5256.2 5288.3 5341.9 5354.3 5371.0 5324.5 5324.9 5437.3 5456.3 5492.2 4765.9 4839.6 4858.6 4863.1 5058.0 4965.9 4982.6 5022.9 5029.5 5035.0 4789.6 4810.0 4836.4 4881.9 4891.5 4881.3 4899.1 4967.3 4971.6 5022.9 4781.8 4930.8 4940.5 4942.2 4966.6 5239.3 5322.2 5333.5 5373.8 5410.8 5841.7 5855.4 5861.2 5869.5 5872.9 5661.5 5741.5 5751.7 5799.4 5852.6 5454.7 5480.5 5486.0 5500.2 5500.6 5985.8 6004.6 6010.2 6015.5 6022.2 5506.2 5616.3 5644.6 5664.5 5762.1 5779.6 5829.9 5836.2 5838.6 5840.9 5756.3 5769.7 5771.0 5771.9 5772.8 5583.8 5791.3 5812.4 5849.7 5865.6 4414.9 4418.2 4421.2 4422.4 4463.8 3837.0 3927.1 3951.2 3969.4 3980.2 5523.5 5575.8 5578.2 5582.9 5607.7 5902.5 5903.5 5906.5 5918.3 5962.8 5326.6 5453.7 5592.7 5600.5 5602.2 4990.9 5017.4 5032.4 5039.3 5062.0 5999.5 6011.4 6011.4 6012.3 6014.8 5613.8 5736.5 5800.0 5819.1 5858.3 5941.8 5993.9 5995.0 6027.9 6037.7 5674.3 5697.7 5722.1 5722.1 5727.9 5683.9 5753.4 5817.5 5818.2 5828.1 5747.5 5751.5 5752.6 5754.1 5786.9 5649.5 5679.9 5715.9 5717.3 5727.6 5432.6 5531.6 5579.1 5605.7 5627.2 5766.2 5768.6 5799.4 5813.5 5816.4 5595.4 5630.6 5632.4 5643.1 5664.7 01:43:24 INFO - PROCESS | 16066 | 01:43:24 INFO - PROCESS | 16066 | [#1] ext.html Cycles:180 Average:56726.74 Median:40089.10 stddev:109291.94 (272.6%) stddev-sans-first:109517.28 01:43:24 INFO - PROCESS | 16066 | Values: 594.5 612.2 626.3 642.5 646.2 30081.2 30973.2 33608.2 33647.7 33683.3 41338.2 42127.4 42155.8 45621.9 45627.3 8737.0 8946.6 8948.6 8948.9 8951.0 8708.2 8848.9 8851.1 8852.9 8859.7 8807.8 8863.8 8864.0 8865.2 8872.2 8824.9 8877.2 8878.0 8885.3 8889.1 8771.5 8832.6 8859.2 8865.8 8878.5 39876.6 40022.2 40099.2 40155.4 40157.8 3493.0 3561.4 3617.5 3638.8 3672.7 31303.5 31414.4 31483.2 31866.5 32988.8 4099.9 4167.4 4208.6 4258.2 4372.0 329860.0 331904.0 332075.3 332273.0 332340.0 56466.2 56627.4 56955.4 56981.7 56985.0 48368.3 49276.8 49383.5 54197.5 57174.4 15455.1 15535.1 15645.2 15653.5 15682.5 12097.2 12276.4 12285.1 12306.7 12307.4 14074.6 15093.0 15312.6 15538.3 15955.8 5927.5 5928.9 5950.6 5951.5 6052.5 997.9 1060.9 1074.2 1095.5 1111.1 31676.0 31728.8 31752.2 31824.8 31890.7 1143.5 1147.4 1173.5 1185.4 1225.3 16750.7 16819.9 16881.4 16908.7 16988.5 477171.0 478873.0 478974.0 479968.0 480027.0 55077.7 56050.4 56054.7 56146.0 56258.0 1248.8 1350.8 1396.3 1402.2 1405.7 31092.7 32841.5 32877.3 32961.8 33431.5 48270.3 48748.5 48861.8 48926.0 49001.8 406624.0 418091.0 418174.0 418518.0 418914.0 34460.1 38527.8 39275.8 40281.4 42441.6 45537.3 46213.0 46294.3 46446.5 47051.5 38375.6 39430.6 40079.0 40128.2 40522.6 39056.2 39406.0 39890.0 39956.4 40067.2 39509.8 39534.8 39855.6 40037.4 40521.0 34214.5 35132.5 35979.6 36167.8 36171.0 27500.7 27842.2 27905.4 27962.4 28032.7 01:43:24 INFO - PROCESS | 16066 | 01:43:24 INFO - PROCESS | 16066 | [#2] jquery.html Cycles:180 Average:31081.82 Median:2568.42 stddev:84638.84 (3295.4%) stddev-sans-first:84844.91 01:43:24 INFO - PROCESS | 16066 | Values: 393.5 394.9 396.7 396.9 407.0 14080.4 15957.4 17783.0 19281.4 19401.7 14613.1 15015.2 17513.5 17683.2 18100.0 5469.6 5600.1 5645.2 5651.9 5656.1 5328.6 5448.5 5475.2 5496.4 5505.6 4033.6 5884.9 6249.3 6255.8 6257.3 6119.6 6139.2 6153.9 6240.8 6260.2 5474.6 5569.5 5611.9 5614.0 5614.7 22029.2 22445.8 23166.5 23223.8 23253.3 2340.8 2368.9 2481.3 2500.1 2636.8 14980.9 15167.6 15193.6 15663.8 16001.3 2014.7 2014.9 2034.4 2040.6 2220.9 91101.0 94640.5 95636.0 96054.5 96439.0 16231.6 17480.9 17590.9 17595.4 17619.0 31044.2 31243.0 31284.5 31325.5 31379.2 8527.7 9047.9 9366.5 9578.6 9801.7 7900.3 7916.7 7962.1 8003.3 8036.9 8588.6 8780.8 8795.5 8820.8 8996.0 3421.8 3514.7 3519.2 3567.4 3570.2 931.5 1021.7 1032.8 1032.9 1074.5 18396.0 18758.6 18781.1 18813.0 19180.0 984.6 1038.5 1040.5 1051.6 1087.2 10096.3 10438.6 10445.7 10507.7 10551.3 481969.0 515064.0 515215.0 520062.6 525911.0 94304.0 100270.0 100917.0 102149.0 102573.5 1008.7 1048.8 1069.7 1084.8 1087.6 16488.8 16630.7 16778.2 16830.5 16900.2 42117.8 43441.5 43705.6 45361.3 45458.1 59861.7 60035.4 60668.4 60701.4 62263.0 8206.3 8234.3 8362.4 8387.3 8456.7 12081.8 12636.7 13100.7 13163.6 13203.3 11409.7 11420.3 11568.6 11659.4 11814.9 11218.0 11400.7 11527.5 11541.7 11591.5 11486.0 11500.1 11643.7 11649.4 11775.8 8303.2 8316.7 8318.8 8331.6 8512.5 10489.5 10812.4 10962.2 11021.8 11041.2 01:43:24 INFO - PROCESS | 16066 | 01:43:24 INFO - PROCESS | 16066 | [#3] mootools.html Cycles:180 Average:5678.02 Median:4633.40 stddev:3282.62 (70.8%) stddev-sans-first:3275.33 01:43:24 INFO - PROCESS | 16066 | Values: 1298.6 1407.8 1476.0 1572.7 1772.3 8198.3 8542.6 8544.6 8785.9 8809.4 8518.8 8714.1 8718.3 8735.9 8754.4 2306.2 2328.8 2332.4 2334.0 2335.1 2288.2 2329.5 2354.5 2363.4 2364.1 2341.6 2343.1 2366.9 2373.2 2379.0 2196.4 2212.7 2226.9 2228.7 2252.4 2237.5 2241.1 2243.5 2245.4 2247.7 8027.6 8191.0 8559.9 8608.4 8624.7 5070.8 5236.5 5238.7 5238.9 5241.3 3216.7 3246.4 3262.2 3285.7 3290.9 1041.3 1042.6 1047.8 1061.5 1070.1 12179.5 12186.0 12224.6 12258.4 12266.4 4433.4 4461.3 4541.0 4569.5 4575.7 9666.3 9678.9 9681.0 9682.4 9687.5 5119.6 5120.2 5121.2 5124.1 5128.2 4262.1 4460.3 4542.7 4579.2 4687.6 3839.2 3839.9 3927.6 3957.2 3966.9 1132.8 1134.3 1141.4 1146.0 1160.4 777.6 966.1 1000.1 1000.7 1009.3 5909.0 5932.8 5943.1 6008.5 6199.8 476.8 477.6 480.9 494.1 666.9 3920.9 4090.6 4140.1 4181.0 4212.8 10668.5 10965.2 11086.4 11086.7 11101.6 10811.6 10920.0 10923.9 10945.5 10954.6 7625.1 7962.8 7975.8 8179.2 8186.8 5978.4 6081.0 6175.4 6291.3 6360.0 9952.5 10056.7 10125.8 10245.8 10341.8 10331.4 10430.3 10461.1 10461.5 10464.3 6648.3 6957.0 7464.0 7655.8 7780.2 8216.5 8288.2 8296.2 8311.7 8322.3 7105.9 7363.0 7398.0 7446.4 7572.7 7156.5 7165.3 7193.6 7292.9 7301.6 6845.5 6983.3 6990.3 6999.1 7000.8 4899.0 4914.4 4923.8 4938.6 4996.2 4748.5 4789.7 4824.4 4865.1 4941.3 01:43:24 INFO - PROCESS | 16066 | 01:43:24 INFO - PROCESS | 16066 | [#4] prototype.html Cycles:180 Average:4700.26 Median:5425.26 stddev:1378.45 (25.4%) stddev-sans-first:1342.57 01:43:24 INFO - PROCESS | 16066 | Values: 321.7 324.9 328.3 337.1 340.7 5322.4 5401.4 5418.0 5423.6 5446.7 5329.7 5337.6 5390.4 5403.2 5406.4 3955.1 4008.1 4124.5 4138.9 4191.5 4065.4 4124.0 4127.8 4164.5 4187.6 3927.0 4078.9 4098.3 4107.7 4125.9 3830.3 3994.3 4000.2 4116.4 4146.4 3682.0 3706.0 3712.4 3726.1 3730.8 5154.2 5166.8 5176.8 5178.4 5180.3 4557.3 4748.9 4759.2 4771.0 4775.2 5434.3 5492.7 5503.9 5519.9 5573.6 4029.7 4046.2 4048.9 4075.6 4081.5 5554.1 5741.2 5749.4 5754.4 5761.1 4151.2 4170.7 4174.8 4193.3 4197.2 4269.8 4278.4 4301.4 4304.4 4307.1 4545.8 4765.9 4769.7 4784.5 4834.6 5561.9 5573.6 5576.2 5594.3 5597.9 1460.2 1478.9 1479.8 1482.5 1484.1 913.7 916.7 950.0 959.4 967.5 5183.4 5426.9 5428.3 5430.5 5458.2 5702.3 5710.3 5733.9 5754.8 5758.3 5268.4 5300.9 5364.7 5435.8 5458.3 2976.9 2995.4 3031.8 3036.7 3038.0 5884.9 5906.0 5914.2 5919.7 5920.9 5575.4 5741.8 5792.0 5817.8 5857.1 5862.8 5883.5 5924.9 5931.2 5932.2 5452.3 5704.0 5755.5 5757.0 5787.6 5675.8 5705.1 5705.7 5708.5 5716.9 5914.7 5935.4 5948.0 5968.7 5976.7 3898.2 4030.0 4036.3 4055.8 4064.6 5724.7 5781.3 5782.3 5789.7 5792.8 5468.4 5661.9 5669.6 5685.5 5714.2 5508.4 5531.1 5557.3 5570.1 5571.0 5283.7 5441.2 5456.8 5461.9 5534.1 5163.8 5437.6 5523.2 5537.6 5539.0 5410.4 5439.6 5440.5 5458.3 5473.9 01:43:24 INFO - PROCESS | 16066 | 01:43:24 INFO - PROCESS | 16066 | [#5] yui.html Cycles:180 Average:21364.58 Median:4670.75 stddev:30448.79 (651.9%) stddev-sans-first:30494.89 01:43:24 INFO - PROCESS | 16066 | Values: 756.4 795.0 805.9 817.6 829.1 15064.6 16103.8 16688.0 17192.7 17208.7 15619.3 15718.6 15734.8 15738.9 15741.8 682.7 808.4 814.7 815.0 816.4 801.4 828.0 829.8 832.8 833.2 843.4 844.2 846.5 850.2 850.7 694.2 821.7 845.6 845.8 846.0 617.7 618.2 621.9 622.0 622.9 15776.9 15843.0 15862.4 15867.4 15874.4 13999.2 14382.0 14428.3 14439.9 14653.1 13833.9 13872.6 13883.6 14145.2 14419.4 4460.9 4490.2 4515.5 4563.2 4605.7 83674.0 84393.2 85232.6 85490.0 85509.0 11536.9 11582.2 11660.4 11807.8 12105.9 21265.1 21390.3 21417.5 21448.2 21895.8 8549.5 8571.3 8611.4 8689.3 8886.7 4735.8 4774.8 4893.7 4897.1 4950.3 3513.1 3603.2 3609.7 3610.2 3634.7 650.6 688.2 693.2 696.1 711.8 687.2 690.2 710.0 792.8 794.2 10257.2 10490.7 10536.4 10753.9 10760.9 754.0 782.6 783.5 793.5 800.9 5095.8 5100.8 5182.3 5197.8 5209.6 76340.2 78421.0 89282.0 115213.0 125512.4 89440.6 102982.5 103018.5 105676.5 106077.0 93204.5 93344.0 95436.0 96220.0 96369.5 9766.3 9836.5 9932.3 9950.5 10017.1 53098.0 54884.1 55000.2 57006.7 57185.4 81002.0 81183.0 84216.2 84314.0 85506.0 11791.2 11952.3 12163.3 12539.1 13039.0 13499.3 13793.9 14134.6 14289.6 14388.6 13494.8 13648.2 13951.0 14054.5 14376.2 13069.9 13159.0 13577.0 14021.3 14133.0 13241.8 13521.1 13621.9 13692.2 14129.6 9967.5 10580.0 10607.9 10701.2 10757.8 10410.4 10444.8 10498.8 10566.3 10631.6 01:43:24 INFO - PROCESS | 16066 | -------- Summary: end -------- 01:43:24 INFO - PROCESS | 16066 | 01:43:25 INFO - TEST-INFO | 16066: exit 0 01:43:25 INFO - TEST-OK | dromaeo_css | took 1113301ms 01:43:25 INFO - TEST-START | kraken 01:43:25 INFO - operating with platform_type : linux_ 01:43:25 INFO - Initialising browser for kraken test... 01:43:25 INFO - TEST-INFO | started process 16242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTTRQSE/profile http://localhost:43768/getInfo.html) 01:43:28 INFO - PROCESS | 16242 | __metrics Screen width/height:1600/1200 01:43:28 INFO - PROCESS | 16242 | colorDepth:24 01:43:28 INFO - PROCESS | 16242 | Browser inner width/height: 1024/697 01:43:28 INFO - PROCESS | 16242 | __metrics 01:43:29 ERROR - PROCESS | 16242 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:43:30 INFO - TEST-INFO | 16242: exit 0 01:43:30 INFO - Browser initialized. 01:43:30 INFO - Running cycle 1/1 for kraken test... 01:43:30 INFO - TEST-INFO | started process 16325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTTRQSE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:43:42 INFO - PROCESS | 16325 | RSS: Main: 155734016 01:43:42 INFO - PROCESS | 16325 | 01:43:45 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43768/tests/kraken/driver.html?testName=audio-beat-detection) 01:43:46 INFO - PROCESS | 16325 | RSS: Main: 214614016 01:43:46 INFO - PROCESS | 16325 | 01:43:48 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43768/tests/kraken/driver.html?testName=audio-dft) 01:43:49 INFO - PROCESS | 16325 | RSS: Main: 198770688 01:43:49 INFO - PROCESS | 16325 | 01:43:52 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43768/tests/kraken/driver.html?testName=audio-fft) 01:43:53 INFO - PROCESS | 16325 | RSS: Main: 268521472 01:43:53 INFO - PROCESS | 16325 | 01:43:55 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43768/tests/kraken/driver.html?testName=audio-oscillator) 01:43:55 INFO - PROCESS | 16325 | RSS: Main: 179216384 01:43:55 INFO - PROCESS | 16325 | 01:43:57 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43768/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:43:58 INFO - PROCESS | 16325 | RSS: Main: 183910400 01:43:58 INFO - PROCESS | 16325 | 01:44:01 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43768/tests/kraken/driver.html?testName=imaging-darkroom) 01:44:02 INFO - PROCESS | 16325 | RSS: Main: 219594752 01:44:02 INFO - PROCESS | 16325 | 01:44:05 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43768/tests/kraken/driver.html?testName=imaging-desaturate) 01:44:06 INFO - PROCESS | 16325 | RSS: Main: 220815360 01:44:06 INFO - PROCESS | 16325 | 01:44:08 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43768/tests/kraken/driver.html?testName=json-parse-financial) 01:44:09 INFO - PROCESS | 16325 | RSS: Main: 220340224 01:44:09 INFO - PROCESS | 16325 | 01:44:11 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43768/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:44:11 INFO - PROCESS | 16325 | RSS: Main: 207224832 01:44:11 INFO - PROCESS | 16325 | 01:44:13 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43768/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:44:14 INFO - PROCESS | 16325 | RSS: Main: 210944000 01:44:14 INFO - PROCESS | 16325 | 01:44:16 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43768/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:44:16 INFO - PROCESS | 16325 | RSS: Main: 217604096 01:44:16 INFO - PROCESS | 16325 | 01:44:19 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:44:20 INFO - PROCESS | 16325 | RSS: Main: 223535104 01:44:20 INFO - PROCESS | 16325 | 01:44:22 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:44:23 INFO - PROCESS | 16325 | RSS: Main: 225558528 01:44:23 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | Cycle 1(1): loaded http://localhost:43768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43768/tests/kraken/driver.html?testName=ai-astar) 01:44:25 INFO - PROCESS | 16325 | RSS: Main: 267481088 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | __start_tp_report 01:44:25 INFO - PROCESS | 16325 | _x_x_mozilla_page_load 01:44:25 INFO - PROCESS | 16325 | _x_x_mozilla_page_load_details 01:44:25 INFO - PROCESS | 16325 | |i|pagename|runs| 01:44:25 INFO - PROCESS | 16325 | |0;ai-astar;110;105;110;110;110;110;110;109;109;111 01:44:25 INFO - PROCESS | 16325 | |1;audio-beat-detection;153;125;134;176;128;159;156;127;181;127 01:44:25 INFO - PROCESS | 16325 | |2;audio-dft;163;161;160;161;161;160;162;161;162;163 01:44:25 INFO - PROCESS | 16325 | |3;audio-fft;75;75;74;113;75;77;75;74;104;75 01:44:25 INFO - PROCESS | 16325 | |4;audio-oscillator;85;84;121;84;85;87;120;84;85;126 01:44:25 INFO - PROCESS | 16325 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 01:44:25 INFO - PROCESS | 16325 | |6;imaging-darkroom;146;147;145;145;147;146;145;146;146;146 01:44:25 INFO - PROCESS | 16325 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;94 01:44:25 INFO - PROCESS | 16325 | |8;json-parse-financial;55;53;53;54;54;54;53;54;62;53 01:44:25 INFO - PROCESS | 16325 | |9;json-stringify-tinderbox;63;64;63;63;64;64;63;63;63;63 01:44:25 INFO - PROCESS | 16325 | |10;stanford-crypto-aes;80;80;81;87;80;80;86;88;143;80 01:44:25 INFO - PROCESS | 16325 | |11;stanford-crypto-ccm;126;122;123;122;121;120;122;120;140;133 01:44:25 INFO - PROCESS | 16325 | |12;stanford-crypto-pbkdf2;163;169;174;159;159;159;163;160;163;160 01:44:25 INFO - PROCESS | 16325 | |13;stanford-crypto-sha256-iterative;63;66;67;64;67;62;62;62;63;61 01:44:25 INFO - PROCESS | 16325 | __end_tp_report 01:44:25 INFO - PROCESS | 16325 | __start_cc_report 01:44:25 INFO - PROCESS | 16325 | _x_x_mozilla_cycle_collect,1649 01:44:25 INFO - PROCESS | 16325 | __end_cc_report 01:44:25 INFO - PROCESS | 16325 | __startTimestamp1465202665277__endTimestamp 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | ------- Summary: start ------- 01:44:25 INFO - PROCESS | 16325 | Number of tests: 14 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.65 (1.5%) stddev-sans-first:1.73 01:44:25 INFO - PROCESS | 16325 | Values: 110.0 105.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 111.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:154.50 stddev:21.27 (13.8%) stddev-sans-first:22.43 01:44:25 INFO - PROCESS | 16325 | Values: 153.0 125.0 134.0 176.0 128.0 159.0 156.0 127.0 181.0 127.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:0.97 01:44:25 INFO - PROCESS | 16325 | Values: 163.0 161.0 160.0 161.0 161.0 160.0 162.0 161.0 162.0 163.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:14.31 (19.1%) stddev-sans-first:14.97 01:44:25 INFO - PROCESS | 16325 | Values: 75.0 75.0 74.0 113.0 75.0 77.0 75.0 74.0 104.0 75.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:84.50 stddev:18.19 (21.5%) stddev-sans-first:18.84 01:44:25 INFO - PROCESS | 16325 | Values: 85.0 84.0 121.0 84.0 85.0 87.0 120.0 84.0 85.0 126.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:44:25 INFO - PROCESS | 16325 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 01:44:25 INFO - PROCESS | 16325 | Values: 146.0 147.0 145.0 145.0 147.0 146.0 145.0 146.0 146.0 146.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 01:44:25 INFO - PROCESS | 16325 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:2.72 (5.0%) stddev-sans-first:2.88 01:44:25 INFO - PROCESS | 16325 | Values: 55.0 53.0 53.0 54.0 54.0 54.0 53.0 54.0 62.0 53.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 01:44:25 INFO - PROCESS | 16325 | Values: 63.0 64.0 63.0 63.0 64.0 64.0 63.0 63.0 63.0 63.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:80.50 stddev:19.43 (24.1%) stddev-sans-first:20.36 01:44:25 INFO - PROCESS | 16325 | Values: 80.0 80.0 81.0 87.0 80.0 80.0 86.0 88.0 143.0 80.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:122.50 stddev:6.56 (5.4%) stddev-sans-first:6.94 01:44:25 INFO - PROCESS | 16325 | Values: 126.0 122.0 123.0 122.0 121.0 120.0 122.0 120.0 140.0 133.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.00 stddev:4.98 (3.1%) stddev-sans-first:5.28 01:44:25 INFO - PROCESS | 16325 | Values: 163.0 169.0 174.0 159.0 159.0 159.0 163.0 160.0 163.0 160.0 01:44:25 INFO - PROCESS | 16325 | 01:44:25 INFO - PROCESS | 16325 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:2.21 (3.5%) stddev-sans-first:2.33 01:44:25 INFO - PROCESS | 16325 | Values: 63.0 66.0 67.0 64.0 67.0 62.0 62.0 62.0 63.0 61.0 01:44:25 INFO - PROCESS | 16325 | -------- Summary: end -------- 01:44:25 INFO - PROCESS | 16325 | 01:44:26 INFO - TEST-INFO | 16325: exit 0 01:44:26 INFO - TEST-OK | kraken | took 61053ms 01:44:26 INFO - SUITE-END | took 1174s 01:44:26 INFO - Completed test suite (00:19:34) 01:44:26 INFO - javascript benchmark 01:44:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.4610943084963, 3080.8151510909333, 3086.6913308669136, 3104.9379012419754, 3105.549695294184, 5256.185291279858, 5288.259643649887, 5341.946580534193, 5354.250404943311, 5371.006363822696, 5324.54741346986, 5324.946750532494, 5437.34751829781, 5456.345238571377, 5492.203630473579, 4765.8570242892765, 4839.637027222972, 4858.635602329822, 4863.076015557051, 5058.038972595214, 4965.875853103666, 4982.626303027269, 5022.924656130161, 5029.547340739351, 5035.043341765071, 4789.592884604813, 4810.0, 4836.37127173467, 4881.8779530511665, 4891.5353041461, 4881.267809828519, 4899.118158731427, 4967.3294105296045, 4971.552560269593, 5022.874428139289, 4781.760911954389, 4930.80276788928, 4940.530649588283, 4942.159832828428, 4966.5778408835295, 5239.266502689627, 5322.175062865262, 5333.49331813481, 5373.785048598091, 5410.810621628224, 5841.678707671076, 5855.4144585541535, 5861.150133230701, 5869.471747542699, 5872.853178670567, 5661.46216109469, 5741.540676745851, 5751.654900705971, 5799.3620701722775, 5852.619579727304, 5454.727263636882, 5480.506754392084, 5486.039943009957, 5500.1749737539685, 5500.642458240201, 5985.820425387158, 6004.639721616717, 6010.218671572755, 6015.54883383748, 6022.247219097613, 5506.229127922014, 5616.297962754656, 5644.57665675076, 5664.49019588239, 5762.1068734346245, 5779.624324418899, 5829.88340233193, 5836.241288632451, 5838.591298609056, 5840.941590584125, 5756.30924289088, 5769.6538207706835, 5771.0477771168125, 5771.942280577225, 5772.826815195551, 5583.832485025456, 5791.276090488689, 5812.360640329561, 5849.707514624251, 5865.618734782225, 4414.911701765946, 4418.2047231498, 4421.182081314967, 4422.380866678667, 4463.799129039201, 3836.961630383716, 3927.0771368728324, 3951.249262640089, 3969.3649016157856, 3980.24375368679, 5523.502884740312, 5575.804846830422, 5578.219049333096, 5582.91625625616, 5607.66354018752, 5902.527797776168, 5903.527717782567, 5906.49794767441, 5918.348981612019, 5962.791302304486, 5326.573874090141, 5453.672779633234, 5592.748326325325, 5600.467955544217, 5602.215689803431, 4990.850274491771, 5017.37282839645, 5032.396112466454, 5039.294498770175, 5062.038212739568, 5999.490043346277, 6011.368806275365, 6011.428914253139, 6012.338642749294, 6014.849628759229, 5613.831585052455, 5736.4550367715, 5799.956007918615, 5819.098039803837, 5858.297004359504, 5941.821745347646, 5993.910091348546, 5994.970025150021, 6027.879442411039, 6037.728302226323, 5674.319081710221, 5697.715114244188, 5722.055860782924, 5722.113072473773, 5727.914081288701, 5683.943160568507, 5753.367129615655, 5817.534597232296, 5818.185454036354, 5828.125781132864, 5747.51146152565, 5751.511121554715, 5752.568557358131, 5754.108113242454, 5786.9131963019745, 5649.491545760901, 5679.886402271849, 5715.8571035724435, 5717.285339332583, 5727.570432217683, 5432.56539476833, 5531.612787104864, 5579.079451890392, 5605.691686957257, 5627.240322556566, 5766.192733017297, 5768.625039372428, 5799.391063938226, 5813.476787089182, 5816.41835816415, 5595.440455954372, 5630.634008789416, 5632.408597097409, 5643.068893632505, 5664.688442135557], "value": 5349.27614395764, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.4501336263954, 612.2224774536339, 626.3016736338981, 642.5052709413751, 646.1696719715167, 30081.24796880079, 30973.22566935828, 33608.15979600505, 33647.66352336476, 33683.32633347331, 41338.17323653525, 42127.36808947861, 42155.78922105385, 45621.85945351368, 45627.315590266175, 8736.956315218415, 8946.64213431462, 8948.64205431782, 8948.910510894873, 8951.0, 8708.17272359125, 8848.867266991001, 8851.070637583058, 8852.8672069919, 8859.689910853122, 8807.779805504882, 8863.822723545525, 8863.95568022159, 8865.202131808135, 8872.245859101984, 8824.911750882473, 8877.245434138105, 8878.0, 8885.289176865868, 8889.111088891124, 8771.517566533837, 8832.558372081434, 8859.202671759573, 8865.822683546294, 8878.511681857495, 39876.60123398758, 40022.199556008716, 40099.19801603952, 40155.39766903499, 40157.79921100405, 3492.9650703492894, 3561.3767590671787, 3617.5478065241846, 3638.8362523686233, 3672.706183505313, 31303.53044704331, 31414.371712565848, 31483.212919677193, 31866.522002169753, 32988.84539041122, 4099.877003689894, 4167.416561681367, 4208.642265407413, 4258.212230737324, 4371.956280437187, 329860.0, 331904.0, 332075.33962330275, 332273.0, 332340.0, 56466.15300770492, 56627.43372566304, 56955.43700533486, 56981.71509142428, 56985.0, 48368.27447588289, 49276.75361623169, 49383.50616493861, 54197.45802542003, 57174.42825571774, 15455.149966751937, 15535.145566993924, 15645.217739112999, 15653.452129175424, 15682.451114211177, 12097.153199275966, 12276.447559859827, 12285.1400401971, 12306.692332691575, 12307.4461649226, 14074.648133796736, 15093.0, 15312.617184570252, 15538.300776465087, 15955.840441595436, 5927.496162826122, 5928.940710592925, 5950.553708471795, 5951.5238780897425, 6052.54605904559, 997.910188083076, 1060.9310394824465, 1074.2265568790458, 1095.5453486802887, 1111.127764704703, 31676.0, 31728.841355793073, 31752.206194845312, 31824.84087579547, 31890.681093189236, 1143.4797167288864, 1147.4205526209212, 1173.5423184957874, 1185.3599056509388, 1225.332193954297, 16750.74873876893, 16819.91590042042, 16881.40915067967, 16908.661826763397, 16988.49034528966, 477171.0, 478873.0, 478974.0, 479968.0, 480027.0, 55077.72461137669, 56050.43949560534, 56054.71972640192, 56145.999999999185, 56258.0, 1248.7689777391213, 1350.8311461067367, 1396.322783450026, 1402.1657114017144, 1405.6556143744847, 31092.689073109883, 32841.50737738983, 32877.34245315128, 32961.79376312164, 33431.49852752162, 48270.27594586154, 48748.5125148744, 48861.75569122132, 48926.0, 49001.754991224814, 406624.0, 418091.0, 418174.0, 418518.0, 418914.0, 34460.13849653779, 38527.807360963016, 39275.803620981715, 40281.395779063925, 42441.575584243765, 45537.31694024526, 46213.0, 46294.30558541692, 46446.53553464422, 47051.52948470609, 38375.61624383832, 39430.60569394269, 40079.0, 40128.1974360517, 40522.59477405188, 39056.21887562289, 39406.0, 39890.0, 39956.40283381571, 40067.198656026136, 39509.80245098756, 39534.80232598819, 39855.601443985186, 40037.39943900786, 40521.0, 34214.486782698776, 35132.473012905335, 35979.64020359763, 36167.81916090403, 36171.0, 27500.724992749816, 27842.16473505798, 27905.44189116247, 27962.44075118527, 28032.719672803825], "value": 19518.864995839813, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.4786408009388, 394.9427333036708, 396.6965271567253, 396.9325214713499, 407.03938704657, 14080.436782528712, 15957.361705531794, 17783.0, 19281.421557353267, 19401.708974365378, 14613.123212607225, 15015.249237538106, 17513.47459576215, 17683.204255808487, 18100.0, 5469.644473109235, 5600.131979543157, 5645.2096706461125, 5651.886962260753, 5656.095024796034, 5328.573714102882, 5448.509634132927, 5475.151351540518, 5496.395396506381, 5505.614606977493, 4033.5764744701823, 5884.941150588504, 6249.2813326467585, 6255.843603909916, 6257.342978987209, 6119.571629985903, 6139.201903752506, 6153.907691384633, 6240.843978900519, 6260.15487909131, 5474.644148130359, 5569.470900264469, 5611.8877622447735, 5614.0, 5614.719264036823, 22029.228976985727, 22445.775542244533, 23166.53666926669, 23223.767762322328, 23253.302400927998, 2340.754220806825, 2368.928932132039, 2481.3424442522746, 2500.0749722602573, 2636.762691357768, 14980.932722247508, 15167.62080947974, 15193.6201594961, 15663.765043524356, 16001.279942402503, 2014.717939488473, 2014.8589598728095, 2034.4201902457876, 2040.5816807554563, 2220.9000594973263, 91101.0, 94640.52679736626, 95636.0, 96054.51972740161, 96439.0, 16231.594210144605, 17480.91259543694, 17590.91204543969, 17595.384161554284, 17619.0, 31044.22389440237, 31243.0, 31284.53073203904, 31325.530117048263, 31379.215519611735, 8527.74416767498, 9047.90952090484, 9366.531673416439, 9578.56896439662, 9801.656942006995, 7900.328472079823, 7916.722914697958, 7962.08436029864, 8003.319717823933, 8036.879446808302, 8588.613512391958, 8780.78048048804, 8795.472271663593, 8820.77948051291, 8996.0, 3421.8194722820585, 3514.683678468899, 3519.1729943463265, 3567.3757092509227, 3570.178858862424, 931.5202670624499, 1021.7088129882948, 1032.767627283855, 1032.9431881246603, 1074.4896174317137, 18395.983011153872, 18758.624827503372, 18781.0609469526, 18813.0, 19180.0, 984.5569493727708, 1038.5015192707392, 1040.4705083527203, 1051.6371851711147, 1087.2063393722626, 10096.293259471766, 10438.582456701799, 10445.68662940113, 10507.684769456928, 10551.314164579278, 481969.0, 515064.0, 515215.0, 520062.5956183107, 525911.0, 94304.0, 100270.0, 100917.0, 102149.0, 102573.48713256385, 1008.702432782331, 1048.826943554305, 1069.727219559023, 1084.7830433913248, 1087.6410784441116, 16488.83511164873, 16630.669546436497, 16778.24497897573, 16830.495085147464, 16900.239489222768, 42117.78941105275, 43441.48377743364, 43705.56294437015, 45361.319580205665, 45458.09083818239, 59861.70069149626, 60035.39964600298, 60668.39331606627, 60701.39298606957, 62263.0, 8206.343492520704, 8234.341252699889, 8362.414630975773, 8387.329013679013, 8456.704015359433, 12081.818772718241, 12636.747265054832, 13100.672483187996, 13163.60509184726, 13203.273819939996, 11409.714757131138, 11420.257683250562, 11568.595099171489, 11659.407839533453, 11814.881851181723, 11218.0, 11400.71498212518, 11527.538898444303, 11541.711457213636, 11591.478383472595, 11486.0, 11500.079993600659, 11643.650690479299, 11649.359285239394, 11775.823362649397, 8303.169683031649, 8316.708915187939, 8318.792030199293, 8331.583420829056, 8512.531810750468, 10489.527971241465, 10812.405317707602, 10962.177836662442, 11021.779564408507, 11041.171912106463], "value": 10024.281788431877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.649364671538, 1407.7817938219575, 1476.0258229568483, 1572.7065112243574, 1772.3442326339248, 8198.344132469403, 8542.572871356431, 8544.615492302846, 8785.912140878589, 8809.427387219826, 8518.787030324245, 8714.128587141282, 8718.302535797136, 8735.91264087359, 8754.3871928965, 2306.181305636496, 2328.8020518255967, 2332.4402143485613, 2334.031376978552, 2335.100986120339, 2288.1533832482005, 2329.534093181362, 2354.5173239485866, 2363.3737059679197, 2364.101641376283, 2341.6019276722914, 2343.1447521654645, 2366.9053237870467, 2373.181252467896, 2378.965150159686, 2196.4442318424567, 2212.7455342635562, 2226.922057727988, 2228.665700144975, 2252.3918541993735, 2237.5455953630108, 2241.1483636218295, 2243.4727838957833, 2245.3937436891947, 2247.685324054634, 8027.598620069031, 8191.017077950624, 8559.914400855974, 8608.440451370641, 8624.65501379944, 5070.783012077111, 5236.502532259467, 5238.68567885928, 5238.895222095537, 5241.31862857826, 3216.694414030663, 3246.4318744219904, 3262.151840521458, 3285.671432856719, 3290.8683652653867, 1041.271110222847, 1042.5985995391752, 1047.8271085270922, 1061.47987486132, 1070.0797314309686, 12179.451924663323, 12186.0, 12224.572139975147, 12258.387080645844, 12266.448009839578, 4433.423654924839, 4461.263891457873, 4540.977295113569, 4569.520200378913, 4575.725456472623, 9666.323357364918, 9678.854817177747, 9680.951595241979, 9682.370645907993, 9687.467189304656, 5119.6416250862085, 5120.206368012964, 5121.231815227746, 5124.077666020152, 5128.205128205134, 4262.147570485915, 4460.330950357472, 4542.704724192917, 4579.22153233951, 4687.578117969331, 3839.1937693084205, 3839.865604703878, 3927.626875446828, 3957.168994511185, 3966.8809935701975, 1132.767782604564, 1134.3364131982717, 1141.3551343490901, 1145.9656210313703, 1160.3733983648735, 777.6034222546542, 966.1304825656824, 1000.0849222961054, 1000.6947880896397, 1009.3287963504188, 5909.0, 5932.762689492458, 5943.071317852567, 6008.549358798107, 6199.752009919643, 476.81642567611027, 477.6489280378919, 480.8773762690561, 494.06868053719, 666.9333066693292, 3920.9019774505296, 4090.5909409058854, 4140.0891803803115, 4180.979095104566, 4212.810423530948, 10668.466576671135, 10965.177611678997, 11086.390248536247, 11086.667399978014, 11101.611443599435, 10811.567537298577, 10920.0, 10923.945380273048, 10945.507452164671, 10954.56181752721, 7625.1231108422135, 7962.761117166494, 7975.7607271781935, 8179.182081791773, 8186.754397367969, 5978.372270911492, 6081.01749815507, 6175.44421002112, 6291.307956124914, 6359.96820015897, 9952.502374881371, 10056.69829905104, 10125.848112278469, 10245.795084098425, 10341.793164136525, 10331.431771252654, 10430.322029068086, 10461.110805581306, 10461.529231184768, 10464.267501274837, 6648.268690444144, 6957.022561169512, 7463.962680186564, 7655.846883062419, 7780.183080776437, 8216.46592971455, 8288.21261980111, 8296.170382961656, 8311.709090181814, 8322.334213263046, 7105.928940710527, 7362.9631851840395, 7398.038255026812, 7446.441516886147, 7572.659230334538, 7156.534825236343, 7165.319294666998, 7193.640317984185, 7292.854142917218, 7301.561906285639, 6845.4865885057825, 6983.266756990442, 6990.335918087773, 6999.0551275577145, 7000.824979375557, 4898.951010489849, 4914.410270767531, 4923.803047878045, 4938.604911607134, 4996.200607902718, 4748.477667456508, 4789.664723469324, 4824.372831531879, 4865.1242776300605, 4941.33292005589], "value": 4462.803048549824, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.6895695653694, 324.9333886553257, 328.25649902969775, 337.0780914199662, 340.74614412262883, 5322.361316642004, 5401.378841433237, 5417.972910135444, 5423.620346575742, 5446.700431476267, 5329.680219186852, 5337.572994160468, 5390.434004429537, 5403.162509810976, 5406.432324605918, 3955.1101002274545, 4008.0581063450068, 4124.484439445069, 4138.8965275868195, 4191.476065491814, 4065.410515475254, 4123.97938010311, 4127.772972486512, 4164.458620379346, 4187.560306167854, 3927.0378757204526, 4078.8572399966006, 4098.303288440972, 4107.650849677781, 4125.9174816503655, 3830.291396091704, 3994.320965435883, 4000.159966407058, 4116.423700681907, 4146.357314616239, 3681.9815900920325, 3705.962940370589, 3712.3874560697454, 3726.142987112979, 3730.8321125549414, 5154.20109882965, 5166.793328266865, 5176.844694659167, 5178.40448348441, 5180.274761533388, 4557.263044303672, 4748.881277968044, 4759.214729569617, 4771.0, 4775.188218002948, 5434.2935418395755, 5492.697901615409, 5503.862403439906, 5519.889602207973, 5573.637713548606, 4029.657479114279, 4046.190761847642, 4048.858289959867, 4075.572064933169, 4081.510218773766, 5554.055810512223, 5741.224934633813, 5749.367569567386, 5754.367019627837, 5761.078227483625, 4151.211269858717, 4170.708050436501, 4174.770387628649, 4193.266178418765, 4197.202531519001, 4269.807858646368, 4278.422412974209, 4301.419308393327, 4304.418903448057, 4307.138572285556, 4545.795439205178, 4765.880852978703, 4769.713817170981, 4784.492884741296, 4834.613230941516, 5561.888762224733, 5573.600103936596, 5576.219329293902, 5594.300712410949, 5597.949117730846, 1460.1677044084981, 1478.8595083467053, 1479.807625008742, 1482.5033613739517, 1484.1021182184838, 913.6939125393068, 916.7295647783919, 950.021477877787, 959.4243453927587, 967.5355829202023, 5183.403908550489, 5426.8914621707345, 5428.348598168166, 5430.506610682015, 5458.208559758892, 5702.287214098238, 5710.2869139258055, 5733.913991290134, 5754.769809207669, 5758.337791154071, 5268.394134674485, 5300.867478313073, 5364.678119312854, 5435.809746658848, 5458.317710286215, 2976.895808646687, 2995.4009198160456, 3031.8484075796123, 3036.69633036699, 3037.9645637422977, 5884.852878678067, 5905.970470147622, 5914.231149950565, 5919.733611987471, 5920.934231838224, 5575.358833734173, 5741.770329186786, 5792.0, 5817.767289308465, 5857.121431785266, 5862.824115276549, 5883.528917854512, 5924.851878703067, 5931.169636250928, 5932.161030080689, 5452.263944367618, 5703.971480142573, 5755.53955683536, 5756.971215143897, 5787.56593255516, 5675.772969081356, 5705.088795253637, 5705.657660540215, 5708.543316534584, 5716.942830571641, 5914.704264786829, 5935.376785437639, 5947.9702601486715, 5968.746563221772, 5976.6712830792985, 3898.2398432305426, 4029.979850100848, 4036.2936486114227, 4055.797210139422, 4064.6138616831354, 5724.656520608777, 5781.253904395378, 5782.277215348082, 5789.710514474175, 5792.768289268382, 5468.3711373191, 5661.886762264649, 5669.603127781016, 5685.545156387562, 5714.200011998407, 5508.375029366427, 5531.1426728857095, 5557.305336832896, 5570.136628822539, 5570.972145139248, 5283.709395983258, 5441.183822426668, 5456.7544460498575, 5461.863453413696, 5534.142207957773, 5163.8192663256605, 5437.646552974044, 5523.171524271392, 5537.640053396516, 5538.972305138448, 5410.3507579090765, 5439.619226654255, 5440.483154100354, 5458.2904222450825, 5473.917891231555], "value": 4260.674966582699, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.3722110648163, 794.992050079499, 805.919408059194, 817.5585184000639, 829.1376967953329, 15064.623384415381, 16103.83896161038, 16687.99872007679, 17192.742108868377, 17208.655826883456, 15619.297131629075, 15718.607034824136, 15734.763978540332, 15738.921305393456, 15741.84258157421, 682.6996121706434, 808.4340961327065, 814.6944895664126, 814.9674013039471, 816.4407380944043, 801.4470015689185, 828.0146625515647, 829.8340331933607, 832.8084540555645, 833.2375876073386, 843.4011851585382, 844.2190973349658, 846.5428668518992, 850.1923172985657, 850.7235148576707, 694.1808665774385, 821.7206149909, 845.602566793606, 845.8392905347964, 846.0397448895517, 617.7405489694294, 618.1778234947509, 621.940915613016, 622.0047923322693, 622.8660837919869, 15776.921115394465, 15843.0, 15862.36550537977, 15867.444639437565, 15874.36502539897, 13999.230042347666, 14382.0, 14428.278586070655, 14439.92780036093, 14653.12081275127, 13833.861661383358, 13872.583822485341, 13883.583492495241, 14145.151290922578, 14419.423223071064, 4460.933086003713, 4490.169318676056, 4515.525869783658, 4563.201439748031, 4605.746683932382, 83674.0, 84393.15606843976, 85232.57383713042, 85490.0, 85509.0, 11536.884631153749, 11582.247153934968, 11660.416979151008, 11807.763844723057, 12105.87894121065, 21265.149394024065, 21390.251341202984, 21417.46456338604, 21448.24931127403, 21895.781042189374, 8549.487030778173, 8571.314294856522, 8611.354148438766, 8689.261412779859, 8886.688965886164, 4735.763211839394, 4774.761261936958, 4893.657443978958, 4897.14299997499, 4950.25746138075, 3513.0690367052753, 3603.22530655905, 3609.711223102198, 3610.205754733954, 3634.727395445352, 650.6291413894035, 688.2051230828401, 693.1543516909362, 696.0742212856889, 711.79713781572, 687.2405991379553, 690.2131570010092, 709.9964500177466, 792.8295416485483, 794.2295972906271, 10257.17942564593, 10490.73773155662, 10536.367817930948, 10753.892461075446, 10760.892391076146, 753.9811504712317, 782.6243403166512, 783.4946459533569, 793.4921650143913, 800.9078955920028, 5095.847124586268, 5100.821471248489, 5182.274481572583, 5197.792088316501, 5209.583233341324, 76340.23659763331, 78421.0, 89282.0, 115213.0, 125512.37243813905, 89440.5527972369, 102982.48508757558, 103018.48490757498, 105676.47161764142, 106076.99999999846, 93204.53397732967, 93344.0, 95436.0, 96220.0, 96369.5181524102, 9766.316357854881, 9836.508174591385, 9932.304738668512, 9950.502474876372, 10017.14854237398, 53098.0, 54884.114194768365, 55000.17499737427, 57006.71496642656, 57185.42814571968, 81002.0, 81183.0, 84216.15783842083, 84314.0, 85506.0, 11791.174617776673, 11952.297870653314, 12163.2702037878, 12539.059570532429, 13039.022073344348, 13499.325033748077, 13793.931030345186, 14134.646633834236, 14289.64275893111, 14388.624933597172, 13494.797578036141, 13648.24934628605, 13951.0, 14054.508092216724, 14376.209308488134, 13069.934650326688, 13159.0, 13577.0, 14021.29893505341, 14133.010689252065, 13241.80137297922, 13521.121127126706, 13621.863781362455, 13692.246926419142, 14129.646758831112, 9967.50162491887, 10580.047795698423, 10607.893921060691, 10701.19741019411, 10757.784844302914, 10410.375377477376, 10444.791104178026, 10498.842517362398, 10566.26036177491, 10631.574737010433], "value": 7786.0287192872165, "unit": "score"}], "name": "dromaeo_css", "value": 7328.951820693129, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 134.0, 176.0, 128.0, 159.0, 156.0, 127.0, 181.0, 127.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 161.0, 161.0, 160.0, 162.0, 161.0, 162.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 113.0, 75.0, 77.0, 75.0, 74.0, 104.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 121.0, 84.0, 85.0, 87.0, 120.0, 84.0, 85.0, 126.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 54.0, 54.0, 54.0, 53.0, 54.0, 62.0, 53.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 87.0, 80.0, 80.0, 86.0, 88.0, 143.0, 80.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 122.0, 123.0, 122.0, 121.0, 120.0, 122.0, 120.0, 140.0, 133.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 174.0, 159.0, 159.0, 159.0, 163.0, 160.0, 163.0, 160.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 67.0, 64.0, 67.0, 62.0, 62.0, 62.0, 63.0, 61.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1510.6000000000001, "alertThreshold": 2.0}]} 01:44:26 INFO - Return code: 0 01:44:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:44:26 ERROR - # TBPL SUCCESS # 01:44:26 INFO - Running post-action listener: _resource_record_post_action 01:44:26 INFO - ##### 01:44:26 INFO - ##### Finished run-tests step (success) 01:44:26 INFO - ##### 01:44:26 INFO - Running post-run listener: _resource_record_post_run 01:44:26 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549249024; Read time: 20; Write time: 439304 01:44:26 INFO - TinderboxPrint: CPU usage
13.1% 01:44:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 01:44:26 INFO - TinderboxPrint: I/O write bytes / time
549,249,024 / 439,304 01:44:26 INFO - TinderboxPrint: CPU idle
8,262.8 (86.8%) 01:44:26 INFO - TinderboxPrint: CPU user
1,207.2 (12.7%) 01:44:26 INFO - TinderboxPrint: Swap in / out
0 / 0 01:44:26 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255053824; Read time: 0; Write time: 249856 01:44:26 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293974016; Read time: 20; Write time: 189448 01:44:27 INFO - Running post-run listener: _upload_blobber_files 01:44:27 INFO - Blob upload gear active. 01:44:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:44:27 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 01:44:27 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'] 01:44:27 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 01:44:27 INFO - (blobuploader) - INFO - Open directory for files ... 01:44:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:44:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:44:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:44:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:44:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:44:28 INFO - (blobuploader) - INFO - Done attempting. 01:44:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:44:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:44:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:44:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:44:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:44:32 INFO - (blobuploader) - INFO - Done attempting. 01:44:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:44:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:44:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:44:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:44:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:44:33 INFO - (blobuploader) - INFO - Done attempting. 01:44:33 INFO - (blobuploader) - INFO - Iteration through files over. 01:44:33 INFO - Return code: 0 01:44:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:44:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:44:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/867e724de9468e5315faa2c9acfbf199667cf04d38acee8d85481e70ed87a828817df7155b47d4d1a2f7f74d49964a43aaa3ee8ca30f5c82eacd783728498659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d6898671caf5acf8d2b1b46c9332570943184e290fb3bcbebe47f049dbb8dd6e923d5858bfc87de58615c7bafc2c8d3cd2086b80a92bc8112b44a27a7a7a189", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be8a5de33fc4513ff2ad31b5238d87195ffe93b091e9543f88bda60d89e803cd500a217e38cbdd95dc459e6846f2359d937e7690986310a1853c5797591c3338"} 01:44:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:44:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:44:33 INFO - Contents: 01:44:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/867e724de9468e5315faa2c9acfbf199667cf04d38acee8d85481e70ed87a828817df7155b47d4d1a2f7f74d49964a43aaa3ee8ca30f5c82eacd783728498659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d6898671caf5acf8d2b1b46c9332570943184e290fb3bcbebe47f049dbb8dd6e923d5858bfc87de58615c7bafc2c8d3cd2086b80a92bc8112b44a27a7a7a189", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be8a5de33fc4513ff2ad31b5238d87195ffe93b091e9543f88bda60d89e803cd500a217e38cbdd95dc459e6846f2359d937e7690986310a1853c5797591c3338"} 01:44:33 INFO - Running post-run listener: copy_logs_to_upload_dir 01:44:33 INFO - Copying logs to upload dir... 01:44:33 INFO - mkdir: /builds/slave/test/build/upload/logs 01:44:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.463072 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-06 01:44:33.136255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 01:44:33.139929) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380 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/867e724de9468e5315faa2c9acfbf199667cf04d38acee8d85481e70ed87a828817df7155b47d4d1a2f7f74d49964a43aaa3ee8ca30f5c82eacd783728498659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d6898671caf5acf8d2b1b46c9332570943184e290fb3bcbebe47f049dbb8dd6e923d5858bfc87de58615c7bafc2c8d3cd2086b80a92bc8112b44a27a7a7a189", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be8a5de33fc4513ff2ad31b5238d87195ffe93b091e9543f88bda60d89e803cd500a217e38cbdd95dc459e6846f2359d937e7690986310a1853c5797591c3338"} build_url:https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/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/867e724de9468e5315faa2c9acfbf199667cf04d38acee8d85481e70ed87a828817df7155b47d4d1a2f7f74d49964a43aaa3ee8ca30f5c82eacd783728498659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d6898671caf5acf8d2b1b46c9332570943184e290fb3bcbebe47f049dbb8dd6e923d5858bfc87de58615c7bafc2c8d3cd2086b80a92bc8112b44a27a7a7a189", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be8a5de33fc4513ff2ad31b5238d87195ffe93b091e9543f88bda60d89e803cd500a217e38cbdd95dc459e6846f2359d937e7690986310a1853c5797591c3338"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 01:44:33.165318) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:44:33.165667) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465199871.68005-299041380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:44:33.251399) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 01:44:33.251712) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 01:44:33.252029) ========= ========= Total master_lag: 0.21 =========