builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1466190844.56 results: success (0) buildid: 20160617092425 builduid: 8a937aa855e741658bb29aaed982b09c revision: 530e96008b7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:04.564782) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:04.565286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:04.565618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:04.583689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:04.583985) ========= 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=4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 12:14:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-06-17 12:14:05 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141425 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:04.740046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:04.740424) ========= 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=4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016837 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:04.794783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:04.795654) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 530e96008b7e --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 530e96008b7e --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=4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 12:14:05,263 Setting DEBUG logging. 2016-06-17 12:14:05,264 attempt 1/10 2016-06-17 12:14:05,264 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/530e96008b7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 12:14:05,635 unpacking tar archive at: fx-team-530e96008b7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696994 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:05.509731) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:05.510158) ========= script_repo_revision: 530e96008b7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:05.510703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:05.511045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 12:14:05.521929) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-17 12:14:05.522300) ========= /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=4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:14:06 INFO - MultiFileLogger online at 20160617 12:14:06 in /builds/slave/test 12:14:06 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 12:14:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:14:06 INFO - {'append_to_log': False, 12:14:06 INFO - 'base_work_dir': '/builds/slave/test', 12:14:06 INFO - 'blob_upload_branch': 'Fx-Team', 12:14:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:14:06 INFO - 'branch': 'Fx-Team', 12:14:06 INFO - 'buildbot_json_path': 'buildprops.json', 12:14:06 INFO - 'config_files': ('talos/linux_config.py',), 12:14:06 INFO - 'default_actions': ('clobber', 12:14:06 INFO - 'read-buildbot-config', 12:14:06 INFO - 'download-and-extract', 12:14:06 INFO - 'populate-webroot', 12:14:06 INFO - 'create-virtualenv', 12:14:06 INFO - 'install', 12:14:06 INFO - 'run-tests'), 12:14:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:14:06 INFO - 'download_minidump_stackwalk': True, 12:14:06 INFO - 'download_symbols': 'ondemand', 12:14:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:14:06 INFO - 'tooltool.py': '/tools/tooltool.py', 12:14:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:14:06 INFO - '/tools/misc-python/virtualenv.py')}, 12:14:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:14:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:14:06 INFO - 'installer_path': 'installer.exe', 12:14:06 INFO - 'log_level': 'info', 12:14:06 INFO - 'log_name': 'talos', 12:14:06 INFO - 'log_to_console': True, 12:14:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:14:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:14:06 INFO - 'opt_config_files': (), 12:14:06 INFO - 'pip_index': False, 12:14:06 INFO - 'sps_profile': False, 12:14:06 INFO - 'sps_profile_interval': 0, 12:14:06 INFO - 'suite': 'dromaeojs', 12:14:06 INFO - 'system_bits': '32', 12:14:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:14:06 INFO - 'title': 'talos-linux64-ix-030', 12:14:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:14:06 INFO - 'use_talos_json': True, 12:14:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:14:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:14:06 INFO - 'work_dir': 'build'} 12:14:06 INFO - ##### 12:14:06 INFO - ##### Running clobber step. 12:14:06 INFO - ##### 12:14:06 INFO - Running pre-action listener: _resource_record_pre_action 12:14:06 INFO - Running main action method: clobber 12:14:06 INFO - rmtree: /builds/slave/test/build 12:14:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:14:06 INFO - Running post-action listener: _resource_record_post_action 12:14:06 INFO - ##### 12:14:06 INFO - ##### Finished clobber step (success) 12:14:06 INFO - ##### 12:14:06 INFO - ##### 12:14:06 INFO - ##### Running read-buildbot-config step. 12:14:06 INFO - ##### 12:14:06 INFO - Running pre-action listener: _resource_record_pre_action 12:14:06 INFO - Running main action method: read_buildbot_config 12:14:06 INFO - Using buildbot properties: 12:14:06 INFO - { 12:14:06 INFO - "project": "", 12:14:06 INFO - "product": "firefox", 12:14:06 INFO - "script_repo_revision": "production", 12:14:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:14:06 INFO - "repository": "", 12:14:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:14:06 INFO - "buildid": "20160617092425", 12:14:06 INFO - "pgo_build": "True", 12:14:06 INFO - "basedir": "/builds/slave/test", 12:14:06 INFO - "buildnumber": 811, 12:14:06 INFO - "slavename": "talos-linux64-ix-030", 12:14:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:14:06 INFO - "platform": "ubuntu64_hw", 12:14:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:14:06 INFO - "branch": "fx-team", 12:14:06 INFO - "repo_path": "integration/fx-team", 12:14:06 INFO - "revision": "530e96008b7e", 12:14:06 INFO - "stage_platform": "linux64-pgo", 12:14:06 INFO - "builduid": "8a937aa855e741658bb29aaed982b09c", 12:14:06 INFO - "slavebuilddir": "test" 12:14:06 INFO - } 12:14:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:14:06 INFO - Running post-action listener: _resource_record_post_action 12:14:06 INFO - ##### 12:14:06 INFO - ##### Finished read-buildbot-config step (success) 12:14:06 INFO - ##### 12:14:06 INFO - ##### 12:14:06 INFO - ##### Running download-and-extract step. 12:14:06 INFO - ##### 12:14:06 INFO - Running pre-action listener: _resource_record_pre_action 12:14:06 INFO - Running main action method: download_and_extract 12:14:06 INFO - mkdir: /builds/slave/test/build/tests 12: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')]} 12:14:06 INFO - https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:14:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:14:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:14:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:14:07 INFO - Downloaded 1361 bytes. 12:14:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:14:07 INFO - Using the following test package requirements: 12:14:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:14:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:14:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:14:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:07 INFO - u'jsshell-linux-x86_64.zip'], 12:14:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:14:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:14:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:14:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:14:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:14:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:14:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:07 INFO - https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:14:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:14:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:14:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:14:08 INFO - Downloaded 24220995 bytes. 12:14:08 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'] 12:14:08 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 12:14:09 INFO - Return code: 0 12:14:09 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 12: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')]} 12:14:09 INFO - https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:14:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:14:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:14:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:14:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:14:10 INFO - Downloaded 24220995 bytes. 12:14:10 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'] 12:14:10 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 12:14:12 INFO - Return code: 0 12:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:12 INFO - https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:14:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:14:13 INFO - Downloaded 14405384 bytes. 12:14:13 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'] 12:14:13 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 12:14:13 INFO - Return code: 0 12:14:13 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')]} 12:14:13 INFO - https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:14:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:14:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:14:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:14:14 INFO - Downloaded 59400986 bytes. 12:14:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:14:14 INFO - mkdir: /builds/slave/test/properties 12:14:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:14 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:14 INFO - Contents: 12:14:14 INFO - build_url:https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:14:15 INFO - Running post-action listener: _resource_record_post_action 12:14:15 INFO - Running post-action listener: set_extra_try_arguments 12:14:15 INFO - ##### 12:14:15 INFO - ##### Finished download-and-extract step (success) 12:14:15 INFO - ##### 12:14:15 INFO - ##### 12:14:15 INFO - ##### Running populate-webroot step. 12:14:15 INFO - ##### 12:14:15 INFO - Running pre-action listener: _resource_record_pre_action 12:14:15 INFO - Running main action method: populate_webroot 12:14:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:15 INFO - '--tppagecycles', 12:14:15 INFO - '7'], 12:14:15 INFO - 'tests': ['tsvgm']}}, 12:14:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:14:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:14:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:14:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:14:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:14:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:15 INFO - 'talos_options': ['--disable-e10s'], 12:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:15 INFO - 'talos_options': ['--disable-e10s'], 12:14:15 INFO - 'tests': ['damp', 'tps']}, 12:14:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:15 INFO - 'tests': ['damp', 'tps']}, 12:14:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:14:15 INFO - 'tests': ['dromaeo_dom']}, 12:14:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:14:15 INFO - 'tests': ['basic_compositor_video']}, 12:14:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:14:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:14:15 INFO - 'tests': ['a11yr', 12:14:15 INFO - 'ts_paint', 12:14:15 INFO - 'tpaint', 12:14:15 INFO - 'sessionrestore', 12:14:15 INFO - 'sessionrestore_no_auto_restore', 12:14:15 INFO - 'tabpaint']}, 12:14:15 INFO - 'other-e10s': {'tests': ['a11yr', 12:14:15 INFO - 'ts_paint', 12:14:15 INFO - 'tpaint', 12:14:15 INFO - 'sessionrestore', 12:14:15 INFO - 'sessionrestore_no_auto_restore', 12:14:15 INFO - 'tabpaint']}, 12:14:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:14:15 INFO - 'ts_paint', 12:14:15 INFO - 'tpaint', 12:14:15 INFO - 'sessionrestore', 12:14:15 INFO - 'sessionrestore_no_auto_restore', 12:14:15 INFO - 'tabpaint']}, 12:14:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:14:15 INFO - 'ts_paint', 12:14:15 INFO - 'tpaint', 12:14:15 INFO - 'sessionrestore', 12:14:15 INFO - 'sessionrestore_no_auto_restore', 12:14:15 INFO - 'tabpaint']}, 12:14:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:14:15 INFO - 'tests': ['a11yr', 12:14:15 INFO - 'ts_paint', 12:14:15 INFO - 'tpaint', 12:14:15 INFO - 'sessionrestore', 12:14:15 INFO - 'sessionrestore_no_auto_restore', 12:14:15 INFO - 'tabpaint']}, 12:14:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:14:15 INFO - 'tests': ['a11yr', 12:14:15 INFO - 'ts_paint', 12:14:15 INFO - 'tpaint', 12:14:15 INFO - 'sessionrestore', 12:14:15 INFO - 'sessionrestore_no_auto_restore', 12:14:15 INFO - 'tabpaint']}, 12:14:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:14:15 INFO - 'tests': ['tsvgx', 12:14:15 INFO - 'tsvgr_opacity', 12:14:15 INFO - 'tart', 12:14:15 INFO - 'tscrollx', 12:14:15 INFO - 'cart']}, 12:14:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:14:15 INFO - 'tsvgr_opacity', 12:14:15 INFO - 'tart', 12:14:15 INFO - 'tscrollx', 12:14:15 INFO - 'cart']}, 12:14:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:15 INFO - 'talos_options': ['--disable-e10s'], 12:14:15 INFO - 'tests': ['tp5o']}, 12:14:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:15 INFO - 'tests': ['tp5o']}, 12:14:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:15 INFO - 'talos_options': ['--disable-e10s', 12:14:15 INFO - '--xperf_path', 12:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:15 INFO - 'tests': ['tp5n']}, 12:14:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:15 INFO - 'talos_options': ['--xperf_path', 12:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:15 INFO - 'tests': ['tp5n']}}, 12:14:15 INFO - 'talos.zip': {'path': '', 12:14:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:15 INFO - Running post-action listener: _resource_record_post_action 12:14:15 INFO - ##### 12:14:15 INFO - ##### Finished populate-webroot step (success) 12:14:15 INFO - ##### 12:14:15 INFO - ##### 12:14:15 INFO - ##### Running create-virtualenv step. 12:14:15 INFO - ##### 12:14:15 INFO - Running pre-action listener: _resource_record_pre_action 12:14:15 INFO - Running main action method: create_virtualenv 12:14:15 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:14:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:15 INFO - Using real prefix '/usr' 12:14:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:16 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:18 INFO - Installing pip.................done. 12:14:18 INFO - Return code: 0 12:14:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12: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')]} 12:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75c35c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719110>, '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 0x1685230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16856c0>, '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': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', '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 12: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', 'pip>=1.5'] in /builds/slave/test/build 12: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 pip>=1.5 12:14:18 INFO - Using env: {'DISPLAY': ':0', 12:14:18 INFO - 'HOME': '/home/cltbld', 12:14:18 INFO - 'LANG': 'en_US.UTF-8', 12:14:18 INFO - 'LANGUAGE': 'en_US:en', 12:14:18 INFO - 'LOGNAME': 'cltbld', 12:14:18 INFO - 'MAIL': '/var/mail/cltbld', 12:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:18 INFO - 'MOZ_NO_REMOTE': '1', 12:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:18 INFO - 'NO_EM_RESTART': '1', 12:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:18 INFO - 'PWD': '/builds/slave/test', 12:14:18 INFO - 'SHELL': '/bin/bash', 12:14:18 INFO - 'SHLVL': '1', 12:14:18 INFO - 'TERM': 'linux', 12:14:18 INFO - 'TMOUT': '86400', 12:14:18 INFO - 'USER': 'cltbld', 12:14:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', 12:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:18 INFO - '_': '/tools/buildbot/bin/python'} 12:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:18 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 12:14:18 INFO - Cleaning up... 12:14:18 INFO - Return code: 0 12:14:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12: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')]} 12:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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', '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 0x7f75c35c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719110>, '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 0x1685230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16856c0>, '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': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', '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 12: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12: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 psutil>=3.1.1 12:14:18 INFO - Using env: {'DISPLAY': ':0', 12:14:18 INFO - 'HOME': '/home/cltbld', 12:14:18 INFO - 'LANG': 'en_US.UTF-8', 12:14:18 INFO - 'LANGUAGE': 'en_US:en', 12:14:18 INFO - 'LOGNAME': 'cltbld', 12:14:18 INFO - 'MAIL': '/var/mail/cltbld', 12:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:18 INFO - 'MOZ_NO_REMOTE': '1', 12:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:18 INFO - 'NO_EM_RESTART': '1', 12:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:18 INFO - 'PWD': '/builds/slave/test', 12:14:18 INFO - 'SHELL': '/bin/bash', 12:14:18 INFO - 'SHLVL': '1', 12:14:18 INFO - 'TERM': 'linux', 12:14:18 INFO - 'TMOUT': '86400', 12:14:18 INFO - 'USER': 'cltbld', 12:14:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', 12:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:18 INFO - '_': '/tools/buildbot/bin/python'} 12:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:18 INFO - Downloading/unpacking psutil>=3.1.1 12: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 12: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 12: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 12: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 12: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 12: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 12:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:20 INFO - Installing collected packages: psutil 12:14:20 INFO - Running setup.py install for psutil 12:14:20 INFO - building 'psutil._psutil_linux' extension 12:14:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:14:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:14:20 INFO - building 'psutil._psutil_posix' extension 12:14:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:14:21 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 12:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:21 INFO - Successfully installed psutil 12:14:21 INFO - Cleaning up... 12:14:21 INFO - Return code: 0 12:14:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75c35c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719110>, '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 0x1685230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16856c0>, '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': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', '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 12:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:14:21 INFO - Using env: {'DISPLAY': ':0', 12:14:21 INFO - 'HOME': '/home/cltbld', 12:14:21 INFO - 'LANG': 'en_US.UTF-8', 12:14:21 INFO - 'LANGUAGE': 'en_US:en', 12:14:21 INFO - 'LOGNAME': 'cltbld', 12:14:21 INFO - 'MAIL': '/var/mail/cltbld', 12:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:21 INFO - 'MOZ_NO_REMOTE': '1', 12:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:21 INFO - 'NO_EM_RESTART': '1', 12:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:21 INFO - 'PWD': '/builds/slave/test', 12:14:21 INFO - 'SHELL': '/bin/bash', 12:14:21 INFO - 'SHLVL': '1', 12:14:21 INFO - 'TERM': 'linux', 12:14:21 INFO - 'TMOUT': '86400', 12:14:21 INFO - 'USER': 'cltbld', 12:14:21 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', 12:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:21 INFO - '_': '/tools/buildbot/bin/python'} 12:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:14:23 INFO - Installing collected packages: mozsystemmonitor 12:14:23 INFO - Running setup.py install for mozsystemmonitor 12:14:23 INFO - Successfully installed mozsystemmonitor 12:14:23 INFO - Cleaning up... 12:14:23 INFO - Return code: 0 12:14:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12: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')]} 12:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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', '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 0x7f75c35c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719110>, '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 0x1685230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16856c0>, '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': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', '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 12: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 12: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 jsonschema==2.5.1 12:14:23 INFO - Using env: {'DISPLAY': ':0', 12:14:23 INFO - 'HOME': '/home/cltbld', 12:14:23 INFO - 'LANG': 'en_US.UTF-8', 12:14:23 INFO - 'LANGUAGE': 'en_US:en', 12:14:23 INFO - 'LOGNAME': 'cltbld', 12:14:23 INFO - 'MAIL': '/var/mail/cltbld', 12:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:23 INFO - 'MOZ_NO_REMOTE': '1', 12:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:23 INFO - 'NO_EM_RESTART': '1', 12:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:23 INFO - 'PWD': '/builds/slave/test', 12:14:23 INFO - 'SHELL': '/bin/bash', 12:14:23 INFO - 'SHLVL': '1', 12:14:23 INFO - 'TERM': 'linux', 12:14:23 INFO - 'TMOUT': '86400', 12:14:23 INFO - 'USER': 'cltbld', 12:14:23 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', 12:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:23 INFO - '_': '/tools/buildbot/bin/python'} 12:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:23 INFO - Downloading/unpacking jsonschema==2.5.1 12: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 12: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 12: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 12: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 12: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 12: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 12:14:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:14:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12: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 12: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 12: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 12: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 12: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 12: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 12:14:25 INFO - Downloading functools32-3.2.3-2.tar.gz 12:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:14:25 INFO - warning: no files found matching '*.txt' 12:14:25 INFO - no previously-included directories found matching 'build' 12:14:25 INFO - no previously-included directories found matching 'dist' 12:14:25 INFO - no previously-included directories found matching '.git*' 12:14:25 INFO - Installing collected packages: jsonschema, functools32 12:14:25 INFO - Running setup.py install for functools32 12:14:26 INFO - warning: no files found matching '*.txt' 12:14:26 INFO - no previously-included directories found matching 'build' 12:14:26 INFO - no previously-included directories found matching 'dist' 12:14:26 INFO - no previously-included directories found matching '.git*' 12:14:26 INFO - Successfully installed jsonschema functools32 12:14:26 INFO - Cleaning up... 12:14:26 INFO - Return code: 0 12:14:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12: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')]} 12:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75c35c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719110>, '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 0x1685230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16856c0>, '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': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', '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 12:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:14:26 INFO - Using env: {'DISPLAY': ':0', 12:14:26 INFO - 'HOME': '/home/cltbld', 12:14:26 INFO - 'LANG': 'en_US.UTF-8', 12:14:26 INFO - 'LANGUAGE': 'en_US:en', 12:14:26 INFO - 'LOGNAME': 'cltbld', 12:14:26 INFO - 'MAIL': '/var/mail/cltbld', 12:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:26 INFO - 'MOZ_NO_REMOTE': '1', 12:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:26 INFO - 'NO_EM_RESTART': '1', 12:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:26 INFO - 'PWD': '/builds/slave/test', 12:14:26 INFO - 'SHELL': '/bin/bash', 12:14:26 INFO - 'SHLVL': '1', 12:14:26 INFO - 'TERM': 'linux', 12:14:26 INFO - 'TMOUT': '86400', 12:14:26 INFO - 'USER': 'cltbld', 12:14:26 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', 12:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:26 INFO - '_': '/tools/buildbot/bin/python'} 12:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:26 INFO - Downloading/unpacking blobuploader==1.2.4 12:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:28 INFO - Downloading blobuploader-1.2.4.tar.gz 12:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:14:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:14:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:28 INFO - Downloading docopt-0.6.1.tar.gz 12:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:14:28 INFO - Installing collected packages: blobuploader, requests, docopt 12:14:28 INFO - Running setup.py install for blobuploader 12:14:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:14:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:14:29 INFO - Running setup.py install for requests 12:14:29 INFO - Running setup.py install for docopt 12:14:29 INFO - Successfully installed blobuploader requests docopt 12:14:29 INFO - Cleaning up... 12:14:29 INFO - Return code: 0 12:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12: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')]} 12:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75c35c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719110>, '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 0x1685230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16856c0>, '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': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', '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 12:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:29 INFO - Using env: {'DISPLAY': ':0', 12:14:29 INFO - 'HOME': '/home/cltbld', 12:14:29 INFO - 'LANG': 'en_US.UTF-8', 12:14:29 INFO - 'LANGUAGE': 'en_US:en', 12:14:29 INFO - 'LOGNAME': 'cltbld', 12:14:29 INFO - 'MAIL': '/var/mail/cltbld', 12:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:29 INFO - 'MOZ_NO_REMOTE': '1', 12:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:29 INFO - 'NO_EM_RESTART': '1', 12:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:29 INFO - 'PWD': '/builds/slave/test', 12:14:29 INFO - 'SHELL': '/bin/bash', 12:14:29 INFO - 'SHLVL': '1', 12:14:29 INFO - 'TERM': 'linux', 12:14:29 INFO - 'TMOUT': '86400', 12:14:29 INFO - 'USER': 'cltbld', 12:14:29 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', 12:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:29 INFO - '_': '/tools/buildbot/bin/python'} 12:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:29 INFO - Running setup.py (path:/tmp/pip-Rk80WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:29 INFO - Running setup.py (path:/tmp/pip-A0bBqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:29 INFO - Running setup.py (path:/tmp/pip-BbMS1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:29 INFO - Running setup.py (path:/tmp/pip-9KStDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:30 INFO - Running setup.py (path:/tmp/pip-bo4XVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:30 INFO - Running setup.py (path:/tmp/pip-GQri9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:30 INFO - Running setup.py (path:/tmp/pip-m2sfnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:30 INFO - Running setup.py (path:/tmp/pip-_qIIBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:30 INFO - Running setup.py (path:/tmp/pip-M2G44B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:30 INFO - Running setup.py (path:/tmp/pip-HyuSV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:30 INFO - Running setup.py (path:/tmp/pip-AH7WvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:30 INFO - Running setup.py (path:/tmp/pip-arumia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:30 INFO - Running setup.py (path:/tmp/pip-XgPLf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:30 INFO - Running setup.py (path:/tmp/pip-qd8MNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:30 INFO - Running setup.py (path:/tmp/pip-VbFpDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:30 INFO - Running setup.py (path:/tmp/pip-7Ra7Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:30 INFO - Running setup.py (path:/tmp/pip-HTSHLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:14:30 INFO - Running setup.py install for manifestparser 12:14:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:14:31 INFO - Running setup.py install for mozcrash 12:14:31 INFO - Running setup.py install for mozdebug 12:14:31 INFO - Running setup.py install for mozdevice 12:14:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:14:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:14:31 INFO - Running setup.py install for mozfile 12:14:31 INFO - Running setup.py install for mozhttpd 12:14:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:14:31 INFO - Running setup.py install for mozinfo 12:14:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:14:31 INFO - Running setup.py install for mozInstall 12:14:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:14:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:14:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:14:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:14:31 INFO - Running setup.py install for mozleak 12:14:31 INFO - Running setup.py install for mozlog 12:14:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:14:32 INFO - Running setup.py install for moznetwork 12:14:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:14:32 INFO - Running setup.py install for mozprocess 12:14:32 INFO - Running setup.py install for mozprofile 12:14:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:14:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:14:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:14:32 INFO - Running setup.py install for mozrunner 12:14:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:14:32 INFO - Running setup.py install for mozscreenshot 12:14:32 INFO - Running setup.py install for moztest 12:14:32 INFO - Running setup.py install for mozversion 12:14:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:14:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:14:32 INFO - Cleaning up... 12:14:32 INFO - Return code: 0 12:14:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75c35c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719110>, '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 0x1685230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16856c0>, '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': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', '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 12:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:32 INFO - Using env: {'DISPLAY': ':0', 12:14:32 INFO - 'HOME': '/home/cltbld', 12:14:32 INFO - 'LANG': 'en_US.UTF-8', 12:14:32 INFO - 'LANGUAGE': 'en_US:en', 12:14:32 INFO - 'LOGNAME': 'cltbld', 12:14:32 INFO - 'MAIL': '/var/mail/cltbld', 12:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:32 INFO - 'MOZ_NO_REMOTE': '1', 12:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:32 INFO - 'NO_EM_RESTART': '1', 12:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:32 INFO - 'PWD': '/builds/slave/test', 12:14:32 INFO - 'SHELL': '/bin/bash', 12:14:32 INFO - 'SHLVL': '1', 12:14:32 INFO - 'TERM': 'linux', 12:14:32 INFO - 'TMOUT': '86400', 12:14:32 INFO - 'USER': 'cltbld', 12:14:32 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', 12:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:32 INFO - '_': '/tools/buildbot/bin/python'} 12:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:32 INFO - Running setup.py (path:/tmp/pip-NTvFIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:33 INFO - Running setup.py (path:/tmp/pip-4mYyJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:33 INFO - Running setup.py (path:/tmp/pip-WdEkRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:33 INFO - Running setup.py (path:/tmp/pip-ni8lHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:33 INFO - Running setup.py (path:/tmp/pip-KVG9oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:33 INFO - Running setup.py (path:/tmp/pip-ddx8TB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:33 INFO - Running setup.py (path:/tmp/pip-fcnCta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:33 INFO - Running setup.py (path:/tmp/pip-SKXJar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:33 INFO - Running setup.py (path:/tmp/pip-9Od6CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:33 INFO - Running setup.py (path:/tmp/pip-Qnqs_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:33 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)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:33 INFO - Running setup.py (path:/tmp/pip-PChvgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:33 INFO - Running setup.py (path:/tmp/pip-gHKTOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:33 INFO - Running setup.py (path:/tmp/pip-RfdqLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:33 INFO - Running setup.py (path:/tmp/pip-6TgMHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:34 INFO - Running setup.py (path:/tmp/pip-L_Eh_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:34 INFO - Running setup.py (path:/tmp/pip-hnHF1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:34 INFO - Running setup.py (path:/tmp/pip-NzfzBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:14:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12: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 12: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 12: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 12: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 12: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 12: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 12:14:36 INFO - Downloading blessings-1.6.tar.gz 12:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:14:36 INFO - Installing collected packages: blessings 12:14:36 INFO - Running setup.py install for blessings 12:14:36 INFO - Successfully installed blessings 12:14:36 INFO - Cleaning up... 12:14:36 INFO - Return code: 0 12:14:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:14:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:36 INFO - Reading from file tmpfile_stdout 12:14:36 INFO - Current package versions: 12:14:36 INFO - argparse == 1.2.1 12:14:36 INFO - blessings == 1.6 12:14:36 INFO - blobuploader == 1.2.4 12:14:36 INFO - docopt == 0.6.1 12:14:36 INFO - functools32 == 3.2.3-2 12:14:36 INFO - jsonschema == 2.5.1 12:14:36 INFO - manifestparser == 1.1 12:14:36 INFO - mozInstall == 1.12 12:14:36 INFO - mozcrash == 0.17 12:14:36 INFO - mozdebug == 0.1 12:14:36 INFO - mozdevice == 0.48 12:14:36 INFO - mozfile == 1.2 12:14:36 INFO - mozhttpd == 0.7 12:14:36 INFO - mozinfo == 0.9 12:14:36 INFO - mozleak == 0.1 12:14:36 INFO - mozlog == 3.2 12:14:36 INFO - moznetwork == 0.27 12:14:36 INFO - mozprocess == 0.22 12:14:36 INFO - mozprofile == 0.28 12:14:36 INFO - mozrunner == 6.11 12:14:36 INFO - mozscreenshot == 0.1 12:14:36 INFO - mozsystemmonitor == 0.3 12:14:36 INFO - moztest == 0.7 12:14:36 INFO - mozversion == 1.4 12:14:36 INFO - psutil == 3.1.1 12:14:36 INFO - requests == 1.2.3 12:14:36 INFO - wsgiref == 0.1.2 12:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75c35c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719110>, '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 0x1685230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16856c0>, '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': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', '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 12:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:36 INFO - Using env: {'DISPLAY': ':0', 12:14:36 INFO - 'HOME': '/home/cltbld', 12:14:36 INFO - 'LANG': 'en_US.UTF-8', 12:14:36 INFO - 'LANGUAGE': 'en_US:en', 12:14:36 INFO - 'LOGNAME': 'cltbld', 12:14:36 INFO - 'MAIL': '/var/mail/cltbld', 12:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:36 INFO - 'MOZ_NO_REMOTE': '1', 12:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:36 INFO - 'NO_EM_RESTART': '1', 12:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:36 INFO - 'PWD': '/builds/slave/test', 12:14:36 INFO - 'SHELL': '/bin/bash', 12:14:36 INFO - 'SHLVL': '1', 12:14:36 INFO - 'TERM': 'linux', 12:14:36 INFO - 'TMOUT': '86400', 12:14:36 INFO - 'USER': 'cltbld', 12:14:36 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', 12:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:36 INFO - '_': '/tools/buildbot/bin/python'} 12:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:14:36 INFO - Cleaning up... 12:14:36 INFO - Return code: 0 12:14:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75c35c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719110>, '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 0x1685230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16856c0>, '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': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', '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 12:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:14:36 INFO - Using env: {'DISPLAY': ':0', 12:14:36 INFO - 'HOME': '/home/cltbld', 12:14:36 INFO - 'LANG': 'en_US.UTF-8', 12:14:36 INFO - 'LANGUAGE': 'en_US:en', 12:14:36 INFO - 'LOGNAME': 'cltbld', 12:14:36 INFO - 'MAIL': '/var/mail/cltbld', 12:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:36 INFO - 'MOZ_NO_REMOTE': '1', 12:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:36 INFO - 'NO_EM_RESTART': '1', 12:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:36 INFO - 'PWD': '/builds/slave/test', 12:14:36 INFO - 'SHELL': '/bin/bash', 12:14:36 INFO - 'SHLVL': '1', 12:14:36 INFO - 'TERM': 'linux', 12:14:36 INFO - 'TMOUT': '86400', 12:14:36 INFO - 'USER': 'cltbld', 12:14:36 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', 12:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:36 INFO - '_': '/tools/buildbot/bin/python'} 12:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:14:37 INFO - Cleaning up... 12:14:37 INFO - Return code: 0 12:14:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:14:37 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')]} 12:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:37 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')]} 12:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:37 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 0x7f75c35c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719110>, '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 0x1685230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16856c0>, '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': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', '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 12:14:37 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 12:14:37 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 12:14:37 INFO - Using env: {'DISPLAY': ':0', 12:14:37 INFO - 'HOME': '/home/cltbld', 12:14:37 INFO - 'LANG': 'en_US.UTF-8', 12:14:37 INFO - 'LANGUAGE': 'en_US:en', 12:14:37 INFO - 'LOGNAME': 'cltbld', 12:14:37 INFO - 'MAIL': '/var/mail/cltbld', 12:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:37 INFO - 'MOZ_NO_REMOTE': '1', 12:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:37 INFO - 'NO_EM_RESTART': '1', 12:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:37 INFO - 'PWD': '/builds/slave/test', 12:14:37 INFO - 'SHELL': '/bin/bash', 12:14:37 INFO - 'SHLVL': '1', 12:14:37 INFO - 'TERM': 'linux', 12:14:37 INFO - 'TMOUT': '86400', 12:14:37 INFO - 'USER': 'cltbld', 12:14:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', 12:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:37 INFO - '_': '/tools/buildbot/bin/python'} 12:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:37 INFO - Downloading/unpacking flake8 12:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:14:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:14:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:14:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:14:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:14:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:14:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:14:39 INFO - no previously-included directories found matching 'docs/_build' 12:14:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:14:39 INFO - Running setup.py install for pep8 12:14:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:14:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:14:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:14:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:14:40 INFO - no previously-included directories found matching 'docs/_build' 12:14:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:14:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:14:40 INFO - Cleaning up... 12:14:40 INFO - Return code: 0 12:14:40 INFO - Running post-action listener: _resource_record_post_action 12:14:40 INFO - Running post-action listener: _start_resource_monitoring 12:14:40 INFO - Starting resource monitoring. 12:14:40 INFO - ##### 12:14:40 INFO - ##### Finished create-virtualenv step (success) 12:14:40 INFO - ##### 12:14:40 INFO - ##### 12:14:40 INFO - ##### Running install step. 12:14:40 INFO - ##### 12:14:40 INFO - Running pre-action listener: _resource_record_pre_action 12:14:40 INFO - Running main action method: install 12:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:40 INFO - Reading from file tmpfile_stdout 12:14:40 INFO - Detecting whether we're running mozinstall >=1.0... 12:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:14:40 INFO - Reading from file tmpfile_stdout 12:14:40 INFO - Output received: 12:14:40 INFO - Usage: mozinstall [options] installer 12:14:40 INFO - Options: 12:14:40 INFO - -h, --help show this help message and exit 12:14:40 INFO - -d DEST, --destination=DEST 12:14:40 INFO - Directory to install application into. [default: 12:14:40 INFO - "/builds/slave/test"] 12:14:40 INFO - --app=APP Application being installed. [default: firefox] 12:14:40 INFO - mkdir: /builds/slave/test/build/application 12:14:40 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'] 12:14:40 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 12:14:57 INFO - Reading from file tmpfile_stdout 12:14:57 INFO - Output received: 12:14:57 INFO - /builds/slave/test/build/application/firefox/firefox 12:14:57 INFO - Running post-action listener: _resource_record_post_action 12:14:57 INFO - ##### 12:14:57 INFO - ##### Finished install step (success) 12:14:57 INFO - ##### 12:14:57 INFO - ##### 12:14:57 INFO - ##### Running run-tests step. 12:14:57 INFO - ##### 12:14:57 INFO - Running pre-action listener: _resource_record_pre_action 12:14:57 INFO - Running main action method: run_tests 12:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:14:57 INFO - Python 2.7.3 12:14:57 INFO - Return code: 0 12:14:57 INFO - grabbing minidump binary from tooltool 12:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719110>, '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 0x1685230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16856c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:14:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:14:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:14:57 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 12:14:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:14:57 INFO - Return code: 0 12:14:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:14:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:14:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:14:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:14:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:14:58 INFO - Return code: 0 12:14:58 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/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 12:14:58 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/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 12:14:58 INFO - Using env: {'DISPLAY': ':0', 12:14:58 INFO - 'HOME': '/home/cltbld', 12:14:58 INFO - 'LANG': 'en_US.UTF-8', 12:14:58 INFO - 'LANGUAGE': 'en_US:en', 12:14:58 INFO - 'LOGNAME': 'cltbld', 12:14:58 INFO - 'MAIL': '/var/mail/cltbld', 12:14:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:14:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:58 INFO - 'MOZ_NO_REMOTE': '1', 12:14:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:58 INFO - 'NO_EM_RESTART': '1', 12:14:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:58 INFO - 'PWD': '/builds/slave/test', 12:14:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:14:58 INFO - 'SHELL': '/bin/bash', 12:14:58 INFO - 'SHLVL': '1', 12:14:58 INFO - 'TERM': 'linux', 12:14:58 INFO - 'TMOUT': '86400', 12:14:58 INFO - 'USER': 'cltbld', 12:14:58 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216', 12:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:58 INFO - '_': '/tools/buildbot/bin/python'} 12:14:58 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/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 12:14:58 INFO - mozversion application_buildid: 20160617092425 12:14:58 INFO - mozversion application_changeset: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 12:14:58 INFO - mozversion application_display_name: Nightly 12:14:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:14:58 INFO - mozversion application_name: Firefox 12:14:58 INFO - mozversion application_remotingname: firefox 12:14:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:14:58 INFO - mozversion application_vendor: Mozilla 12:14:58 INFO - mozversion application_version: 50.0a1 12:14:58 INFO - mozversion platform_buildid: 20160617092425 12:14:58 INFO - mozversion platform_changeset: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 12:14:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:14:58 INFO - mozversion platform_version: 50.0a1 12:14:58 INFO - using testdate: 1466190898 12:14:58 INFO - actual date: 1466190898 12:14:58 INFO - starting webserver on 'localhost:48370' 12:14:58 INFO - SUITE-START | Running 2 tests 12:14:58 INFO - TEST-START | dromaeo_css 12:14:58 INFO - operating with platform_type : linux_ 12:14:58 INFO - Initialising browser for dromaeo_css test... 12:14:58 INFO - TEST-INFO | started process 10685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8fs9BZ/profile http://localhost:48370/getInfo.html) 12:15:02 INFO - PROCESS | 10685 | __metrics Screen width/height:1600/1200 12:15:02 INFO - PROCESS | 10685 | colorDepth:24 12:15:02 INFO - PROCESS | 10685 | Browser inner width/height: 1024/697 12:15:02 INFO - PROCESS | 10685 | __metrics 12:15:03 INFO - PROCESS | 10685 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:15:04 INFO - TEST-INFO | 10685: exit 0 12:15:04 INFO - Browser initialized. 12:15:04 INFO - Running cycle 1/1 for dromaeo_css test... 12:15:04 INFO - TEST-INFO | started process 10769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8fs9BZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:16 INFO - PROCESS | 10769 | RSS: Main: 173260800 12:15:16 INFO - PROCESS | 10769 | 12:16:07 INFO - PROCESS | 10769 | 1466190967019 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] 12:18:15 INFO - PROCESS | 10769 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48370/tests/dromaeo/cssquery-ext.html) 12:18:16 INFO - PROCESS | 10769 | RSS: Main: 264687616 12:18:16 INFO - PROCESS | 10769 | 12:21:19 INFO - PROCESS | 10769 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-ext.html (next: http://localhost:48370/tests/dromaeo/cssquery-jquery.html) 12:21:19 INFO - PROCESS | 10769 | RSS: Main: 272097280 12:21:19 INFO - PROCESS | 10769 | 12:24:21 INFO - PROCESS | 10769 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48370/tests/dromaeo/cssquery-mootools.html) 12:24:22 INFO - PROCESS | 10769 | RSS: Main: 264945664 12:24:22 INFO - PROCESS | 10769 | 12:27:24 INFO - PROCESS | 10769 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48370/tests/dromaeo/cssquery-prototype.html) 12:27:24 INFO - PROCESS | 10769 | RSS: Main: 267247616 12:27:24 INFO - PROCESS | 10769 | 12:30:27 INFO - PROCESS | 10769 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48370/tests/dromaeo/cssquery-yui.html) 12:30:28 INFO - PROCESS | 10769 | RSS: Main: 227790848 12:30:28 INFO - PROCESS | 10769 | 12:33:31 INFO - PROCESS | 10769 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-yui.html (next: http://localhost:48370/tests/dromaeo/cssquery-dojo.html) 12:33:31 INFO - PROCESS | 10769 | RSS: Main: 289083392 12:33:31 INFO - PROCESS | 10769 | 12:33:31 INFO - PROCESS | 10769 | __start_tp_report 12:33:31 INFO - PROCESS | 10769 | _x_x_mozilla_page_load 12:33:31 INFO - PROCESS | 10769 | _x_x_mozilla_page_load_details 12:33:31 INFO - PROCESS | 10769 | |i|pagename|runs| 12:33:31 INFO - PROCESS | 10769 | |0;dojo.html;3102.301982054038;3102.844857757112;3128.984355078225;3141.9528707069385;3162.525621156826;5217.582593392529;5264.184051472028;5286.180642000491;5431;5465.781368745255;5350.866228344284;5366.758495867685;5369.865753356168;5416.620836541444;5445.264889239951;4807.399075115611;4866.440359358684;4893.853184404474;4911.115999120157;5028.094942910293;4974.626902982272;4983.975080124595;5015.172496538085;5052.26742122392;5060.974695126519;4766.070616229837;4823.951760482385;4843.273508973647;4886.902261954741;4923.606111511071;4869.269609558559;4876.049170411771;4881.511848815126;4900.044491324194;4984.87537811554;4864.100141473803;4898.730569818658;4901.289313049588;4916.139675556763;4937.8271760488215;5229.267902493654;5287.656302340336;5323;5327.893442131174;5391.218273350342;5719.227904232917;5721.084626459747;5725.169850371714;5768.538516918678;5778.0466223073145;5775.942240577582;5808.738606762706;5809.477147056785;5826.300843898759;5830.067189249742;5244.580433565306;5298.761555730001;5345.30511033567;5361.249425080492;5373.570114390839;5921.496672782776;5928.110783382527;5931.555133364928;5933.3769954154195;5935.73289201987;5404.162354835007;5661.348944871393;5671.064274394678;5676.858078547987;5679.943200567942;5626.774929002876;5718.342390625131;5718.542516598662;5737.426257374229;5739.655620662774;5665.6034077614995;5683.516901063456;5686.744096515667;5696.23100881384;5724.427557244326;5559.666420014732;5620.634658747168;5738.540916726652;5743.798967036134;5746.224259724967;4348.499922508952;4363.258246098171;4372.23485889968;4415;4417.204903117469;3887.5918028607157;3900.7074469414906;3906.0430194602504;3916.706247031484;3942.526896772348;5274.182501712241;5284.445133261029;5369.5972802040005;5414.18787181918;5444.156155795858;5717.142428635738;5791.913121303184;5808.041673123972;5815.476607105381;5831.300243970751;5350.170723537858;5417.241586177859;5429.375621803464;5429.945700542944;5432.619716619799;4674.929876051862;4747.620190384761;4768.117898188846;4809.374781278481;4845.53967373099;5902.468777809931;5902.61632993854;5908.172855800191;5923.49650279731;5947.762089516457;5764.740586673526;5787.7395517200985;5796.739146738491;5800.39095894925;5804.796832110856;5696.515796157373;5758.798442054508;5765.221695071279;5810.883782324246;5863.296404431496;5620.522255608319;5621.353544342453;5624.915626265528;5629.127485239795;5631.943680563142;5748.511376533042;5772.249607550992;5781.277340332458;5798.420157984337;5801.129830525455;5481.506664400223;5536.446355364431;5555.50000499957;5583.748731307182;5610.4670056344585;5582.246396736388;5582.8325150245555;5585.804496842591;5592.86017849557;5594.188842617879;5344.652597581145;5458.808941687022;5506.449355064461;5523.475269849358;5556.72216389187;5539.584531160099;5573.996680597531;5586.13414920688;5678.0915053591225;5681.573881958952;5484.478974497416;5489;5494.423085575957;5495.175723641486;5496.80761173357 12:33:31 INFO - PROCESS | 10769 | |1;ext.html;598.0998597111346;599.7331187621508;613.5950272819938;622.0389498225242;623.1431781300712;30720;39613.405798913;40570.39144412836;40806.59193408065;43510.564894351046;41591.79204103975;41957.160856782844;42160.156796864045;42187.57812421875;42643.36034959478;8971.551422428885;9100.908990910073;9106.86339704905;9115.453072815651;9117.863232051524;8643.30853531716;8725.825483490358;8748;8749.081346458626;8754.080821513744;8837.513936733478;8865.778355541099;8874.733757987238;8897.466152030867;8899.73300800977;8702.738917832476;8750.737477875675;8756.299496040301;8772.254358379545;8817.515036672981;8781.956090219572;8804.427712198687;8817.118288171196;8818.162274583969;8850.424722393089;38714.419283710486;39693.40459893104;40031.199376012315;40201;40221.195576088605;2991.237234505187;3157.700018498239;3202.247471844115;3208.3904058229095;3217.260030193069;32482.837585812154;32873.17817054593;33086.50370244448;33235.169120771934;34309.82845085759;4319.265724826787;4408.338749187616;4451.354553589711;4503.234450143484;4671.743054132022;329488;331304;331313;331894.3405282982;334164;56094;56109.71945140248;56132.438675613535;56303.71848140733;56440.15339769907;53608.19587706187;57273.427265727645;59081.40918590759;59101;66268.6686566564;13941.930290348686;13943.372548235353;13967.580972570839;13993;13997.650058748613;10849.403282819363;10931.890681093088;11061.281016733887;11064.944675276573;11120.833187502194;14953.40186392554;16314.87906572138;16617.169141542876;16775.2451139699;16910.66178676444;5191.402988656278;5319.308489896289;5340.092184328673;5348.144296912553;5425.131978883439;847.3602430165186;885.2295409181637;933.7198840347869;964;1001.5843424978552;31690.36619267648;32208.35583288321;32402.83798581039;32450;32571.0711058591;1062.1449732965036;1064.5848119233506;1066.0778426660881;1129.2885482146196;1141.6974501756874;15521.407554790314;15680.529584112495;15902;15914.602134946488;16181.676366472604;477949;484774;486195;488080;489185;57238.71380643154;57450;57495;57499.42500575024;57602.42397576055;1106.623747925709;1146.4726225936163;1154.2843437068902;1159.8956093951585;1165.5687395663658;29834.403311933205;31116;31161.37677246488;31206.37587248197;31587.36825263436;50170.24744628907;50646.74676626741;50679.746601268234;50681;50852.49147508626;451499;453131;453276;454424;455639;41222.58777412187;42434;43257.13485730331;43410.56589434065;43427;36121.819390903926;41223.58776412318;46405.76797116128;47818.760906196636;51835.74082129565;38659.37808047325;40715.59284407118;41458.89243716855;41696;42330.36504452497;39377.40933885937;39685.206295873344;40449.39325910055;40775;41656;40819.18361632691;40927.7953610242;41237.79381103075;41798.37302440405;42117.57882421259;34531.82734086414;36299;36645.26709465849;36661.81669091638;36815.44776828296;27736.306592335353;28076;28285.434291313646;28338.14985550437;28365 12:33:31 INFO - PROCESS | 10769 | |2;jquery.html;378.2850412719958;383.8445429601011;390.1280637774575;393.97439166454177;400.0897957147489;17777.555561110978;19601.21595136193;19765;20122.19511219553;20194.697079543817;16041.278142483587;16237.918810405932;16505.33978640856;16514.339426422957;16763.078030708308;5489.533389661883;5645.435456454363;5692.772289108451;5703.771849126051;5740.856478588048;5466.234727138204;5762.193292938992;5791.942080579182;5800.564957628174;5831.533477321804;5636.633618814764;5807.912881306784;5818.040023396155;5855.063189889618;5881.705914704269;5839.9124013139835;5913.408659134052;5933.525317974551;5960.821175364746;5969.761209551612;5671.943280567183;5737.627054241502;5758.078707406795;5839.562032847553;5843.620164689324;13630.93184534071;13793.172409655352;13924.93037534816;14330.49843255481;22980.19569315066;2351.6354964980455;2446.6330050492393;2458.2870967419426;2478.504299140161;2887.9314653578313;9495.66765163223;9661.71014869555;10504.842427363596;10514.158867290598;10520.579176832918;1896.1372575478124;1971.3790156100927;1987.7117817916467;1989.651810933081;2079.5321052763156;76803.23196768017;79251.6037419815;80226.59886700587;80427;81992.77010844841;10614.726232852106;10701.732456688645;10859.891401086046;11031.22781405294;11035.337879727242;15092.698146037237;15101.3204405802;15112.546623601309;15180.544583662508;15223.847761522464;7134.286571342825;7257.8911316330295;7465.328120469184;7778.455508114378;7976.960115199503;6724.428423583952;6738.561993470409;7034.19106802714;7241.348278654947;7248.9275107249305;4566.543345665407;4618.630509559227;4680.906381872412;4725.64557658177;4839.637027222902;1847.3811273223353;1857.4149143019906;1882.9717554236697;1895.4029480713532;1916.9424917252227;771.0901136658797;845.2223953962247;921;933.6358820060182;966.0484422843634;18592.163352649164;18667.81332186688;18675.43973680792;19464.31874884372;19466.90266548658;874.3398733955822;890.8797312362748;893.4728510179026;899.3884158772098;938.863864739609;10171.288009839389;10344.793104137874;10412.635557755442;10426.791464170674;10477.161827053817;450645;450825;451837;451928;477461;62171;77990;79927.60036199898;87167.56416217878;88884;961.2262128986233;964.8793900762405;978.554757585297;982.29274922056;983.8573406856109;17064.31742730277;17169.742453862953;17184.65630687354;17325.913370433067;17628.73556896673;39750.403743944444;41906.58093419149;41934;42364.78817605892;42984;53688.19467708065;55057.72471137779;62195;62351;63264.36735632769;7771.805704857424;7959.323457506177;8784.429012114448;8843.778905527155;8879.955600221958;12278.386080696107;13363.131396459588;13627.454901804213;13701;13960.581182564132;11993.34036627959;12059.095567832623;12324.876751232372;12502.062345323955;12692.936535317263;11272.943635281772;12167.81748273759;12184.878151218729;12266.32535210572;12308.446119924445;12445.564405245774;12506;12765.553205637758;12819.615411537668;12867.163634363736;8708.04211536743;8811.471311721318;9215.585298661443;11768.176227664324;12514.87485125137;12081.214721043105;12268.38658067111;12600.432980515716;12768.87231127714;13347.66630834237 12:33:31 INFO - PROCESS | 10769 | |3;mootools.html;1161.5702190189631;1397.468961794518;1409.3798728559434;1526.5496678479847;1698.8555972742317;8209.794755131117;8569.228769410753;8579.871301930476;8837.248833849131;8884.378093533454;8318.875216871736;8747.731578921053;8755.518446485441;8779.429337093101;8788.78028049299;1957.5399781051442;2208.8895555222257;2272.3750968483673;2274.8407611467205;2303.8617682938993;2336.4626135988733;2347.8239132065164;2348.0842471436154;2350.670906073151;2351.3063646224405;2243.7644047375034;2256.1877724019423;2270.14869423966;2273.5680220758086;2275.567642147995;1951.6584597695346;2224.3882932193615;2234.6089434349005;2286.634138537843;2291.667708182304;2253.4253765289745;2268.7504374518953;2277.4078739527677;2285.6685780561725;2294.862308261493;9043.412178208395;9045.643153526958;9056.230220431271;9084.50035248061;9128.81742365149;5061.5950723942;5210.687358758449;5218.399884013311;5219.817306394258;5222.817201397971;3199.42410366134;3372.37611041958;3386.86452541898;3446.655334466533;3470.8958731238104;1098.1215027977667;1106.9446527673583;1134.0813940708053;1146.3809542846852;1148;12624.936875315656;12635.87364126356;12685.112042157052;12698.174618649758;12700.110992230548;4697.425122323671;4767.928481072787;4834.299026641117;4851.660383773173;4868.586170175575;10612.946935265274;10661.413622250695;10666.626668066581;10669.413182274895;10682.092022178047;5221.321228240305;5226.92159617606;5228.738563071831;5234.842954711365;5235.0576896159055;4091.5499295077516;4678.298255261738;4817.470078291385;4824.035192961422;4902.166631672624;3864.613538646169;3918.804059796999;3950.4074388841905;4016.758994460342;4079.449274347925;1236.4744983382207;1242.0808601634906;1246.731952630189;1251.343044901434;1264.943077561512;863.5336918064176;866.6230189867427;868.700298397052;887.8401887660154;897.3808072430132;6191.4118158774845;6241.21984751906;6318.589291696117;6553.606783592904;6586.6377349245295;867.6659486097898;891.4517571693492;909.6060362053089;946.8627049077845;971.3880255439028;3824.904377390532;3939.9015024624614;3976.4631774710624;4046.291898917678;4053.3717273822604;11011.449427528592;11075.11399088071;11102.333859968428;11107.278026928223;11178.27341222818;11497.942510287396;11598.246114002732;11606.477708503138;11657.76684466306;11666.241694289844;8157.75526734199;8201.179882011871;8214.548199849065;8323.292520135856;8349.165083491724;5822.3304320003745;5848.824535263949;5946.256717910262;5991.1771024325835;6022.5784195105925;10450.895491045296;10562.894371056498;10601.946990265;10609.89390106089;10609.89390106089;10367.429791361548;10650.8402373966;10879.456027198767;10889.911008899047;11008.889911100787;6744.7976560703255;7242.565446073252;7432.293932076444;7473.252674732484;7590.468667193243;8447.873281900653;8473;8500.192481714228;8509.574521273787;8592.65629374818;7738.883916741366;7799.688012479664;7813.765587032398;8106.83786324282;8114;7665;7762.1073576537165;7820.448680163076;7821.765347039598;7915.722949696733;7340.743073992385;7414.406847452299;7497.512661676974;7503.13713922884;7514.812129696801;5067.189249720027;5104.744762761773;5135.589152867687;5159;5202.297689811979;5169.53474187325;5233.188855727369;5280.498352656491;5321.068812957795;5413.24214609947 12:33:31 INFO - PROCESS | 10769 | |4;prototype.html;310.47219726465;321.43588003054634;324.29627707873914;327.5463483075939;329.7296217101976;5355.518003379695;5397.082495975684;5405.567554595633;5446.482584154504;5448.400675925645;5191.454897235783;5293.9735301323535;5367.838964831051;5371.033214021474;5373.704446255454;3999.180168065554;4147.605977432147;4154.086101057777;4160.251154792136;4180.749155050691;4160.7087503874745;4164.416981622575;4172.499300083994;4184.476940382452;4184.686148538856;4084.4281800547797;4106.876793696194;4109.506859176888;4134.524529679095;4144.171165766844;3946.2304850554156;3968.801559922021;4060.8578699745367;4130.772807495587;4131.586841315874;3613.2050948791225;3613.385724426854;3646.562412510489;3658.8170591470584;3671.9082022949374;5078.720670363128;5092.261622064817;5107.361579802525;5152.742362881879;5153.660048387409;4460.33095035744;4554.316852472122;4750.382450281476;4756.311509414143;4778.904421911542;5494.587905907073;5494.670319780826;5507.155103040486;5544.11705912923;5562.16567514872;4035.9708274390136;4053.513578370585;4069.104796944667;4072.2669919414493;4075.53131389891;5552.666839989613;5651.4913657770585;5692.459216374438;5712.914306285409;5743.913841292342;4059.04612416082;4061.878143655695;4100.65144462724;4114.39538579954;4122.752634841919;4168.249715051259;4170.854020109282;4172.70791044624;4229.640480559187;4233.597808208216;4472.888177795516;4719.457262414866;4743.169945259566;4760.143174228603;4760.452547957029;5571.359293681197;5583.832485025456;5602.159676048625;5606.579506536945;5642.351129620064;1415.5399495164113;1441.5675297410735;1441.7549016667192;1445.9421623134956;1447.0666420158939;885.7519894429441;910.899801021887;927.8051609162152;930.8510638297976;931.2736065868634;4801.351817504592;4815.964567617979;4847.345608342899;4868.878278043077;4870.488598697157;5088.236764485283;5119.795208191631;5130.204818253177;5140.691558506502;5148.768305426265;4564.748938808331;4825;4829.492903245179;4835.758212089381;4875.293082503017;2933.9559906601417;2978.836164011;3016.9245768855517;3019;3027.4399236141385;5826.592138550261;5851.795187168429;5870.3249126350165;5883.646541383395;5899.259718383088;5219.451957544403;5606.943930560642;5757.85605359861;5812.941870581325;5854.268216472941;5807.60617451817;5813.8372325535065;5820.476157145878;5852.068817290284;5885.352611212763;5541.085720856014;5683.460071293221;5701.258836351248;5705.545086003042;5721.513671337816;5558.333000040021;5641.689707066151;5646.2942132233475;5661.971690141523;5672.461116193955;5766.654000759968;5794.884102318014;5854.297484301911;5872.297033860304;5875.706214689163;3852.9614703852603;4045.8381664734256;4052.4326594277413;4067.7966101694205;4071.2086681859887;5647.858803529944;5662.150677398423;5680.375158732453;5687.744051517774;5697.57268204878;5559.63862348946;5573.136163894603;5577.609567330248;5595.8880822384135;5631.746571404215;5413.052715774802;5495.670259784426;5561.221428999862;5571.941331147231;5585.860353491195;5363.2759577456545;5408.78364865401;5454.699991500347;5494.890102197854;5497.285352904097;5393.784248630168;5536.363318218457;5551.195076713934;5570.220169176399;5596.384397716167;5478.561715062865;5509.944900550943;5530.778768849362;5534.944650553443;5545.807651354978 12:33:31 INFO - PROCESS | 10769 | |5;yui.html;584.8040906296391;612.1032687113378;621.1366200980636;649.9480041596672;674.4065222604107;14196.148231106115;14809.629759256024;15093.547193584183;15673.921630391833;15769.290381932826;13496.93251533741;13607.387667554958;13614.795778063337;13639.249841258727;13654.726905461885;644.5971267957526;782.3154739602847;793.8848866914309;804.7424824056275;809.1544336168718;796.7808852565562;800.8638531449668;803.2168635580292;805.5207151744703;805.569020573993;825.7646570727314;826.4917075998247;826.6238861318086;827.1645637905698;827.5613924619931;539.8731298144933;552.1441765263825;552.2020680117232;609.7103875659049;616.8026231605888;455.86551967169765;456.45681638849993;456.49329244538535;456.6324109092179;542.9791991056827;15007.474738384213;15225.847741522553;15247.61880952974;15249.923750381176;15252.542423727306;14690.26548672562;15095.924520377328;15225.771613425808;15304.387824487007;15340.463083792125;11998.280103193749;12050.899691818255;12078.69803254917;12290.446929888176;12292.20100693461;3828.2343531293573;3869.419587061935;3960.722749407543;4033.4151548025666;4034.769395334422;68541.65729171323;68910.3108968909;69410.65294673495;69745.3025469749;69769;10547.84178237327;10913.781724365468;11003.779924401468;11081.058110060736;11133.888661113448;23817.880910595337;23849.165279215144;23860.284191474282;23882.641760373608;23897;8330.458520196167;8430.199131082538;8461.984561852494;8666.263367613823;8824.02935677075;4620.19146649335;4787.353707249476;4799.9760001199775;4833.226683730586;4974.030064137459;3643.9635603644156;3859.0931131184147;3863.884083477444;3896.2597106549665;3911.1395492991496;654.7479220500046;661.9669016549153;676.5805200775452;680.1667956753037;687.4294335701356;637.171676820132;657.4608919850242;662.1037428218299;679.9218089919723;682.9009793579903;9616.855747163798;9782.902170978341;9868.605255789831;9970.551325190383;10037.598496060222;589.7198830555452;637.7959053102962;660.5673283998989;663.8008597420754;665.5441022899232;4669.906601867943;4700.55344742249;4732.787024583833;4738.147133515931;4745.264484004984;130445.34777326243;130498;131600;132222;135363;110646;111255.44372278087;111991.4400428009;113631;115927;60651.69674151601;60705;86441.56779216064;95644.0435595649;97339.5962322986;8333.6666533338;8461.915380846112;8838;8967.282617390463;9062.682806101755;49583.75208123936;56663.15005274842;57337.713311433174;58254;59189.112163318445;52386.57833211176;65410.672946634964;69644.6517767408;75499.62250188933;77416.51625676746;11343.262687925258;11492.425378731197;11492.770144597229;11513.884861151617;12417.31704756247;14184.290785460893;14705.264736762905;14886.734627556345;15170.089794612359;15182.164980926154;13279;13295.601131966056;13418.792308692264;13482.393292302066;13692.315384230948;13312.655025177097;13545.729085418434;13565.864341356855;13632.318384080954;14091.577252682437;13082.018848586204;13400.865991339962;13491.73016539644;13517.526886558922;13978.161310321413;10494.422806745702;10800.459977001276;11212.159088068265;11226.21416500837;11472.541098355972;11321.150913681342;11458.457267499438;11809.23239989398;11851.288922664668;12033 12:33:31 INFO - PROCESS | 10769 | __end_tp_report 12:33:31 INFO - PROCESS | 10769 | __start_cc_report 12:33:31 INFO - PROCESS | 10769 | _x_x_mozilla_cycle_collect,784 12:33:31 INFO - PROCESS | 10769 | __end_cc_report 12:33:31 INFO - PROCESS | 10769 | __startTimestamp1466192011434__endTimestamp 12:33:31 INFO - PROCESS | 10769 | 12:33:31 INFO - PROCESS | 10769 | ------- Summary: start ------- 12:33:31 INFO - PROCESS | 10769 | Number of tests: 6 12:33:31 INFO - PROCESS | 10769 | 12:33:31 INFO - PROCESS | 10769 | [#0] dojo.html Cycles:165 Average:5317.69 Median:5495.18 stddev:599.35 (10.9%) stddev-sans-first:575.44 12:33:31 INFO - PROCESS | 10769 | Values: 3102.3 3102.8 3129.0 3142.0 3162.5 5217.6 5264.2 5286.2 5431.0 5465.8 5350.9 5366.8 5369.9 5416.6 5445.3 4807.4 4866.4 4893.9 4911.1 5028.1 4974.6 4984.0 5015.2 5052.3 5061.0 4766.1 4824.0 4843.3 4886.9 4923.6 4869.3 4876.0 4881.5 4900.0 4984.9 4864.1 4898.7 4901.3 4916.1 4937.8 5229.3 5287.7 5323.0 5327.9 5391.2 5719.2 5721.1 5725.2 5768.5 5778.0 5775.9 5808.7 5809.5 5826.3 5830.1 5244.6 5298.8 5345.3 5361.2 5373.6 5921.5 5928.1 5931.6 5933.4 5935.7 5404.2 5661.3 5671.1 5676.9 5679.9 5626.8 5718.3 5718.5 5737.4 5739.7 5665.6 5683.5 5686.7 5696.2 5724.4 5559.7 5620.6 5738.5 5743.8 5746.2 4348.5 4363.3 4372.2 4415.0 4417.2 3887.6 3900.7 3906.0 3916.7 3942.5 5274.2 5284.4 5369.6 5414.2 5444.2 5717.1 5791.9 5808.0 5815.5 5831.3 5350.2 5417.2 5429.4 5429.9 5432.6 4674.9 4747.6 4768.1 4809.4 4845.5 5902.5 5902.6 5908.2 5923.5 5947.8 5764.7 5787.7 5796.7 5800.4 5804.8 5696.5 5758.8 5765.2 5810.9 5863.3 5620.5 5621.4 5624.9 5629.1 5631.9 5748.5 5772.2 5781.3 5798.4 5801.1 5481.5 5536.4 5555.5 5583.7 5610.5 5582.2 5582.8 5585.8 5592.9 5594.2 5344.7 5458.8 5506.4 5523.5 5556.7 5539.6 5574.0 5586.1 5678.1 5681.6 5484.5 5489.0 5494.4 5495.2 5496.8 12:33:31 INFO - PROCESS | 10769 | 12:33:31 INFO - PROCESS | 10769 | [#1] ext.html Cycles:180 Average:58439.22 Median:41747.19 stddev:113484.47 (271.8%) stddev-sans-first:113719.72 12:33:31 INFO - PROCESS | 10769 | Values: 598.1 599.7 613.6 622.0 623.1 30720.0 39613.4 40570.4 40806.6 43510.6 41591.8 41957.2 42160.2 42187.6 42643.4 8971.6 9100.9 9106.9 9115.5 9117.9 8643.3 8725.8 8748.0 8749.1 8754.1 8837.5 8865.8 8874.7 8897.5 8899.7 8702.7 8750.7 8756.3 8772.3 8817.5 8782.0 8804.4 8817.1 8818.2 8850.4 38714.4 39693.4 40031.2 40201.0 40221.2 2991.2 3157.7 3202.2 3208.4 3217.3 32482.8 32873.2 33086.5 33235.2 34309.8 4319.3 4408.3 4451.4 4503.2 4671.7 329488.0 331304.0 331313.0 331894.3 334164.0 56094.0 56109.7 56132.4 56303.7 56440.2 53608.2 57273.4 59081.4 59101.0 66268.7 13941.9 13943.4 13967.6 13993.0 13997.7 10849.4 10931.9 11061.3 11064.9 11120.8 14953.4 16314.9 16617.2 16775.2 16910.7 5191.4 5319.3 5340.1 5348.1 5425.1 847.4 885.2 933.7 964.0 1001.6 31690.4 32208.4 32402.8 32450.0 32571.1 1062.1 1064.6 1066.1 1129.3 1141.7 15521.4 15680.5 15902.0 15914.6 16181.7 477949.0 484774.0 486195.0 488080.0 489185.0 57238.7 57450.0 57495.0 57499.4 57602.4 1106.6 1146.5 1154.3 1159.9 1165.6 29834.4 31116.0 31161.4 31206.4 31587.4 50170.2 50646.7 50679.7 50681.0 50852.5 451499.0 453131.0 453276.0 454424.0 455639.0 41222.6 42434.0 43257.1 43410.6 43427.0 36121.8 41223.6 46405.8 47818.8 51835.7 38659.4 40715.6 41458.9 41696.0 42330.4 39377.4 39685.2 40449.4 40775.0 41656.0 40819.2 40927.8 41237.8 41798.4 42117.6 34531.8 36299.0 36645.3 36661.8 36815.4 27736.3 28076.0 28285.4 28338.1 28365.0 12:33:31 INFO - PROCESS | 10769 | 12:33:31 INFO - PROCESS | 10769 | [#2] jquery.html Cycles:180 Average:27508.30 Median:21153.34 stddev:75249.93 (355.7%) stddev-sans-first:75433.45 12:33:31 INFO - PROCESS | 10769 | Values: 378.3 383.8 390.1 394.0 400.1 17777.6 19601.2 19765.0 20122.2 20194.7 16041.3 16237.9 16505.3 16514.3 16763.1 5489.5 5645.4 5692.8 5703.8 5740.9 5466.2 5762.2 5791.9 5800.6 5831.5 5636.6 5807.9 5818.0 5855.1 5881.7 5839.9 5913.4 5933.5 5960.8 5969.8 5671.9 5737.6 5758.1 5839.6 5843.6 13630.9 13793.2 13924.9 14330.5 22980.2 2351.6 2446.6 2458.3 2478.5 2887.9 9495.7 9661.7 10504.8 10514.2 10520.6 1896.1 1971.4 1987.7 1989.7 2079.5 76803.2 79251.6 80226.6 80427.0 81992.8 10614.7 10701.7 10859.9 11031.2 11035.3 15092.7 15101.3 15112.5 15180.5 15223.8 7134.3 7257.9 7465.3 7778.5 7977.0 6724.4 6738.6 7034.2 7241.3 7248.9 4566.5 4618.6 4680.9 4725.6 4839.6 1847.4 1857.4 1883.0 1895.4 1916.9 771.1 845.2 921.0 933.6 966.0 18592.2 18667.8 18675.4 19464.3 19466.9 874.3 890.9 893.5 899.4 938.9 10171.3 10344.8 10412.6 10426.8 10477.2 450645.0 450825.0 451837.0 451928.0 477461.0 62171.0 77990.0 79927.6 87167.6 88884.0 961.2 964.9 978.6 982.3 983.9 17064.3 17169.7 17184.7 17325.9 17628.7 39750.4 41906.6 41934.0 42364.8 42984.0 53688.2 55057.7 62195.0 62351.0 63264.4 7771.8 7959.3 8784.4 8843.8 8880.0 12278.4 13363.1 13627.5 13701.0 13960.6 11993.3 12059.1 12324.9 12502.1 12692.9 11272.9 12167.8 12184.9 12266.3 12308.4 12445.6 12506.0 12765.6 12819.6 12867.2 8708.0 8811.5 9215.6 11768.2 12514.9 12081.2 12268.4 12600.4 12768.9 13347.7 12:33:31 INFO - PROCESS | 10769 | 12:33:31 INFO - PROCESS | 10769 | [#3] mootools.html Cycles:180 Average:5881.84 Median:4829.17 stddev:3436.75 (71.2%) stddev-sans-first:3428.08 12:33:31 INFO - PROCESS | 10769 | Values: 1161.6 1397.5 1409.4 1526.5 1698.9 8209.8 8569.2 8579.9 8837.2 8884.4 8318.9 8747.7 8755.5 8779.4 8788.8 1957.5 2208.9 2272.4 2274.8 2303.9 2336.5 2347.8 2348.1 2350.7 2351.3 2243.8 2256.2 2270.1 2273.6 2275.6 1951.7 2224.4 2234.6 2286.6 2291.7 2253.4 2268.8 2277.4 2285.7 2294.9 9043.4 9045.6 9056.2 9084.5 9128.8 5061.6 5210.7 5218.4 5219.8 5222.8 3199.4 3372.4 3386.9 3446.7 3470.9 1098.1 1106.9 1134.1 1146.4 1148.0 12624.9 12635.9 12685.1 12698.2 12700.1 4697.4 4767.9 4834.3 4851.7 4868.6 10612.9 10661.4 10666.6 10669.4 10682.1 5221.3 5226.9 5228.7 5234.8 5235.1 4091.5 4678.3 4817.5 4824.0 4902.2 3864.6 3918.8 3950.4 4016.8 4079.4 1236.5 1242.1 1246.7 1251.3 1264.9 863.5 866.6 868.7 887.8 897.4 6191.4 6241.2 6318.6 6553.6 6586.6 867.7 891.5 909.6 946.9 971.4 3824.9 3939.9 3976.5 4046.3 4053.4 11011.4 11075.1 11102.3 11107.3 11178.3 11497.9 11598.2 11606.5 11657.8 11666.2 8157.8 8201.2 8214.5 8323.3 8349.2 5822.3 5848.8 5946.3 5991.2 6022.6 10450.9 10562.9 10601.9 10609.9 10609.9 10367.4 10650.8 10879.5 10889.9 11008.9 6744.8 7242.6 7432.3 7473.3 7590.5 8447.9 8473.0 8500.2 8509.6 8592.7 7738.9 7799.7 7813.8 8106.8 8114.0 7665.0 7762.1 7820.4 7821.8 7915.7 7340.7 7414.4 7497.5 7503.1 7514.8 5067.2 5104.7 5135.6 5159.0 5202.3 5169.5 5233.2 5280.5 5321.1 5413.2 12:33:31 INFO - PROCESS | 10769 | 12:33:31 INFO - PROCESS | 10769 | [#4] prototype.html Cycles:180 Average:4629.52 Median:5205.45 stddev:1354.37 (26.0%) stddev-sans-first:1318.81 12:33:31 INFO - PROCESS | 10769 | Values: 310.5 321.4 324.3 327.5 329.7 5355.5 5397.1 5405.6 5446.5 5448.4 5191.5 5294.0 5367.8 5371.0 5373.7 3999.2 4147.6 4154.1 4160.3 4180.7 4160.7 4164.4 4172.5 4184.5 4184.7 4084.4 4106.9 4109.5 4134.5 4144.2 3946.2 3968.8 4060.9 4130.8 4131.6 3613.2 3613.4 3646.6 3658.8 3671.9 5078.7 5092.3 5107.4 5152.7 5153.7 4460.3 4554.3 4750.4 4756.3 4778.9 5494.6 5494.7 5507.2 5544.1 5562.2 4036.0 4053.5 4069.1 4072.3 4075.5 5552.7 5651.5 5692.5 5712.9 5743.9 4059.0 4061.9 4100.7 4114.4 4122.8 4168.2 4170.9 4172.7 4229.6 4233.6 4472.9 4719.5 4743.2 4760.1 4760.5 5571.4 5583.8 5602.2 5606.6 5642.4 1415.5 1441.6 1441.8 1445.9 1447.1 885.8 910.9 927.8 930.9 931.3 4801.4 4816.0 4847.3 4868.9 4870.5 5088.2 5119.8 5130.2 5140.7 5148.8 4564.7 4825.0 4829.5 4835.8 4875.3 2934.0 2978.8 3016.9 3019.0 3027.4 5826.6 5851.8 5870.3 5883.6 5899.3 5219.5 5606.9 5757.9 5812.9 5854.3 5807.6 5813.8 5820.5 5852.1 5885.4 5541.1 5683.5 5701.3 5705.5 5721.5 5558.3 5641.7 5646.3 5662.0 5672.5 5766.7 5794.9 5854.3 5872.3 5875.7 3853.0 4045.8 4052.4 4067.8 4071.2 5647.9 5662.2 5680.4 5687.7 5697.6 5559.6 5573.1 5577.6 5595.9 5631.7 5413.1 5495.7 5561.2 5571.9 5585.9 5363.3 5408.8 5454.7 5494.9 5497.3 5393.8 5536.4 5551.2 5570.2 5596.4 5478.6 5509.9 5530.8 5534.9 5545.8 12:33:31 INFO - PROCESS | 10769 | 12:33:31 INFO - PROCESS | 10769 | [#5] yui.html Cycles:180 Average:21240.48 Median:2245.32 stddev:31917.20 (1421.5%) stddev-sans-first:31969.05 12:33:31 INFO - PROCESS | 10769 | Values: 584.8 612.1 621.1 649.9 674.4 14196.1 14809.6 15093.5 15673.9 15769.3 13496.9 13607.4 13614.8 13639.2 13654.7 644.6 782.3 793.9 804.7 809.2 796.8 800.9 803.2 805.5 805.6 825.8 826.5 826.6 827.2 827.6 539.9 552.1 552.2 609.7 616.8 455.9 456.5 456.5 456.6 543.0 15007.5 15225.8 15247.6 15249.9 15252.5 14690.3 15095.9 15225.8 15304.4 15340.5 11998.3 12050.9 12078.7 12290.4 12292.2 3828.2 3869.4 3960.7 4033.4 4034.8 68541.7 68910.3 69410.7 69745.3 69769.0 10547.8 10913.8 11003.8 11081.1 11133.9 23817.9 23849.2 23860.3 23882.6 23897.0 8330.5 8430.2 8462.0 8666.3 8824.0 4620.2 4787.4 4800.0 4833.2 4974.0 3644.0 3859.1 3863.9 3896.3 3911.1 654.7 662.0 676.6 680.2 687.4 637.2 657.5 662.1 679.9 682.9 9616.9 9782.9 9868.6 9970.6 10037.6 589.7 637.8 660.6 663.8 665.5 4669.9 4700.6 4732.8 4738.1 4745.3 130445.3 130498.0 131600.0 132222.0 135363.0 110646.0 111255.4 111991.4 113631.0 115927.0 60651.7 60705.0 86441.6 95644.0 97339.6 8333.7 8461.9 8838.0 8967.3 9062.7 49583.8 56663.2 57337.7 58254.0 59189.1 52386.6 65410.7 69644.7 75499.6 77416.5 11343.3 11492.4 11492.8 11513.9 12417.3 14184.3 14705.3 14886.7 15170.1 15182.2 13279.0 13295.6 13418.8 13482.4 13692.3 13312.7 13545.7 13565.9 13632.3 14091.6 13082.0 13400.9 13491.7 13517.5 13978.2 10494.4 10800.5 11212.2 11226.2 11472.5 11321.2 11458.5 11809.2 11851.3 12033.0 12:33:31 INFO - PROCESS | 10769 | -------- Summary: end -------- 12:33:31 INFO - PROCESS | 10769 | 12:33:32 INFO - TEST-INFO | 10769: exit 0 12:33:32 INFO - TEST-OK | dromaeo_css | took 1113676ms 12:33:32 INFO - TEST-START | kraken 12:33:32 INFO - operating with platform_type : linux_ 12:33:32 INFO - Initialising browser for kraken test... 12:33:32 INFO - TEST-INFO | started process 10955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoKkxKv/profile http://localhost:48370/getInfo.html) 12:33:36 INFO - PROCESS | 10955 | __metrics Screen width/height:1600/1200 12:33:36 INFO - PROCESS | 10955 | colorDepth:24 12:33:36 INFO - PROCESS | 10955 | Browser inner width/height: 1024/697 12:33:36 INFO - PROCESS | 10955 | __metrics 12:33:37 INFO - PROCESS | 10955 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:33:37 INFO - TEST-INFO | 10955: exit 0 12:33:37 INFO - Browser initialized. 12:33:37 INFO - Running cycle 1/1 for kraken test... 12:33:37 INFO - TEST-INFO | started process 11035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoKkxKv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:49 INFO - PROCESS | 11035 | RSS: Main: 173838336 12:33:49 INFO - PROCESS | 11035 | 12:33:52 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48370/tests/kraken/driver.html?testName=audio-beat-detection) 12:33:53 INFO - PROCESS | 11035 | RSS: Main: 232300544 12:33:53 INFO - PROCESS | 11035 | 12:33:55 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48370/tests/kraken/driver.html?testName=audio-dft) 12:33:56 INFO - PROCESS | 11035 | RSS: Main: 221085696 12:33:56 INFO - PROCESS | 11035 | 12:33:59 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48370/tests/kraken/driver.html?testName=audio-fft) 12:34:00 INFO - PROCESS | 11035 | RSS: Main: 286998528 12:34:00 INFO - PROCESS | 11035 | 12:34:02 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48370/tests/kraken/driver.html?testName=audio-oscillator) 12:34:02 INFO - PROCESS | 11035 | RSS: Main: 198340608 12:34:02 INFO - PROCESS | 11035 | 12:34:05 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48370/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:34:05 INFO - PROCESS | 11035 | RSS: Main: 202964992 12:34:05 INFO - PROCESS | 11035 | 12:34:08 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48370/tests/kraken/driver.html?testName=imaging-darkroom) 12:34:09 INFO - PROCESS | 11035 | RSS: Main: 236519424 12:34:09 INFO - PROCESS | 11035 | 12:34:12 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48370/tests/kraken/driver.html?testName=imaging-desaturate) 12:34:13 INFO - PROCESS | 11035 | RSS: Main: 238587904 12:34:13 INFO - PROCESS | 11035 | 12:34:16 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48370/tests/kraken/driver.html?testName=json-parse-financial) 12:34:16 INFO - PROCESS | 11035 | RSS: Main: 238346240 12:34:16 INFO - PROCESS | 11035 | 12:34:18 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48370/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:34:18 INFO - PROCESS | 11035 | RSS: Main: 228257792 12:34:18 INFO - PROCESS | 11035 | 12:34:20 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:34:21 INFO - PROCESS | 11035 | RSS: Main: 229724160 12:34:21 INFO - PROCESS | 11035 | 12:34:23 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:34:23 INFO - PROCESS | 11035 | RSS: Main: 238202880 12:34:23 INFO - PROCESS | 11035 | 12:34:26 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:34:27 INFO - PROCESS | 11035 | RSS: Main: 241549312 12:34:27 INFO - PROCESS | 11035 | 12:34:29 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:34:30 INFO - PROCESS | 11035 | RSS: Main: 243503104 12:34:30 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48370/tests/kraken/driver.html?testName=ai-astar) 12:34:32 INFO - PROCESS | 11035 | RSS: Main: 286912512 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | __start_tp_report 12:34:32 INFO - PROCESS | 11035 | _x_x_mozilla_page_load 12:34:32 INFO - PROCESS | 11035 | _x_x_mozilla_page_load_details 12:34:32 INFO - PROCESS | 11035 | |i|pagename|runs| 12:34:32 INFO - PROCESS | 11035 | |0;ai-astar;110;105;112;109;110;110;111;111;110;109 12:34:32 INFO - PROCESS | 11035 | |1;audio-beat-detection;151;125;126;179;126;139;160;128;190;137 12:34:32 INFO - PROCESS | 11035 | |2;audio-dft;161;161;161;162;163;159;161;162;161;161 12:34:32 INFO - PROCESS | 11035 | |3;audio-fft;75;74;75;137;76;75;74;74;98;75 12:34:32 INFO - PROCESS | 11035 | |4;audio-oscillator;85;85;112;85;85;85;117;84;87;123 12:34:32 INFO - PROCESS | 11035 | |5;imaging-gaussian-blur;116;116;116;117;118;117;117;117;117;116 12:34:32 INFO - PROCESS | 11035 | |6;imaging-darkroom;146;146;146;146;146;145;146;145;145;145 12:34:32 INFO - PROCESS | 11035 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;94 12:34:32 INFO - PROCESS | 11035 | |8;json-parse-financial;54;52;53;53;53;54;53;53;52;53 12:34:32 INFO - PROCESS | 11035 | |9;json-stringify-tinderbox;61;61;61;61;62;62;61;62;61;62 12:34:32 INFO - PROCESS | 11035 | |10;stanford-crypto-aes;79;79;79;79;80;82;83;82;111;84 12:34:32 INFO - PROCESS | 11035 | |11;stanford-crypto-ccm;121;121;126;128;121;122;127;122;139;126 12:34:32 INFO - PROCESS | 11035 | |12;stanford-crypto-pbkdf2;167;163;159;167;157;160;161;161;163;162 12:34:32 INFO - PROCESS | 11035 | |13;stanford-crypto-sha256-iterative;64;66;66;62;61;66;69;64;64;62 12:34:32 INFO - PROCESS | 11035 | __end_tp_report 12:34:32 INFO - PROCESS | 11035 | __start_cc_report 12:34:32 INFO - PROCESS | 11035 | _x_x_mozilla_cycle_collect,1626 12:34:32 INFO - PROCESS | 11035 | __end_cc_report 12:34:32 INFO - PROCESS | 11035 | __startTimestamp1466192072359__endTimestamp 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | ------- Summary: start ------- 12:34:32 INFO - PROCESS | 11035 | Number of tests: 14 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.89 (1.7%) stddev-sans-first:2.00 12:34:32 INFO - PROCESS | 11035 | Values: 110.0 105.0 112.0 109.0 110.0 110.0 111.0 111.0 110.0 109.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:145.00 stddev:23.43 (16.2%) stddev-sans-first:24.78 12:34:32 INFO - PROCESS | 11035 | Values: 151.0 125.0 126.0 179.0 126.0 139.0 160.0 128.0 190.0 137.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 12:34:32 INFO - PROCESS | 11035 | Values: 161.0 161.0 161.0 162.0 163.0 159.0 161.0 162.0 161.0 161.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.00 stddev:20.24 (27.0%) stddev-sans-first:21.25 12:34:32 INFO - PROCESS | 11035 | Values: 75.0 74.0 75.0 137.0 76.0 75.0 74.0 74.0 98.0 75.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:85.00 stddev:15.78 (18.6%) stddev-sans-first:16.34 12:34:32 INFO - PROCESS | 11035 | Values: 85.0 85.0 112.0 85.0 85.0 85.0 117.0 84.0 87.0 123.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 12:34:32 INFO - PROCESS | 11035 | Values: 116.0 116.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:34:32 INFO - PROCESS | 11035 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 12:34:32 INFO - PROCESS | 11035 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.60 12:34:32 INFO - PROCESS | 11035 | Values: 54.0 52.0 53.0 53.0 53.0 54.0 53.0 53.0 52.0 53.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 12:34:32 INFO - PROCESS | 11035 | Values: 61.0 61.0 61.0 61.0 62.0 62.0 61.0 62.0 61.0 62.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:81.00 stddev:9.74 (12.0%) stddev-sans-first:10.17 12:34:32 INFO - PROCESS | 11035 | Values: 79.0 79.0 79.0 79.0 80.0 82.0 83.0 82.0 111.0 84.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:126.00 stddev:5.54 (4.4%) stddev-sans-first:5.65 12:34:32 INFO - PROCESS | 11035 | Values: 121.0 121.0 126.0 128.0 121.0 122.0 127.0 122.0 139.0 126.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.50 stddev:3.20 (2.0%) stddev-sans-first:2.83 12:34:32 INFO - PROCESS | 11035 | Values: 167.0 163.0 159.0 167.0 157.0 160.0 161.0 161.0 163.0 162.0 12:34:32 INFO - PROCESS | 11035 | 12:34:32 INFO - PROCESS | 11035 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:2.41 (3.7%) stddev-sans-first:2.55 12:34:32 INFO - PROCESS | 11035 | Values: 64.0 66.0 66.0 62.0 61.0 66.0 69.0 64.0 64.0 62.0 12:34:32 INFO - PROCESS | 11035 | -------- Summary: end -------- 12:34:32 INFO - PROCESS | 11035 | 12:34:33 INFO - TEST-INFO | 11035: exit 0 12:34:33 INFO - TEST-OK | kraken | took 61162ms 12:34:33 INFO - SUITE-END | took 1174s 12:34:33 INFO - Completed test suite (00:19:35) 12:34:33 INFO - javascript benchmark 12:34:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.301982054038, 3102.844857757112, 3128.984355078225, 3141.9528707069385, 3162.525621156826, 5217.582593392529, 5264.184051472028, 5286.180642000491, 5431.0, 5465.781368745255, 5350.866228344284, 5366.758495867685, 5369.865753356168, 5416.620836541444, 5445.264889239951, 4807.399075115611, 4866.440359358684, 4893.853184404474, 4911.115999120157, 5028.094942910293, 4974.626902982272, 4983.975080124595, 5015.172496538085, 5052.26742122392, 5060.974695126519, 4766.070616229837, 4823.951760482385, 4843.273508973647, 4886.902261954741, 4923.606111511071, 4869.269609558559, 4876.049170411771, 4881.511848815126, 4900.044491324194, 4984.87537811554, 4864.100141473803, 4898.730569818658, 4901.289313049588, 4916.139675556763, 4937.8271760488215, 5229.267902493654, 5287.656302340336, 5323.0, 5327.893442131174, 5391.218273350342, 5719.227904232917, 5721.084626459747, 5725.169850371714, 5768.538516918678, 5778.0466223073145, 5775.942240577582, 5808.738606762706, 5809.477147056785, 5826.300843898759, 5830.067189249742, 5244.580433565306, 5298.761555730001, 5345.30511033567, 5361.249425080492, 5373.570114390839, 5921.496672782776, 5928.110783382527, 5931.555133364928, 5933.3769954154195, 5935.73289201987, 5404.162354835007, 5661.348944871393, 5671.064274394678, 5676.858078547987, 5679.943200567942, 5626.774929002876, 5718.342390625131, 5718.542516598662, 5737.426257374229, 5739.655620662774, 5665.6034077614995, 5683.516901063456, 5686.744096515667, 5696.23100881384, 5724.427557244326, 5559.666420014732, 5620.634658747168, 5738.540916726652, 5743.798967036134, 5746.224259724967, 4348.499922508952, 4363.258246098171, 4372.23485889968, 4415.0, 4417.204903117469, 3887.5918028607157, 3900.7074469414906, 3906.0430194602504, 3916.706247031484, 3942.526896772348, 5274.182501712241, 5284.445133261029, 5369.5972802040005, 5414.18787181918, 5444.156155795858, 5717.142428635738, 5791.913121303184, 5808.041673123972, 5815.476607105381, 5831.300243970751, 5350.170723537858, 5417.241586177859, 5429.375621803464, 5429.945700542944, 5432.619716619799, 4674.929876051862, 4747.620190384761, 4768.117898188846, 4809.374781278481, 4845.53967373099, 5902.468777809931, 5902.61632993854, 5908.172855800191, 5923.49650279731, 5947.762089516457, 5764.740586673526, 5787.7395517200985, 5796.739146738491, 5800.39095894925, 5804.796832110856, 5696.515796157373, 5758.798442054508, 5765.221695071279, 5810.883782324246, 5863.296404431496, 5620.522255608319, 5621.353544342453, 5624.915626265528, 5629.127485239795, 5631.943680563142, 5748.511376533042, 5772.249607550992, 5781.277340332458, 5798.420157984337, 5801.129830525455, 5481.506664400223, 5536.446355364431, 5555.50000499957, 5583.748731307182, 5610.4670056344585, 5582.246396736388, 5582.8325150245555, 5585.804496842591, 5592.86017849557, 5594.188842617879, 5344.652597581145, 5458.808941687022, 5506.449355064461, 5523.475269849358, 5556.72216389187, 5539.584531160099, 5573.996680597531, 5586.13414920688, 5678.0915053591225, 5681.573881958952, 5484.478974497416, 5489.0, 5494.423085575957, 5495.175723641486, 5496.80761173357], "value": 5277.66425877245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.0998597111346, 599.7331187621508, 613.5950272819938, 622.0389498225242, 623.1431781300712, 30720.0, 39613.405798913, 40570.39144412836, 40806.59193408065, 43510.564894351046, 41591.79204103975, 41957.160856782844, 42160.156796864045, 42187.57812421875, 42643.36034959478, 8971.551422428885, 9100.908990910073, 9106.86339704905, 9115.453072815651, 9117.863232051524, 8643.30853531716, 8725.825483490358, 8748.0, 8749.081346458626, 8754.080821513744, 8837.513936733478, 8865.778355541099, 8874.733757987238, 8897.466152030867, 8899.73300800977, 8702.738917832476, 8750.737477875675, 8756.299496040301, 8772.254358379545, 8817.515036672981, 8781.956090219572, 8804.427712198687, 8817.118288171196, 8818.162274583969, 8850.424722393089, 38714.419283710486, 39693.40459893104, 40031.199376012315, 40201.0, 40221.195576088605, 2991.237234505187, 3157.700018498239, 3202.247471844115, 3208.3904058229095, 3217.260030193069, 32482.837585812154, 32873.17817054593, 33086.50370244448, 33235.169120771934, 34309.82845085759, 4319.265724826787, 4408.338749187616, 4451.354553589711, 4503.234450143484, 4671.743054132022, 329488.0, 331304.0, 331313.0, 331894.3405282982, 334164.0, 56094.0, 56109.71945140248, 56132.438675613535, 56303.71848140733, 56440.15339769907, 53608.19587706187, 57273.427265727645, 59081.40918590759, 59101.0, 66268.6686566564, 13941.930290348686, 13943.372548235353, 13967.580972570839, 13993.0, 13997.650058748613, 10849.403282819363, 10931.890681093088, 11061.281016733887, 11064.944675276573, 11120.833187502194, 14953.40186392554, 16314.87906572138, 16617.169141542876, 16775.2451139699, 16910.66178676444, 5191.402988656278, 5319.308489896289, 5340.092184328673, 5348.144296912553, 5425.131978883439, 847.3602430165186, 885.2295409181637, 933.7198840347869, 964.0, 1001.5843424978552, 31690.36619267648, 32208.35583288321, 32402.83798581039, 32450.0, 32571.0711058591, 1062.1449732965036, 1064.5848119233506, 1066.0778426660881, 1129.2885482146196, 1141.6974501756874, 15521.407554790314, 15680.529584112495, 15902.0, 15914.602134946488, 16181.676366472604, 477949.0, 484774.0, 486195.0, 488080.0, 489185.0, 57238.71380643154, 57450.0, 57495.0, 57499.42500575024, 57602.42397576055, 1106.623747925709, 1146.4726225936163, 1154.2843437068902, 1159.8956093951585, 1165.5687395663658, 29834.403311933205, 31116.0, 31161.37677246488, 31206.37587248197, 31587.36825263436, 50170.24744628907, 50646.74676626741, 50679.746601268234, 50681.0, 50852.49147508626, 451499.0, 453131.0, 453276.0, 454424.0, 455639.0, 41222.58777412187, 42434.0, 43257.13485730331, 43410.56589434065, 43427.0, 36121.819390903926, 41223.58776412318, 46405.76797116128, 47818.760906196636, 51835.74082129565, 38659.37808047325, 40715.59284407118, 41458.89243716855, 41696.0, 42330.36504452497, 39377.40933885937, 39685.206295873344, 40449.39325910055, 40775.0, 41656.0, 40819.18361632691, 40927.7953610242, 41237.79381103075, 41798.37302440405, 42117.57882421259, 34531.82734086414, 36299.0, 36645.26709465849, 36661.81669091638, 36815.44776828296, 27736.306592335353, 28076.0, 28285.434291313646, 28338.14985550437, 28365.0], "value": 19413.722166047202, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.2850412719958, 383.8445429601011, 390.1280637774575, 393.97439166454177, 400.0897957147489, 17777.555561110978, 19601.21595136193, 19765.0, 20122.19511219553, 20194.697079543817, 16041.278142483587, 16237.918810405932, 16505.33978640856, 16514.339426422957, 16763.078030708308, 5489.533389661883, 5645.435456454363, 5692.772289108451, 5703.771849126051, 5740.856478588048, 5466.234727138204, 5762.193292938992, 5791.942080579182, 5800.564957628174, 5831.533477321804, 5636.633618814764, 5807.912881306784, 5818.040023396155, 5855.063189889618, 5881.705914704269, 5839.9124013139835, 5913.408659134052, 5933.525317974551, 5960.821175364746, 5969.761209551612, 5671.943280567183, 5737.627054241502, 5758.078707406795, 5839.562032847553, 5843.620164689324, 13630.93184534071, 13793.172409655352, 13924.93037534816, 14330.49843255481, 22980.19569315066, 2351.6354964980455, 2446.6330050492393, 2458.2870967419426, 2478.504299140161, 2887.9314653578313, 9495.66765163223, 9661.71014869555, 10504.842427363596, 10514.158867290598, 10520.579176832918, 1896.1372575478124, 1971.3790156100927, 1987.7117817916467, 1989.651810933081, 2079.5321052763156, 76803.23196768017, 79251.6037419815, 80226.59886700587, 80427.0, 81992.77010844841, 10614.726232852106, 10701.732456688645, 10859.891401086046, 11031.22781405294, 11035.337879727242, 15092.698146037237, 15101.3204405802, 15112.546623601309, 15180.544583662508, 15223.847761522464, 7134.286571342825, 7257.8911316330295, 7465.328120469184, 7778.455508114378, 7976.960115199503, 6724.428423583952, 6738.561993470409, 7034.19106802714, 7241.348278654947, 7248.9275107249305, 4566.543345665407, 4618.630509559227, 4680.906381872412, 4725.64557658177, 4839.637027222902, 1847.3811273223353, 1857.4149143019906, 1882.9717554236697, 1895.4029480713532, 1916.9424917252227, 771.0901136658797, 845.2223953962247, 921.0, 933.6358820060182, 966.0484422843634, 18592.163352649164, 18667.81332186688, 18675.43973680792, 19464.31874884372, 19466.90266548658, 874.3398733955822, 890.8797312362748, 893.4728510179026, 899.3884158772098, 938.863864739609, 10171.288009839389, 10344.793104137874, 10412.635557755442, 10426.791464170674, 10477.161827053817, 450645.0, 450825.0, 451837.0, 451928.0, 477461.0, 62171.0, 77990.0, 79927.60036199898, 87167.56416217878, 88884.0, 961.2262128986233, 964.8793900762405, 978.554757585297, 982.29274922056, 983.8573406856109, 17064.31742730277, 17169.742453862953, 17184.65630687354, 17325.913370433067, 17628.73556896673, 39750.403743944444, 41906.58093419149, 41934.0, 42364.78817605892, 42984.0, 53688.19467708065, 55057.72471137779, 62195.0, 62351.0, 63264.36735632769, 7771.805704857424, 7959.323457506177, 8784.429012114448, 8843.778905527155, 8879.955600221958, 12278.386080696107, 13363.131396459588, 13627.454901804213, 13701.0, 13960.581182564132, 11993.34036627959, 12059.095567832623, 12324.876751232372, 12502.062345323955, 12692.936535317263, 11272.943635281772, 12167.81748273759, 12184.878151218729, 12266.32535210572, 12308.446119924445, 12445.564405245774, 12506.0, 12765.553205637758, 12819.615411537668, 12867.163634363736, 8708.04211536743, 8811.471311721318, 9215.585298661443, 11768.176227664324, 12514.87485125137, 12081.214721043105, 12268.38658067111, 12600.432980515716, 12768.87231127714, 13347.66630834237], "value": 9029.269864332824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1161.5702190189631, 1397.468961794518, 1409.3798728559434, 1526.5496678479847, 1698.8555972742317, 8209.794755131117, 8569.228769410753, 8579.871301930476, 8837.248833849131, 8884.378093533454, 8318.875216871736, 8747.731578921053, 8755.518446485441, 8779.429337093101, 8788.78028049299, 1957.5399781051442, 2208.8895555222257, 2272.3750968483673, 2274.8407611467205, 2303.8617682938993, 2336.4626135988733, 2347.8239132065164, 2348.0842471436154, 2350.670906073151, 2351.3063646224405, 2243.7644047375034, 2256.1877724019423, 2270.14869423966, 2273.5680220758086, 2275.567642147995, 1951.6584597695346, 2224.3882932193615, 2234.6089434349005, 2286.634138537843, 2291.667708182304, 2253.4253765289745, 2268.7504374518953, 2277.4078739527677, 2285.6685780561725, 2294.862308261493, 9043.412178208395, 9045.643153526958, 9056.230220431271, 9084.50035248061, 9128.81742365149, 5061.5950723942, 5210.687358758449, 5218.399884013311, 5219.817306394258, 5222.817201397971, 3199.42410366134, 3372.37611041958, 3386.86452541898, 3446.655334466533, 3470.8958731238104, 1098.1215027977667, 1106.9446527673583, 1134.0813940708053, 1146.3809542846852, 1148.0, 12624.936875315656, 12635.87364126356, 12685.112042157052, 12698.174618649758, 12700.110992230548, 4697.425122323671, 4767.928481072787, 4834.299026641117, 4851.660383773173, 4868.586170175575, 10612.946935265274, 10661.413622250695, 10666.626668066581, 10669.413182274895, 10682.092022178047, 5221.321228240305, 5226.92159617606, 5228.738563071831, 5234.842954711365, 5235.0576896159055, 4091.5499295077516, 4678.298255261738, 4817.470078291385, 4824.035192961422, 4902.166631672624, 3864.613538646169, 3918.804059796999, 3950.4074388841905, 4016.758994460342, 4079.449274347925, 1236.4744983382207, 1242.0808601634906, 1246.731952630189, 1251.343044901434, 1264.943077561512, 863.5336918064176, 866.6230189867427, 868.700298397052, 887.8401887660154, 897.3808072430132, 6191.4118158774845, 6241.21984751906, 6318.589291696117, 6553.606783592904, 6586.6377349245295, 867.6659486097898, 891.4517571693492, 909.6060362053089, 946.8627049077845, 971.3880255439028, 3824.904377390532, 3939.9015024624614, 3976.4631774710624, 4046.291898917678, 4053.3717273822604, 11011.449427528592, 11075.11399088071, 11102.333859968428, 11107.278026928223, 11178.27341222818, 11497.942510287396, 11598.246114002732, 11606.477708503138, 11657.76684466306, 11666.241694289844, 8157.75526734199, 8201.179882011871, 8214.548199849065, 8323.292520135856, 8349.165083491724, 5822.3304320003745, 5848.824535263949, 5946.256717910262, 5991.1771024325835, 6022.5784195105925, 10450.895491045296, 10562.894371056498, 10601.946990265, 10609.89390106089, 10609.89390106089, 10367.429791361548, 10650.8402373966, 10879.456027198767, 10889.911008899047, 11008.889911100787, 6744.7976560703255, 7242.565446073252, 7432.293932076444, 7473.252674732484, 7590.468667193243, 8447.873281900653, 8473.0, 8500.192481714228, 8509.574521273787, 8592.65629374818, 7738.883916741366, 7799.688012479664, 7813.765587032398, 8106.83786324282, 8114.0, 7665.0, 7762.1073576537165, 7820.448680163076, 7821.765347039598, 7915.722949696733, 7340.743073992385, 7414.406847452299, 7497.512661676974, 7503.13713922884, 7514.812129696801, 5067.189249720027, 5104.744762761773, 5135.589152867687, 5159.0, 5202.297689811979, 5169.53474187325, 5233.188855727369, 5280.498352656491, 5321.068812957795, 5413.24214609947], "value": 4641.444269753049, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.47219726465, 321.43588003054634, 324.29627707873914, 327.5463483075939, 329.7296217101976, 5355.518003379695, 5397.082495975684, 5405.567554595633, 5446.482584154504, 5448.400675925645, 5191.454897235783, 5293.9735301323535, 5367.838964831051, 5371.033214021474, 5373.704446255454, 3999.180168065554, 4147.605977432147, 4154.086101057777, 4160.251154792136, 4180.749155050691, 4160.7087503874745, 4164.416981622575, 4172.499300083994, 4184.476940382452, 4184.686148538856, 4084.4281800547797, 4106.876793696194, 4109.506859176888, 4134.524529679095, 4144.171165766844, 3946.2304850554156, 3968.801559922021, 4060.8578699745367, 4130.772807495587, 4131.586841315874, 3613.2050948791225, 3613.385724426854, 3646.562412510489, 3658.8170591470584, 3671.9082022949374, 5078.720670363128, 5092.261622064817, 5107.361579802525, 5152.742362881879, 5153.660048387409, 4460.33095035744, 4554.316852472122, 4750.382450281476, 4756.311509414143, 4778.904421911542, 5494.587905907073, 5494.670319780826, 5507.155103040486, 5544.11705912923, 5562.16567514872, 4035.9708274390136, 4053.513578370585, 4069.104796944667, 4072.2669919414493, 4075.53131389891, 5552.666839989613, 5651.4913657770585, 5692.459216374438, 5712.914306285409, 5743.913841292342, 4059.04612416082, 4061.878143655695, 4100.65144462724, 4114.39538579954, 4122.752634841919, 4168.249715051259, 4170.854020109282, 4172.70791044624, 4229.640480559187, 4233.597808208216, 4472.888177795516, 4719.457262414866, 4743.169945259566, 4760.143174228603, 4760.452547957029, 5571.359293681197, 5583.832485025456, 5602.159676048625, 5606.579506536945, 5642.351129620064, 1415.5399495164113, 1441.5675297410735, 1441.7549016667192, 1445.9421623134956, 1447.0666420158939, 885.7519894429441, 910.899801021887, 927.8051609162152, 930.8510638297976, 931.2736065868634, 4801.351817504592, 4815.964567617979, 4847.345608342899, 4868.878278043077, 4870.488598697157, 5088.236764485283, 5119.795208191631, 5130.204818253177, 5140.691558506502, 5148.768305426265, 4564.748938808331, 4825.0, 4829.492903245179, 4835.758212089381, 4875.293082503017, 2933.9559906601417, 2978.836164011, 3016.9245768855517, 3019.0, 3027.4399236141385, 5826.592138550261, 5851.795187168429, 5870.3249126350165, 5883.646541383395, 5899.259718383088, 5219.451957544403, 5606.943930560642, 5757.85605359861, 5812.941870581325, 5854.268216472941, 5807.60617451817, 5813.8372325535065, 5820.476157145878, 5852.068817290284, 5885.352611212763, 5541.085720856014, 5683.460071293221, 5701.258836351248, 5705.545086003042, 5721.513671337816, 5558.333000040021, 5641.689707066151, 5646.2942132233475, 5661.971690141523, 5672.461116193955, 5766.654000759968, 5794.884102318014, 5854.297484301911, 5872.297033860304, 5875.706214689163, 3852.9614703852603, 4045.8381664734256, 4052.4326594277413, 4067.7966101694205, 4071.2086681859887, 5647.858803529944, 5662.150677398423, 5680.375158732453, 5687.744051517774, 5697.57268204878, 5559.63862348946, 5573.136163894603, 5577.609567330248, 5595.8880822384135, 5631.746571404215, 5413.052715774802, 5495.670259784426, 5561.221428999862, 5571.941331147231, 5585.860353491195, 5363.2759577456545, 5408.78364865401, 5454.699991500347, 5494.890102197854, 5497.285352904097, 5393.784248630168, 5536.363318218457, 5551.195076713934, 5570.220169176399, 5596.384397716167, 5478.561715062865, 5509.944900550943, 5530.778768849362, 5534.944650553443, 5545.807651354978], "value": 4195.685962358021, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.8040906296391, 612.1032687113378, 621.1366200980636, 649.9480041596672, 674.4065222604107, 14196.148231106115, 14809.629759256024, 15093.547193584183, 15673.921630391833, 15769.290381932826, 13496.93251533741, 13607.387667554958, 13614.795778063337, 13639.249841258727, 13654.726905461885, 644.5971267957526, 782.3154739602847, 793.8848866914309, 804.7424824056275, 809.1544336168718, 796.7808852565562, 800.8638531449668, 803.2168635580292, 805.5207151744703, 805.569020573993, 825.7646570727314, 826.4917075998247, 826.6238861318086, 827.1645637905698, 827.5613924619931, 539.8731298144933, 552.1441765263825, 552.2020680117232, 609.7103875659049, 616.8026231605888, 455.86551967169765, 456.45681638849993, 456.49329244538535, 456.6324109092179, 542.9791991056827, 15007.474738384213, 15225.847741522553, 15247.61880952974, 15249.923750381176, 15252.542423727306, 14690.26548672562, 15095.924520377328, 15225.771613425808, 15304.387824487007, 15340.463083792125, 11998.280103193749, 12050.899691818255, 12078.69803254917, 12290.446929888176, 12292.20100693461, 3828.2343531293573, 3869.419587061935, 3960.722749407543, 4033.4151548025666, 4034.769395334422, 68541.65729171323, 68910.3108968909, 69410.65294673495, 69745.3025469749, 69769.0, 10547.84178237327, 10913.781724365468, 11003.779924401468, 11081.058110060736, 11133.888661113448, 23817.880910595337, 23849.165279215144, 23860.284191474282, 23882.641760373608, 23897.0, 8330.458520196167, 8430.199131082538, 8461.984561852494, 8666.263367613823, 8824.02935677075, 4620.19146649335, 4787.353707249476, 4799.9760001199775, 4833.226683730586, 4974.030064137459, 3643.9635603644156, 3859.0931131184147, 3863.884083477444, 3896.2597106549665, 3911.1395492991496, 654.7479220500046, 661.9669016549153, 676.5805200775452, 680.1667956753037, 687.4294335701356, 637.171676820132, 657.4608919850242, 662.1037428218299, 679.9218089919723, 682.9009793579903, 9616.855747163798, 9782.902170978341, 9868.605255789831, 9970.551325190383, 10037.598496060222, 589.7198830555452, 637.7959053102962, 660.5673283998989, 663.8008597420754, 665.5441022899232, 4669.906601867943, 4700.55344742249, 4732.787024583833, 4738.147133515931, 4745.264484004984, 130445.34777326243, 130498.0, 131600.0, 132222.0, 135363.0, 110646.0, 111255.44372278087, 111991.4400428009, 113631.0, 115927.0, 60651.69674151601, 60705.0, 86441.56779216064, 95644.0435595649, 97339.5962322986, 8333.6666533338, 8461.915380846112, 8838.0, 8967.282617390463, 9062.682806101755, 49583.75208123936, 56663.15005274842, 57337.713311433174, 58254.0, 59189.112163318445, 52386.57833211176, 65410.672946634964, 69644.6517767408, 75499.62250188933, 77416.51625676746, 11343.262687925258, 11492.425378731197, 11492.770144597229, 11513.884861151617, 12417.31704756247, 14184.290785460893, 14705.264736762905, 14886.734627556345, 15170.089794612359, 15182.164980926154, 13279.0, 13295.601131966056, 13418.792308692264, 13482.393292302066, 13692.315384230948, 13312.655025177097, 13545.729085418434, 13565.864341356855, 13632.318384080954, 14091.577252682437, 13082.018848586204, 13400.865991339962, 13491.73016539644, 13517.526886558922, 13978.161310321413, 10494.422806745702, 10800.459977001276, 11212.159088068265, 11226.21416500837, 11472.541098355972, 11321.150913681342, 11458.457267499438, 11809.23239989398, 11851.288922664668, 12033.0], "value": 7365.900615284186, "unit": "score"}], "name": "dromaeo_css", "value": 7142.027496572002, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 112.0, 109.0, 110.0, 110.0, 111.0, 111.0, 110.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 126.0, 179.0, 126.0, 139.0, 160.0, 128.0, 190.0, 137.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 163.0, 159.0, 161.0, 162.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 137.0, 76.0, 75.0, 74.0, 74.0, 98.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 112.0, 85.0, 85.0, 85.0, 117.0, 84.0, 87.0, 123.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 52.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 80.0, 82.0, 83.0, 82.0, 111.0, 84.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 126.0, 128.0, 121.0, 122.0, 127.0, 122.0, 139.0, 126.0], "value": 125.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 159.0, 167.0, 157.0, 160.0, 161.0, 161.0, 163.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 62.0, 61.0, 66.0, 69.0, 64.0, 64.0, 62.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1502.1000000000001, "alertThreshold": 2.0}]} 12:34:33 INFO - Return code: 0 12:34:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:34:33 INFO - # TBPL SUCCESS # 12:34:33 INFO - Running post-action listener: _resource_record_post_action 12:34:33 INFO - ##### 12:34:33 INFO - ##### Finished run-tests step (success) 12:34:33 INFO - ##### 12:34:33 INFO - Running post-run listener: _resource_record_post_run 12:34:33 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 560246784; Read time: 16; Write time: 556840 12:34:33 INFO - TinderboxPrint: CPU usage
13.2% 12:34:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:34:33 INFO - TinderboxPrint: I/O write bytes / time
560,246,784 / 556,840 12:34:33 INFO - TinderboxPrint: CPU idle
8,260.1 (86.8%) 12:34:33 INFO - TinderboxPrint: CPU user
1,211.4 (12.7%) 12:34:33 INFO - TinderboxPrint: Swap in / out
0 / 0 12:34:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 266203136; Read time: 0; Write time: 301200 12:34:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294043648; Read time: 16; Write time: 255640 12:34:34 INFO - Running post-run listener: _upload_blobber_files 12:34:34 INFO - Blob upload gear active. 12:34:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:34:34 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 12:34:34 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'] 12:34:34 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 12:34:34 INFO - (blobuploader) - INFO - Open directory for files ... 12:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:35 INFO - (blobuploader) - INFO - Done attempting. 12:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:36 INFO - (blobuploader) - INFO - Done attempting. 12:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:34:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:40 INFO - (blobuploader) - INFO - Done attempting. 12:34:40 INFO - (blobuploader) - INFO - Iteration through files over. 12:34:40 INFO - Return code: 0 12:34:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:34:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:34:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40f030c6397273b6bd6b42d38dd40d857b9e7fa045649fecf220e27af4f114df0c88afb70ca04e7cf8bb46d172f69c12cd04d975671ceb73b46a6cb0f3f7c7af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/923f0c6bc60f438ded23e5ffba5a3f87571b44602238fc1b57f51559112e4c47ed54b33a9bb598b28d378aed90645dc2b04253662d4c1d4ce58b5a31c9dbce46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd33a0b22c6bf075c1a6e5b20607363cc07ab34a92f1aa6ad4cc477cc674fa5c9b529be652952905ce263cc658d4c09525d79b2c104997451eb597551e85ee1c"} 12:34:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:34:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:34:40 INFO - Contents: 12:34:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40f030c6397273b6bd6b42d38dd40d857b9e7fa045649fecf220e27af4f114df0c88afb70ca04e7cf8bb46d172f69c12cd04d975671ceb73b46a6cb0f3f7c7af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/923f0c6bc60f438ded23e5ffba5a3f87571b44602238fc1b57f51559112e4c47ed54b33a9bb598b28d378aed90645dc2b04253662d4c1d4ce58b5a31c9dbce46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd33a0b22c6bf075c1a6e5b20607363cc07ab34a92f1aa6ad4cc477cc674fa5c9b529be652952905ce263cc658d4c09525d79b2c104997451eb597551e85ee1c"} 12:34:40 INFO - Running post-run listener: copy_logs_to_upload_dir 12:34:40 INFO - Copying logs to upload dir... 12:34:40 INFO - mkdir: /builds/slave/test/build/upload/logs 12:34:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.514060 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-17 12:34:40.060283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 12:34:40.063762) ========= 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=4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216 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/40f030c6397273b6bd6b42d38dd40d857b9e7fa045649fecf220e27af4f114df0c88afb70ca04e7cf8bb46d172f69c12cd04d975671ceb73b46a6cb0f3f7c7af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/923f0c6bc60f438ded23e5ffba5a3f87571b44602238fc1b57f51559112e4c47ed54b33a9bb598b28d378aed90645dc2b04253662d4c1d4ce58b5a31c9dbce46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd33a0b22c6bf075c1a6e5b20607363cc07ab34a92f1aa6ad4cc477cc674fa5c9b529be652952905ce263cc658d4c09525d79b2c104997451eb597551e85ee1c"} build_url:https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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/40f030c6397273b6bd6b42d38dd40d857b9e7fa045649fecf220e27af4f114df0c88afb70ca04e7cf8bb46d172f69c12cd04d975671ceb73b46a6cb0f3f7c7af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/923f0c6bc60f438ded23e5ffba5a3f87571b44602238fc1b57f51559112e4c47ed54b33a9bb598b28d378aed90645dc2b04253662d4c1d4ce58b5a31c9dbce46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd33a0b22c6bf075c1a6e5b20607363cc07ab34a92f1aa6ad4cc477cc674fa5c9b529be652952905ce263cc658d4c09525d79b2c104997451eb597551e85ee1c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 12:34:40.089719) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:34:40.090048) ========= 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=4ac8d263c7293b36a1be1aed000001be-1466184094.271059-390484216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:34:40.173453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 12:34:40.173784) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 12:34:40.174103) ========= ========= Total master_lag: 0.19 =========