builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1466176441.39 results: success (0) buildid: 20160617053003 builduid: a87d7cf7d9e74bcda32a5e3bf8bb01db revision: 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:01.393645) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:01.394052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:01.394363) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:01.419530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:01.419848) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 08:14:01-- 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% 114M=0s 2016-06-17 08:14:01 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129916 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:01.563578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:01.563905) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019922 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:01.614378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:01.614879) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 08:14:01,766 truncating revision to first 12 chars 2016-06-17 08:14:01,766 Setting DEBUG logging. 2016-06-17 08:14:01,766 attempt 1/10 2016-06-17 08:14:01,766 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6b61c987f9ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 08:14:02,289 unpacking tar archive at: fx-team-6b61c987f9ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.837944 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:02.467513) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:02.467830) ========= script_repo_revision: 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:02.468280) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:02.468560) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 08:14:02.478114) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-17 08:14:02.478436) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:02 INFO - MultiFileLogger online at 20160617 08:14:02 in /builds/slave/test 08:14:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:14:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:02 INFO - {'append_to_log': False, 08:14:02 INFO - 'base_work_dir': '/builds/slave/test', 08:14:02 INFO - 'blob_upload_branch': 'Fx-Team', 08:14:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:02 INFO - 'branch': 'Fx-Team', 08:14:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:02 INFO - 'config_files': ('talos/linux_config.py',), 08:14:02 INFO - 'default_actions': ('clobber', 08:14:02 INFO - 'read-buildbot-config', 08:14:02 INFO - 'download-and-extract', 08:14:02 INFO - 'populate-webroot', 08:14:02 INFO - 'create-virtualenv', 08:14:02 INFO - 'install', 08:14:02 INFO - 'run-tests'), 08:14:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:02 INFO - 'download_minidump_stackwalk': True, 08:14:02 INFO - 'download_symbols': 'ondemand', 08:14:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:02 INFO - 'installer_path': 'installer.exe', 08:14:02 INFO - 'log_level': 'info', 08:14:02 INFO - 'log_name': 'talos', 08:14:02 INFO - 'log_to_console': True, 08:14:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:02 INFO - 'opt_config_files': (), 08:14:02 INFO - 'pip_index': False, 08:14:02 INFO - 'sps_profile': False, 08:14:02 INFO - 'sps_profile_interval': 0, 08:14:02 INFO - 'suite': 'dromaeojs', 08:14:02 INFO - 'system_bits': '32', 08:14:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:02 INFO - 'title': 'talos-linux64-ix-022', 08:14:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:02 INFO - 'use_talos_json': True, 08:14:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:02 INFO - 'work_dir': 'build'} 08:14:02 INFO - ##### 08:14:02 INFO - ##### Running clobber step. 08:14:02 INFO - ##### 08:14:02 INFO - Running pre-action listener: _resource_record_pre_action 08:14:02 INFO - Running main action method: clobber 08:14:02 INFO - rmtree: /builds/slave/test/build 08:14:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:03 INFO - Running post-action listener: _resource_record_post_action 08:14:03 INFO - ##### 08:14:03 INFO - ##### Finished clobber step (success) 08:14:03 INFO - ##### 08:14:03 INFO - ##### 08:14:03 INFO - ##### Running read-buildbot-config step. 08:14:03 INFO - ##### 08:14:03 INFO - Running pre-action listener: _resource_record_pre_action 08:14:03 INFO - Running main action method: read_buildbot_config 08:14:03 INFO - Using buildbot properties: 08:14:03 INFO - { 08:14:03 INFO - "project": "", 08:14:03 INFO - "product": "firefox", 08:14:03 INFO - "script_repo_revision": "production", 08:14:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:14:03 INFO - "repository": "", 08:14:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:14:03 INFO - "buildid": "20160617053003", 08:14:03 INFO - "pgo_build": "True", 08:14:03 INFO - "basedir": "/builds/slave/test", 08:14:03 INFO - "buildnumber": 195, 08:14:03 INFO - "slavename": "talos-linux64-ix-022", 08:14:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:14:03 INFO - "platform": "ubuntu64_hw", 08:14:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:14:03 INFO - "branch": "fx-team", 08:14:03 INFO - "repo_path": "integration/fx-team", 08:14:03 INFO - "revision": "6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5", 08:14:03 INFO - "stage_platform": "linux64-pgo", 08:14:03 INFO - "builduid": "a87d7cf7d9e74bcda32a5e3bf8bb01db", 08:14:03 INFO - "slavebuilddir": "test" 08:14:03 INFO - } 08:14:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:14:03 INFO - Running post-action listener: _resource_record_post_action 08:14:03 INFO - ##### 08:14:03 INFO - ##### Finished read-buildbot-config step (success) 08:14:03 INFO - ##### 08:14:03 INFO - ##### 08:14:03 INFO - ##### Running download-and-extract step. 08:14:03 INFO - ##### 08:14:03 INFO - Running pre-action listener: _resource_record_pre_action 08:14:03 INFO - Running main action method: download_and_extract 08:14:03 INFO - mkdir: /builds/slave/test/build/tests 08:14:03 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:14:03 INFO - https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:14:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:14:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:14:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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:14:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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:14:04 INFO - Downloaded 1361 bytes. 08:14:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:14:04 INFO - Using the following test package requirements: 08:14:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:14:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:14:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:04 INFO - u'jsshell-linux-x86_64.zip'], 08:14:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:14:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:14:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:14:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:14:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:14:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:14: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:14:04 INFO - https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:14:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:14:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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:14:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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:14:05 INFO - Downloaded 24175990 bytes. 08:14:05 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:14:05 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:14:06 INFO - Return code: 0 08:14:06 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:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:06 INFO - https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:14:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:14:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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:14:07 INFO - Downloaded 24175990 bytes. 08:14:07 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:14:07 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:14:09 INFO - Return code: 0 08:14: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:14:09 INFO - https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:14:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:14:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:14:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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:14:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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:14:10 INFO - Downloaded 14405384 bytes. 08:14:10 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:14:10 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:14:10 INFO - Return code: 0 08:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:10 INFO - https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:14:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:14:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:14:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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:14:11 INFO - Downloaded 58447307 bytes. 08:14:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:14:11 INFO - mkdir: /builds/slave/test/properties 08:14:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:11 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:11 INFO - Contents: 08:14:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:14:12 INFO - Running post-action listener: _resource_record_post_action 08:14:12 INFO - Running post-action listener: set_extra_try_arguments 08:14:12 INFO - ##### 08:14:12 INFO - ##### Finished download-and-extract step (success) 08:14:12 INFO - ##### 08:14:12 INFO - ##### 08:14:12 INFO - ##### Running populate-webroot step. 08:14:12 INFO - ##### 08:14:12 INFO - Running pre-action listener: _resource_record_pre_action 08:14:12 INFO - Running main action method: populate_webroot 08:14:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:12 INFO - '--tppagecycles', 08:14:12 INFO - '7'], 08:14:12 INFO - 'tests': ['tsvgm']}}, 08:14:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:12 INFO - 'talos_options': ['--disable-e10s'], 08:14:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:12 INFO - 'talos_options': ['--disable-e10s'], 08:14:12 INFO - 'tests': ['damp', 'tps']}, 08:14:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:12 INFO - 'tests': ['damp', 'tps']}, 08:14:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:12 INFO - 'tests': ['dromaeo_dom']}, 08:14:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:12 INFO - 'tests': ['basic_compositor_video']}, 08:14:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:12 INFO - 'tests': ['a11yr', 08:14:12 INFO - 'ts_paint', 08:14:12 INFO - 'tpaint', 08:14:12 INFO - 'sessionrestore', 08:14:12 INFO - 'sessionrestore_no_auto_restore', 08:14:12 INFO - 'tabpaint']}, 08:14:12 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:12 INFO - 'ts_paint', 08:14:12 INFO - 'tpaint', 08:14:12 INFO - 'sessionrestore', 08:14:12 INFO - 'sessionrestore_no_auto_restore', 08:14:12 INFO - 'tabpaint']}, 08:14:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:12 INFO - 'ts_paint', 08:14:12 INFO - 'tpaint', 08:14:12 INFO - 'sessionrestore', 08:14:12 INFO - 'sessionrestore_no_auto_restore', 08:14:12 INFO - 'tabpaint']}, 08:14:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:12 INFO - 'ts_paint', 08:14:12 INFO - 'tpaint', 08:14:12 INFO - 'sessionrestore', 08:14:12 INFO - 'sessionrestore_no_auto_restore', 08:14:12 INFO - 'tabpaint']}, 08:14:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:12 INFO - 'tests': ['a11yr', 08:14:12 INFO - 'ts_paint', 08:14:12 INFO - 'tpaint', 08:14:12 INFO - 'sessionrestore', 08:14:12 INFO - 'sessionrestore_no_auto_restore', 08:14:12 INFO - 'tabpaint']}, 08:14:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:12 INFO - 'tests': ['a11yr', 08:14:12 INFO - 'ts_paint', 08:14:12 INFO - 'tpaint', 08:14:12 INFO - 'sessionrestore', 08:14:12 INFO - 'sessionrestore_no_auto_restore', 08:14:12 INFO - 'tabpaint']}, 08:14:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:12 INFO - 'tests': ['tsvgx', 08:14:12 INFO - 'tsvgr_opacity', 08:14:12 INFO - 'tart', 08:14:12 INFO - 'tscrollx', 08:14:12 INFO - 'cart']}, 08:14:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:12 INFO - 'tsvgr_opacity', 08:14:12 INFO - 'tart', 08:14:12 INFO - 'tscrollx', 08:14:12 INFO - 'cart']}, 08:14:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:12 INFO - 'talos_options': ['--disable-e10s'], 08:14:12 INFO - 'tests': ['tp5o']}, 08:14:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:12 INFO - 'tests': ['tp5o']}, 08:14:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:12 INFO - 'talos_options': ['--disable-e10s', 08:14:12 INFO - '--xperf_path', 08:14:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:12 INFO - 'tests': ['tp5n']}, 08:14:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:12 INFO - 'talos_options': ['--xperf_path', 08:14:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:12 INFO - 'tests': ['tp5n']}}, 08:14:12 INFO - 'talos.zip': {'path': '', 08:14:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:12 INFO - Running post-action listener: _resource_record_post_action 08:14:12 INFO - ##### 08:14:12 INFO - ##### Finished populate-webroot step (success) 08:14:12 INFO - ##### 08:14:12 INFO - ##### 08:14:12 INFO - ##### Running create-virtualenv step. 08:14:12 INFO - ##### 08:14:12 INFO - Running pre-action listener: _resource_record_pre_action 08:14:12 INFO - Running main action method: create_virtualenv 08:14:12 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:12 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:14:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:12 INFO - Using real prefix '/usr' 08:14:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:13 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:15 INFO - Installing pip.................done. 08:14:15 INFO - Return code: 0 08:14:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14: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:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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 0x7f4d1563df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d31110>, '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 0x2c9d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9d6c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', '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:14: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:14: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:14:15 INFO - Using env: {'DISPLAY': ':0', 08:14:15 INFO - 'HOME': '/home/cltbld', 08:14:15 INFO - 'LANG': 'en_US.UTF-8', 08:14:15 INFO - 'LANGUAGE': 'en_US:en', 08:14:15 INFO - 'LOGNAME': 'cltbld', 08:14:15 INFO - 'MAIL': '/var/mail/cltbld', 08:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:15 INFO - 'MOZ_NO_REMOTE': '1', 08:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:15 INFO - 'NO_EM_RESTART': '1', 08:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:15 INFO - 'PWD': '/builds/slave/test', 08:14:15 INFO - 'SHELL': '/bin/bash', 08:14:15 INFO - 'SHLVL': '1', 08:14:15 INFO - 'TERM': 'linux', 08:14:15 INFO - 'TMOUT': '86400', 08:14:15 INFO - 'USER': 'cltbld', 08:14:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', 08:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:15 INFO - '_': '/tools/buildbot/bin/python'} 08:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14: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:14:15 INFO - Cleaning up... 08:14:15 INFO - Return code: 0 08:14:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14: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:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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 0x7f4d1563df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d31110>, '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 0x2c9d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9d6c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', '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:14: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:14: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:14:15 INFO - Using env: {'DISPLAY': ':0', 08:14:15 INFO - 'HOME': '/home/cltbld', 08:14:15 INFO - 'LANG': 'en_US.UTF-8', 08:14:15 INFO - 'LANGUAGE': 'en_US:en', 08:14:15 INFO - 'LOGNAME': 'cltbld', 08:14:15 INFO - 'MAIL': '/var/mail/cltbld', 08:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:15 INFO - 'MOZ_NO_REMOTE': '1', 08:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:15 INFO - 'NO_EM_RESTART': '1', 08:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:15 INFO - 'PWD': '/builds/slave/test', 08:14:15 INFO - 'SHELL': '/bin/bash', 08:14:15 INFO - 'SHLVL': '1', 08:14:15 INFO - 'TERM': 'linux', 08:14:15 INFO - 'TMOUT': '86400', 08:14:15 INFO - 'USER': 'cltbld', 08:14:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', 08:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:15 INFO - '_': '/tools/buildbot/bin/python'} 08:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:15 INFO - Downloading/unpacking psutil>=3.1.1 08:14:15 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:14:15 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:14:15 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:14:15 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:14:15 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:14:15 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:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:17 INFO - Installing collected packages: psutil 08:14:17 INFO - Running setup.py install for psutil 08:14:17 INFO - building 'psutil._psutil_linux' extension 08:14:17 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:14:17 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:14:17 INFO - building 'psutil._psutil_posix' extension 08:14:17 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:14: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:14:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:18 INFO - Successfully installed psutil 08:14:18 INFO - Cleaning up... 08:14:18 INFO - Return code: 0 08:14:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14: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:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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 0x7f4d1563df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d31110>, '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 0x2c9d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9d6c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', '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:14: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:14: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:14:18 INFO - Using env: {'DISPLAY': ':0', 08:14:18 INFO - 'HOME': '/home/cltbld', 08:14:18 INFO - 'LANG': 'en_US.UTF-8', 08:14:18 INFO - 'LANGUAGE': 'en_US:en', 08:14:18 INFO - 'LOGNAME': 'cltbld', 08:14:18 INFO - 'MAIL': '/var/mail/cltbld', 08:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:18 INFO - 'MOZ_NO_REMOTE': '1', 08:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:18 INFO - 'NO_EM_RESTART': '1', 08:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:18 INFO - 'PWD': '/builds/slave/test', 08:14:18 INFO - 'SHELL': '/bin/bash', 08:14:18 INFO - 'SHLVL': '1', 08:14:18 INFO - 'TERM': 'linux', 08:14:18 INFO - 'TMOUT': '86400', 08:14:18 INFO - 'USER': 'cltbld', 08:14:18 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', 08:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:18 INFO - '_': '/tools/buildbot/bin/python'} 08:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14: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:14: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:14: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:14: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:14: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:14: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:14:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14: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:14:20 INFO - Installing collected packages: mozsystemmonitor 08:14:20 INFO - Running setup.py install for mozsystemmonitor 08:14:20 INFO - Successfully installed mozsystemmonitor 08:14:20 INFO - Cleaning up... 08:14:20 INFO - Return code: 0 08:14:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14: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:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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 0x7f4d1563df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d31110>, '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 0x2c9d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9d6c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', '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:14: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:14: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:14:20 INFO - Using env: {'DISPLAY': ':0', 08:14:20 INFO - 'HOME': '/home/cltbld', 08:14:20 INFO - 'LANG': 'en_US.UTF-8', 08:14:20 INFO - 'LANGUAGE': 'en_US:en', 08:14:20 INFO - 'LOGNAME': 'cltbld', 08:14:20 INFO - 'MAIL': '/var/mail/cltbld', 08:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:20 INFO - 'MOZ_NO_REMOTE': '1', 08:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:20 INFO - 'NO_EM_RESTART': '1', 08:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:20 INFO - 'PWD': '/builds/slave/test', 08:14:20 INFO - 'SHELL': '/bin/bash', 08:14:20 INFO - 'SHLVL': '1', 08:14:20 INFO - 'TERM': 'linux', 08:14:20 INFO - 'TMOUT': '86400', 08:14:20 INFO - 'USER': 'cltbld', 08:14:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', 08:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:20 INFO - '_': '/tools/buildbot/bin/python'} 08:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:22 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:22 INFO - warning: no files found matching '*.txt' 08:14:22 INFO - no previously-included directories found matching 'build' 08:14:22 INFO - no previously-included directories found matching 'dist' 08:14:22 INFO - no previously-included directories found matching '.git*' 08:14:22 INFO - Installing collected packages: jsonschema, functools32 08:14:22 INFO - Running setup.py install for functools32 08:14:22 INFO - warning: no files found matching '*.txt' 08:14:22 INFO - no previously-included directories found matching 'build' 08:14:22 INFO - no previously-included directories found matching 'dist' 08:14:22 INFO - no previously-included directories found matching '.git*' 08:14:22 INFO - Successfully installed jsonschema functools32 08:14:22 INFO - Cleaning up... 08:14:23 INFO - Return code: 0 08:14:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14: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:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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 0x7f4d1563df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d31110>, '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 0x2c9d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9d6c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', '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:14: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:14: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:14:23 INFO - Using env: {'DISPLAY': ':0', 08:14:23 INFO - 'HOME': '/home/cltbld', 08:14:23 INFO - 'LANG': 'en_US.UTF-8', 08:14:23 INFO - 'LANGUAGE': 'en_US:en', 08:14:23 INFO - 'LOGNAME': 'cltbld', 08:14:23 INFO - 'MAIL': '/var/mail/cltbld', 08:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:23 INFO - 'MOZ_NO_REMOTE': '1', 08:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:23 INFO - 'NO_EM_RESTART': '1', 08:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:23 INFO - 'PWD': '/builds/slave/test', 08:14:23 INFO - 'SHELL': '/bin/bash', 08:14:23 INFO - 'SHLVL': '1', 08:14:23 INFO - 'TERM': 'linux', 08:14:23 INFO - 'TMOUT': '86400', 08:14:23 INFO - 'USER': 'cltbld', 08:14:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', 08:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:23 INFO - '_': '/tools/buildbot/bin/python'} 08:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:23 INFO - Downloading/unpacking blobuploader==1.2.4 08:14: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:14: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:14: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:14: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:14: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:14: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:14:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14: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:14: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:14: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:14: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:14: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:14: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:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14: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:14: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:14: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:14: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:14: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:14: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:14:26 INFO - Downloading docopt-0.6.1.tar.gz 08:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:26 INFO - Running setup.py install for blobuploader 08:14:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:26 INFO - Running setup.py install for requests 08:14:26 INFO - Running setup.py install for docopt 08:14:26 INFO - Successfully installed blobuploader requests docopt 08:14:26 INFO - Cleaning up... 08:14:26 INFO - Return code: 0 08:14:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14: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:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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 0x7f4d1563df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d31110>, '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 0x2c9d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9d6c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', '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:14: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:14: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:14:26 INFO - Using env: {'DISPLAY': ':0', 08:14:26 INFO - 'HOME': '/home/cltbld', 08:14:26 INFO - 'LANG': 'en_US.UTF-8', 08:14:26 INFO - 'LANGUAGE': 'en_US:en', 08:14:26 INFO - 'LOGNAME': 'cltbld', 08:14:26 INFO - 'MAIL': '/var/mail/cltbld', 08:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:26 INFO - 'MOZ_NO_REMOTE': '1', 08:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:26 INFO - 'NO_EM_RESTART': '1', 08:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:26 INFO - 'PWD': '/builds/slave/test', 08:14:26 INFO - 'SHELL': '/bin/bash', 08:14:26 INFO - 'SHLVL': '1', 08:14:26 INFO - 'TERM': 'linux', 08:14:26 INFO - 'TMOUT': '86400', 08:14:26 INFO - 'USER': 'cltbld', 08:14:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', 08:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:26 INFO - '_': '/tools/buildbot/bin/python'} 08:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:26 INFO - Running setup.py (path:/tmp/pip-WH4T4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:26 INFO - Running setup.py (path:/tmp/pip-h5ICxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:27 INFO - Running setup.py (path:/tmp/pip-ffZNJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:27 INFO - Running setup.py (path:/tmp/pip-wsUfxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:27 INFO - Running setup.py (path:/tmp/pip-2Qk_67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:27 INFO - Running setup.py (path:/tmp/pip-POxb9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:27 INFO - Running setup.py (path:/tmp/pip-Ho3_y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:27 INFO - Running setup.py (path:/tmp/pip-L6D9Wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:27 INFO - Running setup.py (path:/tmp/pip-QwOqbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:27 INFO - Running setup.py (path:/tmp/pip-UoEhbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:27 INFO - Running setup.py (path:/tmp/pip-e4uwbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:27 INFO - Running setup.py (path:/tmp/pip-qITzkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:27 INFO - Running setup.py (path:/tmp/pip-3QeLJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:27 INFO - Running setup.py (path:/tmp/pip-CGCX6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:27 INFO - Running setup.py (path:/tmp/pip-3QRfNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:28 INFO - Running setup.py (path:/tmp/pip-qTeD5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:28 INFO - Running setup.py (path:/tmp/pip-BHbrXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:28 INFO - Running setup.py install for manifestparser 08:14:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:28 INFO - Running setup.py install for mozcrash 08:14:28 INFO - Running setup.py install for mozdebug 08:14:28 INFO - Running setup.py install for mozdevice 08:14:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:28 INFO - Running setup.py install for mozfile 08:14:28 INFO - Running setup.py install for mozhttpd 08:14:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:28 INFO - Running setup.py install for mozinfo 08:14:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:28 INFO - Running setup.py install for mozInstall 08:14:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:28 INFO - Running setup.py install for mozleak 08:14:29 INFO - Running setup.py install for mozlog 08:14:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Running setup.py install for moznetwork 08:14:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Running setup.py install for mozprocess 08:14:29 INFO - Running setup.py install for mozprofile 08:14:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Running setup.py install for mozrunner 08:14:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Running setup.py install for mozscreenshot 08:14:29 INFO - Running setup.py install for moztest 08:14:29 INFO - Running setup.py install for mozversion 08:14:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:29 INFO - Cleaning up... 08:14:29 INFO - Return code: 0 08:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d1563df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d31110>, '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 0x2c9d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9d6c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', '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:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:29 INFO - Using env: {'DISPLAY': ':0', 08:14:29 INFO - 'HOME': '/home/cltbld', 08:14:29 INFO - 'LANG': 'en_US.UTF-8', 08:14:29 INFO - 'LANGUAGE': 'en_US:en', 08:14:29 INFO - 'LOGNAME': 'cltbld', 08:14:29 INFO - 'MAIL': '/var/mail/cltbld', 08:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:29 INFO - 'MOZ_NO_REMOTE': '1', 08:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:29 INFO - 'NO_EM_RESTART': '1', 08:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:29 INFO - 'PWD': '/builds/slave/test', 08:14:29 INFO - 'SHELL': '/bin/bash', 08:14:29 INFO - 'SHLVL': '1', 08:14:29 INFO - 'TERM': 'linux', 08:14:29 INFO - 'TMOUT': '86400', 08:14:29 INFO - 'USER': 'cltbld', 08:14:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', 08:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:29 INFO - '_': '/tools/buildbot/bin/python'} 08:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:30 INFO - Running setup.py (path:/tmp/pip-shuIdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14: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:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:30 INFO - Running setup.py (path:/tmp/pip-Pu9B7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14: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:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:30 INFO - Running setup.py (path:/tmp/pip-0ROdPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14: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:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:30 INFO - Running setup.py (path:/tmp/pip-M2WUHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14: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:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:30 INFO - Running setup.py (path:/tmp/pip-tJOkk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14: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:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:30 INFO - Running setup.py (path:/tmp/pip-lh0LSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14: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:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:30 INFO - Running setup.py (path:/tmp/pip-SuSHkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14: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:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:30 INFO - Running setup.py (path:/tmp/pip-XRRejP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14: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:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:30 INFO - Running setup.py (path:/tmp/pip-pzRjcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:30 INFO - Running setup.py (path:/tmp/pip-vdZtBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:30 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:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:30 INFO - Running setup.py (path:/tmp/pip-Z6u7J4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:30 INFO - Running setup.py (path:/tmp/pip-1W7BTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14: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:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:31 INFO - Running setup.py (path:/tmp/pip-Zt7myW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14: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:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:31 INFO - Running setup.py (path:/tmp/pip-criPMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14: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:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:31 INFO - Running setup.py (path:/tmp/pip-aiBxVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14: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:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:31 INFO - Running setup.py (path:/tmp/pip-G98IWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14: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:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:31 INFO - Running setup.py (path:/tmp/pip-yuuhDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14: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:14: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:14: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:14: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:14: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:14: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:14:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14: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:14: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:14: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:14: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:14: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:14: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:14:33 INFO - Downloading blessings-1.6.tar.gz 08:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:33 INFO - Installing collected packages: blessings 08:14:33 INFO - Running setup.py install for blessings 08:14:33 INFO - Successfully installed blessings 08:14:33 INFO - Cleaning up... 08:14:33 INFO - Return code: 0 08:14:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:33 INFO - Reading from file tmpfile_stdout 08:14:33 INFO - Current package versions: 08:14:33 INFO - argparse == 1.2.1 08:14:33 INFO - blessings == 1.6 08:14:33 INFO - blobuploader == 1.2.4 08:14:33 INFO - docopt == 0.6.1 08:14:33 INFO - functools32 == 3.2.3-2 08:14:33 INFO - jsonschema == 2.5.1 08:14:33 INFO - manifestparser == 1.1 08:14:33 INFO - mozInstall == 1.12 08:14:33 INFO - mozcrash == 0.17 08:14:33 INFO - mozdebug == 0.1 08:14:33 INFO - mozdevice == 0.48 08:14:33 INFO - mozfile == 1.2 08:14:33 INFO - mozhttpd == 0.7 08:14:33 INFO - mozinfo == 0.9 08:14:33 INFO - mozleak == 0.1 08:14:33 INFO - mozlog == 3.2 08:14:33 INFO - moznetwork == 0.27 08:14:33 INFO - mozprocess == 0.22 08:14:33 INFO - mozprofile == 0.28 08:14:33 INFO - mozrunner == 6.11 08:14:33 INFO - mozscreenshot == 0.1 08:14:33 INFO - mozsystemmonitor == 0.3 08:14:33 INFO - moztest == 0.7 08:14:33 INFO - mozversion == 1.4 08:14:33 INFO - psutil == 3.1.1 08:14:33 INFO - requests == 1.2.3 08:14:33 INFO - wsgiref == 0.1.2 08:14:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14: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:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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 0x7f4d1563df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d31110>, '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 0x2c9d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9d6c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', '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:14: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:14: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:14:33 INFO - Using env: {'DISPLAY': ':0', 08:14:33 INFO - 'HOME': '/home/cltbld', 08:14:33 INFO - 'LANG': 'en_US.UTF-8', 08:14:33 INFO - 'LANGUAGE': 'en_US:en', 08:14:33 INFO - 'LOGNAME': 'cltbld', 08:14:33 INFO - 'MAIL': '/var/mail/cltbld', 08:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:33 INFO - 'MOZ_NO_REMOTE': '1', 08:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:33 INFO - 'NO_EM_RESTART': '1', 08:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:33 INFO - 'PWD': '/builds/slave/test', 08:14:33 INFO - 'SHELL': '/bin/bash', 08:14:33 INFO - 'SHLVL': '1', 08:14:33 INFO - 'TERM': 'linux', 08:14:33 INFO - 'TMOUT': '86400', 08:14:33 INFO - 'USER': 'cltbld', 08:14:33 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', 08:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:33 INFO - '_': '/tools/buildbot/bin/python'} 08:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:14:33 INFO - Cleaning up... 08:14:34 INFO - Return code: 0 08:14:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14: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:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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 0x7f4d1563df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d31110>, '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 0x2c9d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9d6c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', '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:14: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:14: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:14:34 INFO - Using env: {'DISPLAY': ':0', 08:14:34 INFO - 'HOME': '/home/cltbld', 08:14:34 INFO - 'LANG': 'en_US.UTF-8', 08:14:34 INFO - 'LANGUAGE': 'en_US:en', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MAIL': '/var/mail/cltbld', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SHLVL': '1', 08:14:34 INFO - 'TERM': 'linux', 08:14:34 INFO - 'TMOUT': '86400', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - '_': '/tools/buildbot/bin/python'} 08:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:34 INFO - Cleaning up... 08:14:34 INFO - Return code: 0 08:14:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:14: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:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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 0x7f4d1563df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d31110>, '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 0x2c9d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9d6c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', '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:14: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:14: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:14:34 INFO - Using env: {'DISPLAY': ':0', 08:14:34 INFO - 'HOME': '/home/cltbld', 08:14:34 INFO - 'LANG': 'en_US.UTF-8', 08:14:34 INFO - 'LANGUAGE': 'en_US:en', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MAIL': '/var/mail/cltbld', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SHLVL': '1', 08:14:34 INFO - 'TERM': 'linux', 08:14:34 INFO - 'TMOUT': '86400', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - '_': '/tools/buildbot/bin/python'} 08:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:34 INFO - Downloading/unpacking flake8 08:14: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:14: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:14: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:14: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:14: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:14: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:14:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:14:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:14: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:14: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:14: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:14: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:14: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:14: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:14:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:14:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:14: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:14: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:14: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:14: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:14: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:14: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:14:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:14: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:14: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:14: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:14: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:14: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:14: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:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:14:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:37 INFO - no previously-included directories found matching 'docs/_build' 08:14:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:14:37 INFO - Running setup.py install for pep8 08:14:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:37 INFO - no previously-included directories found matching 'docs/_build' 08:14:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:14:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:14:37 INFO - Cleaning up... 08:14:37 INFO - Return code: 0 08:14:37 INFO - Running post-action listener: _resource_record_post_action 08:14:37 INFO - Running post-action listener: _start_resource_monitoring 08:14:37 INFO - Starting resource monitoring. 08:14:37 INFO - ##### 08:14:37 INFO - ##### Finished create-virtualenv step (success) 08:14:37 INFO - ##### 08:14:37 INFO - ##### 08:14:37 INFO - ##### Running install step. 08:14:37 INFO - ##### 08:14:37 INFO - Running pre-action listener: _resource_record_pre_action 08:14:37 INFO - Running main action method: install 08:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:37 INFO - Reading from file tmpfile_stdout 08:14:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:37 INFO - Reading from file tmpfile_stdout 08:14:37 INFO - Output received: 08:14:37 INFO - Usage: mozinstall [options] installer 08:14:37 INFO - Options: 08:14:37 INFO - -h, --help show this help message and exit 08:14:37 INFO - -d DEST, --destination=DEST 08:14:37 INFO - Directory to install application into. [default: 08:14:37 INFO - "/builds/slave/test"] 08:14:37 INFO - --app=APP Application being installed. [default: firefox] 08:14:37 INFO - mkdir: /builds/slave/test/build/application 08:14:37 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:14:37 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:14:54 INFO - Reading from file tmpfile_stdout 08:14:54 INFO - Output received: 08:14:54 INFO - /builds/slave/test/build/application/firefox/firefox 08:14:54 INFO - Running post-action listener: _resource_record_post_action 08:14:54 INFO - ##### 08:14:54 INFO - ##### Finished install step (success) 08:14:54 INFO - ##### 08:14:54 INFO - ##### 08:14:54 INFO - ##### Running run-tests step. 08:14:54 INFO - ##### 08:14:54 INFO - Running pre-action listener: _resource_record_pre_action 08:14:54 INFO - Running main action method: run_tests 08:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:54 INFO - Python 2.7.3 08:14:54 INFO - Return code: 0 08:14:54 INFO - grabbing minidump binary from tooltool 08:14: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:14: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 0x2d31110>, '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 0x2c9d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9d6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14: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:14: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:14: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:14:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:14:54 INFO - Return code: 0 08:14:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:14:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:14:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:14:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:14:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:14:55 INFO - Return code: 0 08:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:14:55 INFO - Using env: {'DISPLAY': ':0', 08:14:55 INFO - 'HOME': '/home/cltbld', 08:14:55 INFO - 'LANG': 'en_US.UTF-8', 08:14:55 INFO - 'LANGUAGE': 'en_US:en', 08:14:55 INFO - 'LOGNAME': 'cltbld', 08:14:55 INFO - 'MAIL': '/var/mail/cltbld', 08:14:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:14:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:55 INFO - 'MOZ_NO_REMOTE': '1', 08:14:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:55 INFO - 'NO_EM_RESTART': '1', 08:14:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:55 INFO - 'PWD': '/builds/slave/test', 08:14:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:14:55 INFO - 'SHELL': '/bin/bash', 08:14:55 INFO - 'SHLVL': '1', 08:14:55 INFO - 'TERM': 'linux', 08:14:55 INFO - 'TMOUT': '86400', 08:14:55 INFO - 'USER': 'cltbld', 08:14:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038', 08:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:55 INFO - '_': '/tools/buildbot/bin/python'} 08:14:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:14:55 INFO - mozversion application_buildid: 20160617053003 08:14:55 INFO - mozversion application_changeset: 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 08:14:55 INFO - mozversion application_display_name: Nightly 08:14:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:14:55 INFO - mozversion application_name: Firefox 08:14:55 INFO - mozversion application_remotingname: firefox 08:14:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:14:55 INFO - mozversion application_vendor: Mozilla 08:14:55 INFO - mozversion application_version: 50.0a1 08:14:55 INFO - mozversion platform_buildid: 20160617053003 08:14:55 INFO - mozversion platform_changeset: 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 08:14:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:14:55 INFO - mozversion platform_version: 50.0a1 08:14:55 INFO - using testdate: 1466176495 08:14:55 INFO - actual date: 1466176495 08:14:55 INFO - starting webserver on 'localhost:52476' 08:14:55 INFO - SUITE-START | Running 2 tests 08:14:55 INFO - TEST-START | dromaeo_css 08:14:55 INFO - operating with platform_type : linux_ 08:14:55 INFO - Initialising browser for dromaeo_css test... 08:14:55 INFO - TEST-INFO | started process 25964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxJZ_Ko/profile http://localhost:52476/getInfo.html) 08:14:59 INFO - PROCESS | 25964 | __metrics Screen width/height:1600/1200 08:14:59 INFO - PROCESS | 25964 | colorDepth:24 08:14:59 INFO - PROCESS | 25964 | Browser inner width/height: 1024/697 08:14:59 INFO - PROCESS | 25964 | __metrics 08:15:00 INFO - PROCESS | 25964 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:01 INFO - TEST-INFO | 25964: exit 0 08:15:01 INFO - Browser initialized. 08:15:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:01 INFO - TEST-INFO | started process 26050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxJZ_Ko/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:13 INFO - PROCESS | 26050 | RSS: Main: 174419968 08:15:13 INFO - PROCESS | 26050 | 08:16:05 INFO - PROCESS | 26050 | 1466176565200 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:18:12 INFO - PROCESS | 26050 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52476/tests/dromaeo/cssquery-ext.html) 08:18:13 INFO - PROCESS | 26050 | RSS: Main: 292286464 08:18:13 INFO - PROCESS | 26050 | 08:21:16 INFO - PROCESS | 26050 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-ext.html (next: http://localhost:52476/tests/dromaeo/cssquery-jquery.html) 08:21:16 INFO - PROCESS | 26050 | RSS: Main: 265502720 08:21:16 INFO - PROCESS | 26050 | 08:24:18 INFO - PROCESS | 26050 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52476/tests/dromaeo/cssquery-mootools.html) 08:24:19 INFO - PROCESS | 26050 | RSS: Main: 262340608 08:24:19 INFO - PROCESS | 26050 | 08:27:21 INFO - PROCESS | 26050 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52476/tests/dromaeo/cssquery-prototype.html) 08:27:22 INFO - PROCESS | 26050 | RSS: Main: 255422464 08:27:22 INFO - PROCESS | 26050 | 08:30:24 INFO - PROCESS | 26050 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52476/tests/dromaeo/cssquery-yui.html) 08:30:25 INFO - PROCESS | 26050 | RSS: Main: 237379584 08:30:25 INFO - PROCESS | 26050 | 08:33:27 INFO - PROCESS | 26050 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-yui.html (next: http://localhost:52476/tests/dromaeo/cssquery-dojo.html) 08:33:28 INFO - PROCESS | 26050 | RSS: Main: 320573440 08:33:28 INFO - PROCESS | 26050 | 08:33:28 INFO - PROCESS | 26050 | __start_tp_report 08:33:28 INFO - PROCESS | 26050 | _x_x_mozilla_page_load 08:33:28 INFO - PROCESS | 26050 | _x_x_mozilla_page_load_details 08:33:28 INFO - PROCESS | 26050 | |i|pagename|runs| 08:33:28 INFO - PROCESS | 26050 | |0;dojo.html;2812.465631530009;2827.180117765848;2844;2860.756835668968;2882.207392966935;4618.884527886805;4678.53214678532;4691.850496628331;4748.2165442702;4789.18583840747;4614.676972611918;4618.19181643212;4621.445426548818;4625.537446255373;4640.582347588716;4233.640140588053;4266.957330426702;4311.28863737483;4330.480342358921;4455.821767129327;4406.184855801687;4416.470023597173;4433.024734558392;4455.487618923833;4469.195544801934;4236.830526778926;4272.572742725733;4275.636570891478;4278.229918614648;4339.262325404673;4278.208531421666;4278.2940814765525;4290.635295999844;4298.742075475481;4326;4284.378765079077;4307.375430562583;4314.784260786948;4321.848735294281;4339.566043395666;4502.639788816887;4606.147862645388;4670.322803193552;4670.369500117475;4699.530046995307;4983.8504844854715;4995.325631039799;5000.599952003831;5003.324551185579;5004.549590536869;5009.924851127236;5025.99480103977;5026.220935754964;5037.370328708911;5038.093143234217;4582.060677561092;4638.466576343696;4643.512431194744;4684.976575117103;4691.507391723854;5046.697198168122;5054.898902021939;5069.44236134025;5083.517065878736;5116.56509196715;4960.355153829979;5010.123228435009;5011.022850544182;5014.197728363444;5015.573676237561;5052.69683818972;5059.671121377172;5061.089003979319;5063.0380227756605;5063.316452278968;4844.515548445127;4863.902721945541;4909.950900491021;5021.874453138627;5022.698638081727;4964.652474326835;4966.801327946841;4993.226049962189;4995.100881841231;5002.649814512949;3926.9986153530667;3941.586133455946;3989.5810939851476;3992.8003599819895;3994.800259986989;3541.5041894134843;3542.220711443478;3545.308664810389;3550.343186510504;3576.195356044869;4732.5977291929885;4739.668223224341;4740.336352910526;4748.952510474851;4794.400699912511;4824.614030877521;4869.415670119608;4910.263460480885;4918.90162196754;4925.926111108336;4738.265568836836;4743.1225223333795;4755.619550435957;4776.8566942991765;4794.9280760788615;4353.82584696615;4364.192624364503;4366.388705581221;4366.432363792686;4406.977965110218;5018.197088465828;5115.7953681852305;5136.460671629425;5166.896662066738;5175.249588809602;4976.2286845539;4984.925226121683;4991.07665081961;5002.199648056294;5042.596592272683;5143.8456846294675;5160.251763494347;5176.818811341585;5177.378714554277;5180.611454140879;4790.784414701417;4897.338859254098;4940.7035577865445;4954.281629163823;4972.477889821516;5023.648344615842;5042.571381432619;5052.292679025013;5059.139946209079;5098.566621837185;4779.139754844023;4915.631327650369;4936.432310284364;4939.086269040239;4980.178270585313;4852.587530059844;4893.975530122327;4894.632902532253;4904.141775189399;4953.777080031336;4838.080764654705;4840.298156767179;4841.685290456109;4847.878803029953;4889.242167464049;4723.8819029523165;4930.383702037246;4947.406311242674;4978.8755281118265;4988.176950803077;4768.976155119202;4799.640026997919;4800.3759511263315;4805.879853003703;4817.494163112823 08:33:28 INFO - PROCESS | 26050 | |1;ext.html;570.3554982869357;613.7176898626631;618.3970628637077;627.6171535363429;632.7469012395044;43442.78278608606;44912;44932.10135797286;44943.32585011223;45030.32454513185;41911.79044104775;42594;42606.78696606521;42625.78687106568;42644.36033459493;8707.608157632922;8827.029026807046;8844.11558844117;8853;8867.955660221689;8694.869576956351;8830.072842351557;8833.381663283573;8834;8834.11658834118;8838.204561589455;8879.245264152554;8887.333449991243;8888.06675299094;8889.199972002518;8801.471911685287;8802.471851688919;8814.559272036373;8823.205911467934;8840.38117331787;8681.30549556034;8757.56212189388;8759.956200218958;8764.56177191138;8768.246350729816;40434.79782601068;40917.590824091676;40964.38553421701;41029.79485102585;41047.1790564187;3298.6371499135075;3409.62494125646;3496.370653282408;3797.373433383488;3846.076941534012;31389.215269618213;32014.03957881244;32043.198920027186;32180.678193218002;32299.354012919845;4152.231837110114;4216.557261487561;4249.766262855542;4289.871303860858;4373.431453911003;334425;337605;338009.99999999756;338315;338829;49720;58777.41222587805;59424.40575594275;59533.702331488064;59545.106823397684;59045.40954590485;59925.70037149874;60501;64310;64351;14016.649583760487;14085.43658253679;14185.290735463392;14210.786838197435;14251.287435628177;10554.419506927039;10997.285176463663;11137.331760094421;11189.216754827085;11208.831867521994;18186.818131818778;18455.16951737175;18582.163802628915;19145.329913452963;19211.711824322647;6896.620685862325;6927.445804335641;6995.8950615740805;7013.3687968082095;7029.859402811915;877.4691311756295;902.1654969153507;960.3181740963994;1027.390428312094;1037.1547189040907;30236.546451803242;31091;31405.685943140277;31891;31930.840345798122;1046.2780681329857;1129.4014172488594;1130.12415378081;1130.4517309105076;1142.2404101272562;16237.675246495004;16357.509274721777;16420.1789910504;16453.259603317878;16693.582660433345;575166;581310;581485;581549;582587;57335;57853.71073144692;57857.4214257852;57925.42074579284;57956.420435795946;1258.8237646729465;1293.9482420703255;1302.5636411802152;1311.1543054729837;1320.4484730441884;29475.852620736758;29819.25451863634;29930.401391972475;30338;30738.231544211572;47519.52480475151;48047.75976120097;48463.5153648459;48521.544353669444;48610;505748;507177;509182;510030;510302;23661.171858984853;26564;27336;27389.86305068462;27435.491047991753;46205.76897115493;46889.53110468988;47224;47632.7618361906;48294.75852620855;39768.801155994035;40129.39805902856;42415.7879210602;42925;44526.77736611296;40271.59728402796;40399;40462.79768601256;41250.38124428196;41829.58170418257;39737.60262397455;40115;40704.18591628092;40846.79576602098;41060.384094239205;34072.65927340695;34775.304493909476;35940.8202958994;36317.81841090778;36587.45118823273;27292.59061114045;27317.726822731518;27466.313342166606;27539.862300688368;27611.30971725723 08:33:28 INFO - PROCESS | 26050 | |2;jquery.html;387.3144534174512;391.5751409720453;395.1169136978852;397.4713630870941;422.37910271900296;13420.986851972184;14155.858441415583;17268.82731172688;18686.159122839472;18708.719369209473;12511.687207819808;14339.064226329443;14351.210683412408;16967.06681132537;18073.45779626613;3766.8304926278383;3927.0771368728324;3932.6264004919485;3935.1736135411456;5684.772609095631;5540.36285827131;5554.250176226218;5609.411011843759;5646.717664116798;5704.429557044283;5534.363548191969;5538;5546.084895992157;5572.498475137237;5587.972060139694;3889.397143442771;5979.581429299951;6250.843728906813;6260.749570017217;6377.075324077982;5594.832155035356;5650.124230744241;5664.971675141639;5668.178114173463;5678.829635110953;21342.146314147416;21613.78386216149;21686.34940951774;22114.22600208985;22433.551328973328;2328.1502251678185;2379.4646204604;2521.7730404263702;2721.863906804652;3043.25440267136;9109.772255693595;13699;13979.161250325013;13984.230867302294;14602.853971460256;1896.0804010055112;1924.769027716683;1934.2843148035176;1955.8337541309006;1987.8608497405187;80586.59706701488;80861.3682434119;82348.58825705833;82586.58706706489;83174.58412707898;10547.208959328082;10605.363678179334;10670.51982660782;10741.24811263204;10958.397288149228;14793.11241325524;14887.47893823711;14895.851041489446;14912.403503859725;14912.925435372754;7273.927260727325;7559.659815308324;7566.772996810105;7590.1650818409935;7632.084149901936;5907.763689452459;6425.678716064178;6624.768133115318;6689.397954184147;7449.217832127657;4080.591940805955;4099.323611604052;4179.811908464127;4291.098869237433;4441.489228738672;1890.5462688954826;1937.777155627121;1958.5397431603562;1962.2347284559035;1983.7817840037585;906.3564868942992;950.8906475755239;965.0783501755947;983.7786498037884;1057.4289883462843;17136.657266854843;18510.259589616264;18851;19068.2372705093;19619.411417657495;918.4626993208914;947.3699989507038;965.0638880286111;970.1220395542045;976.0873583199731;10116.645917392856;10505.789884202273;10528.315659482108;10542.525586348633;10547.472626368652;431403;446284;459562;460206;460277;87634.56182719045;88272;89632.55183724039;89987.55006224927;91572.54213729022;1010.6664800615779;1054.841773733946;1075.870895492546;1087.3258579680648;1087.456271864068;16340.428085017444;16467.423640172536;16532.75200872012;16603.584910377336;16632.16839158013;39153.90645932768;39496.802515987234;40553.1889362217;40937.59062409338;42012;53258;53719.731401342746;55187.44812551823;55264;55665.721671393;5990.610610310316;7946.92053079485;8112.797180070545;8204.589770511331;8710.47737135774;8562.272206862237;12323.383830808245;12704.555340563036;12964.286964217059;12986.285754283605;11146.72133196644;11436.370999595103;11489.597864074718;11569.421528923689;11581.13141514373;11375.26060806045;11434.08527317796;11460.395544623927;11460.426978650867;11776.411179440822;11329.546818127183;11736.413179341169;11784.941075294912;11978.341191234565;12000.099992500423;8126.106128325998;8156.10282868872;8232.711855085283;8461.576921153795;8579.313654907717;10562.419066951392;11487.655370338904;11515.5969541069;11651.825222621837;11875.346855923008 08:33:28 INFO - PROCESS | 26050 | |3;mootools.html;1252.937353132343;1396.1902096783863;1443.3865607116975;1505.284989629926;1693.9915300423495;8421.78945526362;8724.956375218131;8750.868736968943;8934.285257179426;9032.72901812945;8609.698660546883;8768.34237432192;8816.250618697419;8818;8820.514871682055;1882.8587855910794;2186.8250539956766;2212.944676383095;2323.7095363079616;2366.183666635008;2382.618780995041;2382.940426489343;2386.773256540626;2388.2835149455095;2394.5091256292417;2303.147835300941;2316.953660926789;2327.511222643247;2328.3131476214558;2339.368370539953;1825.0783354406074;1878.8309052185368;1879.0229080878003;2193.1885202475028;2325.93022209334;2260.1298500077423;2292.79364857162;2294.9426264343356;2295.5638428698494;2296.9655455168186;8892.199702026848;8907;8953.059928707522;8955.194032537038;8957.776055598597;5073.112205364084;5235.450277720823;5237.973810130963;5239.083160446907;5243.397009343898;3153.7950033247766;3216.212028053142;3341.365140623274;3368.949465758016;3396.6603339666085;1086.8858769829133;1110.7611863449317;1141.657502749172;1141.6689160143549;1142.8514293141839;12540.372981350987;12605.810912836314;12608.36958152098;12613.873861261362;12618.621441356774;4572.4055872737;4774.594159496482;4780.330753694486;4786.904261914742;4793.376861008047;10532.526036328383;10542.947285263677;10565.101966332948;10632.46837658114;10640.148788097089;5102.413222479462;5264.15773476242;5269.920951185735;5271.789128434896;5278.894422111536;4149.564295748903;4308.46144231971;4371.606555410029;4386.122775444924;4434.711743736647;3934.232824599233;3965.6629186518894;3990.900227494336;4030.1738143680477;4067.2678917794487;1261.7791886420023;1272.821804947308;1273.961781146567;1283.1723538317733;1286.395394164741;770;918.673870775865;946.7443790176613;954.5322791831952;963.8939716631165;5780.132980053026;5896.454935022122;5991.460768530766;6018.488428483541;6067.544934129958;393.28618557318373;398.23538805492944;401.7870528619836;410.07528024305003;414.7677300711611;4030.6775457963295;4171.20747058058;4218.957810421856;4225.577442255812;4315.417418648505;10732.731681707864;10747.516361763739;10763.13894888407;10841.67474975752;10947.726306842393;10501.789964200672;10734.57061717538;10763.56945722178;10768.300060496043;10777.083947864363;8218.917810821935;8301.335893128535;8400.41197116196;8407.663693452194;8414.410991230556;5714.457126572969;5770.596058275881;5775.5090817281;5781.971090144522;5897.734601942837;10184.134348580454;10406.323588966692;10416.687499375032;10437;10441.425721585385;10187.847182292124;10399;10685.57257709683;10705.250632455653;10770.192235582519;7281.089863767029;7560.848783024198;7722.111957125003;8032.397570182143;8186.713465028695;8392.66429342844;8399.202075802788;8434.198751118634;8467.78830529217;8475.49147051179;7272.454565907684;7430.687058752801;7448.962755186406;7543.283388078124;7584.355329797029;7225.674844632109;7248.637568121679;7281.890771638324;7354.889676654748;7384.815379615337;6834.521583489108;6882.965585172042;6902.93097069043;6908.171019477695;6915.654217289216;4791.832285869978;4876.463589005278;4942.827001054946;5069.873253168553;5121.257417674491;4952;5008.524190201925;5070.4929507049;5148.948510514997;5166.922496162485 08:33:28 INFO - PROCESS | 26050 | |4;prototype.html;305.50508176753664;311.38812233960266;316.6153123954395;317.7140573483864;318.708381830625;4529.569690879362;4659.883502912429;4792.6405519586;4818.686785358954;4825.445073816512;4589.678722489427;4711.175544279755;4718.197906355919;4725.480197178316;4729.550692684198;3810.494854532472;3812.6568608825132;3815.294170578438;3838.1556057667267;3858.1704933439305;3559.341521818459;3670.724695647824;3796.14586717989;3806.809659517027;3843;3789.2610940866543;3807.6953843692577;3810.485584446106;3813.1229817141934;3819.3888977763563;3769.4911186989816;3770.924581508368;3788.109794198361;3790.6588407043223;3814.5886022171976;3371.9041311573837;3376.729861611065;3388.5594872666643;3399.1162297802503;3421.606515250753;4545.772711364419;4586;4618.214903466419;4622.9075418491775;4623.2371658676275;4248.936265956013;4257.74453532789;4262.488501379854;4274.380214868857;4297.806598703035;4811.831585894477;4871.732054736988;4880.633952453544;4917;4935.950640493585;3456.913577160566;3628.840839700374;3641.963580364189;3649.3796054670506;3674.4488326750934;5085.415177254626;5101.4133374662015;5106.923396149061;5128.71792051437;5136.203888397305;3745.5318085239346;3752.774833509998;3755.8122093895195;3799.848006079726;3816.713746469026;3719.7210209234418;3824.7513911595656;3846.3076646203394;3847.1343947611563;3853.3834586466032;4241.257779888507;4248.893777655583;4258.339957306623;4276.850310239127;4308.74147551148;4866.0317206504005;4879.316895634614;4968.975155124202;4979.800807967641;4990.675606085593;1206.6726600739291;1256.5664845628426;1283.7162837162837;1294.3463550906731;1303.9869601304056;866.921977022071;870.6822009966317;898.3621628643737;899.3479727197729;900.8874040559904;4301.000034983685;4317.330813723878;4334.8266069357505;4344.522102568715;4381.277089280296;4441.955580444154;4484.932726009112;4502.842400516031;4506.436695413074;4551.590356867831;4272.209641216385;4286.828526858953;4293.119910418357;4336.089421221515;4336.566343365701;2350.9059637614305;2474.9481470375017;2715.7827373810046;2719.3201699575106;2721.6597925259343;5326.680399176062;5340.25236466895;5345.70598617072;5350.0904846176245;5357.258890860408;5118.692878427306;5227.738613069331;5245.186996015624;5268.762905669254;5270.683758974474;5301;5308.672831792052;5316.202569614588;5331.306930098985;5337.146056630998;5050.84847454577;5078.847634570969;5099.419180054195;5101.9489805101475;5117.309163262912;4906.386701662293;4999.77501012448;5042.117629414764;5063;5067.366579177603;5222.55608273301;5224.686518808883;5243.737813109253;5263.36839579253;5273.892482578702;3670.926581468409;3694.113412780967;3694.408894576855;3696.944545831761;3704.759190652599;4896.902061958812;5027.497250274943;5041.495850414929;5049.6465247432325;5061.139606267017;4957.801687932442;4990;4991.625628077836;4995.8001679932395;4996.725180114983;4951.084049450863;4951.678140920829;4956.157453232887;4975.776090075883;4979.228219625964;4793.736344501086;4871.34236878017;4875.780589873393;4937.35814344133;4942.901141977069;4955;4966.428860680923;4976.054549635558;4978.352814134139;4984.92824042818;4915.090708218991;4921.704697718148;4923.4584195737725;4926.975365123151;4941.530554597308 08:33:28 INFO - PROCESS | 26050 | |5;yui.html;693.5076095971859;731.2943009995354;744.2743325257877;774.752079334613;776.7126163319571;13819.861801381983;14384.280785960713;14582.125072495644;14733.852661473382;14868;14336;14393.64015899603;14531.636709082279;14542.272886355666;14545.272736363166;621.5928566788738;751.6655088485626;760.243557660129;775.5889378629336;778.9026371703537;757.0763668324663;758.1092216645447;759.9088109426876;760.1752098972594;760.5968836516655;798.7803354077618;799.2047912327242;800.3997002248313;800.6637212370819;801.0307527891258;636.2110982381836;779.840132772783;794.1780257433528;795.4829360915422;798.1180795221255;578.2684903596953;580.4485738548395;582.2314544800864;583.9416058394169;585.2274997003957;14168.149911005372;14184.57446276603;14192.50326238587;14214.50249241282;14218.3601737921;13833;14144.929275353661;14162.858371416258;14177.645558861008;14289.499337615876;11809.94095029528;12132.211406258653;12184.451699673536;12359.134860559674;12569.434375453127;4282.5075116361395;4319.67602429819;4330.480342358906;4398.362237475548;4459.085887393109;72074.63962680206;76506.61746691287;76998.6150069246;77679.22320776833;77887;9997.600095996224;10008.299419040597;10042.146417554444;10222.591096356062;10344.22418318629;17445;17696.469105926844;17712.55718607045;17800.287988480573;17986.190621421807;7905.920940790634;7945.960270198612;7983.161768014391;8062.435629505878;8125.75622731319;4533.52397998212;4535.274356103007;4554.134714404318;4555.908881822345;4674.182018146811;3094.8916787912317;3359.596848378161;3486.7559270850797;3490.755647104729;3520.2607452434763;543.7852048440923;602;627.2911609880897;653.6698967021624;667.0394631730293;555.952744016755;592.780671151668;670;682.5972676121112;700.5656492974389;8980.416272942239;9021.74129254266;9218.58516366765;9325.440473571607;9460.716178514656;587.3011116771029;602.4457499100838;676.631235976394;676.8104930619435;691.0912150522047;4173.311403618369;4419.845305414359;4462.977685111554;4576.8626941191815;4699.882502937386;121943;122767;124959;124974;127500;83308;85079;85809.57095214608;100389;108789.45605272081;93395.53302233445;95650.52174739221;95834;98093;100404;9218.400803947721;9282.257419406296;9309.487978161265;9339.859902101338;9386.624535018524;50661;50761.492385075675;52118;52300.21549676834;52321.47678523166;47964.7601761989;66071.33928660845;76083;80112;83681.16318836977;12497.2552150914;12991.35043247815;13074.150180238254;13249.403776829873;13346.599602011955;14317.856821431653;14510.927445363128;14723.33744981457;15141.621459463602;15761.211939403212;14449.349779260168;14478.348474318891;14576.781348279572;15122.697546049238;15185;13159.802602961156;13224.66938326511;13349.332533373099;13491.460341586228;13547.25490098054;13983.230922299372;14278.643033924234;14330.426782928565;14409.351579178752;14474.710505790035;11256.774864502828;11306.208565400342;11556;11577.24747891418;11973.10201734856;11152.721181970192;11491.712707182387;11659.475323610628;11861.347625880659;11894.940525297317 08:33:28 INFO - PROCESS | 26050 | __end_tp_report 08:33:28 INFO - PROCESS | 26050 | __start_cc_report 08:33:28 INFO - PROCESS | 26050 | _x_x_mozilla_cycle_collect,995 08:33:28 INFO - PROCESS | 26050 | __end_cc_report 08:33:28 INFO - PROCESS | 26050 | __startTimestamp1466177608090__endTimestamp 08:33:28 INFO - PROCESS | 26050 | 08:33:28 INFO - PROCESS | 26050 | ------- Summary: start ------- 08:33:28 INFO - PROCESS | 26050 | Number of tests: 6 08:33:28 INFO - PROCESS | 26050 | 08:33:28 INFO - PROCESS | 26050 | [#0] dojo.html Cycles:165 Average:4669.69 Median:4817.49 stddev:484.45 (10.1%) stddev-sans-first:463.51 08:33:28 INFO - PROCESS | 26050 | Values: 2812.5 2827.2 2844.0 2860.8 2882.2 4618.9 4678.5 4691.9 4748.2 4789.2 4614.7 4618.2 4621.4 4625.5 4640.6 4233.6 4267.0 4311.3 4330.5 4455.8 4406.2 4416.5 4433.0 4455.5 4469.2 4236.8 4272.6 4275.6 4278.2 4339.3 4278.2 4278.3 4290.6 4298.7 4326.0 4284.4 4307.4 4314.8 4321.8 4339.6 4502.6 4606.1 4670.3 4670.4 4699.5 4983.9 4995.3 5000.6 5003.3 5004.5 5009.9 5026.0 5026.2 5037.4 5038.1 4582.1 4638.5 4643.5 4685.0 4691.5 5046.7 5054.9 5069.4 5083.5 5116.6 4960.4 5010.1 5011.0 5014.2 5015.6 5052.7 5059.7 5061.1 5063.0 5063.3 4844.5 4863.9 4910.0 5021.9 5022.7 4964.7 4966.8 4993.2 4995.1 5002.6 3927.0 3941.6 3989.6 3992.8 3994.8 3541.5 3542.2 3545.3 3550.3 3576.2 4732.6 4739.7 4740.3 4749.0 4794.4 4824.6 4869.4 4910.3 4918.9 4925.9 4738.3 4743.1 4755.6 4776.9 4794.9 4353.8 4364.2 4366.4 4366.4 4407.0 5018.2 5115.8 5136.5 5166.9 5175.2 4976.2 4984.9 4991.1 5002.2 5042.6 5143.8 5160.3 5176.8 5177.4 5180.6 4790.8 4897.3 4940.7 4954.3 4972.5 5023.6 5042.6 5052.3 5059.1 5098.6 4779.1 4915.6 4936.4 4939.1 4980.2 4852.6 4894.0 4894.6 4904.1 4953.8 4838.1 4840.3 4841.7 4847.9 4889.2 4723.9 4930.4 4947.4 4978.9 4988.2 4769.0 4799.6 4800.4 4805.9 4817.5 08:33:28 INFO - PROCESS | 26050 | 08:33:28 INFO - PROCESS | 26050 | [#1] ext.html Cycles:180 Average:62664.39 Median:23064.17 stddev:129519.08 (561.6%) stddev-sans-first:129798.51 08:33:28 INFO - PROCESS | 26050 | Values: 570.4 613.7 618.4 627.6 632.7 43442.8 44912.0 44932.1 44943.3 45030.3 41911.8 42594.0 42606.8 42625.8 42644.4 8707.6 8827.0 8844.1 8853.0 8868.0 8694.9 8830.1 8833.4 8834.0 8834.1 8838.2 8879.2 8887.3 8888.1 8889.2 8801.5 8802.5 8814.6 8823.2 8840.4 8681.3 8757.6 8760.0 8764.6 8768.2 40434.8 40917.6 40964.4 41029.8 41047.2 3298.6 3409.6 3496.4 3797.4 3846.1 31389.2 32014.0 32043.2 32180.7 32299.4 4152.2 4216.6 4249.8 4289.9 4373.4 334425.0 337605.0 338010.0 338315.0 338829.0 49720.0 58777.4 59424.4 59533.7 59545.1 59045.4 59925.7 60501.0 64310.0 64351.0 14016.6 14085.4 14185.3 14210.8 14251.3 10554.4 10997.3 11137.3 11189.2 11208.8 18186.8 18455.2 18582.2 19145.3 19211.7 6896.6 6927.4 6995.9 7013.4 7029.9 877.5 902.2 960.3 1027.4 1037.2 30236.5 31091.0 31405.7 31891.0 31930.8 1046.3 1129.4 1130.1 1130.5 1142.2 16237.7 16357.5 16420.2 16453.3 16693.6 575166.0 581310.0 581485.0 581549.0 582587.0 57335.0 57853.7 57857.4 57925.4 57956.4 1258.8 1293.9 1302.6 1311.2 1320.4 29475.9 29819.3 29930.4 30338.0 30738.2 47519.5 48047.8 48463.5 48521.5 48610.0 505748.0 507177.0 509182.0 510030.0 510302.0 23661.2 26564.0 27336.0 27389.9 27435.5 46205.8 46889.5 47224.0 47632.8 48294.8 39768.8 40129.4 42415.8 42925.0 44526.8 40271.6 40399.0 40462.8 41250.4 41829.6 39737.6 40115.0 40704.2 40846.8 41060.4 34072.7 34775.3 35940.8 36317.8 36587.5 27292.6 27317.7 27466.3 27539.9 27611.3 08:33:28 INFO - PROCESS | 26050 | 08:33:28 INFO - PROCESS | 26050 | [#2] jquery.html Cycles:180 Average:27358.95 Median:2138.36 stddev:74692.38 (3493.0%) stddev-sans-first:74874.45 08:33:28 INFO - PROCESS | 26050 | Values: 387.3 391.6 395.1 397.5 422.4 13421.0 14155.9 17268.8 18686.2 18708.7 12511.7 14339.1 14351.2 16967.1 18073.5 3766.8 3927.1 3932.6 3935.2 5684.8 5540.4 5554.3 5609.4 5646.7 5704.4 5534.4 5538.0 5546.1 5572.5 5588.0 3889.4 5979.6 6250.8 6260.7 6377.1 5594.8 5650.1 5665.0 5668.2 5678.8 21342.1 21613.8 21686.3 22114.2 22433.6 2328.2 2379.5 2521.8 2721.9 3043.3 9109.8 13699.0 13979.2 13984.2 14602.9 1896.1 1924.8 1934.3 1955.8 1987.9 80586.6 80861.4 82348.6 82586.6 83174.6 10547.2 10605.4 10670.5 10741.2 10958.4 14793.1 14887.5 14895.9 14912.4 14912.9 7273.9 7559.7 7566.8 7590.2 7632.1 5907.8 6425.7 6624.8 6689.4 7449.2 4080.6 4099.3 4179.8 4291.1 4441.5 1890.5 1937.8 1958.5 1962.2 1983.8 906.4 950.9 965.1 983.8 1057.4 17136.7 18510.3 18851.0 19068.2 19619.4 918.5 947.4 965.1 970.1 976.1 10116.6 10505.8 10528.3 10542.5 10547.5 431403.0 446284.0 459562.0 460206.0 460277.0 87634.6 88272.0 89632.6 89987.6 91572.5 1010.7 1054.8 1075.9 1087.3 1087.5 16340.4 16467.4 16532.8 16603.6 16632.2 39153.9 39496.8 40553.2 40937.6 42012.0 53258.0 53719.7 55187.4 55264.0 55665.7 5990.6 7946.9 8112.8 8204.6 8710.5 8562.3 12323.4 12704.6 12964.3 12986.3 11146.7 11436.4 11489.6 11569.4 11581.1 11375.3 11434.1 11460.4 11460.4 11776.4 11329.5 11736.4 11784.9 11978.3 12000.1 8126.1 8156.1 8232.7 8461.6 8579.3 10562.4 11487.7 11515.6 11651.8 11875.3 08:33:28 INFO - PROCESS | 26050 | 08:33:28 INFO - PROCESS | 26050 | [#3] mootools.html Cycles:180 Average:5762.03 Median:4311.94 stddev:3375.49 (78.3%) stddev-sans-first:3367.95 08:33:28 INFO - PROCESS | 26050 | Values: 1252.9 1396.2 1443.4 1505.3 1694.0 8421.8 8725.0 8750.9 8934.3 9032.7 8609.7 8768.3 8816.3 8818.0 8820.5 1882.9 2186.8 2212.9 2323.7 2366.2 2382.6 2382.9 2386.8 2388.3 2394.5 2303.1 2317.0 2327.5 2328.3 2339.4 1825.1 1878.8 1879.0 2193.2 2325.9 2260.1 2292.8 2294.9 2295.6 2297.0 8892.2 8907.0 8953.1 8955.2 8957.8 5073.1 5235.5 5238.0 5239.1 5243.4 3153.8 3216.2 3341.4 3368.9 3396.7 1086.9 1110.8 1141.7 1141.7 1142.9 12540.4 12605.8 12608.4 12613.9 12618.6 4572.4 4774.6 4780.3 4786.9 4793.4 10532.5 10542.9 10565.1 10632.5 10640.1 5102.4 5264.2 5269.9 5271.8 5278.9 4149.6 4308.5 4371.6 4386.1 4434.7 3934.2 3965.7 3990.9 4030.2 4067.3 1261.8 1272.8 1274.0 1283.2 1286.4 770.0 918.7 946.7 954.5 963.9 5780.1 5896.5 5991.5 6018.5 6067.5 393.3 398.2 401.8 410.1 414.8 4030.7 4171.2 4219.0 4225.6 4315.4 10732.7 10747.5 10763.1 10841.7 10947.7 10501.8 10734.6 10763.6 10768.3 10777.1 8218.9 8301.3 8400.4 8407.7 8414.4 5714.5 5770.6 5775.5 5782.0 5897.7 10184.1 10406.3 10416.7 10437.0 10441.4 10187.8 10399.0 10685.6 10705.3 10770.2 7281.1 7560.8 7722.1 8032.4 8186.7 8392.7 8399.2 8434.2 8467.8 8475.5 7272.5 7430.7 7449.0 7543.3 7584.4 7225.7 7248.6 7281.9 7354.9 7384.8 6834.5 6883.0 6902.9 6908.2 6915.7 4791.8 4876.5 4942.8 5069.9 5121.3 4952.0 5008.5 5070.5 5148.9 5166.9 08:33:28 INFO - PROCESS | 26050 | 08:33:28 INFO - PROCESS | 26050 | [#4] prototype.html Cycles:180 Average:4170.05 Median:4623.07 stddev:1203.20 (26.0%) stddev-sans-first:1171.09 08:33:28 INFO - PROCESS | 26050 | Values: 305.5 311.4 316.6 317.7 318.7 4529.6 4659.9 4792.6 4818.7 4825.4 4589.7 4711.2 4718.2 4725.5 4729.6 3810.5 3812.7 3815.3 3838.2 3858.2 3559.3 3670.7 3796.1 3806.8 3843.0 3789.3 3807.7 3810.5 3813.1 3819.4 3769.5 3770.9 3788.1 3790.7 3814.6 3371.9 3376.7 3388.6 3399.1 3421.6 4545.8 4586.0 4618.2 4622.9 4623.2 4248.9 4257.7 4262.5 4274.4 4297.8 4811.8 4871.7 4880.6 4917.0 4936.0 3456.9 3628.8 3642.0 3649.4 3674.4 5085.4 5101.4 5106.9 5128.7 5136.2 3745.5 3752.8 3755.8 3799.8 3816.7 3719.7 3824.8 3846.3 3847.1 3853.4 4241.3 4248.9 4258.3 4276.9 4308.7 4866.0 4879.3 4969.0 4979.8 4990.7 1206.7 1256.6 1283.7 1294.3 1304.0 866.9 870.7 898.4 899.3 900.9 4301.0 4317.3 4334.8 4344.5 4381.3 4442.0 4484.9 4502.8 4506.4 4551.6 4272.2 4286.8 4293.1 4336.1 4336.6 2350.9 2474.9 2715.8 2719.3 2721.7 5326.7 5340.3 5345.7 5350.1 5357.3 5118.7 5227.7 5245.2 5268.8 5270.7 5301.0 5308.7 5316.2 5331.3 5337.1 5050.8 5078.8 5099.4 5101.9 5117.3 4906.4 4999.8 5042.1 5063.0 5067.4 5222.6 5224.7 5243.7 5263.4 5273.9 3670.9 3694.1 3694.4 3696.9 3704.8 4896.9 5027.5 5041.5 5049.6 5061.1 4957.8 4990.0 4991.6 4995.8 4996.7 4951.1 4951.7 4956.2 4975.8 4979.2 4793.7 4871.3 4875.8 4937.4 4942.9 4955.0 4966.4 4976.1 4978.4 4984.9 4915.1 4921.7 4923.5 4927.0 4941.5 08:33:28 INFO - PROCESS | 26050 | 08:33:28 INFO - PROCESS | 26050 | [#5] yui.html Cycles:180 Average:20911.65 Median:4534.40 stddev:30998.91 (683.6%) stddev-sans-first:31048.70 08:33:28 INFO - PROCESS | 26050 | Values: 693.5 731.3 744.3 774.8 776.7 13819.9 14384.3 14582.1 14733.9 14868.0 14336.0 14393.6 14531.6 14542.3 14545.3 621.6 751.7 760.2 775.6 778.9 757.1 758.1 759.9 760.2 760.6 798.8 799.2 800.4 800.7 801.0 636.2 779.8 794.2 795.5 798.1 578.3 580.4 582.2 583.9 585.2 14168.1 14184.6 14192.5 14214.5 14218.4 13833.0 14144.9 14162.9 14177.6 14289.5 11809.9 12132.2 12184.5 12359.1 12569.4 4282.5 4319.7 4330.5 4398.4 4459.1 72074.6 76506.6 76998.6 77679.2 77887.0 9997.6 10008.3 10042.1 10222.6 10344.2 17445.0 17696.5 17712.6 17800.3 17986.2 7905.9 7946.0 7983.2 8062.4 8125.8 4533.5 4535.3 4554.1 4555.9 4674.2 3094.9 3359.6 3486.8 3490.8 3520.3 543.8 602.0 627.3 653.7 667.0 556.0 592.8 670.0 682.6 700.6 8980.4 9021.7 9218.6 9325.4 9460.7 587.3 602.4 676.6 676.8 691.1 4173.3 4419.8 4463.0 4576.9 4699.9 121943.0 122767.0 124959.0 124974.0 127500.0 83308.0 85079.0 85809.6 100389.0 108789.5 93395.5 95650.5 95834.0 98093.0 100404.0 9218.4 9282.3 9309.5 9339.9 9386.6 50661.0 50761.5 52118.0 52300.2 52321.5 47964.8 66071.3 76083.0 80112.0 83681.2 12497.3 12991.4 13074.2 13249.4 13346.6 14317.9 14510.9 14723.3 15141.6 15761.2 14449.3 14478.3 14576.8 15122.7 15185.0 13159.8 13224.7 13349.3 13491.5 13547.3 13983.2 14278.6 14330.4 14409.4 14474.7 11256.8 11306.2 11556.0 11577.2 11973.1 11152.7 11491.7 11659.5 11861.3 11894.9 08:33:28 INFO - PROCESS | 26050 | -------- Summary: end -------- 08:33:28 INFO - PROCESS | 26050 | 08:33:28 INFO - TEST-INFO | 26050: exit 0 08:33:28 INFO - TEST-OK | dromaeo_css | took 1113310ms 08:33:28 INFO - TEST-START | kraken 08:33:28 INFO - operating with platform_type : linux_ 08:33:28 INFO - Initialising browser for kraken test... 08:33:28 INFO - TEST-INFO | started process 26234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaIjueB/profile http://localhost:52476/getInfo.html) 08:33:33 INFO - PROCESS | 26234 | __metrics Screen width/height:1600/1200 08:33:33 INFO - PROCESS | 26234 | colorDepth:24 08:33:33 INFO - PROCESS | 26234 | Browser inner width/height: 1024/697 08:33:33 INFO - PROCESS | 26234 | __metrics 08:33:34 INFO - PROCESS | 26234 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:34 INFO - TEST-INFO | 26234: exit 0 08:33:34 INFO - Browser initialized. 08:33:34 INFO - Running cycle 1/1 for kraken test... 08:33:34 INFO - TEST-INFO | started process 26320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaIjueB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:46 INFO - PROCESS | 26320 | RSS: Main: 173948928 08:33:46 INFO - PROCESS | 26320 | 08:33:49 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52476/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:50 INFO - PROCESS | 26320 | RSS: Main: 234098688 08:33:50 INFO - PROCESS | 26320 | 08:33:53 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52476/tests/kraken/driver.html?testName=audio-dft) 08:33:53 INFO - PROCESS | 26320 | RSS: Main: 221995008 08:33:53 INFO - PROCESS | 26320 | 08:33:56 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52476/tests/kraken/driver.html?testName=audio-fft) 08:33:57 INFO - PROCESS | 26320 | RSS: Main: 287649792 08:33:57 INFO - PROCESS | 26320 | 08:33:59 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52476/tests/kraken/driver.html?testName=audio-oscillator) 08:34:00 INFO - PROCESS | 26320 | RSS: Main: 198852608 08:34:00 INFO - PROCESS | 26320 | 08:34:02 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52476/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:03 INFO - PROCESS | 26320 | RSS: Main: 201887744 08:34:03 INFO - PROCESS | 26320 | 08:34:06 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52476/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:06 INFO - PROCESS | 26320 | RSS: Main: 238575616 08:34:06 INFO - PROCESS | 26320 | 08:34:10 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52476/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:10 INFO - PROCESS | 26320 | RSS: Main: 239067136 08:34:10 INFO - PROCESS | 26320 | 08:34:13 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52476/tests/kraken/driver.html?testName=json-parse-financial) 08:34:14 INFO - PROCESS | 26320 | RSS: Main: 238964736 08:34:14 INFO - PROCESS | 26320 | 08:34:15 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52476/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:16 INFO - PROCESS | 26320 | RSS: Main: 227688448 08:34:16 INFO - PROCESS | 26320 | 08:34:18 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:18 INFO - PROCESS | 26320 | RSS: Main: 229265408 08:34:18 INFO - PROCESS | 26320 | 08:34:20 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:21 INFO - PROCESS | 26320 | RSS: Main: 238759936 08:34:21 INFO - PROCESS | 26320 | 08:34:24 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:24 INFO - PROCESS | 26320 | RSS: Main: 240762880 08:34:24 INFO - PROCESS | 26320 | 08:34:27 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:28 INFO - PROCESS | 26320 | RSS: Main: 240734208 08:34:28 INFO - PROCESS | 26320 | 08:34:29 INFO - PROCESS | 26320 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52476/tests/kraken/driver.html?testName=ai-astar) 08:34:30 INFO - PROCESS | 26320 | RSS: Main: 284389376 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | __start_tp_report 08:34:30 INFO - PROCESS | 26320 | _x_x_mozilla_page_load 08:34:30 INFO - PROCESS | 26320 | _x_x_mozilla_page_load_details 08:34:30 INFO - PROCESS | 26320 | |i|pagename|runs| 08:34:30 INFO - PROCESS | 26320 | |0;ai-astar;110;102;109;109;109;109;108;109;108;108 08:34:30 INFO - PROCESS | 26320 | |1;audio-beat-detection;154;127;140;177;139;135;154;126;176;130 08:34:30 INFO - PROCESS | 26320 | |2;audio-dft;161;161;161;163;162;162;162;162;164;161 08:34:30 INFO - PROCESS | 26320 | |3;audio-fft;74;74;77;128;74;75;74;79;98;74 08:34:30 INFO - PROCESS | 26320 | |4;audio-oscillator;86;86;110;87;86;85;124;85;85;126 08:34:30 INFO - PROCESS | 26320 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;118;117;117 08:34:30 INFO - PROCESS | 26320 | |6;imaging-darkroom;146;146;147;146;146;147;147;145;146;146 08:34:30 INFO - PROCESS | 26320 | |7;imaging-desaturate;96;95;96;95;95;95;95;96;96;96 08:34:30 INFO - PROCESS | 26320 | |8;json-parse-financial;60;61;62;60;61;63;61;60;61;60 08:34:30 INFO - PROCESS | 26320 | |9;json-stringify-tinderbox;61;61;61;61;62;61;60;62;61;61 08:34:30 INFO - PROCESS | 26320 | |10;stanford-crypto-aes;88;82;82;82;81;83;89;83;116;83 08:34:30 INFO - PROCESS | 26320 | |11;stanford-crypto-ccm;132;134;133;123;123;124;122;123;127;133 08:34:30 INFO - PROCESS | 26320 | |12;stanford-crypto-pbkdf2;165;167;165;169;173;172;167;164;170;167 08:34:30 INFO - PROCESS | 26320 | |13;stanford-crypto-sha256-iterative;75;65;67;65;64;64;63;64;63;62 08:34:30 INFO - PROCESS | 26320 | __end_tp_report 08:34:30 INFO - PROCESS | 26320 | __start_cc_report 08:34:30 INFO - PROCESS | 26320 | _x_x_mozilla_cycle_collect,1696 08:34:30 INFO - PROCESS | 26320 | __end_cc_report 08:34:30 INFO - PROCESS | 26320 | __startTimestamp1466177670130__endTimestamp 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | ------- Summary: start ------- 08:34:30 INFO - PROCESS | 26320 | Number of tests: 14 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:2.23 (2.0%) stddev-sans-first:2.26 08:34:30 INFO - PROCESS | 26320 | Values: 110.0 102.0 109.0 109.0 109.0 109.0 108.0 109.0 108.0 108.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:147.00 stddev:18.89 (12.9%) stddev-sans-first:19.80 08:34:30 INFO - PROCESS | 26320 | Values: 154.0 127.0 140.0 177.0 139.0 135.0 154.0 126.0 176.0 130.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 08:34:30 INFO - PROCESS | 26320 | Values: 161.0 161.0 161.0 163.0 162.0 162.0 162.0 162.0 164.0 161.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#3] audio-fft Cycles:10 Average:82.70 Median:74.50 stddev:17.54 (23.5%) stddev-sans-first:18.32 08:34:30 INFO - PROCESS | 26320 | Values: 74.0 74.0 77.0 128.0 74.0 75.0 74.0 79.0 98.0 74.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:85.50 stddev:17.07 (20.0%) stddev-sans-first:17.72 08:34:30 INFO - PROCESS | 26320 | Values: 86.0 86.0 110.0 87.0 86.0 85.0 124.0 85.0 85.0 126.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:34:30 INFO - PROCESS | 26320 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:34:30 INFO - PROCESS | 26320 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 147.0 145.0 146.0 146.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:34:30 INFO - PROCESS | 26320 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 08:34:30 INFO - PROCESS | 26320 | Values: 60.0 61.0 62.0 60.0 61.0 63.0 61.0 60.0 61.0 60.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 08:34:30 INFO - PROCESS | 26320 | Values: 61.0 61.0 61.0 61.0 62.0 61.0 60.0 62.0 61.0 61.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:83.00 stddev:10.57 (12.7%) stddev-sans-first:11.20 08:34:30 INFO - PROCESS | 26320 | Values: 88.0 82.0 82.0 82.0 81.0 83.0 89.0 83.0 116.0 83.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:129.50 stddev:5.02 (3.9%) stddev-sans-first:5.04 08:34:30 INFO - PROCESS | 26320 | Values: 132.0 134.0 133.0 123.0 123.0 124.0 122.0 123.0 127.0 133.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:3.03 (1.8%) stddev-sans-first:3.03 08:34:30 INFO - PROCESS | 26320 | Values: 165.0 167.0 165.0 169.0 173.0 172.0 167.0 164.0 170.0 167.0 08:34:30 INFO - PROCESS | 26320 | 08:34:30 INFO - PROCESS | 26320 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:64.50 stddev:3.71 (5.7%) stddev-sans-first:1.45 08:34:30 INFO - PROCESS | 26320 | Values: 75.0 65.0 67.0 65.0 64.0 64.0 63.0 64.0 63.0 62.0 08:34:30 INFO - PROCESS | 26320 | -------- Summary: end -------- 08:34:30 INFO - PROCESS | 26320 | 08:34:31 INFO - TEST-INFO | 26320: exit 0 08:34:31 INFO - TEST-OK | kraken | took 62317ms 08:34:31 INFO - SUITE-END | took 1175s 08:34:31 INFO - Completed test suite (00:19:35) 08:34:31 INFO - javascript benchmark 08:34:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2812.465631530009, 2827.180117765848, 2844.0, 2860.756835668968, 2882.207392966935, 4618.884527886805, 4678.53214678532, 4691.850496628331, 4748.2165442702, 4789.18583840747, 4614.676972611918, 4618.19181643212, 4621.445426548818, 4625.537446255373, 4640.582347588716, 4233.640140588053, 4266.957330426702, 4311.28863737483, 4330.480342358921, 4455.821767129327, 4406.184855801687, 4416.470023597173, 4433.024734558392, 4455.487618923833, 4469.195544801934, 4236.830526778926, 4272.572742725733, 4275.636570891478, 4278.229918614648, 4339.262325404673, 4278.208531421666, 4278.2940814765525, 4290.635295999844, 4298.742075475481, 4326.0, 4284.378765079077, 4307.375430562583, 4314.784260786948, 4321.848735294281, 4339.566043395666, 4502.639788816887, 4606.147862645388, 4670.322803193552, 4670.369500117475, 4699.530046995307, 4983.8504844854715, 4995.325631039799, 5000.599952003831, 5003.324551185579, 5004.549590536869, 5009.924851127236, 5025.99480103977, 5026.220935754964, 5037.370328708911, 5038.093143234217, 4582.060677561092, 4638.466576343696, 4643.512431194744, 4684.976575117103, 4691.507391723854, 5046.697198168122, 5054.898902021939, 5069.44236134025, 5083.517065878736, 5116.56509196715, 4960.355153829979, 5010.123228435009, 5011.022850544182, 5014.197728363444, 5015.573676237561, 5052.69683818972, 5059.671121377172, 5061.089003979319, 5063.0380227756605, 5063.316452278968, 4844.515548445127, 4863.902721945541, 4909.950900491021, 5021.874453138627, 5022.698638081727, 4964.652474326835, 4966.801327946841, 4993.226049962189, 4995.100881841231, 5002.649814512949, 3926.9986153530667, 3941.586133455946, 3989.5810939851476, 3992.8003599819895, 3994.800259986989, 3541.5041894134843, 3542.220711443478, 3545.308664810389, 3550.343186510504, 3576.195356044869, 4732.5977291929885, 4739.668223224341, 4740.336352910526, 4748.952510474851, 4794.400699912511, 4824.614030877521, 4869.415670119608, 4910.263460480885, 4918.90162196754, 4925.926111108336, 4738.265568836836, 4743.1225223333795, 4755.619550435957, 4776.8566942991765, 4794.9280760788615, 4353.82584696615, 4364.192624364503, 4366.388705581221, 4366.432363792686, 4406.977965110218, 5018.197088465828, 5115.7953681852305, 5136.460671629425, 5166.896662066738, 5175.249588809602, 4976.2286845539, 4984.925226121683, 4991.07665081961, 5002.199648056294, 5042.596592272683, 5143.8456846294675, 5160.251763494347, 5176.818811341585, 5177.378714554277, 5180.611454140879, 4790.784414701417, 4897.338859254098, 4940.7035577865445, 4954.281629163823, 4972.477889821516, 5023.648344615842, 5042.571381432619, 5052.292679025013, 5059.139946209079, 5098.566621837185, 4779.139754844023, 4915.631327650369, 4936.432310284364, 4939.086269040239, 4980.178270585313, 4852.587530059844, 4893.975530122327, 4894.632902532253, 4904.141775189399, 4953.777080031336, 4838.080764654705, 4840.298156767179, 4841.685290456109, 4847.878803029953, 4889.242167464049, 4723.8819029523165, 4930.383702037246, 4947.406311242674, 4978.8755281118265, 4988.176950803077, 4768.976155119202, 4799.640026997919, 4800.3759511263315, 4805.879853003703, 4817.494163112823], "value": 4640.172011689228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.3554982869357, 613.7176898626631, 618.3970628637077, 627.6171535363429, 632.7469012395044, 43442.78278608606, 44912.0, 44932.10135797286, 44943.32585011223, 45030.32454513185, 41911.79044104775, 42594.0, 42606.78696606521, 42625.78687106568, 42644.36033459493, 8707.608157632922, 8827.029026807046, 8844.11558844117, 8853.0, 8867.955660221689, 8694.869576956351, 8830.072842351557, 8833.381663283573, 8834.0, 8834.11658834118, 8838.204561589455, 8879.245264152554, 8887.333449991243, 8888.06675299094, 8889.199972002518, 8801.471911685287, 8802.471851688919, 8814.559272036373, 8823.205911467934, 8840.38117331787, 8681.30549556034, 8757.56212189388, 8759.956200218958, 8764.56177191138, 8768.246350729816, 40434.79782601068, 40917.590824091676, 40964.38553421701, 41029.79485102585, 41047.1790564187, 3298.6371499135075, 3409.62494125646, 3496.370653282408, 3797.373433383488, 3846.076941534012, 31389.215269618213, 32014.03957881244, 32043.198920027186, 32180.678193218002, 32299.354012919845, 4152.231837110114, 4216.557261487561, 4249.766262855542, 4289.871303860858, 4373.431453911003, 334425.0, 337605.0, 338009.99999999756, 338315.0, 338829.0, 49720.0, 58777.41222587805, 59424.40575594275, 59533.702331488064, 59545.106823397684, 59045.40954590485, 59925.70037149874, 60501.0, 64310.0, 64351.0, 14016.649583760487, 14085.43658253679, 14185.290735463392, 14210.786838197435, 14251.287435628177, 10554.419506927039, 10997.285176463663, 11137.331760094421, 11189.216754827085, 11208.831867521994, 18186.818131818778, 18455.16951737175, 18582.163802628915, 19145.329913452963, 19211.711824322647, 6896.620685862325, 6927.445804335641, 6995.8950615740805, 7013.3687968082095, 7029.859402811915, 877.4691311756295, 902.1654969153507, 960.3181740963994, 1027.390428312094, 1037.1547189040907, 30236.546451803242, 31091.0, 31405.685943140277, 31891.0, 31930.840345798122, 1046.2780681329857, 1129.4014172488594, 1130.12415378081, 1130.4517309105076, 1142.2404101272562, 16237.675246495004, 16357.509274721777, 16420.1789910504, 16453.259603317878, 16693.582660433345, 575166.0, 581310.0, 581485.0, 581549.0, 582587.0, 57335.0, 57853.71073144692, 57857.4214257852, 57925.42074579284, 57956.420435795946, 1258.8237646729465, 1293.9482420703255, 1302.5636411802152, 1311.1543054729837, 1320.4484730441884, 29475.852620736758, 29819.25451863634, 29930.401391972475, 30338.0, 30738.231544211572, 47519.52480475151, 48047.75976120097, 48463.5153648459, 48521.544353669444, 48610.0, 505748.0, 507177.0, 509182.0, 510030.0, 510302.0, 23661.171858984853, 26564.0, 27336.0, 27389.86305068462, 27435.491047991753, 46205.76897115493, 46889.53110468988, 47224.0, 47632.7618361906, 48294.75852620855, 39768.801155994035, 40129.39805902856, 42415.7879210602, 42925.0, 44526.77736611296, 40271.59728402796, 40399.0, 40462.79768601256, 41250.38124428196, 41829.58170418257, 39737.60262397455, 40115.0, 40704.18591628092, 40846.79576602098, 41060.384094239205, 34072.65927340695, 34775.304493909476, 35940.8202958994, 36317.81841090778, 36587.45118823273, 27292.59061114045, 27317.726822731518, 27466.313342166606, 27539.862300688368, 27611.30971725723], "value": 19764.19417151116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.3144534174512, 391.5751409720453, 395.1169136978852, 397.4713630870941, 422.37910271900296, 13420.986851972184, 14155.858441415583, 17268.82731172688, 18686.159122839472, 18708.719369209473, 12511.687207819808, 14339.064226329443, 14351.210683412408, 16967.06681132537, 18073.45779626613, 3766.8304926278383, 3927.0771368728324, 3932.6264004919485, 3935.1736135411456, 5684.772609095631, 5540.36285827131, 5554.250176226218, 5609.411011843759, 5646.717664116798, 5704.429557044283, 5534.363548191969, 5538.0, 5546.084895992157, 5572.498475137237, 5587.972060139694, 3889.397143442771, 5979.581429299951, 6250.843728906813, 6260.749570017217, 6377.075324077982, 5594.832155035356, 5650.124230744241, 5664.971675141639, 5668.178114173463, 5678.829635110953, 21342.146314147416, 21613.78386216149, 21686.34940951774, 22114.22600208985, 22433.551328973328, 2328.1502251678185, 2379.4646204604, 2521.7730404263702, 2721.863906804652, 3043.25440267136, 9109.772255693595, 13699.0, 13979.161250325013, 13984.230867302294, 14602.853971460256, 1896.0804010055112, 1924.769027716683, 1934.2843148035176, 1955.8337541309006, 1987.8608497405187, 80586.59706701488, 80861.3682434119, 82348.58825705833, 82586.58706706489, 83174.58412707898, 10547.208959328082, 10605.363678179334, 10670.51982660782, 10741.24811263204, 10958.397288149228, 14793.11241325524, 14887.47893823711, 14895.851041489446, 14912.403503859725, 14912.925435372754, 7273.927260727325, 7559.659815308324, 7566.772996810105, 7590.1650818409935, 7632.084149901936, 5907.763689452459, 6425.678716064178, 6624.768133115318, 6689.397954184147, 7449.217832127657, 4080.591940805955, 4099.323611604052, 4179.811908464127, 4291.098869237433, 4441.489228738672, 1890.5462688954826, 1937.777155627121, 1958.5397431603562, 1962.2347284559035, 1983.7817840037585, 906.3564868942992, 950.8906475755239, 965.0783501755947, 983.7786498037884, 1057.4289883462843, 17136.657266854843, 18510.259589616264, 18851.0, 19068.2372705093, 19619.411417657495, 918.4626993208914, 947.3699989507038, 965.0638880286111, 970.1220395542045, 976.0873583199731, 10116.645917392856, 10505.789884202273, 10528.315659482108, 10542.525586348633, 10547.472626368652, 431403.0, 446284.0, 459562.0, 460206.0, 460277.0, 87634.56182719045, 88272.0, 89632.55183724039, 89987.55006224927, 91572.54213729022, 1010.6664800615779, 1054.841773733946, 1075.870895492546, 1087.3258579680648, 1087.456271864068, 16340.428085017444, 16467.423640172536, 16532.75200872012, 16603.584910377336, 16632.16839158013, 39153.90645932768, 39496.802515987234, 40553.1889362217, 40937.59062409338, 42012.0, 53258.0, 53719.731401342746, 55187.44812551823, 55264.0, 55665.721671393, 5990.610610310316, 7946.92053079485, 8112.797180070545, 8204.589770511331, 8710.47737135774, 8562.272206862237, 12323.383830808245, 12704.555340563036, 12964.286964217059, 12986.285754283605, 11146.72133196644, 11436.370999595103, 11489.597864074718, 11569.421528923689, 11581.13141514373, 11375.26060806045, 11434.08527317796, 11460.395544623927, 11460.426978650867, 11776.411179440822, 11329.546818127183, 11736.413179341169, 11784.941075294912, 11978.341191234565, 12000.099992500423, 8126.106128325998, 8156.10282868872, 8232.711855085283, 8461.576921153795, 8579.313654907717, 10562.419066951392, 11487.655370338904, 11515.5969541069, 11651.825222621837, 11875.346855923008], "value": 8860.858774224547, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.937353132343, 1396.1902096783863, 1443.3865607116975, 1505.284989629926, 1693.9915300423495, 8421.78945526362, 8724.956375218131, 8750.868736968943, 8934.285257179426, 9032.72901812945, 8609.698660546883, 8768.34237432192, 8816.250618697419, 8818.0, 8820.514871682055, 1882.8587855910794, 2186.8250539956766, 2212.944676383095, 2323.7095363079616, 2366.183666635008, 2382.618780995041, 2382.940426489343, 2386.773256540626, 2388.2835149455095, 2394.5091256292417, 2303.147835300941, 2316.953660926789, 2327.511222643247, 2328.3131476214558, 2339.368370539953, 1825.0783354406074, 1878.8309052185368, 1879.0229080878003, 2193.1885202475028, 2325.93022209334, 2260.1298500077423, 2292.79364857162, 2294.9426264343356, 2295.5638428698494, 2296.9655455168186, 8892.199702026848, 8907.0, 8953.059928707522, 8955.194032537038, 8957.776055598597, 5073.112205364084, 5235.450277720823, 5237.973810130963, 5239.083160446907, 5243.397009343898, 3153.7950033247766, 3216.212028053142, 3341.365140623274, 3368.949465758016, 3396.6603339666085, 1086.8858769829133, 1110.7611863449317, 1141.657502749172, 1141.6689160143549, 1142.8514293141839, 12540.372981350987, 12605.810912836314, 12608.36958152098, 12613.873861261362, 12618.621441356774, 4572.4055872737, 4774.594159496482, 4780.330753694486, 4786.904261914742, 4793.376861008047, 10532.526036328383, 10542.947285263677, 10565.101966332948, 10632.46837658114, 10640.148788097089, 5102.413222479462, 5264.15773476242, 5269.920951185735, 5271.789128434896, 5278.894422111536, 4149.564295748903, 4308.46144231971, 4371.606555410029, 4386.122775444924, 4434.711743736647, 3934.232824599233, 3965.6629186518894, 3990.900227494336, 4030.1738143680477, 4067.2678917794487, 1261.7791886420023, 1272.821804947308, 1273.961781146567, 1283.1723538317733, 1286.395394164741, 770.0, 918.673870775865, 946.7443790176613, 954.5322791831952, 963.8939716631165, 5780.132980053026, 5896.454935022122, 5991.460768530766, 6018.488428483541, 6067.544934129958, 393.28618557318373, 398.23538805492944, 401.7870528619836, 410.07528024305003, 414.7677300711611, 4030.6775457963295, 4171.20747058058, 4218.957810421856, 4225.577442255812, 4315.417418648505, 10732.731681707864, 10747.516361763739, 10763.13894888407, 10841.67474975752, 10947.726306842393, 10501.789964200672, 10734.57061717538, 10763.56945722178, 10768.300060496043, 10777.083947864363, 8218.917810821935, 8301.335893128535, 8400.41197116196, 8407.663693452194, 8414.410991230556, 5714.457126572969, 5770.596058275881, 5775.5090817281, 5781.971090144522, 5897.734601942837, 10184.134348580454, 10406.323588966692, 10416.687499375032, 10437.0, 10441.425721585385, 10187.847182292124, 10399.0, 10685.57257709683, 10705.250632455653, 10770.192235582519, 7281.089863767029, 7560.848783024198, 7722.111957125003, 8032.397570182143, 8186.713465028695, 8392.66429342844, 8399.202075802788, 8434.198751118634, 8467.78830529217, 8475.49147051179, 7272.454565907684, 7430.687058752801, 7448.962755186406, 7543.283388078124, 7584.355329797029, 7225.674844632109, 7248.637568121679, 7281.890771638324, 7354.889676654748, 7384.815379615337, 6834.521583489108, 6882.965585172042, 6902.93097069043, 6908.171019477695, 6915.654217289216, 4791.832285869978, 4876.463589005278, 4942.827001054946, 5069.873253168553, 5121.257417674491, 4952.0, 5008.524190201925, 5070.4929507049, 5148.948510514997, 5166.922496162485], "value": 4478.74370687779, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.50508176753664, 311.38812233960266, 316.6153123954395, 317.7140573483864, 318.708381830625, 4529.569690879362, 4659.883502912429, 4792.6405519586, 4818.686785358954, 4825.445073816512, 4589.678722489427, 4711.175544279755, 4718.197906355919, 4725.480197178316, 4729.550692684198, 3810.494854532472, 3812.6568608825132, 3815.294170578438, 3838.1556057667267, 3858.1704933439305, 3559.341521818459, 3670.724695647824, 3796.14586717989, 3806.809659517027, 3843.0, 3789.2610940866543, 3807.6953843692577, 3810.485584446106, 3813.1229817141934, 3819.3888977763563, 3769.4911186989816, 3770.924581508368, 3788.109794198361, 3790.6588407043223, 3814.5886022171976, 3371.9041311573837, 3376.729861611065, 3388.5594872666643, 3399.1162297802503, 3421.606515250753, 4545.772711364419, 4586.0, 4618.214903466419, 4622.9075418491775, 4623.2371658676275, 4248.936265956013, 4257.74453532789, 4262.488501379854, 4274.380214868857, 4297.806598703035, 4811.831585894477, 4871.732054736988, 4880.633952453544, 4917.0, 4935.950640493585, 3456.913577160566, 3628.840839700374, 3641.963580364189, 3649.3796054670506, 3674.4488326750934, 5085.415177254626, 5101.4133374662015, 5106.923396149061, 5128.71792051437, 5136.203888397305, 3745.5318085239346, 3752.774833509998, 3755.8122093895195, 3799.848006079726, 3816.713746469026, 3719.7210209234418, 3824.7513911595656, 3846.3076646203394, 3847.1343947611563, 3853.3834586466032, 4241.257779888507, 4248.893777655583, 4258.339957306623, 4276.850310239127, 4308.74147551148, 4866.0317206504005, 4879.316895634614, 4968.975155124202, 4979.800807967641, 4990.675606085593, 1206.6726600739291, 1256.5664845628426, 1283.7162837162837, 1294.3463550906731, 1303.9869601304056, 866.921977022071, 870.6822009966317, 898.3621628643737, 899.3479727197729, 900.8874040559904, 4301.000034983685, 4317.330813723878, 4334.8266069357505, 4344.522102568715, 4381.277089280296, 4441.955580444154, 4484.932726009112, 4502.842400516031, 4506.436695413074, 4551.590356867831, 4272.209641216385, 4286.828526858953, 4293.119910418357, 4336.089421221515, 4336.566343365701, 2350.9059637614305, 2474.9481470375017, 2715.7827373810046, 2719.3201699575106, 2721.6597925259343, 5326.680399176062, 5340.25236466895, 5345.70598617072, 5350.0904846176245, 5357.258890860408, 5118.692878427306, 5227.738613069331, 5245.186996015624, 5268.762905669254, 5270.683758974474, 5301.0, 5308.672831792052, 5316.202569614588, 5331.306930098985, 5337.146056630998, 5050.84847454577, 5078.847634570969, 5099.419180054195, 5101.9489805101475, 5117.309163262912, 4906.386701662293, 4999.77501012448, 5042.117629414764, 5063.0, 5067.366579177603, 5222.55608273301, 5224.686518808883, 5243.737813109253, 5263.36839579253, 5273.892482578702, 3670.926581468409, 3694.113412780967, 3694.408894576855, 3696.944545831761, 3704.759190652599, 4896.902061958812, 5027.497250274943, 5041.495850414929, 5049.6465247432325, 5061.139606267017, 4957.801687932442, 4990.0, 4991.625628077836, 4995.8001679932395, 4996.725180114983, 4951.084049450863, 4951.678140920829, 4956.157453232887, 4975.776090075883, 4979.228219625964, 4793.736344501086, 4871.34236878017, 4875.780589873393, 4937.35814344133, 4942.901141977069, 4955.0, 4966.428860680923, 4976.054549635558, 4978.352814134139, 4984.92824042818, 4915.090708218991, 4921.704697718148, 4923.4584195737725, 4926.975365123151, 4941.530554597308], "value": 3793.73832682504, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.5076095971859, 731.2943009995354, 744.2743325257877, 774.752079334613, 776.7126163319571, 13819.861801381983, 14384.280785960713, 14582.125072495644, 14733.852661473382, 14868.0, 14336.0, 14393.64015899603, 14531.636709082279, 14542.272886355666, 14545.272736363166, 621.5928566788738, 751.6655088485626, 760.243557660129, 775.5889378629336, 778.9026371703537, 757.0763668324663, 758.1092216645447, 759.9088109426876, 760.1752098972594, 760.5968836516655, 798.7803354077618, 799.2047912327242, 800.3997002248313, 800.6637212370819, 801.0307527891258, 636.2110982381836, 779.840132772783, 794.1780257433528, 795.4829360915422, 798.1180795221255, 578.2684903596953, 580.4485738548395, 582.2314544800864, 583.9416058394169, 585.2274997003957, 14168.149911005372, 14184.57446276603, 14192.50326238587, 14214.50249241282, 14218.3601737921, 13833.0, 14144.929275353661, 14162.858371416258, 14177.645558861008, 14289.499337615876, 11809.94095029528, 12132.211406258653, 12184.451699673536, 12359.134860559674, 12569.434375453127, 4282.5075116361395, 4319.67602429819, 4330.480342358906, 4398.362237475548, 4459.085887393109, 72074.63962680206, 76506.61746691287, 76998.6150069246, 77679.22320776833, 77887.0, 9997.600095996224, 10008.299419040597, 10042.146417554444, 10222.591096356062, 10344.22418318629, 17445.0, 17696.469105926844, 17712.55718607045, 17800.287988480573, 17986.190621421807, 7905.920940790634, 7945.960270198612, 7983.161768014391, 8062.435629505878, 8125.75622731319, 4533.52397998212, 4535.274356103007, 4554.134714404318, 4555.908881822345, 4674.182018146811, 3094.8916787912317, 3359.596848378161, 3486.7559270850797, 3490.755647104729, 3520.2607452434763, 543.7852048440923, 602.0, 627.2911609880897, 653.6698967021624, 667.0394631730293, 555.952744016755, 592.780671151668, 670.0, 682.5972676121112, 700.5656492974389, 8980.416272942239, 9021.74129254266, 9218.58516366765, 9325.440473571607, 9460.716178514656, 587.3011116771029, 602.4457499100838, 676.631235976394, 676.8104930619435, 691.0912150522047, 4173.311403618369, 4419.845305414359, 4462.977685111554, 4576.8626941191815, 4699.882502937386, 121943.0, 122767.0, 124959.0, 124974.0, 127500.0, 83308.0, 85079.0, 85809.57095214608, 100389.0, 108789.45605272081, 93395.53302233445, 95650.52174739221, 95834.0, 98093.0, 100404.0, 9218.400803947721, 9282.257419406296, 9309.487978161265, 9339.859902101338, 9386.624535018524, 50661.0, 50761.492385075675, 52118.0, 52300.21549676834, 52321.47678523166, 47964.7601761989, 66071.33928660845, 76083.0, 80112.0, 83681.16318836977, 12497.2552150914, 12991.35043247815, 13074.150180238254, 13249.403776829873, 13346.599602011955, 14317.856821431653, 14510.927445363128, 14723.33744981457, 15141.621459463602, 15761.211939403212, 14449.349779260168, 14478.348474318891, 14576.781348279572, 15122.697546049238, 15185.0, 13159.802602961156, 13224.66938326511, 13349.332533373099, 13491.460341586228, 13547.25490098054, 13983.230922299372, 14278.643033924234, 14330.426782928565, 14409.351579178752, 14474.710505790035, 11256.774864502828, 11306.208565400342, 11556.0, 11577.24747891418, 11973.10201734856, 11152.721181970192, 11491.712707182387, 11659.475323610628, 11861.347625880659, 11894.940525297317], "value": 7365.286955270449, "unit": "score"}], "name": "dromaeo_css", "value": 6832.180111609036, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 102.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 108.0, 108.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 140.0, 177.0, 139.0, 135.0, 154.0, 126.0, 176.0, 130.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 162.0, 162.0, 162.0, 162.0, 164.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 128.0, 74.0, 75.0, 74.0, 79.0, 98.0, 74.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 110.0, 87.0, 86.0, 85.0, 124.0, 85.0, 85.0, 126.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 60.0, 61.0, 63.0, 61.0, 60.0, 61.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 60.0, 62.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 82.0, 82.0, 81.0, 83.0, 89.0, 83.0, 116.0, 83.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 133.0, 123.0, 123.0, 124.0, 122.0, 123.0, 127.0, 133.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 165.0, 169.0, 173.0, 172.0, 167.0, 164.0, 170.0, 167.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 65.0, 67.0, 65.0, 64.0, 64.0, 63.0, 64.0, 63.0, 62.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1523.2000000000003, "alertThreshold": 2.0}]} 08:34:31 INFO - Return code: 0 08:34:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:31 INFO - # TBPL SUCCESS # 08:34:31 INFO - Running post-action listener: _resource_record_post_action 08:34:31 INFO - ##### 08:34:31 INFO - ##### Finished run-tests step (success) 08:34:31 INFO - ##### 08:34:31 INFO - Running post-run listener: _resource_record_post_run 08:34:31 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 553021440; Read time: 28; Write time: 525816 08:34:31 INFO - TinderboxPrint: CPU usage
13.1% 08:34:31 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 08:34:31 INFO - TinderboxPrint: I/O write bytes / time
553,021,440 / 525,816 08:34:31 INFO - TinderboxPrint: CPU idle
8,275.5 (86.8%) 08:34:31 INFO - TinderboxPrint: CPU user
1,203.1 (12.6%) 08:34:31 INFO - TinderboxPrint: Swap in / out
0 / 0 08:34:31 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 261292032; Read time: 0; Write time: 300496 08:34:31 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290496512; Read time: 28; Write time: 225304 08:34:32 INFO - Running post-run listener: _upload_blobber_files 08:34:32 INFO - Blob upload gear active. 08:34:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:34:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:32 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:33 INFO - (blobuploader) - INFO - Done attempting. 08:34:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:36 INFO - (blobuploader) - INFO - Done attempting. 08:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:37 INFO - (blobuploader) - INFO - Done attempting. 08:34:37 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:37 INFO - Return code: 0 08:34:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c65e0065ea44dd0e79a4e858583cd6b32a98f2b171bf5179babd99bf2ec52e569805822ef2ffdc6f3b48136749ed7a1f5e4127df2eafbc6e0a0b6edbb3de6a88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44e987f70d2aec9bc865f1d793e2462cf514d90ae37989d3b17e6e4841755f06a86ff466636148e6478cca5b9e32f446f33cf106b5e2a4a44bf7020fa682ecb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09720dbed6e549c0feaa324c0b7446e50c6042e68c58115a2327b092843d3430e5a4884de4dddbfebb4057baea0f83d6df4f212008a8124a6b8799f731b16661"} 08:34:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:37 INFO - Contents: 08:34:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c65e0065ea44dd0e79a4e858583cd6b32a98f2b171bf5179babd99bf2ec52e569805822ef2ffdc6f3b48136749ed7a1f5e4127df2eafbc6e0a0b6edbb3de6a88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44e987f70d2aec9bc865f1d793e2462cf514d90ae37989d3b17e6e4841755f06a86ff466636148e6478cca5b9e32f446f33cf106b5e2a4a44bf7020fa682ecb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09720dbed6e549c0feaa324c0b7446e50c6042e68c58115a2327b092843d3430e5a4884de4dddbfebb4057baea0f83d6df4f212008a8124a6b8799f731b16661"} 08:34:37 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:37 INFO - Copying logs to upload dir... 08:34:37 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.333401 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-17 08:34:37.827965) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 08:34:37.831944) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c65e0065ea44dd0e79a4e858583cd6b32a98f2b171bf5179babd99bf2ec52e569805822ef2ffdc6f3b48136749ed7a1f5e4127df2eafbc6e0a0b6edbb3de6a88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44e987f70d2aec9bc865f1d793e2462cf514d90ae37989d3b17e6e4841755f06a86ff466636148e6478cca5b9e32f446f33cf106b5e2a4a44bf7020fa682ecb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09720dbed6e549c0feaa324c0b7446e50c6042e68c58115a2327b092843d3430e5a4884de4dddbfebb4057baea0f83d6df4f212008a8124a6b8799f731b16661"} build_url:https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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/Fx-Team/sha512/c65e0065ea44dd0e79a4e858583cd6b32a98f2b171bf5179babd99bf2ec52e569805822ef2ffdc6f3b48136749ed7a1f5e4127df2eafbc6e0a0b6edbb3de6a88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44e987f70d2aec9bc865f1d793e2462cf514d90ae37989d3b17e6e4841755f06a86ff466636148e6478cca5b9e32f446f33cf106b5e2a4a44bf7020fa682ecb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09720dbed6e549c0feaa324c0b7446e50c6042e68c58115a2327b092843d3430e5a4884de4dddbfebb4057baea0f83d6df4f212008a8124a6b8799f731b16661"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 08:34:37.857728) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:34:37.858054) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1466176243.166066-163872038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:34:37.942426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 08:34:37.942761) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 08:34:37.943049) ========= ========= Total master_lag: 0.17 =========