builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1465570797.91 results: success (0) buildid: 20160610064032 builduid: bc424c7ae5be49acae6de7605d307785 revision: 52679ce4756c53fd88054a55da482291c26ef8db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:57.909866) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:57.910626) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:57.910957) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:57.927586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:57.928577) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 07:59:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.5M=0s 2016-06-10 07:59:58 (23.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107867 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:58.455492) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:58.455874) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022872 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:58.525736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 07:59:58.526153) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52679ce4756c53fd88054a55da482291c26ef8db --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 52679ce4756c53fd88054a55da482291c26ef8db --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=edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 07:59:58,707 truncating revision to first 12 chars 2016-06-10 07:59:58,707 Setting DEBUG logging. 2016-06-10 07:59:58,707 attempt 1/10 2016-06-10 07:59:58,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52679ce4756c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 07:59:59,684 unpacking tar archive at: mozilla-central-52679ce4756c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.303529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 07:59:59.847137) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:59.847520) ========= script_repo_revision: 52679ce4756c53fd88054a55da482291c26ef8db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:59.847930) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:59.848284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 07:59:59.858180) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-10 07:59:59.858604) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:00 INFO - MultiFileLogger online at 20160610 08:00:00 in /builds/slave/test 08:00:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:00:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:00:00 INFO - {'append_to_log': False, 08:00:00 INFO - 'base_work_dir': '/builds/slave/test', 08:00:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:00:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:00:00 INFO - 'branch': 'Firefox-Non-PGO', 08:00:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:00 INFO - 'config_files': ('talos/linux_config.py',), 08:00:00 INFO - 'default_actions': ('clobber', 08:00:00 INFO - 'read-buildbot-config', 08:00:00 INFO - 'download-and-extract', 08:00:00 INFO - 'populate-webroot', 08:00:00 INFO - 'create-virtualenv', 08:00:00 INFO - 'install', 08:00:00 INFO - 'run-tests'), 08:00:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:00 INFO - 'download_minidump_stackwalk': True, 08:00:00 INFO - 'download_symbols': 'ondemand', 08:00:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:00 INFO - 'installer_path': 'installer.exe', 08:00:00 INFO - 'log_level': 'info', 08:00:00 INFO - 'log_name': 'talos', 08:00:00 INFO - 'log_to_console': True, 08:00:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:00 INFO - 'opt_config_files': (), 08:00:00 INFO - 'pip_index': False, 08:00:00 INFO - 'sps_profile': False, 08:00:00 INFO - 'sps_profile_interval': 0, 08:00:00 INFO - 'suite': 'dromaeojs', 08:00:00 INFO - 'system_bits': '32', 08:00:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:00 INFO - 'title': 'talos-linux64-ix-033', 08:00:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:00 INFO - 'use_talos_json': True, 08:00:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:00:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:00 INFO - 'work_dir': 'build'} 08:00:00 INFO - ##### 08:00:00 INFO - ##### Running clobber step. 08:00:00 INFO - ##### 08:00:00 INFO - Running pre-action listener: _resource_record_pre_action 08:00:00 INFO - Running main action method: clobber 08:00:00 INFO - rmtree: /builds/slave/test/build 08:00:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:00:01 INFO - Running post-action listener: _resource_record_post_action 08:00:01 INFO - ##### 08:00:01 INFO - ##### Finished clobber step (success) 08:00:01 INFO - ##### 08:00:01 INFO - ##### 08:00:01 INFO - ##### Running read-buildbot-config step. 08:00:01 INFO - ##### 08:00:01 INFO - Running pre-action listener: _resource_record_pre_action 08:00:01 INFO - Running main action method: read_buildbot_config 08:00:01 INFO - Using buildbot properties: 08:00:01 INFO - { 08:00:01 INFO - "project": "", 08:00:01 INFO - "product": "firefox", 08:00:01 INFO - "script_repo_revision": "production", 08:00:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:00:01 INFO - "repository": "", 08:00:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:00:01 INFO - "buildid": "20160610064032", 08:00:01 INFO - "pgo_build": "False", 08:00:01 INFO - "basedir": "/builds/slave/test", 08:00:01 INFO - "buildnumber": 528, 08:00:01 INFO - "slavename": "talos-linux64-ix-033", 08:00:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:00:01 INFO - "platform": "ubuntu64_hw", 08:00:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:00:01 INFO - "branch": "mozilla-central", 08:00:01 INFO - "repo_path": "mozilla-central", 08:00:01 INFO - "revision": "52679ce4756c53fd88054a55da482291c26ef8db", 08:00:01 INFO - "stage_platform": "linux64", 08:00:01 INFO - "builduid": "bc424c7ae5be49acae6de7605d307785", 08:00:01 INFO - "slavebuilddir": "test" 08:00:01 INFO - } 08:00:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:00:01 INFO - Running post-action listener: _resource_record_post_action 08:00:01 INFO - ##### 08:00:01 INFO - ##### Finished read-buildbot-config step (success) 08:00:01 INFO - ##### 08:00:01 INFO - ##### 08:00:01 INFO - ##### Running download-and-extract step. 08:00:01 INFO - ##### 08:00:01 INFO - Running pre-action listener: _resource_record_pre_action 08:00:01 INFO - Running main action method: download_and_extract 08:00:01 INFO - mkdir: /builds/slave/test/build/tests 08:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:01 INFO - https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:00:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:00:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:00:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:00:02 INFO - Downloaded 1361 bytes. 08:00:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:00:02 INFO - Using the following test package requirements: 08:00:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:00:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:02 INFO - u'jsshell-linux-x86_64.zip'], 08:00:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:00:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:00:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00: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')]} 08:00:02 INFO - https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:03 INFO - Downloaded 22891291 bytes. 08:00:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:00:04 INFO - Return code: 0 08:00:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:00:04 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')]} 08:00:04 INFO - https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:06 INFO - Downloaded 22891291 bytes. 08:00:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:00:07 INFO - Return code: 0 08:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:07 INFO - https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:00:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:00:09 INFO - Downloaded 10833377 bytes. 08:00:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:00:09 INFO - Return code: 0 08:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:09 INFO - https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:00:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:00:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:00:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:00:12 INFO - Downloaded 55392537 bytes. 08:00:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:00:12 INFO - mkdir: /builds/slave/test/properties 08:00:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:00:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:00:12 INFO - Contents: 08:00:12 INFO - build_url:https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:00:13 INFO - Running post-action listener: _resource_record_post_action 08:00:13 INFO - Running post-action listener: set_extra_try_arguments 08:00:13 INFO - ##### 08:00:13 INFO - ##### Finished download-and-extract step (success) 08:00:13 INFO - ##### 08:00:13 INFO - ##### 08:00:13 INFO - ##### Running populate-webroot step. 08:00:13 INFO - ##### 08:00:13 INFO - Running pre-action listener: _resource_record_pre_action 08:00:13 INFO - Running main action method: populate_webroot 08:00:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:13 INFO - '--tppagecycles', 08:00:13 INFO - '7'], 08:00:13 INFO - 'tests': ['tsvgm']}}, 08:00:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:00:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:00:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['damp', 'tps']}, 08:00:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'tests': ['damp', 'tps']}, 08:00:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['dromaeo_dom']}, 08:00:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['tsvgx', 08:00:13 INFO - 'tsvgr_opacity', 08:00:13 INFO - 'tart', 08:00:13 INFO - 'tscrollx', 08:00:13 INFO - 'cart']}, 08:00:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:00:13 INFO - 'tsvgr_opacity', 08:00:13 INFO - 'tart', 08:00:13 INFO - 'tscrollx', 08:00:13 INFO - 'cart']}, 08:00:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['tp5o']}, 08:00:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'tests': ['tp5o']}, 08:00:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'talos_options': ['--disable-e10s', 08:00:13 INFO - '--xperf_path', 08:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:13 INFO - 'tests': ['tp5n']}, 08:00:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'talos_options': ['--xperf_path', 08:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:13 INFO - 'tests': ['tp5n']}}, 08:00:13 INFO - 'talos.zip': {'path': '', 08:00:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:13 INFO - Running post-action listener: _resource_record_post_action 08:00:13 INFO - ##### 08:00:13 INFO - ##### Finished populate-webroot step (success) 08:00:13 INFO - ##### 08:00:13 INFO - ##### 08:00:13 INFO - ##### Running create-virtualenv step. 08:00:13 INFO - ##### 08:00:13 INFO - Running pre-action listener: _resource_record_pre_action 08:00:13 INFO - Running main action method: create_virtualenv 08:00:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:00:13 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 08:00:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:00:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:13 INFO - Using real prefix '/usr' 08:00:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:00:13 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:15 INFO - Installing pip.................done. 08:00:15 INFO - Return code: 0 08:00:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:15 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 0x7fc235dd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', '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 08:00:15 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 08:00:15 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 08:00:15 INFO - Using env: {'DISPLAY': ':0', 08:00:15 INFO - 'HOME': '/home/cltbld', 08:00:15 INFO - 'LANG': 'en_US.UTF-8', 08:00:15 INFO - 'LANGUAGE': 'en_US:en', 08:00:15 INFO - 'LOGNAME': 'cltbld', 08:00:15 INFO - 'MAIL': '/var/mail/cltbld', 08:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:15 INFO - 'MOZ_NO_REMOTE': '1', 08:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:15 INFO - 'NO_EM_RESTART': '1', 08:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:15 INFO - 'PWD': '/builds/slave/test', 08:00:15 INFO - 'SHELL': '/bin/bash', 08:00:15 INFO - 'SHLVL': '1', 08:00:15 INFO - 'TERM': 'linux', 08:00:15 INFO - 'TMOUT': '86400', 08:00:15 INFO - 'USER': 'cltbld', 08:00:15 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', 08:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:15 INFO - '_': '/tools/buildbot/bin/python'} 08:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:15 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 08:00:15 INFO - Cleaning up... 08:00:15 INFO - Return code: 0 08:00:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:15 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 0x7fc235dd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', '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 08:00:15 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 08:00:15 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 08:00:15 INFO - Using env: {'DISPLAY': ':0', 08:00:15 INFO - 'HOME': '/home/cltbld', 08:00:15 INFO - 'LANG': 'en_US.UTF-8', 08:00:15 INFO - 'LANGUAGE': 'en_US:en', 08:00:15 INFO - 'LOGNAME': 'cltbld', 08:00:15 INFO - 'MAIL': '/var/mail/cltbld', 08:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:15 INFO - 'MOZ_NO_REMOTE': '1', 08:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:15 INFO - 'NO_EM_RESTART': '1', 08:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:15 INFO - 'PWD': '/builds/slave/test', 08:00:15 INFO - 'SHELL': '/bin/bash', 08:00:15 INFO - 'SHLVL': '1', 08:00:15 INFO - 'TERM': 'linux', 08:00:15 INFO - 'TMOUT': '86400', 08:00:15 INFO - 'USER': 'cltbld', 08:00:15 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', 08:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:15 INFO - '_': '/tools/buildbot/bin/python'} 08:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:16 INFO - Downloading/unpacking psutil>=3.1.1 08:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:18 INFO - Installing collected packages: psutil 08:00:18 INFO - Running setup.py install for psutil 08:00:18 INFO - building 'psutil._psutil_linux' extension 08:00:18 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 08:00:18 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 08:00:18 INFO - building 'psutil._psutil_posix' extension 08:00:18 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 08:00:18 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 08:00:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:18 INFO - Successfully installed psutil 08:00:18 INFO - Cleaning up... 08:00:18 INFO - Return code: 0 08:00:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:18 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 0x7fc235dd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', '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 08:00:18 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 08:00:18 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 08:00:18 INFO - Using env: {'DISPLAY': ':0', 08:00:18 INFO - 'HOME': '/home/cltbld', 08:00:18 INFO - 'LANG': 'en_US.UTF-8', 08:00:18 INFO - 'LANGUAGE': 'en_US:en', 08:00:18 INFO - 'LOGNAME': 'cltbld', 08:00:18 INFO - 'MAIL': '/var/mail/cltbld', 08:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:18 INFO - 'MOZ_NO_REMOTE': '1', 08:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:18 INFO - 'NO_EM_RESTART': '1', 08:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:18 INFO - 'PWD': '/builds/slave/test', 08:00:18 INFO - 'SHELL': '/bin/bash', 08:00:18 INFO - 'SHLVL': '1', 08:00:18 INFO - 'TERM': 'linux', 08:00:18 INFO - 'TMOUT': '86400', 08:00:18 INFO - 'USER': 'cltbld', 08:00:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', 08:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:18 INFO - '_': '/tools/buildbot/bin/python'} 08:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:00:20 INFO - Installing collected packages: mozsystemmonitor 08:00:20 INFO - Running setup.py install for mozsystemmonitor 08:00:20 INFO - Successfully installed mozsystemmonitor 08:00:20 INFO - Cleaning up... 08:00:20 INFO - Return code: 0 08:00:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc235dd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', '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 08:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:00:20 INFO - Using env: {'DISPLAY': ':0', 08:00:20 INFO - 'HOME': '/home/cltbld', 08:00:20 INFO - 'LANG': 'en_US.UTF-8', 08:00:20 INFO - 'LANGUAGE': 'en_US:en', 08:00:20 INFO - 'LOGNAME': 'cltbld', 08:00:20 INFO - 'MAIL': '/var/mail/cltbld', 08:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:20 INFO - 'MOZ_NO_REMOTE': '1', 08:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:20 INFO - 'NO_EM_RESTART': '1', 08:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:20 INFO - 'PWD': '/builds/slave/test', 08:00:20 INFO - 'SHELL': '/bin/bash', 08:00:20 INFO - 'SHLVL': '1', 08:00:20 INFO - 'TERM': 'linux', 08:00:20 INFO - 'TMOUT': '86400', 08:00:20 INFO - 'USER': 'cltbld', 08:00:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', 08:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:20 INFO - '_': '/tools/buildbot/bin/python'} 08:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:21 INFO - Downloading/unpacking jsonschema==2.5.1 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:00:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:00:23 INFO - warning: no files found matching '*.txt' 08:00:23 INFO - no previously-included directories found matching 'build' 08:00:23 INFO - no previously-included directories found matching 'dist' 08:00:23 INFO - no previously-included directories found matching '.git*' 08:00:23 INFO - Installing collected packages: jsonschema, functools32 08:00:23 INFO - Running setup.py install for functools32 08:00:23 INFO - warning: no files found matching '*.txt' 08:00:23 INFO - no previously-included directories found matching 'build' 08:00:23 INFO - no previously-included directories found matching 'dist' 08:00:23 INFO - no previously-included directories found matching '.git*' 08:00:23 INFO - Successfully installed jsonschema functools32 08:00:23 INFO - Cleaning up... 08:00:23 INFO - Return code: 0 08:00:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc235dd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', '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 08:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:00:23 INFO - Using env: {'DISPLAY': ':0', 08:00:23 INFO - 'HOME': '/home/cltbld', 08:00:23 INFO - 'LANG': 'en_US.UTF-8', 08:00:23 INFO - 'LANGUAGE': 'en_US:en', 08:00:23 INFO - 'LOGNAME': 'cltbld', 08:00:23 INFO - 'MAIL': '/var/mail/cltbld', 08:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:23 INFO - 'MOZ_NO_REMOTE': '1', 08:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:23 INFO - 'NO_EM_RESTART': '1', 08:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:23 INFO - 'PWD': '/builds/slave/test', 08:00:23 INFO - 'SHELL': '/bin/bash', 08:00:23 INFO - 'SHLVL': '1', 08:00:23 INFO - 'TERM': 'linux', 08:00:23 INFO - 'TMOUT': '86400', 08:00:23 INFO - 'USER': 'cltbld', 08:00:23 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', 08:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:23 INFO - '_': '/tools/buildbot/bin/python'} 08:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:23 INFO - Downloading/unpacking blobuploader==1.2.4 08:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:00:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:26 INFO - Downloading docopt-0.6.1.tar.gz 08:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:26 INFO - Running setup.py install for blobuploader 08:00:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:00:26 INFO - Running setup.py install for requests 08:00:26 INFO - Running setup.py install for docopt 08:00:26 INFO - Successfully installed blobuploader requests docopt 08:00:26 INFO - Cleaning up... 08:00:26 INFO - Return code: 0 08:00:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00: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')]} 08:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc235dd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', '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 08:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:26 INFO - Using env: {'DISPLAY': ':0', 08:00:26 INFO - 'HOME': '/home/cltbld', 08:00:26 INFO - 'LANG': 'en_US.UTF-8', 08:00:26 INFO - 'LANGUAGE': 'en_US:en', 08:00:26 INFO - 'LOGNAME': 'cltbld', 08:00:26 INFO - 'MAIL': '/var/mail/cltbld', 08:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:26 INFO - 'MOZ_NO_REMOTE': '1', 08:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:26 INFO - 'NO_EM_RESTART': '1', 08:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:26 INFO - 'PWD': '/builds/slave/test', 08:00:26 INFO - 'SHELL': '/bin/bash', 08:00:26 INFO - 'SHLVL': '1', 08:00:26 INFO - 'TERM': 'linux', 08:00:26 INFO - 'TMOUT': '86400', 08:00:26 INFO - 'USER': 'cltbld', 08:00:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', 08:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:26 INFO - '_': '/tools/buildbot/bin/python'} 08:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:27 INFO - Running setup.py (path:/tmp/pip-2KXqmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:27 INFO - Running setup.py (path:/tmp/pip-WyHHoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:27 INFO - Running setup.py (path:/tmp/pip-R8HhZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:27 INFO - Running setup.py (path:/tmp/pip-5Onnbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:27 INFO - Running setup.py (path:/tmp/pip-OoZY6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:27 INFO - Running setup.py (path:/tmp/pip-5Fht3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:27 INFO - Running setup.py (path:/tmp/pip-IkuZFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:27 INFO - Running setup.py (path:/tmp/pip-ORLL_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:27 INFO - Running setup.py (path:/tmp/pip-pfPLqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:27 INFO - Running setup.py (path:/tmp/pip-avoV_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:27 INFO - Running setup.py (path:/tmp/pip-YMwAeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:27 INFO - Running setup.py (path:/tmp/pip-0kFlHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:28 INFO - Running setup.py (path:/tmp/pip-v6z68_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:28 INFO - Running setup.py (path:/tmp/pip-ZizMuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:28 INFO - Running setup.py (path:/tmp/pip-Xfa6qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:28 INFO - Running setup.py (path:/tmp/pip-5JmbPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:28 INFO - Running setup.py (path:/tmp/pip-zHF6iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:28 INFO - Running setup.py install for manifestparser 08:00:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:00:28 INFO - Running setup.py install for mozcrash 08:00:28 INFO - Running setup.py install for mozdebug 08:00:28 INFO - Running setup.py install for mozdevice 08:00:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:00:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:00:28 INFO - Running setup.py install for mozfile 08:00:28 INFO - Running setup.py install for mozhttpd 08:00:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Running setup.py install for mozinfo 08:00:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Running setup.py install for mozInstall 08:00:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Running setup.py install for mozleak 08:00:29 INFO - Running setup.py install for mozlog 08:00:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Running setup.py install for moznetwork 08:00:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Running setup.py install for mozprocess 08:00:29 INFO - Running setup.py install for mozprofile 08:00:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Running setup.py install for mozrunner 08:00:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Running setup.py install for mozscreenshot 08:00:29 INFO - Running setup.py install for moztest 08:00:30 INFO - Running setup.py install for mozversion 08:00:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:30 INFO - Cleaning up... 08:00:30 INFO - Return code: 0 08:00:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00: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')]} 08:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:30 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 0x7fc235dd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', '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 08:00:30 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 08:00:30 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 08:00:30 INFO - Using env: {'DISPLAY': ':0', 08:00:30 INFO - 'HOME': '/home/cltbld', 08:00:30 INFO - 'LANG': 'en_US.UTF-8', 08:00:30 INFO - 'LANGUAGE': 'en_US:en', 08:00:30 INFO - 'LOGNAME': 'cltbld', 08:00:30 INFO - 'MAIL': '/var/mail/cltbld', 08:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:30 INFO - 'MOZ_NO_REMOTE': '1', 08:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:30 INFO - 'NO_EM_RESTART': '1', 08:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:30 INFO - 'PWD': '/builds/slave/test', 08:00:30 INFO - 'SHELL': '/bin/bash', 08:00:30 INFO - 'SHLVL': '1', 08:00:30 INFO - 'TERM': 'linux', 08:00:30 INFO - 'TMOUT': '86400', 08:00:30 INFO - 'USER': 'cltbld', 08:00:30 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', 08:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:30 INFO - '_': '/tools/buildbot/bin/python'} 08:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:30 INFO - Running setup.py (path:/tmp/pip-B6Ew0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:30 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)) 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:30 INFO - Running setup.py (path:/tmp/pip-vJQU59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:30 INFO - Running setup.py (path:/tmp/pip-TdwyKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:30 INFO - Running setup.py (path:/tmp/pip-CDbmGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:30 INFO - Running setup.py (path:/tmp/pip-MOZf2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:30 INFO - Running setup.py (path:/tmp/pip-i0EH5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:30 INFO - Running setup.py (path:/tmp/pip-pZ0n7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:30 INFO - Running setup.py (path:/tmp/pip-BOjqRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:30 INFO - Running setup.py (path:/tmp/pip-FoVQ40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:31 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)) 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:31 INFO - Running setup.py (path:/tmp/pip-tVWTHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:31 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)) 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:31 INFO - Running setup.py (path:/tmp/pip-oem5sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:31 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)) 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:31 INFO - Running setup.py (path:/tmp/pip-AbK7UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:31 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)) 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:31 INFO - Running setup.py (path:/tmp/pip-X1eiD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:31 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)) 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:31 INFO - Running setup.py (path:/tmp/pip-oyeCOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:31 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)) 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:31 INFO - Running setup.py (path:/tmp/pip-f45F43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:31 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)) 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:31 INFO - Running setup.py (path:/tmp/pip-vUYnHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:31 INFO - Running setup.py (path:/tmp/pip-5rSmjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:33 INFO - Downloading blessings-1.6.tar.gz 08:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:33 INFO - Installing collected packages: blessings 08:00:33 INFO - Running setup.py install for blessings 08:00:33 INFO - Successfully installed blessings 08:00:33 INFO - Cleaning up... 08:00:33 INFO - Return code: 0 08:00:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:00:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:33 INFO - Reading from file tmpfile_stdout 08:00:33 INFO - Current package versions: 08:00:33 INFO - argparse == 1.2.1 08:00:33 INFO - blessings == 1.6 08:00:33 INFO - blobuploader == 1.2.4 08:00:33 INFO - docopt == 0.6.1 08:00:33 INFO - functools32 == 3.2.3-2 08:00:33 INFO - jsonschema == 2.5.1 08:00:33 INFO - manifestparser == 1.1 08:00:33 INFO - mozInstall == 1.12 08:00:33 INFO - mozcrash == 0.17 08:00:33 INFO - mozdebug == 0.1 08:00:33 INFO - mozdevice == 0.48 08:00:33 INFO - mozfile == 1.2 08:00:33 INFO - mozhttpd == 0.7 08:00:33 INFO - mozinfo == 0.9 08:00:33 INFO - mozleak == 0.1 08:00:33 INFO - mozlog == 3.2 08:00:33 INFO - moznetwork == 0.27 08:00:33 INFO - mozprocess == 0.22 08:00:33 INFO - mozprofile == 0.28 08:00:33 INFO - mozrunner == 6.11 08:00:33 INFO - mozscreenshot == 0.1 08:00:33 INFO - mozsystemmonitor == 0.3 08:00:33 INFO - moztest == 0.7 08:00:33 INFO - mozversion == 1.4 08:00:33 INFO - psutil == 3.1.1 08:00:33 INFO - requests == 1.2.3 08:00:33 INFO - wsgiref == 0.1.2 08:00:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc235dd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', '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 08:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:33 INFO - Using env: {'DISPLAY': ':0', 08:00:33 INFO - 'HOME': '/home/cltbld', 08:00:33 INFO - 'LANG': 'en_US.UTF-8', 08:00:33 INFO - 'LANGUAGE': 'en_US:en', 08:00:33 INFO - 'LOGNAME': 'cltbld', 08:00:33 INFO - 'MAIL': '/var/mail/cltbld', 08:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:33 INFO - 'MOZ_NO_REMOTE': '1', 08:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:33 INFO - 'NO_EM_RESTART': '1', 08:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:33 INFO - 'PWD': '/builds/slave/test', 08:00:33 INFO - 'SHELL': '/bin/bash', 08:00:33 INFO - 'SHLVL': '1', 08:00:33 INFO - 'TERM': 'linux', 08:00:33 INFO - 'TMOUT': '86400', 08:00:33 INFO - 'USER': 'cltbld', 08:00:33 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', 08:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:33 INFO - '_': '/tools/buildbot/bin/python'} 08:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:34 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)) 08:00:34 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)) 08:00:34 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)) 08:00:34 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)) 08:00:34 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)) 08:00:34 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)) 08:00:34 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)) 08:00:34 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)) 08:00:34 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)) 08:00:34 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)) 08:00:34 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)) 08:00:34 INFO - Cleaning up... 08:00:34 INFO - Return code: 0 08:00:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:00:34 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')]} 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:34 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')]} 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:34 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 0x7fc235dd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', '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 08:00:34 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 08:00:34 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 08:00:34 INFO - Using env: {'DISPLAY': ':0', 08:00:34 INFO - 'HOME': '/home/cltbld', 08:00:34 INFO - 'LANG': 'en_US.UTF-8', 08:00:34 INFO - 'LANGUAGE': 'en_US:en', 08:00:34 INFO - 'LOGNAME': 'cltbld', 08:00:34 INFO - 'MAIL': '/var/mail/cltbld', 08:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:34 INFO - 'MOZ_NO_REMOTE': '1', 08:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:34 INFO - 'NO_EM_RESTART': '1', 08:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:34 INFO - 'PWD': '/builds/slave/test', 08:00:34 INFO - 'SHELL': '/bin/bash', 08:00:34 INFO - 'SHLVL': '1', 08:00:34 INFO - 'TERM': 'linux', 08:00:34 INFO - 'TMOUT': '86400', 08:00:34 INFO - 'USER': 'cltbld', 08:00:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', 08:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:34 INFO - '_': '/tools/buildbot/bin/python'} 08:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:00:34 INFO - Cleaning up... 08:00:34 INFO - Return code: 0 08:00:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:00:34 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')]} 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:34 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')]} 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:34 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 0x7fc235dd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', '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 08:00:34 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 08:00:34 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 08:00:34 INFO - Using env: {'DISPLAY': ':0', 08:00:34 INFO - 'HOME': '/home/cltbld', 08:00:34 INFO - 'LANG': 'en_US.UTF-8', 08:00:34 INFO - 'LANGUAGE': 'en_US:en', 08:00:34 INFO - 'LOGNAME': 'cltbld', 08:00:34 INFO - 'MAIL': '/var/mail/cltbld', 08:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:34 INFO - 'MOZ_NO_REMOTE': '1', 08:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:34 INFO - 'NO_EM_RESTART': '1', 08:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:34 INFO - 'PWD': '/builds/slave/test', 08:00:34 INFO - 'SHELL': '/bin/bash', 08:00:34 INFO - 'SHLVL': '1', 08:00:34 INFO - 'TERM': 'linux', 08:00:34 INFO - 'TMOUT': '86400', 08:00:34 INFO - 'USER': 'cltbld', 08:00:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', 08:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:34 INFO - '_': '/tools/buildbot/bin/python'} 08:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:34 INFO - Downloading/unpacking flake8 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:00:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:00:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:00:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:37 INFO - no previously-included directories found matching 'docs/_build' 08:00:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:00:37 INFO - Running setup.py install for pep8 08:00:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:37 INFO - no previously-included directories found matching 'docs/_build' 08:00:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:00:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:00:37 INFO - Cleaning up... 08:00:38 INFO - Return code: 0 08:00:38 INFO - Running post-action listener: _resource_record_post_action 08:00:38 INFO - Running post-action listener: _start_resource_monitoring 08:00:38 INFO - Starting resource monitoring. 08:00:38 INFO - ##### 08:00:38 INFO - ##### Finished create-virtualenv step (success) 08:00:38 INFO - ##### 08:00:38 INFO - ##### 08:00:38 INFO - ##### Running install step. 08:00:38 INFO - ##### 08:00:38 INFO - Running pre-action listener: _resource_record_pre_action 08:00:38 INFO - Running main action method: install 08:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:38 INFO - Reading from file tmpfile_stdout 08:00:38 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:00:38 INFO - Reading from file tmpfile_stdout 08:00:38 INFO - Output received: 08:00:38 INFO - Usage: mozinstall [options] installer 08:00:38 INFO - Options: 08:00:38 INFO - -h, --help show this help message and exit 08:00:38 INFO - -d DEST, --destination=DEST 08:00:38 INFO - Directory to install application into. [default: 08:00:38 INFO - "/builds/slave/test"] 08:00:38 INFO - --app=APP Application being installed. [default: firefox] 08:00:38 INFO - mkdir: /builds/slave/test/build/application 08:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:00:54 INFO - Reading from file tmpfile_stdout 08:00:54 INFO - Output received: 08:00:54 INFO - /builds/slave/test/build/application/firefox/firefox 08:00:54 INFO - Running post-action listener: _resource_record_post_action 08:00:54 INFO - ##### 08:00:54 INFO - ##### Finished install step (success) 08:00:54 INFO - ##### 08:00:54 INFO - ##### 08:00:54 INFO - ##### Running run-tests step. 08:00:54 INFO - ##### 08:00:54 INFO - Running pre-action listener: _resource_record_pre_action 08:00:54 INFO - Running main action method: run_tests 08:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:00:54 INFO - Python 2.7.3 08:00:54 INFO - Return code: 0 08:00:54 INFO - grabbing minidump binary from tooltool 08:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:54 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 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:00:54 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 08:00:54 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 08:00:54 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 08:00:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:00:54 INFO - Return code: 0 08:00:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:00:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:00:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:00:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:00:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:00:55 INFO - Return code: 0 08:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 08:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 08:00:55 INFO - Using env: {'DISPLAY': ':0', 08:00:55 INFO - 'HOME': '/home/cltbld', 08:00:55 INFO - 'LANG': 'en_US.UTF-8', 08:00:55 INFO - 'LANGUAGE': 'en_US:en', 08:00:55 INFO - 'LOGNAME': 'cltbld', 08:00:55 INFO - 'MAIL': '/var/mail/cltbld', 08:00:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:55 INFO - 'MOZ_NO_REMOTE': '1', 08:00:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:55 INFO - 'NO_EM_RESTART': '1', 08:00:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:55 INFO - 'PWD': '/builds/slave/test', 08:00:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:55 INFO - 'SHELL': '/bin/bash', 08:00:55 INFO - 'SHLVL': '1', 08:00:55 INFO - 'TERM': 'linux', 08:00:55 INFO - 'TMOUT': '86400', 08:00:55 INFO - 'USER': 'cltbld', 08:00:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063', 08:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:55 INFO - '_': '/tools/buildbot/bin/python'} 08:00:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 08:00:55 INFO - mozversion application_buildid: 20160610064032 08:00:55 INFO - mozversion application_changeset: 52679ce4756c53fd88054a55da482291c26ef8db 08:00:55 INFO - mozversion application_display_name: Nightly 08:00:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:00:55 INFO - mozversion application_name: Firefox 08:00:55 INFO - mozversion application_remotingname: firefox 08:00:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:00:55 INFO - mozversion application_vendor: Mozilla 08:00:55 INFO - mozversion application_version: 50.0a1 08:00:55 INFO - mozversion platform_buildid: 20160610064032 08:00:55 INFO - mozversion platform_changeset: 52679ce4756c53fd88054a55da482291c26ef8db 08:00:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:00:55 INFO - mozversion platform_version: 50.0a1 08:00:55 INFO - using testdate: 1465570855 08:00:55 INFO - actual date: 1465570855 08:00:55 INFO - starting webserver on 'localhost:51256' 08:00:55 INFO - SUITE-START | Running 2 tests 08:00:55 INFO - TEST-START | dromaeo_css 08:00:55 INFO - operating with platform_type : linux_ 08:00:55 INFO - Initialising browser for dromaeo_css test... 08:00:55 INFO - TEST-INFO | started process 19322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjwCLtD/profile http://localhost:51256/getInfo.html) 08:01:00 INFO - PROCESS | 19322 | __metrics Screen width/height:1600/1200 08:01:00 INFO - PROCESS | 19322 | colorDepth:24 08:01:00 INFO - PROCESS | 19322 | Browser inner width/height: 1024/697 08:01:00 INFO - PROCESS | 19322 | __metrics 08:01:02 ERROR - PROCESS | 19322 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:01:02 INFO - PROCESS | 19322 | console.error: PushService: 08:01:02 INFO - PROCESS | 19322 | stateChangeProcessEnqueue: Error transitioning state 08:01:02 INFO - PROCESS | 19322 | UnknownError 08:01:03 INFO - TEST-INFO | 19322: exit 0 08:01:03 INFO - Browser initialized. 08:01:03 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:03 INFO - TEST-INFO | started process 19401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjwCLtD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:15 INFO - PROCESS | 19401 | RSS: Main: 178913280 08:01:15 INFO - PROCESS | 19401 | 08:02:06 INFO - PROCESS | 19401 | 1465570926880 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] 08:04:18 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51256/tests/dromaeo/cssquery-ext.html) 08:04:19 INFO - PROCESS | 19401 | RSS: Main: 258052096 08:04:19 INFO - PROCESS | 19401 | 08:07:22 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-ext.html (next: http://localhost:51256/tests/dromaeo/cssquery-jquery.html) 08:07:23 INFO - PROCESS | 19401 | RSS: Main: 263892992 08:07:23 INFO - PROCESS | 19401 | 08:10:25 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51256/tests/dromaeo/cssquery-mootools.html) 08:10:26 INFO - PROCESS | 19401 | RSS: Main: 268914688 08:10:26 INFO - PROCESS | 19401 | 08:13:28 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51256/tests/dromaeo/cssquery-prototype.html) 08:13:28 INFO - PROCESS | 19401 | RSS: Main: 255733760 08:13:28 INFO - PROCESS | 19401 | 08:16:31 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51256/tests/dromaeo/cssquery-yui.html) 08:16:32 INFO - PROCESS | 19401 | RSS: Main: 233451520 08:16:32 INFO - PROCESS | 19401 | 08:19:35 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-yui.html (next: http://localhost:51256/tests/dromaeo/cssquery-dojo.html) 08:19:35 INFO - PROCESS | 19401 | RSS: Main: 300728320 08:19:35 INFO - PROCESS | 19401 | 08:19:35 INFO - PROCESS | 19401 | __start_tp_report 08:19:35 INFO - PROCESS | 19401 | _x_x_mozilla_page_load 08:19:35 INFO - PROCESS | 19401 | _x_x_mozilla_page_load_details 08:19:35 INFO - PROCESS | 19401 | |i|pagename|runs| 08:19:35 INFO - PROCESS | 19401 | |0;dojo.html;2517.9118730844425;2545.1473756291643;2549.592065269556;2576.7165611782707;2611.738826117388;4628.560286772759;4662.557057079572;4665.556772106649;4670.743109128996;4682.274247491636;4624.09830083134;4657.720536767796;4673.345731597579;4680.368150299709;4683.765811709418;4084.611961863633;4243.978780106103;4325.805338759764;4346.391505189276;4497.550244975509;4403.405540252073;4435.711678740871;4446.844360447385;4460.442444694413;4492.505824359318;4130.524989626201;4157.293260145752;4196.412502249687;4286.271333873249;4342.826286948518;4183.058811767359;4200.306949353353;4238.491381034296;4239.321708526621;4246.723962942398;4227.8097485613225;4249.405083288342;4250.128723611652;4271.765052922088;4288.292431748758;4617.561331673485;4687.390639216914;4731.5268473152755;4752.049590081963;4764.499727528594;5110.28456016158;5113.207452844815;5133.4609865964285;5146.922796158024;5149.871253218662;4956.578690811285;4966.230234313687;5143.742812859342;5174.7671354788745;5188.507091826308;4670.3461515387535;4716.834910778106;4734.26618874075;4739.241721324641;4742.241241401428;5146.974265128651;5162.328897243335;5168.121419358718;5169.767360468788;5173.870653233624;4879.878003049952;4887.0714564232685;4940.333055037596;5048.469910659402;5054;5009.599232061426;5030.723310217973;5033.2701758245585;5037.29477873098;5085.110105731482;4974.427940786783;4977.477364876709;4981.800727970913;4987.80048798044;5021.774020169101;4876.804927802848;4967.5777558907175;5004.3994720633755;5013.674111182834;5020.824271150492;4209.368594710757;4226.830926762957;4232.894177645583;4264.552222016706;4280.16536775332;3678.4114541673202;3691.7600355976774;3706.1475860552223;3730.570984336836;3743.47591337213;4316.223079845658;4334.306510958231;4342;4363.52001279859;4420.204363214652;5010.048090862724;5024.648274620741;5025.070361983045;5028.421731500925;5086.92369614456;4342.413774140514;4357.607815296638;4365.934510982338;4389.934150987738;4396.582324679151;4336.262835318003;4372.803223854934;4459.308807134899;4548.5906268436;4588.95411045892;4826.686265392878;4850.95149048505;4855.805767769391;4888.291197776302;4895.290182923527;5136.512031357015;5138.07514647367;5139.229115632685;5143.6399452039495;5143.974280128576;4682.41469816273;4762.833300834454;4802.399700037496;4821.108095002436;4876.171050921423;5048.823291184791;5052.418971818288;5053.267276244997;5069.112905241494;5073.720945347894;5120.820771272987;5130.48695130484;5136.101182293009;5140.56305214061;5141.897162056663;4821.373221481185;4864.6594738369395;4921;4929.704217746947;4944.085344211332;4908.460069392293;4936.703797772145;4936.7284799336385;4941.975290123526;4988.600911926965;4724.692894961817;4854.660173787942;4867.975660121677;4868.902621947612;4947.2579113133315;4944.802207911644;4958.603311734981;4974.452810190804;4982.153033984159;5002.2496625506465;4896.11869863428;4896.755162241945;4899.069176856528;4900.4854490278;4946 08:19:35 INFO - PROCESS | 19401 | |1;ext.html;570.7517230004948;592.2330581896443;595.5592861282652;598.6228675934161;603.9547033972453;39259.41110883339;41225.58774412255;41295;44363;44475;40952;41097.58902410975;41227.38158927611;41382.79308603453;41527;7616.543007419545;7909.960450197741;8051.557164355958;8055.15420880805;10151.390916544993;10022.699319020441;10382.532786024647;10396.792064158712;10401.635942742005;10404.843927341097;10380.584776608926;10422.218333624971;10425.218108641844;10425.530851111718;10428.89571104287;7707.845843083135;10071.194304455626;10321.638742644009;10360.119389851872;10371.325863818827;10230.641927532575;10276.94861525695;10287.12559432449;10292.279540432173;10296.691099267035;38512.807435962925;38657.613423865965;38827.41758873619;38876.61123388758;38902.61097389018;2912.388398436331;2922.1963959911195;2933.1054028521294;2996.4306781711407;3072.0937323489625;29680.406391872042;30242;30353.392932141454;30507.542386864214;31169.84415077933;3342.5821772278464;3442.6385229550788;3452.3613131570487;3462.082548124749;3512.8770493032875;254589;255110;255655.72172139207;256155;256340;33380.16549586231;53558;54058.729706351216;54166.72916635471;54179.18731219035;34081.829590851885;34117.658823411446;34207.65792342094;34267.485987710206;34272.82863585716;12955.417006234742;13056.608301750963;13070;13082;13119.540816071392;10265;10578.788424231472;10715.571377144983;10749.40878251688;10964.671059868217;7917.129115797257;7947.966764320601;7955;8008.519488830689;8039.196080392031;3082.9383412331626;3085.799423037495;3142.9471127172196;3150.33842892995;3152.2907345847;793.8015496125969;841.3857883744901;888.853379140914;931.29221791439;1015.4668798880647;26696.59955100675;27913.162605121877;28121.296967575974;28263.29341766472;28465.71534284672;926.2775035472342;942.2509105261333;953.7901661634429;959.7456673981401;1044.3107549017611;14364.569062928129;14779.26103694811;14846.777298340534;14871.47949821751;14877.776833347292;374384;379623;380030;380077;381188;51451.48548514467;51903;51996.480035199165;52008.73995629998;52025.219621705706;1060.3213943076437;1146.18620779246;1175.1480176871871;1195.276857501234;1196.2164782067587;28181;29403.85298073496;29563.26091847721;29798.404031918806;29844;42317.576824231364;42455.36316955186;43017.569824301354;43085;43193;313998;315950;315965;316137;316278;22681;23427.88286058559;25843.741562584135;26709;26838;41324.38013429861;41691.79154104331;42110;43018.139637206456;43062.78468607762;35716;36193.27613447663;36357;36435;36690.63309366872;36240;36280;36487;36526.26947461089;37709.24581508409;37044.259114818095;37202.8139859299;37414.8129259352;37823.81088094652;38123.42814857724;32037.839810800797;33433.83283083569;33698.66301336955;33794;33813.66186338203;25395.746042539336;25526.744732552437;25974;26019.739802601733;26434.471310574067 08:19:35 INFO - PROCESS | 19401 | |2;jquery.html;362.7932078715132;365.27857481474086;372.3558244237469;375.68442508293026;390.9882703518895;15753.684926301466;16415.507534773962;17252.48242552722;17266.740998885012;17278.56803579911;16651.25069371881;16664;16883.83116168841;17227.22477488513;17265;4853.102176097415;5095.9745201273945;5128.871778205537;5130.410002849682;5131.461196574362;3780.1494663700587;3958.010497375656;5080.923786143211;5577.972110139443;5903;5897.705114744267;5910.822675319747;5920.644761314314;5933.34733179352;5938.792142275;5810.535157187415;5865;5946.851328716795;5967.254093238345;5993.730282137336;3400.387930172568;4850.75746212688;5112.463191364927;5138.640295179339;5257.421683614799;17577.56056098595;17582.824171758373;18116.365927192484;20645;20694.5861082779;1973.8618296719235;2110.609537235601;2291.873946932918;2437.2322718343844;2463.519613675334;12891.290978996152;13082.542111026069;13220.338983050906;13286.402111904987;13612.591622251348;1718.7593736876847;1728.1013872786082;1731.3161301286048;1742.4337090445656;1798.082977681379;66082;74718.62640686762;81575.5921220396;87391;88926.55536722275;16764.916175419046;16876.481116699557;17441.912790435967;17487.038212898413;17580.12099395025;28813.711862881522;28974.27564310909;29072.41855162885;30204.09387718372;30340.54489182664;8329.458585191944;8797.604107815163;8812.8678069829;9013.278937684969;9068;7435.814104647319;7504.174540800507;7532.623368831537;7630.542167469858;7676.501027433199;8264.586770661443;8343.582820858932;8353;8464.746057618282;8478.406511544134;2722.618833363331;3063.2801291696433;3211.1490455029434;3270.8834479523443;3291.765587904536;739.8816189409669;791.5883740454931;875.3347455933537;913.3423934766957;933.0948979489884;15866;16140.435084771976;16494.42269520561;16767.161641917854;17060.14699265032;856.8886044814134;893.2358591781181;899.8335307968047;903.846346121161;905.9320550958704;9137.269018478506;9327.580258888367;9424.481653509123;9437.103475169848;9579.616815327308;367240;375523;382248;382911;391323;76191.61904190443;77082.6145869267;77231.61384193043;77756.61121694355;78076.60961695155;845.9111793261619;892.4199270474244;923.3813345058827;941.8540126280437;946.7017889364828;14652.78020829667;14735.56036848892;14834.184119873511;15009.924950375178;15208.46770363032;34776.65223347734;36413.63586364102;36591;36693.44959825658;38338.23323533458;46188.53811461842;48153.518464816305;48791.75604121957;49327.753361232964;49974.00051998867;6899.965500172467;6918.135233095863;7876.09424916142;7882.684692612232;8112.351011918914;10711.303765255234;11570.479328430409;11654.825177622173;12032.879671203526;12037.879621204027;10080.69757907264;10127.037931396506;10325;10456.372617642966;10668.1998850085;10228.795424091328;10245;10274.486275686037;10378.221633377678;10720.946395267974;5490.423505532021;6503;10039.548220329956;10428.383600541929;10837.133029357476;7616.619169041636;7686.500377475446;7737.264959829033;7765.7670269892;7875;9305.906940930505;9936.950315248378;10070.123574759506;10188.134008609351;10190 08:19:35 INFO - PROCESS | 19401 | |3;mootools.html;1210.8425904632397;1347.3802051056514;1384.8961327900406;1447.6742732885102;1698.2273065755076;6870.141232345957;7494.7002119915205;7704.114026886909;7713.73001944932;7892.052953645571;7608.125065617442;7751.18612545683;7759.301662850342;7766.184550622174;7771.33943614792;1889.2726300374318;2154.5798569278995;2221.0782525252043;2248.8875556222206;2255.2783109404913;2219.3120132758895;2234.9329520114343;2242.4057624729458;2245.5621153875;2246.663000549914;2195.5279614882797;2211.060299372768;2224.6218142915745;2224.7775222477703;2228.799408053275;1814.2470874587098;2058.9485262868398;2137.5511142659984;2141.2826703054498;2147.7207962964712;2151.3115802943066;2180.858244214121;2181.3783071824614;2182.6835108909117;2183.716116904808;7901.881471777928;7952.880706789403;7955.840883182362;7963.641636126388;7970.123286438487;4669.626429885635;4807.375041244651;4812.7352995585225;4814.975925120387;4815.759212039384;2734.849583272919;2816.7183281671873;2939.8236105833503;2966.0656893078612;2968.0947311070113;881.5504092912597;907.5915837872983;915.1900567997304;1732.1252767352407;1814.6280012597517;10411.219158563063;10522.105621022223;10526.789464210673;10533.68398948025;10536.841947370796;4176.540580536139;4183.895402614959;4276.48682158143;4281.7002809803635;4294.484661840599;8532.23209911111;8536.615852286663;8543.658253669784;8550.1449855014;8554.144585541397;4613.331066995267;4642.5821676048645;4666.183417901853;4672;4675.485696573374;3729.272791805572;4252.978735106367;4419.7127186733405;4431.8670439886855;4475.060237350193;3437.74216933731;3486.633903440102;3541.911452213664;3586.049696830342;3685.1708365617524;986.9506524673737;1007.5667462990984;1015.720676813882;1017.5370206555999;1035.7565971996576;649.3344322069917;679.7654809090856;830.8213734047088;867;868.6264906090315;5244.396894357198;5292.126799078186;5321;5359.249705041298;5359.839204823861;823.2261674026396;850.9106543812934;873.5763154869883;891.6700820696384;894.083564346537;3685.7972811495624;3751.381022131318;3756.567994680592;3903.531576210816;3910.159315747128;9562.28282878787;9698;9865.950670246746;9878.308518403786;9880.703578892644;9715.125638692552;9798.559064842098;9825.164860986895;9827.852582211273;9839.409635421898;7214.89177662346;7262.600556969312;7353.816154596071;7381.11426628808;7467.439942004371;5177.922331165111;5301.3373328333955;5332;5352.357717073976;5374.919376209438;8529.872051919103;8883.511406872683;8961.327900407365;9009.819803604023;9030.63877444895;8787.077356877437;9100.635974560944;9110.954445227731;9125.634974600942;9147.307748066629;5975.342712301556;6059.787907423219;6163.260408750979;6965.860682786215;7108.644567771694;6851.177858656993;7518.360939320219;7528.887066694114;7713.305802477804;7729.304362607392;6569.146011018537;6617.470602351897;6713.395794378529;6721.361470660279;6774.051632771318;6824.283450237654;6840.9657951711915;6881.311868813079;6937.687804048729;7000.719971201095;6345.302016778059;6389.073584330339;6415.486761059011;6425.164728585254;6426.260979987362;4279.914401711886;4386.12277544486;4444.28891377378;4456.6211871991245;4461.219286624892;4661.766911654336;4679.649026323107;4721.74030428316;4734.668573199843;4753.762311884461 08:19:35 INFO - PROCESS | 19401 | |4;prototype.html;297.9255186203449;303.0680656979786;304.5979307314345;307.86300096457086;311.4798286860942;4791;4806.759662016902;4826.031990325951;4842.8547143585665;4868;4718.363020992165;4772.902232486522;4787.9521204788025;4788.784504697288;4823.686460380081;3591.533100696906;3696.981515092421;3718.6839118674943;3788.810559472029;3832.3485007548784;3728.272986767581;3759.1541903071725;3780.621937806211;3803.3914573668217;3803.744764227812;3698.7780733155964;3724.6834019108273;3726.962730372702;3739.9626003739886;3741.4948981887505;3493.755437119403;3587.910302242439;3759.2105657811894;3788.8105594720155;3797.39241721326;3339.3321335732708;3354.9496757548654;3364.34395292918;3385.3567822113964;3386.72906167506;4636.907261854778;4649.745178375151;4671.252599584084;4683.391159149322;4719.221328480797;4158.108060832314;4304.321314687274;4314.223439780838;4321.935170972438;4362.192994296065;4953.529414705597;5006.424261209934;5031.798728050873;5037.546620804109;5043.646944713872;3656.579493358271;3677.2093999789904;3689.114612493009;3698.7410881238325;3706.3328600851837;5045.520675535819;5146.176611742103;5211.296474975868;5245.527902488794;5251.186066159751;3725.6088110747983;3731.9253614927547;3735.8879233623034;3754.549454065475;3755.455458958436;3797.7721336719333;3799.5630502492013;3800.809959502069;3819.197968426606;3830.80845957701;4311.353297005474;4313.482382114166;4327.939654784598;4345.326474396474;4348.826046958149;4790.209615413418;4957.801687932442;4975.875603109879;4977.452480227172;5088.898222035613;1288.7100402409383;1294.5792617399195;1302.4920281090383;1303.8305020347293;1305.458234832534;848.8769128476337;861.7414775567305;865.8959826221618;869.4001139213922;905.5879574793453;4459.754713490789;4468.620167285752;4474.843380481668;4499.797509112098;4521.59305662492;5129.461406552258;5159.626571777025;5161.690298582097;5165.874645839213;5184.807494276262;4255.382257705761;4456.930336719229;4468.352088947085;4479.686421950498;4504.842330518416;2680.1021657744486;2696.91909242723;2710.4985577668194;2728.522508560994;2732.8522020751334;4779.928301075487;4824.443045186057;4833.9033219335415;4866.78099485524;4869.853904382874;5076.873078173076;5175.870603234874;5196.908649183713;5246.527812496894;5256.448072952285;4775.7076603231335;4781.235002399669;4801.542889119828;4807.7836497357;4844.806207751721;5060.746962651926;5066.240063990431;5120.97439512815;5124.461931497288;5148.665336753099;4775.928361074517;4972.190712247569;5029.622778291716;5030.4718004608985;5055.1153548128195;4825.131476334153;4836.854894353175;4855.684380515255;4863.197572400514;4864.221724524059;3753.981230093832;3775.11284848066;3777.6033516480375;3780.527434070741;3798.0694729791376;4960.387873940911;5049.671771334852;5082.415522214993;5099.311592935054;5122.257272695513;5053.7220452875445;5065;5080.822171223989;5082.110630639697;5090.956353947506;5040.949590504048;5065.13892638245;5065.442801291929;5076.416212135504;5079.619028572798;4840.878978025577;5003.77483013258;5014.899702006012;5017.222330538772;5020.221865610836;4842.83050093245;4926.211806111005;5081.085404627055;5103.540681338697;5137.768800404066;4971.975140124277;4992.750362481789;5006.69959802413;5022.698638081727;5027.32131162303 08:19:35 INFO - PROCESS | 19401 | |5;yui.html;574.8066221687056;692.8787462194118;703.3002162847966;715.2454160860293;741.7709782104774;12697.492100315987;13303.4013469394;13695;13715.999999999987;13717.108387954777;13015.154014989019;13094.541691040815;13154.079214454992;13175.934120329384;13249.80125298119;619.4486906653083;633.708494092718;760.2359628573276;772.6600295869828;777.0248338335409;757.696921231509;787.8148635070754;788.5032429569363;793.3851265269404;795.3438413309015;833.2417500074934;833.5873742497472;835.4611275727152;837.7612380471567;838.4885220015785;648.4423395879539;660.696079803291;827.3009307135461;827.3215962910416;827.3339961331096;493.28473713116125;493.6939097759412;589.7581991383512;602.6956387024568;602.7016626769733;12980.740385192337;12983.610491685264;13031.283279419627;13053.804192937114;13145.802812957812;12729.108962372638;13070.54253101137;13246.139000964906;13369.197848129143;13475.326233688276;11452.656420307405;11729.648110556696;11776.470058847286;11872.584459543874;11982.400879956054;4244.702870799046;4245.299525578276;4263.296556068245;4287.935680964788;4304.483461984551;56933.43066569364;56940.43059569393;57070.42929570693;57489.13766293509;57885.13172302419;10285.28003039795;10420.478976051167;10534;10582.629607963685;10794.730131746612;19625.509362266057;19627.411177664693;19631;19638.312659056865;19673.508162296057;6829.078074459983;6989.33601307875;7003.474739394565;7064.1876184238445;7072.929270707227;3419.26485805548;3433.6909678129086;3441.8451169697423;3503.2468019375447;3546.078019714893;2818.168640251131;2907.549329853876;2909.2145120817686;2917.9854100729362;2918.8102773319665;483.05803682818646;488.32367171467064;488.82158012325243;489.48848453366315;500.2895887839204;379.33616171699526;398.5177934698989;481.33816002995883;506.1395627433378;542.4385760737697;7098.254683258287;7146.464015198881;7384.630768461556;7424.740134095281;7488.4009279257525;419.4107279272627;467.99064018720117;505.73196206010874;560.9354924183771;567.6168586204378;3433.5536380270405;3513.2270900401872;3516.0682419158943;3521.3837578424186;3628.129248980226;75250.62374688091;78896.60551697205;79050.20949790544;87125.56437217773;87698.56150719206;74609;76734;76779.23220767721;77435.22564774392;79573.20426795658;48781.75609122003;50033.49966500361;72502.63748681222;74118;74486.9435463815;8105.351571874354;8369.83260334802;8374.748757537283;8493.405461617627;8555.35834812404;41537.58462415337;42281.365779512715;42784.786076069424;43223;43681.126377471635;52686.47313526969;60988.39011609827;61052.38947610467;61671;62503.37496624976;9269.67556135532;9544.141027307576;9560.139587437165;10363.015513526203;10453.895461045293;12442.564510242099;12483.375831208221;13084.934575327063;13183.077184596987;13316.400761965928;9715.17421019193;10626.256162068581;10684.57261709523;10718.73203169927;10981.231313807957;11813.291202527877;12081.879181208076;12192.207506512048;12293.692657683629;12412.937935310265;10961.342319460859;11090.778184436427;11149.275297105662;11206.43967801623;11677.88322116802;10147.137493312855;10229;10422.895771042497;10538.209634277613;10610.946945265534;9027.23268522183;9096;9124.635014599342;9391.624335026796;9427.095034823855 08:19:35 INFO - PROCESS | 19401 | __end_tp_report 08:19:35 INFO - PROCESS | 19401 | __start_cc_report 08:19:35 INFO - PROCESS | 19401 | _x_x_mozilla_cycle_collect,930 08:19:35 INFO - PROCESS | 19401 | __end_cc_report 08:19:35 INFO - PROCESS | 19401 | __startTimestamp1465571975726__endTimestamp 08:19:35 INFO - PROCESS | 19401 | 08:19:35 INFO - PROCESS | 19401 | ------- Summary: start ------- 08:19:35 INFO - PROCESS | 19401 | Number of tests: 6 08:19:35 INFO - PROCESS | 19401 | 08:19:35 INFO - PROCESS | 19401 | [#0] dojo.html Cycles:165 Average:4662.01 Median:4850.95 stddev:516.59 (10.6%) stddev-sans-first:490.03 08:19:35 INFO - PROCESS | 19401 | Values: 2517.9 2545.1 2549.6 2576.7 2611.7 4628.6 4662.6 4665.6 4670.7 4682.3 4624.1 4657.7 4673.3 4680.4 4683.8 4084.6 4244.0 4325.8 4346.4 4497.6 4403.4 4435.7 4446.8 4460.4 4492.5 4130.5 4157.3 4196.4 4286.3 4342.8 4183.1 4200.3 4238.5 4239.3 4246.7 4227.8 4249.4 4250.1 4271.8 4288.3 4617.6 4687.4 4731.5 4752.0 4764.5 5110.3 5113.2 5133.5 5146.9 5149.9 4956.6 4966.2 5143.7 5174.8 5188.5 4670.3 4716.8 4734.3 4739.2 4742.2 5147.0 5162.3 5168.1 5169.8 5173.9 4879.9 4887.1 4940.3 5048.5 5054.0 5009.6 5030.7 5033.3 5037.3 5085.1 4974.4 4977.5 4981.8 4987.8 5021.8 4876.8 4967.6 5004.4 5013.7 5020.8 4209.4 4226.8 4232.9 4264.6 4280.2 3678.4 3691.8 3706.1 3730.6 3743.5 4316.2 4334.3 4342.0 4363.5 4420.2 5010.0 5024.6 5025.1 5028.4 5086.9 4342.4 4357.6 4365.9 4389.9 4396.6 4336.3 4372.8 4459.3 4548.6 4589.0 4826.7 4851.0 4855.8 4888.3 4895.3 5136.5 5138.1 5139.2 5143.6 5144.0 4682.4 4762.8 4802.4 4821.1 4876.2 5048.8 5052.4 5053.3 5069.1 5073.7 5120.8 5130.5 5136.1 5140.6 5141.9 4821.4 4864.7 4921.0 4929.7 4944.1 4908.5 4936.7 4936.7 4942.0 4988.6 4724.7 4854.7 4868.0 4868.9 4947.3 4944.8 4958.6 4974.5 4982.2 5002.2 4896.1 4896.8 4899.1 4900.5 4946.0 08:19:35 INFO - PROCESS | 19401 | 08:19:35 INFO - PROCESS | 19401 | [#1] ext.html Cycles:180 Average:46792.44 Median:33566.25 stddev:84393.94 (251.4%) stddev-sans-first:84559.34 08:19:35 INFO - PROCESS | 19401 | Values: 570.8 592.2 595.6 598.6 604.0 39259.4 41225.6 41295.0 44363.0 44475.0 40952.0 41097.6 41227.4 41382.8 41527.0 7616.5 7910.0 8051.6 8055.2 10151.4 10022.7 10382.5 10396.8 10401.6 10404.8 10380.6 10422.2 10425.2 10425.5 10428.9 7707.8 10071.2 10321.6 10360.1 10371.3 10230.6 10276.9 10287.1 10292.3 10296.7 38512.8 38657.6 38827.4 38876.6 38902.6 2912.4 2922.2 2933.1 2996.4 3072.1 29680.4 30242.0 30353.4 30507.5 31169.8 3342.6 3442.6 3452.4 3462.1 3512.9 254589.0 255110.0 255655.7 256155.0 256340.0 33380.2 53558.0 54058.7 54166.7 54179.2 34081.8 34117.7 34207.7 34267.5 34272.8 12955.4 13056.6 13070.0 13082.0 13119.5 10265.0 10578.8 10715.6 10749.4 10964.7 7917.1 7948.0 7955.0 8008.5 8039.2 3082.9 3085.8 3142.9 3150.3 3152.3 793.8 841.4 888.9 931.3 1015.5 26696.6 27913.2 28121.3 28263.3 28465.7 926.3 942.3 953.8 959.7 1044.3 14364.6 14779.3 14846.8 14871.5 14877.8 374384.0 379623.0 380030.0 380077.0 381188.0 51451.5 51903.0 51996.5 52008.7 52025.2 1060.3 1146.2 1175.1 1195.3 1196.2 28181.0 29403.9 29563.3 29798.4 29844.0 42317.6 42455.4 43017.6 43085.0 43193.0 313998.0 315950.0 315965.0 316137.0 316278.0 22681.0 23427.9 25843.7 26709.0 26838.0 41324.4 41691.8 42110.0 43018.1 43062.8 35716.0 36193.3 36357.0 36435.0 36690.6 36240.0 36280.0 36487.0 36526.3 37709.2 37044.3 37202.8 37414.8 37823.8 38123.4 32037.8 33433.8 33698.7 33794.0 33813.7 25395.7 25526.7 25974.0 26019.7 26434.5 08:19:35 INFO - PROCESS | 19401 | 08:19:35 INFO - PROCESS | 19401 | [#2] jquery.html Cycles:180 Average:25077.62 Median:19364.61 stddev:62906.08 (324.9%) stddev-sans-first:63055.18 08:19:35 INFO - PROCESS | 19401 | Values: 362.8 365.3 372.4 375.7 391.0 15753.7 16415.5 17252.5 17266.7 17278.6 16651.3 16664.0 16883.8 17227.2 17265.0 4853.1 5096.0 5128.9 5130.4 5131.5 3780.1 3958.0 5080.9 5578.0 5903.0 5897.7 5910.8 5920.6 5933.3 5938.8 5810.5 5865.0 5946.9 5967.3 5993.7 3400.4 4850.8 5112.5 5138.6 5257.4 17577.6 17582.8 18116.4 20645.0 20694.6 1973.9 2110.6 2291.9 2437.2 2463.5 12891.3 13082.5 13220.3 13286.4 13612.6 1718.8 1728.1 1731.3 1742.4 1798.1 66082.0 74718.6 81575.6 87391.0 88926.6 16764.9 16876.5 17441.9 17487.0 17580.1 28813.7 28974.3 29072.4 30204.1 30340.5 8329.5 8797.6 8812.9 9013.3 9068.0 7435.8 7504.2 7532.6 7630.5 7676.5 8264.6 8343.6 8353.0 8464.7 8478.4 2722.6 3063.3 3211.1 3270.9 3291.8 739.9 791.6 875.3 913.3 933.1 15866.0 16140.4 16494.4 16767.2 17060.1 856.9 893.2 899.8 903.8 905.9 9137.3 9327.6 9424.5 9437.1 9579.6 367240.0 375523.0 382248.0 382911.0 391323.0 76191.6 77082.6 77231.6 77756.6 78076.6 845.9 892.4 923.4 941.9 946.7 14652.8 14735.6 14834.2 15009.9 15208.5 34776.7 36413.6 36591.0 36693.4 38338.2 46188.5 48153.5 48791.8 49327.8 49974.0 6900.0 6918.1 7876.1 7882.7 8112.4 10711.3 11570.5 11654.8 12032.9 12037.9 10080.7 10127.0 10325.0 10456.4 10668.2 10228.8 10245.0 10274.5 10378.2 10720.9 5490.4 6503.0 10039.5 10428.4 10837.1 7616.6 7686.5 7737.3 7765.8 7875.0 9305.9 9937.0 10070.1 10188.1 10190.0 08:19:35 INFO - PROCESS | 19401 | 08:19:35 INFO - PROCESS | 19401 | [#3] mootools.html Cycles:180 Average:5141.72 Median:5326.50 stddev:2859.93 (53.7%) stddev-sans-first:2852.69 08:19:35 INFO - PROCESS | 19401 | Values: 1210.8 1347.4 1384.9 1447.7 1698.2 6870.1 7494.7 7704.1 7713.7 7892.1 7608.1 7751.2 7759.3 7766.2 7771.3 1889.3 2154.6 2221.1 2248.9 2255.3 2219.3 2234.9 2242.4 2245.6 2246.7 2195.5 2211.1 2224.6 2224.8 2228.8 1814.2 2058.9 2137.6 2141.3 2147.7 2151.3 2180.9 2181.4 2182.7 2183.7 7901.9 7952.9 7955.8 7963.6 7970.1 4669.6 4807.4 4812.7 4815.0 4815.8 2734.8 2816.7 2939.8 2966.1 2968.1 881.6 907.6 915.2 1732.1 1814.6 10411.2 10522.1 10526.8 10533.7 10536.8 4176.5 4183.9 4276.5 4281.7 4294.5 8532.2 8536.6 8543.7 8550.1 8554.1 4613.3 4642.6 4666.2 4672.0 4675.5 3729.3 4253.0 4419.7 4431.9 4475.1 3437.7 3486.6 3541.9 3586.0 3685.2 987.0 1007.6 1015.7 1017.5 1035.8 649.3 679.8 830.8 867.0 868.6 5244.4 5292.1 5321.0 5359.2 5359.8 823.2 850.9 873.6 891.7 894.1 3685.8 3751.4 3756.6 3903.5 3910.2 9562.3 9698.0 9866.0 9878.3 9880.7 9715.1 9798.6 9825.2 9827.9 9839.4 7214.9 7262.6 7353.8 7381.1 7467.4 5177.9 5301.3 5332.0 5352.4 5374.9 8529.9 8883.5 8961.3 9009.8 9030.6 8787.1 9100.6 9111.0 9125.6 9147.3 5975.3 6059.8 6163.3 6965.9 7108.6 6851.2 7518.4 7528.9 7713.3 7729.3 6569.1 6617.5 6713.4 6721.4 6774.1 6824.3 6841.0 6881.3 6937.7 7000.7 6345.3 6389.1 6415.5 6425.2 6426.3 4279.9 4386.1 4444.3 4456.6 4461.2 4661.8 4679.6 4721.7 4734.7 4753.8 08:19:35 INFO - PROCESS | 19401 | 08:19:35 INFO - PROCESS | 19401 | [#4] prototype.html Cycles:180 Average:4182.33 Median:4784.59 stddev:1197.93 (25.0%) stddev-sans-first:1165.27 08:19:35 INFO - PROCESS | 19401 | Values: 297.9 303.1 304.6 307.9 311.5 4791.0 4806.8 4826.0 4842.9 4868.0 4718.4 4772.9 4788.0 4788.8 4823.7 3591.5 3697.0 3718.7 3788.8 3832.3 3728.3 3759.2 3780.6 3803.4 3803.7 3698.8 3724.7 3727.0 3740.0 3741.5 3493.8 3587.9 3759.2 3788.8 3797.4 3339.3 3354.9 3364.3 3385.4 3386.7 4636.9 4649.7 4671.3 4683.4 4719.2 4158.1 4304.3 4314.2 4321.9 4362.2 4953.5 5006.4 5031.8 5037.5 5043.6 3656.6 3677.2 3689.1 3698.7 3706.3 5045.5 5146.2 5211.3 5245.5 5251.2 3725.6 3731.9 3735.9 3754.5 3755.5 3797.8 3799.6 3800.8 3819.2 3830.8 4311.4 4313.5 4327.9 4345.3 4348.8 4790.2 4957.8 4975.9 4977.5 5088.9 1288.7 1294.6 1302.5 1303.8 1305.5 848.9 861.7 865.9 869.4 905.6 4459.8 4468.6 4474.8 4499.8 4521.6 5129.5 5159.6 5161.7 5165.9 5184.8 4255.4 4456.9 4468.4 4479.7 4504.8 2680.1 2696.9 2710.5 2728.5 2732.9 4779.9 4824.4 4833.9 4866.8 4869.9 5076.9 5175.9 5196.9 5246.5 5256.4 4775.7 4781.2 4801.5 4807.8 4844.8 5060.7 5066.2 5121.0 5124.5 5148.7 4775.9 4972.2 5029.6 5030.5 5055.1 4825.1 4836.9 4855.7 4863.2 4864.2 3754.0 3775.1 3777.6 3780.5 3798.1 4960.4 5049.7 5082.4 5099.3 5122.3 5053.7 5065.0 5080.8 5082.1 5091.0 5040.9 5065.1 5065.4 5076.4 5079.6 4840.9 5003.8 5014.9 5017.2 5020.2 4842.8 4926.2 5081.1 5103.5 5137.8 4972.0 4992.8 5006.7 5022.7 5027.3 08:19:35 INFO - PROCESS | 19401 | 08:19:35 INFO - PROCESS | 19401 | [#5] yui.html Cycles:180 Average:16554.30 Median:482.20 stddev:22473.13 (4660.6%) stddev-sans-first:22504.14 08:19:35 INFO - PROCESS | 19401 | Values: 574.8 692.9 703.3 715.2 741.8 12697.5 13303.4 13695.0 13716.0 13717.1 13015.2 13094.5 13154.1 13175.9 13249.8 619.4 633.7 760.2 772.7 777.0 757.7 787.8 788.5 793.4 795.3 833.2 833.6 835.5 837.8 838.5 648.4 660.7 827.3 827.3 827.3 493.3 493.7 589.8 602.7 602.7 12980.7 12983.6 13031.3 13053.8 13145.8 12729.1 13070.5 13246.1 13369.2 13475.3 11452.7 11729.6 11776.5 11872.6 11982.4 4244.7 4245.3 4263.3 4287.9 4304.5 56933.4 56940.4 57070.4 57489.1 57885.1 10285.3 10420.5 10534.0 10582.6 10794.7 19625.5 19627.4 19631.0 19638.3 19673.5 6829.1 6989.3 7003.5 7064.2 7072.9 3419.3 3433.7 3441.8 3503.2 3546.1 2818.2 2907.5 2909.2 2918.0 2918.8 483.1 488.3 488.8 489.5 500.3 379.3 398.5 481.3 506.1 542.4 7098.3 7146.5 7384.6 7424.7 7488.4 419.4 468.0 505.7 560.9 567.6 3433.6 3513.2 3516.1 3521.4 3628.1 75250.6 78896.6 79050.2 87125.6 87698.6 74609.0 76734.0 76779.2 77435.2 79573.2 48781.8 50033.5 72502.6 74118.0 74486.9 8105.4 8369.8 8374.7 8493.4 8555.4 41537.6 42281.4 42784.8 43223.0 43681.1 52686.5 60988.4 61052.4 61671.0 62503.4 9269.7 9544.1 9560.1 10363.0 10453.9 12442.6 12483.4 13084.9 13183.1 13316.4 9715.2 10626.3 10684.6 10718.7 10981.2 11813.3 12081.9 12192.2 12293.7 12412.9 10961.3 11090.8 11149.3 11206.4 11677.9 10147.1 10229.0 10422.9 10538.2 10610.9 9027.2 9096.0 9124.6 9391.6 9427.1 08:19:35 INFO - PROCESS | 19401 | -------- Summary: end -------- 08:19:35 INFO - PROCESS | 19401 | 08:19:36 INFO - TEST-INFO | 19401: exit 0 08:19:36 INFO - TEST-OK | dromaeo_css | took 1120984ms 08:19:36 INFO - TEST-START | kraken 08:19:36 INFO - operating with platform_type : linux_ 08:19:36 INFO - Initialising browser for kraken test... 08:19:36 INFO - TEST-INFO | started process 19584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpde1vrD/profile http://localhost:51256/getInfo.html) 08:19:41 INFO - PROCESS | 19584 | __metrics Screen width/height:1600/1200 08:19:41 INFO - PROCESS | 19584 | colorDepth:24 08:19:41 INFO - PROCESS | 19584 | Browser inner width/height: 1024/697 08:19:41 INFO - PROCESS | 19584 | __metrics 08:19:43 ERROR - PROCESS | 19584 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:19:43 INFO - PROCESS | 19584 | console.error: PushService: 08:19:43 INFO - PROCESS | 19584 | stateChangeProcessEnqueue: Error transitioning state 08:19:43 INFO - PROCESS | 19584 | UnknownError 08:19:44 INFO - TEST-INFO | 19584: exit 0 08:19:44 INFO - Browser initialized. 08:19:44 INFO - Running cycle 1/1 for kraken test... 08:19:44 INFO - TEST-INFO | started process 19664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpde1vrD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:56 INFO - PROCESS | 19664 | RSS: Main: 175202304 08:19:56 INFO - PROCESS | 19664 | 08:19:58 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51256/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:59 INFO - PROCESS | 19664 | RSS: Main: 232660992 08:19:59 INFO - PROCESS | 19664 | 08:20:02 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51256/tests/kraken/driver.html?testName=audio-dft) 08:20:03 INFO - PROCESS | 19664 | RSS: Main: 220946432 08:20:03 INFO - PROCESS | 19664 | 08:20:06 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51256/tests/kraken/driver.html?testName=audio-fft) 08:20:07 INFO - PROCESS | 19664 | RSS: Main: 287924224 08:20:07 INFO - PROCESS | 19664 | 08:20:09 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51256/tests/kraken/driver.html?testName=audio-oscillator) 08:20:09 INFO - PROCESS | 19664 | RSS: Main: 198184960 08:20:09 INFO - PROCESS | 19664 | 08:20:12 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51256/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:12 INFO - PROCESS | 19664 | RSS: Main: 201916416 08:20:12 INFO - PROCESS | 19664 | 08:20:16 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51256/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:16 INFO - PROCESS | 19664 | RSS: Main: 237862912 08:20:16 INFO - PROCESS | 19664 | 08:20:20 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51256/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:20 INFO - PROCESS | 19664 | RSS: Main: 233426944 08:20:20 INFO - PROCESS | 19664 | 08:20:23 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51256/tests/kraken/driver.html?testName=json-parse-financial) 08:20:24 INFO - PROCESS | 19664 | RSS: Main: 236589056 08:20:24 INFO - PROCESS | 19664 | 08:20:26 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51256/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:26 INFO - PROCESS | 19664 | RSS: Main: 221798400 08:20:26 INFO - PROCESS | 19664 | 08:20:28 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:29 INFO - PROCESS | 19664 | RSS: Main: 226594816 08:20:29 INFO - PROCESS | 19664 | 08:20:31 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:32 INFO - PROCESS | 19664 | RSS: Main: 235433984 08:20:32 INFO - PROCESS | 19664 | 08:20:34 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:35 INFO - PROCESS | 19664 | RSS: Main: 238669824 08:20:35 INFO - PROCESS | 19664 | 08:20:38 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:39 INFO - PROCESS | 19664 | RSS: Main: 240558080 08:20:39 INFO - PROCESS | 19664 | 08:20:40 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51256/tests/kraken/driver.html?testName=ai-astar) 08:20:41 INFO - PROCESS | 19664 | RSS: Main: 283627520 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | __start_tp_report 08:20:41 INFO - PROCESS | 19664 | _x_x_mozilla_page_load 08:20:41 INFO - PROCESS | 19664 | _x_x_mozilla_page_load_details 08:20:41 INFO - PROCESS | 19664 | |i|pagename|runs| 08:20:41 INFO - PROCESS | 19664 | |0;ai-astar;114;110;113;112;114;114;112;113;112;112 08:20:41 INFO - PROCESS | 19664 | |1;audio-beat-detection;154;135;130;187;132;129;169;131;163;131 08:20:41 INFO - PROCESS | 19664 | |2;audio-dft;162;160;162;162;163;164;161;163;164;162 08:20:41 INFO - PROCESS | 19664 | |3;audio-fft;76;75;79;128;75;76;76;74;101;76 08:20:41 INFO - PROCESS | 19664 | |4;audio-oscillator;86;88;117;86;87;85;119;86;86;132 08:20:41 INFO - PROCESS | 19664 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;117;117;118 08:20:41 INFO - PROCESS | 19664 | |6;imaging-darkroom;146;146;147;145;146;146;147;145;146;147 08:20:41 INFO - PROCESS | 19664 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 08:20:41 INFO - PROCESS | 19664 | |8;json-parse-financial;63;64;64;65;65;64;65;64;63;65 08:20:41 INFO - PROCESS | 19664 | |9;json-stringify-tinderbox;65;65;65;65;65;65;66;66;65;65 08:20:41 INFO - PROCESS | 19664 | |10;stanford-crypto-aes;83;83;84;89;90;84;85;91;118;90 08:20:41 INFO - PROCESS | 19664 | |11;stanford-crypto-ccm;134;136;141;130;129;132;132;146;135;144 08:20:41 INFO - PROCESS | 19664 | |12;stanford-crypto-pbkdf2;173;176;169;175;174;172;172;174;171;171 08:20:41 INFO - PROCESS | 19664 | |13;stanford-crypto-sha256-iterative;67;68;68;68;67;66;68;69;69;68 08:20:41 INFO - PROCESS | 19664 | __end_tp_report 08:20:41 INFO - PROCESS | 19664 | __start_cc_report 08:20:41 INFO - PROCESS | 19664 | _x_x_mozilla_cycle_collect,1928 08:20:41 INFO - PROCESS | 19664 | __end_cc_report 08:20:41 INFO - PROCESS | 19664 | __startTimestamp1465572041024__endTimestamp 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | ------- Summary: start ------- 08:20:41 INFO - PROCESS | 19664 | Number of tests: 14 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:1.26 (1.1%) stddev-sans-first:1.24 08:20:41 INFO - PROCESS | 19664 | Values: 114.0 110.0 113.0 112.0 114.0 114.0 112.0 113.0 112.0 112.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:144.50 stddev:20.75 (14.4%) stddev-sans-first:21.81 08:20:41 INFO - PROCESS | 19664 | Values: 154.0 135.0 130.0 187.0 132.0 129.0 169.0 131.0 163.0 131.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 08:20:41 INFO - PROCESS | 19664 | Values: 162.0 160.0 162.0 162.0 163.0 164.0 161.0 163.0 164.0 162.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:17.53 (23.1%) stddev-sans-first:18.38 08:20:41 INFO - PROCESS | 19664 | Values: 76.0 75.0 79.0 128.0 75.0 76.0 76.0 74.0 101.0 76.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:86.00 stddev:18.00 (20.9%) stddev-sans-first:18.64 08:20:41 INFO - PROCESS | 19664 | Values: 86.0 88.0 117.0 86.0 87.0 85.0 119.0 86.0 86.0 132.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:20:41 INFO - PROCESS | 19664 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:20:41 INFO - PROCESS | 19664 | Values: 146.0 146.0 147.0 145.0 146.0 146.0 147.0 145.0 146.0 147.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:20:41 INFO - PROCESS | 19664 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 08:20:41 INFO - PROCESS | 19664 | Values: 63.0 64.0 64.0 65.0 65.0 64.0 65.0 64.0 63.0 65.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 08:20:41 INFO - PROCESS | 19664 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 66.0 66.0 65.0 65.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:87.00 stddev:10.44 (12.0%) stddev-sans-first:10.78 08:20:41 INFO - PROCESS | 19664 | Values: 83.0 83.0 84.0 89.0 90.0 84.0 85.0 91.0 118.0 90.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:135.50 stddev:5.88 (4.3%) stddev-sans-first:6.19 08:20:41 INFO - PROCESS | 19664 | Values: 134.0 136.0 141.0 130.0 129.0 132.0 132.0 146.0 135.0 144.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.50 stddev:2.11 (1.2%) stddev-sans-first:2.24 08:20:41 INFO - PROCESS | 19664 | Values: 173.0 176.0 169.0 175.0 174.0 172.0 172.0 174.0 171.0 171.0 08:20:41 INFO - PROCESS | 19664 | 08:20:41 INFO - PROCESS | 19664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 08:20:41 INFO - PROCESS | 19664 | Values: 67.0 68.0 68.0 68.0 67.0 66.0 68.0 69.0 69.0 68.0 08:20:41 INFO - PROCESS | 19664 | -------- Summary: end -------- 08:20:41 INFO - PROCESS | 19664 | 08:20:42 INFO - TEST-INFO | 19664: exit 0 08:20:42 INFO - TEST-OK | kraken | took 65760ms 08:20:42 INFO - SUITE-END | took 1186s 08:20:42 INFO - Completed test suite (00:19:47) 08:20:42 INFO - javascript benchmark 08:20:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2517.9118730844425, 2545.1473756291643, 2549.592065269556, 2576.7165611782707, 2611.738826117388, 4628.560286772759, 4662.557057079572, 4665.556772106649, 4670.743109128996, 4682.274247491636, 4624.09830083134, 4657.720536767796, 4673.345731597579, 4680.368150299709, 4683.765811709418, 4084.611961863633, 4243.978780106103, 4325.805338759764, 4346.391505189276, 4497.550244975509, 4403.405540252073, 4435.711678740871, 4446.844360447385, 4460.442444694413, 4492.505824359318, 4130.524989626201, 4157.293260145752, 4196.412502249687, 4286.271333873249, 4342.826286948518, 4183.058811767359, 4200.306949353353, 4238.491381034296, 4239.321708526621, 4246.723962942398, 4227.8097485613225, 4249.405083288342, 4250.128723611652, 4271.765052922088, 4288.292431748758, 4617.561331673485, 4687.390639216914, 4731.5268473152755, 4752.049590081963, 4764.499727528594, 5110.28456016158, 5113.207452844815, 5133.4609865964285, 5146.922796158024, 5149.871253218662, 4956.578690811285, 4966.230234313687, 5143.742812859342, 5174.7671354788745, 5188.507091826308, 4670.3461515387535, 4716.834910778106, 4734.26618874075, 4739.241721324641, 4742.241241401428, 5146.974265128651, 5162.328897243335, 5168.121419358718, 5169.767360468788, 5173.870653233624, 4879.878003049952, 4887.0714564232685, 4940.333055037596, 5048.469910659402, 5054.0, 5009.599232061426, 5030.723310217973, 5033.2701758245585, 5037.29477873098, 5085.110105731482, 4974.427940786783, 4977.477364876709, 4981.800727970913, 4987.80048798044, 5021.774020169101, 4876.804927802848, 4967.5777558907175, 5004.3994720633755, 5013.674111182834, 5020.824271150492, 4209.368594710757, 4226.830926762957, 4232.894177645583, 4264.552222016706, 4280.16536775332, 3678.4114541673202, 3691.7600355976774, 3706.1475860552223, 3730.570984336836, 3743.47591337213, 4316.223079845658, 4334.306510958231, 4342.0, 4363.52001279859, 4420.204363214652, 5010.048090862724, 5024.648274620741, 5025.070361983045, 5028.421731500925, 5086.92369614456, 4342.413774140514, 4357.607815296638, 4365.934510982338, 4389.934150987738, 4396.582324679151, 4336.262835318003, 4372.803223854934, 4459.308807134899, 4548.5906268436, 4588.95411045892, 4826.686265392878, 4850.95149048505, 4855.805767769391, 4888.291197776302, 4895.290182923527, 5136.512031357015, 5138.07514647367, 5139.229115632685, 5143.6399452039495, 5143.974280128576, 4682.41469816273, 4762.833300834454, 4802.399700037496, 4821.108095002436, 4876.171050921423, 5048.823291184791, 5052.418971818288, 5053.267276244997, 5069.112905241494, 5073.720945347894, 5120.820771272987, 5130.48695130484, 5136.101182293009, 5140.56305214061, 5141.897162056663, 4821.373221481185, 4864.6594738369395, 4921.0, 4929.704217746947, 4944.085344211332, 4908.460069392293, 4936.703797772145, 4936.7284799336385, 4941.975290123526, 4988.600911926965, 4724.692894961817, 4854.660173787942, 4867.975660121677, 4868.902621947612, 4947.2579113133315, 4944.802207911644, 4958.603311734981, 4974.452810190804, 4982.153033984159, 5002.2496625506465, 4896.11869863428, 4896.755162241945, 4899.069176856528, 4900.4854490278, 4946.0], "value": 4627.027150528511, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7517230004948, 592.2330581896443, 595.5592861282652, 598.6228675934161, 603.9547033972453, 39259.41110883339, 41225.58774412255, 41295.0, 44363.0, 44475.0, 40952.0, 41097.58902410975, 41227.38158927611, 41382.79308603453, 41527.0, 7616.543007419545, 7909.960450197741, 8051.557164355958, 8055.15420880805, 10151.390916544993, 10022.699319020441, 10382.532786024647, 10396.792064158712, 10401.635942742005, 10404.843927341097, 10380.584776608926, 10422.218333624971, 10425.218108641844, 10425.530851111718, 10428.89571104287, 7707.845843083135, 10071.194304455626, 10321.638742644009, 10360.119389851872, 10371.325863818827, 10230.641927532575, 10276.94861525695, 10287.12559432449, 10292.279540432173, 10296.691099267035, 38512.807435962925, 38657.613423865965, 38827.41758873619, 38876.61123388758, 38902.61097389018, 2912.388398436331, 2922.1963959911195, 2933.1054028521294, 2996.4306781711407, 3072.0937323489625, 29680.406391872042, 30242.0, 30353.392932141454, 30507.542386864214, 31169.84415077933, 3342.5821772278464, 3442.6385229550788, 3452.3613131570487, 3462.082548124749, 3512.8770493032875, 254589.0, 255110.0, 255655.72172139207, 256155.0, 256340.0, 33380.16549586231, 53558.0, 54058.729706351216, 54166.72916635471, 54179.18731219035, 34081.829590851885, 34117.658823411446, 34207.65792342094, 34267.485987710206, 34272.82863585716, 12955.417006234742, 13056.608301750963, 13070.0, 13082.0, 13119.540816071392, 10265.0, 10578.788424231472, 10715.571377144983, 10749.40878251688, 10964.671059868217, 7917.129115797257, 7947.966764320601, 7955.0, 8008.519488830689, 8039.196080392031, 3082.9383412331626, 3085.799423037495, 3142.9471127172196, 3150.33842892995, 3152.2907345847, 793.8015496125969, 841.3857883744901, 888.853379140914, 931.29221791439, 1015.4668798880647, 26696.59955100675, 27913.162605121877, 28121.296967575974, 28263.29341766472, 28465.71534284672, 926.2775035472342, 942.2509105261333, 953.7901661634429, 959.7456673981401, 1044.3107549017611, 14364.569062928129, 14779.26103694811, 14846.777298340534, 14871.47949821751, 14877.776833347292, 374384.0, 379623.0, 380030.0, 380077.0, 381188.0, 51451.48548514467, 51903.0, 51996.480035199165, 52008.73995629998, 52025.219621705706, 1060.3213943076437, 1146.18620779246, 1175.1480176871871, 1195.276857501234, 1196.2164782067587, 28181.0, 29403.85298073496, 29563.26091847721, 29798.404031918806, 29844.0, 42317.576824231364, 42455.36316955186, 43017.569824301354, 43085.0, 43193.0, 313998.0, 315950.0, 315965.0, 316137.0, 316278.0, 22681.0, 23427.88286058559, 25843.741562584135, 26709.0, 26838.0, 41324.38013429861, 41691.79154104331, 42110.0, 43018.139637206456, 43062.78468607762, 35716.0, 36193.27613447663, 36357.0, 36435.0, 36690.63309366872, 36240.0, 36280.0, 36487.0, 36526.26947461089, 37709.24581508409, 37044.259114818095, 37202.8139859299, 37414.8129259352, 37823.81088094652, 38123.42814857724, 32037.839810800797, 33433.83283083569, 33698.66301336955, 33794.0, 33813.66186338203, 25395.746042539336, 25526.744732552437, 25974.0, 26019.739802601733, 26434.471310574067], "value": 17105.58561346156, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.7932078715132, 365.27857481474086, 372.3558244237469, 375.68442508293026, 390.9882703518895, 15753.684926301466, 16415.507534773962, 17252.48242552722, 17266.740998885012, 17278.56803579911, 16651.25069371881, 16664.0, 16883.83116168841, 17227.22477488513, 17265.0, 4853.102176097415, 5095.9745201273945, 5128.871778205537, 5130.410002849682, 5131.461196574362, 3780.1494663700587, 3958.010497375656, 5080.923786143211, 5577.972110139443, 5903.0, 5897.705114744267, 5910.822675319747, 5920.644761314314, 5933.34733179352, 5938.792142275, 5810.535157187415, 5865.0, 5946.851328716795, 5967.254093238345, 5993.730282137336, 3400.387930172568, 4850.75746212688, 5112.463191364927, 5138.640295179339, 5257.421683614799, 17577.56056098595, 17582.824171758373, 18116.365927192484, 20645.0, 20694.5861082779, 1973.8618296719235, 2110.609537235601, 2291.873946932918, 2437.2322718343844, 2463.519613675334, 12891.290978996152, 13082.542111026069, 13220.338983050906, 13286.402111904987, 13612.591622251348, 1718.7593736876847, 1728.1013872786082, 1731.3161301286048, 1742.4337090445656, 1798.082977681379, 66082.0, 74718.62640686762, 81575.5921220396, 87391.0, 88926.55536722275, 16764.916175419046, 16876.481116699557, 17441.912790435967, 17487.038212898413, 17580.12099395025, 28813.711862881522, 28974.27564310909, 29072.41855162885, 30204.09387718372, 30340.54489182664, 8329.458585191944, 8797.604107815163, 8812.8678069829, 9013.278937684969, 9068.0, 7435.814104647319, 7504.174540800507, 7532.623368831537, 7630.542167469858, 7676.501027433199, 8264.586770661443, 8343.582820858932, 8353.0, 8464.746057618282, 8478.406511544134, 2722.618833363331, 3063.2801291696433, 3211.1490455029434, 3270.8834479523443, 3291.765587904536, 739.8816189409669, 791.5883740454931, 875.3347455933537, 913.3423934766957, 933.0948979489884, 15866.0, 16140.435084771976, 16494.42269520561, 16767.161641917854, 17060.14699265032, 856.8886044814134, 893.2358591781181, 899.8335307968047, 903.846346121161, 905.9320550958704, 9137.269018478506, 9327.580258888367, 9424.481653509123, 9437.103475169848, 9579.616815327308, 367240.0, 375523.0, 382248.0, 382911.0, 391323.0, 76191.61904190443, 77082.6145869267, 77231.61384193043, 77756.61121694355, 78076.60961695155, 845.9111793261619, 892.4199270474244, 923.3813345058827, 941.8540126280437, 946.7017889364828, 14652.78020829667, 14735.56036848892, 14834.184119873511, 15009.924950375178, 15208.46770363032, 34776.65223347734, 36413.63586364102, 36591.0, 36693.44959825658, 38338.23323533458, 46188.53811461842, 48153.518464816305, 48791.75604121957, 49327.753361232964, 49974.00051998867, 6899.965500172467, 6918.135233095863, 7876.09424916142, 7882.684692612232, 8112.351011918914, 10711.303765255234, 11570.479328430409, 11654.825177622173, 12032.879671203526, 12037.879621204027, 10080.69757907264, 10127.037931396506, 10325.0, 10456.372617642966, 10668.1998850085, 10228.795424091328, 10245.0, 10274.486275686037, 10378.221633377678, 10720.946395267974, 5490.423505532021, 6503.0, 10039.548220329956, 10428.383600541929, 10837.133029357476, 7616.619169041636, 7686.500377475446, 7737.264959829033, 7765.7670269892, 7875.0, 9305.906940930505, 9936.950315248378, 10070.123574759506, 10188.134008609351, 10190.0], "value": 8908.76410922489, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1210.8425904632397, 1347.3802051056514, 1384.8961327900406, 1447.6742732885102, 1698.2273065755076, 6870.141232345957, 7494.7002119915205, 7704.114026886909, 7713.73001944932, 7892.052953645571, 7608.125065617442, 7751.18612545683, 7759.301662850342, 7766.184550622174, 7771.33943614792, 1889.2726300374318, 2154.5798569278995, 2221.0782525252043, 2248.8875556222206, 2255.2783109404913, 2219.3120132758895, 2234.9329520114343, 2242.4057624729458, 2245.5621153875, 2246.663000549914, 2195.5279614882797, 2211.060299372768, 2224.6218142915745, 2224.7775222477703, 2228.799408053275, 1814.2470874587098, 2058.9485262868398, 2137.5511142659984, 2141.2826703054498, 2147.7207962964712, 2151.3115802943066, 2180.858244214121, 2181.3783071824614, 2182.6835108909117, 2183.716116904808, 7901.881471777928, 7952.880706789403, 7955.840883182362, 7963.641636126388, 7970.123286438487, 4669.626429885635, 4807.375041244651, 4812.7352995585225, 4814.975925120387, 4815.759212039384, 2734.849583272919, 2816.7183281671873, 2939.8236105833503, 2966.0656893078612, 2968.0947311070113, 881.5504092912597, 907.5915837872983, 915.1900567997304, 1732.1252767352407, 1814.6280012597517, 10411.219158563063, 10522.105621022223, 10526.789464210673, 10533.68398948025, 10536.841947370796, 4176.540580536139, 4183.895402614959, 4276.48682158143, 4281.7002809803635, 4294.484661840599, 8532.23209911111, 8536.615852286663, 8543.658253669784, 8550.1449855014, 8554.144585541397, 4613.331066995267, 4642.5821676048645, 4666.183417901853, 4672.0, 4675.485696573374, 3729.272791805572, 4252.978735106367, 4419.7127186733405, 4431.8670439886855, 4475.060237350193, 3437.74216933731, 3486.633903440102, 3541.911452213664, 3586.049696830342, 3685.1708365617524, 986.9506524673737, 1007.5667462990984, 1015.720676813882, 1017.5370206555999, 1035.7565971996576, 649.3344322069917, 679.7654809090856, 830.8213734047088, 867.0, 868.6264906090315, 5244.396894357198, 5292.126799078186, 5321.0, 5359.249705041298, 5359.839204823861, 823.2261674026396, 850.9106543812934, 873.5763154869883, 891.6700820696384, 894.083564346537, 3685.7972811495624, 3751.381022131318, 3756.567994680592, 3903.531576210816, 3910.159315747128, 9562.28282878787, 9698.0, 9865.950670246746, 9878.308518403786, 9880.703578892644, 9715.125638692552, 9798.559064842098, 9825.164860986895, 9827.852582211273, 9839.409635421898, 7214.89177662346, 7262.600556969312, 7353.816154596071, 7381.11426628808, 7467.439942004371, 5177.922331165111, 5301.3373328333955, 5332.0, 5352.357717073976, 5374.919376209438, 8529.872051919103, 8883.511406872683, 8961.327900407365, 9009.819803604023, 9030.63877444895, 8787.077356877437, 9100.635974560944, 9110.954445227731, 9125.634974600942, 9147.307748066629, 5975.342712301556, 6059.787907423219, 6163.260408750979, 6965.860682786215, 7108.644567771694, 6851.177858656993, 7518.360939320219, 7528.887066694114, 7713.305802477804, 7729.304362607392, 6569.146011018537, 6617.470602351897, 6713.395794378529, 6721.361470660279, 6774.051632771318, 6824.283450237654, 6840.9657951711915, 6881.311868813079, 6937.687804048729, 7000.719971201095, 6345.302016778059, 6389.073584330339, 6415.486761059011, 6425.164728585254, 6426.260979987362, 4279.914401711886, 4386.12277544486, 4444.28891377378, 4456.6211871991245, 4461.219286624892, 4661.766911654336, 4679.649026323107, 4721.74030428316, 4734.668573199843, 4753.762311884461], "value": 4150.4114982782885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.9255186203449, 303.0680656979786, 304.5979307314345, 307.86300096457086, 311.4798286860942, 4791.0, 4806.759662016902, 4826.031990325951, 4842.8547143585665, 4868.0, 4718.363020992165, 4772.902232486522, 4787.9521204788025, 4788.784504697288, 4823.686460380081, 3591.533100696906, 3696.981515092421, 3718.6839118674943, 3788.810559472029, 3832.3485007548784, 3728.272986767581, 3759.1541903071725, 3780.621937806211, 3803.3914573668217, 3803.744764227812, 3698.7780733155964, 3724.6834019108273, 3726.962730372702, 3739.9626003739886, 3741.4948981887505, 3493.755437119403, 3587.910302242439, 3759.2105657811894, 3788.8105594720155, 3797.39241721326, 3339.3321335732708, 3354.9496757548654, 3364.34395292918, 3385.3567822113964, 3386.72906167506, 4636.907261854778, 4649.745178375151, 4671.252599584084, 4683.391159149322, 4719.221328480797, 4158.108060832314, 4304.321314687274, 4314.223439780838, 4321.935170972438, 4362.192994296065, 4953.529414705597, 5006.424261209934, 5031.798728050873, 5037.546620804109, 5043.646944713872, 3656.579493358271, 3677.2093999789904, 3689.114612493009, 3698.7410881238325, 3706.3328600851837, 5045.520675535819, 5146.176611742103, 5211.296474975868, 5245.527902488794, 5251.186066159751, 3725.6088110747983, 3731.9253614927547, 3735.8879233623034, 3754.549454065475, 3755.455458958436, 3797.7721336719333, 3799.5630502492013, 3800.809959502069, 3819.197968426606, 3830.80845957701, 4311.353297005474, 4313.482382114166, 4327.939654784598, 4345.326474396474, 4348.826046958149, 4790.209615413418, 4957.801687932442, 4975.875603109879, 4977.452480227172, 5088.898222035613, 1288.7100402409383, 1294.5792617399195, 1302.4920281090383, 1303.8305020347293, 1305.458234832534, 848.8769128476337, 861.7414775567305, 865.8959826221618, 869.4001139213922, 905.5879574793453, 4459.754713490789, 4468.620167285752, 4474.843380481668, 4499.797509112098, 4521.59305662492, 5129.461406552258, 5159.626571777025, 5161.690298582097, 5165.874645839213, 5184.807494276262, 4255.382257705761, 4456.930336719229, 4468.352088947085, 4479.686421950498, 4504.842330518416, 2680.1021657744486, 2696.91909242723, 2710.4985577668194, 2728.522508560994, 2732.8522020751334, 4779.928301075487, 4824.443045186057, 4833.9033219335415, 4866.78099485524, 4869.853904382874, 5076.873078173076, 5175.870603234874, 5196.908649183713, 5246.527812496894, 5256.448072952285, 4775.7076603231335, 4781.235002399669, 4801.542889119828, 4807.7836497357, 4844.806207751721, 5060.746962651926, 5066.240063990431, 5120.97439512815, 5124.461931497288, 5148.665336753099, 4775.928361074517, 4972.190712247569, 5029.622778291716, 5030.4718004608985, 5055.1153548128195, 4825.131476334153, 4836.854894353175, 4855.684380515255, 4863.197572400514, 4864.221724524059, 3753.981230093832, 3775.11284848066, 3777.6033516480375, 3780.527434070741, 3798.0694729791376, 4960.387873940911, 5049.671771334852, 5082.415522214993, 5099.311592935054, 5122.257272695513, 5053.7220452875445, 5065.0, 5080.822171223989, 5082.110630639697, 5090.956353947506, 5040.949590504048, 5065.13892638245, 5065.442801291929, 5076.416212135504, 5079.619028572798, 4840.878978025577, 5003.77483013258, 5014.899702006012, 5017.222330538772, 5020.221865610836, 4842.83050093245, 4926.211806111005, 5081.085404627055, 5103.540681338697, 5137.768800404066, 4971.975140124277, 4992.750362481789, 5006.69959802413, 5022.698638081727, 5027.32131162303], "value": 3803.7698132510523, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.8066221687056, 692.8787462194118, 703.3002162847966, 715.2454160860293, 741.7709782104774, 12697.492100315987, 13303.4013469394, 13695.0, 13715.999999999987, 13717.108387954777, 13015.154014989019, 13094.541691040815, 13154.079214454992, 13175.934120329384, 13249.80125298119, 619.4486906653083, 633.708494092718, 760.2359628573276, 772.6600295869828, 777.0248338335409, 757.696921231509, 787.8148635070754, 788.5032429569363, 793.3851265269404, 795.3438413309015, 833.2417500074934, 833.5873742497472, 835.4611275727152, 837.7612380471567, 838.4885220015785, 648.4423395879539, 660.696079803291, 827.3009307135461, 827.3215962910416, 827.3339961331096, 493.28473713116125, 493.6939097759412, 589.7581991383512, 602.6956387024568, 602.7016626769733, 12980.740385192337, 12983.610491685264, 13031.283279419627, 13053.804192937114, 13145.802812957812, 12729.108962372638, 13070.54253101137, 13246.139000964906, 13369.197848129143, 13475.326233688276, 11452.656420307405, 11729.648110556696, 11776.470058847286, 11872.584459543874, 11982.400879956054, 4244.702870799046, 4245.299525578276, 4263.296556068245, 4287.935680964788, 4304.483461984551, 56933.43066569364, 56940.43059569393, 57070.42929570693, 57489.13766293509, 57885.13172302419, 10285.28003039795, 10420.478976051167, 10534.0, 10582.629607963685, 10794.730131746612, 19625.509362266057, 19627.411177664693, 19631.0, 19638.312659056865, 19673.508162296057, 6829.078074459983, 6989.33601307875, 7003.474739394565, 7064.1876184238445, 7072.929270707227, 3419.26485805548, 3433.6909678129086, 3441.8451169697423, 3503.2468019375447, 3546.078019714893, 2818.168640251131, 2907.549329853876, 2909.2145120817686, 2917.9854100729362, 2918.8102773319665, 483.05803682818646, 488.32367171467064, 488.82158012325243, 489.48848453366315, 500.2895887839204, 379.33616171699526, 398.5177934698989, 481.33816002995883, 506.1395627433378, 542.4385760737697, 7098.254683258287, 7146.464015198881, 7384.630768461556, 7424.740134095281, 7488.4009279257525, 419.4107279272627, 467.99064018720117, 505.73196206010874, 560.9354924183771, 567.6168586204378, 3433.5536380270405, 3513.2270900401872, 3516.0682419158943, 3521.3837578424186, 3628.129248980226, 75250.62374688091, 78896.60551697205, 79050.20949790544, 87125.56437217773, 87698.56150719206, 74609.0, 76734.0, 76779.23220767721, 77435.22564774392, 79573.20426795658, 48781.75609122003, 50033.49966500361, 72502.63748681222, 74118.0, 74486.9435463815, 8105.351571874354, 8369.83260334802, 8374.748757537283, 8493.405461617627, 8555.35834812404, 41537.58462415337, 42281.365779512715, 42784.786076069424, 43223.0, 43681.126377471635, 52686.47313526969, 60988.39011609827, 61052.38947610467, 61671.0, 62503.37496624976, 9269.67556135532, 9544.141027307576, 9560.139587437165, 10363.015513526203, 10453.895461045293, 12442.564510242099, 12483.375831208221, 13084.934575327063, 13183.077184596987, 13316.400761965928, 9715.17421019193, 10626.256162068581, 10684.57261709523, 10718.73203169927, 10981.231313807957, 11813.291202527877, 12081.879181208076, 12192.207506512048, 12293.692657683629, 12412.937935310265, 10961.342319460859, 11090.778184436427, 11149.275297105662, 11206.43967801623, 11677.88322116802, 10147.137493312855, 10229.0, 10422.895771042497, 10538.209634277613, 10610.946945265534, 9027.23268522183, 9096.0, 9124.635014599342, 9391.624335026796, 9427.095034823855], "value": 6343.038907377898, "unit": "score"}], "name": "dromaeo_css", "value": 6429.122420880658, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 113.0, 112.0, 114.0, 114.0, 112.0, 113.0, 112.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 135.0, 130.0, 187.0, 132.0, 129.0, 169.0, 131.0, 163.0, 131.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 162.0, 163.0, 164.0, 161.0, 163.0, 164.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 79.0, 128.0, 75.0, 76.0, 76.0, 74.0, 101.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 117.0, 86.0, 87.0, 85.0, 119.0, 86.0, 86.0, 132.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 63.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 89.0, 90.0, 84.0, 85.0, 91.0, 118.0, 90.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 141.0, 130.0, 129.0, 132.0, 132.0, 146.0, 135.0, 144.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 169.0, 175.0, 174.0, 172.0, 172.0, 174.0, 171.0, 171.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 66.0, 68.0, 69.0, 69.0, 68.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1555.9000000000003, "alertThreshold": 2.0}]} 08:20:42 INFO - Return code: 0 08:20:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:20:42 ERROR - # TBPL SUCCESS # 08:20:42 INFO - Running post-action listener: _resource_record_post_action 08:20:42 INFO - ##### 08:20:42 INFO - ##### Finished run-tests step (success) 08:20:42 INFO - ##### 08:20:42 INFO - Running post-run listener: _resource_record_post_run 08:20:42 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504528896; Read time: 12; Write time: 848196 08:20:42 INFO - TinderboxPrint: CPU usage
13.2% 08:20:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:20:42 INFO - TinderboxPrint: I/O write bytes / time
504,528,896 / 848,196 08:20:42 INFO - TinderboxPrint: CPU idle
8,336.8 (86.8%) 08:20:42 INFO - TinderboxPrint: CPU user
1,213.7 (12.6%) 08:20:42 INFO - TinderboxPrint: Swap in / out
0 / 0 08:20:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 144678912; Read time: 0; Write time: 239340 08:20:42 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288399360; Read time: 12; Write time: 456916 08:20:43 INFO - Running post-run listener: _upload_blobber_files 08:20:43 INFO - Blob upload gear active. 08:20:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:20:43 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 08:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:20:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:20:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:20:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:47 INFO - (blobuploader) - INFO - Done attempting. 08:20:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:20:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:20:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:48 INFO - (blobuploader) - INFO - Done attempting. 08:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:20:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:49 INFO - (blobuploader) - INFO - Done attempting. 08:20:49 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:49 INFO - Return code: 0 08:20:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:20:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33d66e55feac76d41be4d7b784e74f79a9acbe7753ac99667a8d9ab9bebed8df7daccc0fc66d9af3a233e563ce71a8f0e83043357fa1a8b48c5ec52c21a71be0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b602eaab82ab08391376da84fa24fe9ca8aafd26ed8fcae4d4c7bd7694a9f74677476ccce5b4f53e55b2fdf39d29d28eafded5ea02d9973a23ef314cbbc0b3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ef316d5fa739f1d7c4ec4f7d172b06608f7293c5c8369384ae447dbf03e74cc471732f6aa86df8855b82d5b8024eebf39b0d4b2842f40fa5130091fb2c19c66"} 08:20:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:20:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:20:49 INFO - Contents: 08:20:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33d66e55feac76d41be4d7b784e74f79a9acbe7753ac99667a8d9ab9bebed8df7daccc0fc66d9af3a233e563ce71a8f0e83043357fa1a8b48c5ec52c21a71be0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b602eaab82ab08391376da84fa24fe9ca8aafd26ed8fcae4d4c7bd7694a9f74677476ccce5b4f53e55b2fdf39d29d28eafded5ea02d9973a23ef314cbbc0b3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ef316d5fa739f1d7c4ec4f7d172b06608f7293c5c8369384ae447dbf03e74cc471732f6aa86df8855b82d5b8024eebf39b0d4b2842f40fa5130091fb2c19c66"} 08:20:49 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:49 INFO - Copying logs to upload dir... 08:20:49 INFO - mkdir: /builds/slave/test/build/upload/logs 08:20:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.248674 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-10 08:20:49.137060) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 08:20:49.140977) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33d66e55feac76d41be4d7b784e74f79a9acbe7753ac99667a8d9ab9bebed8df7daccc0fc66d9af3a233e563ce71a8f0e83043357fa1a8b48c5ec52c21a71be0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b602eaab82ab08391376da84fa24fe9ca8aafd26ed8fcae4d4c7bd7694a9f74677476ccce5b4f53e55b2fdf39d29d28eafded5ea02d9973a23ef314cbbc0b3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ef316d5fa739f1d7c4ec4f7d172b06608f7293c5c8369384ae447dbf03e74cc471732f6aa86df8855b82d5b8024eebf39b0d4b2842f40fa5130091fb2c19c66"} build_url:https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/WuvQPFECQpKT0dGPyXHLIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33d66e55feac76d41be4d7b784e74f79a9acbe7753ac99667a8d9ab9bebed8df7daccc0fc66d9af3a233e563ce71a8f0e83043357fa1a8b48c5ec52c21a71be0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b602eaab82ab08391376da84fa24fe9ca8aafd26ed8fcae4d4c7bd7694a9f74677476ccce5b4f53e55b2fdf39d29d28eafded5ea02d9973a23ef314cbbc0b3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ef316d5fa739f1d7c4ec4f7d172b06608f7293c5c8369384ae447dbf03e74cc471732f6aa86df8855b82d5b8024eebf39b0d4b2842f40fa5130091fb2c19c66"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 08:20:49.167296) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:20:49.167669) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465569976.188824-1375167063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:20:49.251895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 08:20:49.252408) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 08:20:49.252863) ========= ========= Total master_lag: 0.61 =========