builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1466159245.55 results: success (0) buildid: 20160617004051 builduid: 967082ce4a094d2c8330f0c05e303702 revision: 541035fe27cb71fd6fdcd273c5190edd688f0731 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:25.550226) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:25.550723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:25.551027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:25.593095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:25.593358) ========= 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=232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 03:27:25-- 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% 231M=0s 2016-06-17 03:27:25 (231 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154637 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:25.783112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:25.783398) ========= 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=232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.056584 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:25.851617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:25.851949) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 541035fe27cb71fd6fdcd273c5190edd688f0731 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 541035fe27cb71fd6fdcd273c5190edd688f0731 --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=232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 03:27:25,959 truncating revision to first 12 chars 2016-06-17 03:27:25,959 Setting DEBUG logging. 2016-06-17 03:27:25,959 attempt 1/10 2016-06-17 03:27:25,959 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/541035fe27cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 03:27:26,314 unpacking tar archive at: mozilla-aurora-541035fe27cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720705 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:26.583764) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:26.584234) ========= script_repo_revision: 541035fe27cb71fd6fdcd273c5190edd688f0731 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:26.584727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:26.585018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 03:27:26.599943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-17 03:27:26.600356) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:26 INFO - MultiFileLogger online at 20160617 03:27:26 in /builds/slave/test 03:27:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:27:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:26 INFO - {'append_to_log': False, 03:27:26 INFO - 'base_work_dir': '/builds/slave/test', 03:27:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:27:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:26 INFO - 'branch': 'Mozilla-Aurora', 03:27:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:26 INFO - 'config_files': ('talos/linux_config.py',), 03:27:26 INFO - 'default_actions': ('clobber', 03:27:26 INFO - 'read-buildbot-config', 03:27:26 INFO - 'download-and-extract', 03:27:26 INFO - 'populate-webroot', 03:27:26 INFO - 'create-virtualenv', 03:27:26 INFO - 'install', 03:27:26 INFO - 'run-tests'), 03:27:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:26 INFO - 'download_minidump_stackwalk': True, 03:27:26 INFO - 'download_symbols': 'ondemand', 03:27:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:26 INFO - 'installer_path': 'installer.exe', 03:27:26 INFO - 'log_level': 'info', 03:27:26 INFO - 'log_name': 'talos', 03:27:26 INFO - 'log_to_console': True, 03:27:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:26 INFO - 'opt_config_files': (), 03:27:26 INFO - 'pip_index': False, 03:27:26 INFO - 'sps_profile': False, 03:27:26 INFO - 'sps_profile_interval': 0, 03:27:26 INFO - 'suite': 'dromaeojs-e10s', 03:27:26 INFO - 'system_bits': '32', 03:27:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:26 INFO - 'title': 'talos-linux64-ix-025', 03:27:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:26 INFO - 'use_talos_json': True, 03:27:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:26 INFO - 'work_dir': 'build'} 03:27:26 INFO - ##### 03:27:26 INFO - ##### Running clobber step. 03:27:26 INFO - ##### 03:27:26 INFO - Running pre-action listener: _resource_record_pre_action 03:27:26 INFO - Running main action method: clobber 03:27:26 INFO - rmtree: /builds/slave/test/build 03:27:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:28 INFO - Running post-action listener: _resource_record_post_action 03:27:28 INFO - ##### 03:27:28 INFO - ##### Finished clobber step (success) 03:27:28 INFO - ##### 03:27:28 INFO - ##### 03:27:28 INFO - ##### Running read-buildbot-config step. 03:27:28 INFO - ##### 03:27:28 INFO - Running pre-action listener: _resource_record_pre_action 03:27:28 INFO - Running main action method: read_buildbot_config 03:27:28 INFO - Using buildbot properties: 03:27:28 INFO - { 03:27:28 INFO - "project": "", 03:27:28 INFO - "product": "firefox", 03:27:28 INFO - "script_repo_revision": "production", 03:27:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:27:28 INFO - "repository": "", 03:27:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:27:28 INFO - "buildid": "20160617004051", 03:27:28 INFO - "stage_platform": "linux64-pgo", 03:27:28 INFO - "basedir": "/builds/slave/test", 03:27:28 INFO - "nightly_build": "True", 03:27:28 INFO - "buildnumber": 357, 03:27:28 INFO - "slavename": "talos-linux64-ix-025", 03:27:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:27:28 INFO - "platform": "ubuntu64_hw", 03:27:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:27:28 INFO - "branch": "mozilla-aurora", 03:27:28 INFO - "repo_path": "releases/mozilla-aurora", 03:27:28 INFO - "revision": "541035fe27cb71fd6fdcd273c5190edd688f0731", 03:27:28 INFO - "pgo_build": "True", 03:27:28 INFO - "builduid": "967082ce4a094d2c8330f0c05e303702", 03:27:28 INFO - "slavebuilddir": "test" 03:27:28 INFO - } 03:27:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:27:28 INFO - Running post-action listener: _resource_record_post_action 03:27:28 INFO - ##### 03:27:28 INFO - ##### Finished read-buildbot-config step (success) 03:27:28 INFO - ##### 03:27:28 INFO - ##### 03:27:28 INFO - ##### Running download-and-extract step. 03:27:28 INFO - ##### 03:27:28 INFO - Running pre-action listener: _resource_record_pre_action 03:27:28 INFO - Running main action method: download_and_extract 03:27:28 INFO - mkdir: /builds/slave/test/build/tests 03:27:28 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')]} 03:27:28 INFO - https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:27:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:27:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:27:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:27:30 INFO - Downloaded 1361 bytes. 03:27:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:27:30 INFO - Using the following test package requirements: 03:27:30 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:30 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:27:30 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:27:30 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'jsshell-linux-x86_64.zip'], 03:27:30 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:27:30 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:30 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:27:30 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:27:30 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:27:30 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:27:30 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:30 INFO - https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:27:42 INFO - Downloaded 24473874 bytes. 03:27:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:27:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:27:43 INFO - Return code: 0 03:27:43 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:27:43 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')]} 03:27:43 INFO - https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:27:44 INFO - Downloaded 24473874 bytes. 03:27:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:27:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:27:47 INFO - Return code: 0 03:27:47 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')]} 03:27:47 INFO - https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:27:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:27:48 INFO - Downloaded 10833369 bytes. 03:27:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:27:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:27:48 INFO - Return code: 0 03:27:48 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')]} 03:27:48 INFO - https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:27:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:27:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:27:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:27:49 INFO - Downloaded 63562967 bytes. 03:27:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:27:49 INFO - mkdir: /builds/slave/test/properties 03:27:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:27:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:27:49 INFO - Contents: 03:27:49 INFO - build_url:https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:27:50 INFO - Running post-action listener: _resource_record_post_action 03:27:50 INFO - Running post-action listener: set_extra_try_arguments 03:27:50 INFO - ##### 03:27:50 INFO - ##### Finished download-and-extract step (success) 03:27:50 INFO - ##### 03:27:50 INFO - ##### 03:27:50 INFO - ##### Running populate-webroot step. 03:27:50 INFO - ##### 03:27:50 INFO - Running pre-action listener: _resource_record_pre_action 03:27:50 INFO - Running main action method: populate_webroot 03:27:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:27:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:27:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:27:50 INFO - '--tppagecycles', 03:27:50 INFO - '7'], 03:27:50 INFO - 'tests': ['tsvgm']}}, 03:27:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:27:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:27:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:27:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:27:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:27:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:27:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:50 INFO - 'talos_options': ['--disable-e10s'], 03:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:50 INFO - 'talos_options': ['--disable-e10s'], 03:27:50 INFO - 'tests': ['damp', 'tps']}, 03:27:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:50 INFO - 'tests': ['damp', 'tps']}, 03:27:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:27:50 INFO - 'tests': ['dromaeo_dom']}, 03:27:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:27:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:27:50 INFO - 'tests': ['a11yr', 03:27:50 INFO - 'ts_paint', 03:27:50 INFO - 'tpaint', 03:27:50 INFO - 'sessionrestore', 03:27:50 INFO - 'sessionrestore_no_auto_restore', 03:27:50 INFO - 'tabpaint']}, 03:27:50 INFO - 'other-e10s': {'tests': ['a11yr', 03:27:50 INFO - 'ts_paint', 03:27:50 INFO - 'tpaint', 03:27:50 INFO - 'sessionrestore', 03:27:50 INFO - 'sessionrestore_no_auto_restore', 03:27:50 INFO - 'tabpaint']}, 03:27:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:27:50 INFO - 'ts_paint', 03:27:50 INFO - 'tpaint', 03:27:50 INFO - 'sessionrestore', 03:27:50 INFO - 'sessionrestore_no_auto_restore', 03:27:50 INFO - 'tabpaint']}, 03:27:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:27:50 INFO - 'ts_paint', 03:27:50 INFO - 'tpaint', 03:27:50 INFO - 'sessionrestore', 03:27:50 INFO - 'sessionrestore_no_auto_restore', 03:27:50 INFO - 'tabpaint']}, 03:27:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:27:50 INFO - 'tests': ['a11yr', 03:27:50 INFO - 'ts_paint', 03:27:50 INFO - 'tpaint', 03:27:50 INFO - 'sessionrestore', 03:27:50 INFO - 'sessionrestore_no_auto_restore', 03:27:50 INFO - 'tabpaint']}, 03:27:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:27:50 INFO - 'tests': ['a11yr', 03:27:50 INFO - 'ts_paint', 03:27:50 INFO - 'tpaint', 03:27:50 INFO - 'sessionrestore', 03:27:50 INFO - 'sessionrestore_no_auto_restore', 03:27:50 INFO - 'tabpaint']}, 03:27:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:27:50 INFO - 'tests': ['tsvgx', 03:27:50 INFO - 'tsvgr_opacity', 03:27:50 INFO - 'tart', 03:27:50 INFO - 'tscrollx', 03:27:50 INFO - 'cart']}, 03:27:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:27:50 INFO - 'tsvgr_opacity', 03:27:50 INFO - 'tart', 03:27:50 INFO - 'tscrollx', 03:27:50 INFO - 'cart']}, 03:27:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:50 INFO - 'talos_options': ['--disable-e10s'], 03:27:50 INFO - 'tests': ['tp5o']}, 03:27:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:50 INFO - 'tests': ['tp5o']}, 03:27:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:50 INFO - 'talos_options': ['--disable-e10s', 03:27:50 INFO - '--xperf_path', 03:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:50 INFO - 'tests': ['tp5n']}, 03:27:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:50 INFO - 'talos_options': ['--xperf_path', 03:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:50 INFO - 'tests': ['tp5n']}}, 03:27:50 INFO - 'talos.zip': {'path': '', 03:27:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:27:50 INFO - Running post-action listener: _resource_record_post_action 03:27:50 INFO - ##### 03:27:50 INFO - ##### Finished populate-webroot step (success) 03:27:50 INFO - ##### 03:27:50 INFO - ##### 03:27:50 INFO - ##### Running create-virtualenv step. 03:27:50 INFO - ##### 03:27:50 INFO - Running pre-action listener: _resource_record_pre_action 03:27:50 INFO - Running main action method: create_virtualenv 03:27:50 INFO - Creating virtualenv /builds/slave/test/build/venv 03:27:50 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 03:27:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:27:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:27:50 INFO - Using real prefix '/usr' 03:27:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:27:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:27:53 INFO - Installing pip.................done. 03:27:53 INFO - Return code: 0 03:27:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:27:53 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')]} 03:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:53 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')]} 03:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:53 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 0x7f6724205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d751c0>, '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 0x1d760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76550>, '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': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', '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 03:27:53 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 03:27:53 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 03:27:53 INFO - Using env: {'DISPLAY': ':0', 03:27:53 INFO - 'HOME': '/home/cltbld', 03:27:53 INFO - 'LANG': 'en_US.UTF-8', 03:27:53 INFO - 'LANGUAGE': 'en_US:en', 03:27:53 INFO - 'LOGNAME': 'cltbld', 03:27:53 INFO - 'MAIL': '/var/mail/cltbld', 03:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:53 INFO - 'MOZ_NO_REMOTE': '1', 03:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:53 INFO - 'NO_EM_RESTART': '1', 03:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:53 INFO - 'PWD': '/builds/slave/test', 03:27:53 INFO - 'SHELL': '/bin/bash', 03:27:53 INFO - 'SHLVL': '1', 03:27:53 INFO - 'TERM': 'linux', 03:27:53 INFO - 'TMOUT': '86400', 03:27:53 INFO - 'USER': 'cltbld', 03:27:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', 03:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:53 INFO - '_': '/tools/buildbot/bin/python'} 03:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:53 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 03:27:53 INFO - Cleaning up... 03:27:53 INFO - Return code: 0 03:27:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:27:53 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')]} 03:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:53 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')]} 03:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:53 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 0x7f6724205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d751c0>, '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 0x1d760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76550>, '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': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', '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 03:27:53 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 03:27:53 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 03:27:53 INFO - Using env: {'DISPLAY': ':0', 03:27:53 INFO - 'HOME': '/home/cltbld', 03:27:53 INFO - 'LANG': 'en_US.UTF-8', 03:27:53 INFO - 'LANGUAGE': 'en_US:en', 03:27:53 INFO - 'LOGNAME': 'cltbld', 03:27:53 INFO - 'MAIL': '/var/mail/cltbld', 03:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:53 INFO - 'MOZ_NO_REMOTE': '1', 03:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:53 INFO - 'NO_EM_RESTART': '1', 03:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:53 INFO - 'PWD': '/builds/slave/test', 03:27:53 INFO - 'SHELL': '/bin/bash', 03:27:53 INFO - 'SHLVL': '1', 03:27:53 INFO - 'TERM': 'linux', 03:27:53 INFO - 'TMOUT': '86400', 03:27:53 INFO - 'USER': 'cltbld', 03:27:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', 03:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:53 INFO - '_': '/tools/buildbot/bin/python'} 03:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:54 INFO - Downloading/unpacking psutil>=3.1.1 03:27:54 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 03:27:54 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 03:27:54 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 03:27:54 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 03:27:54 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 03:27:54 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 03:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:27:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:56 INFO - Installing collected packages: psutil 03:27:56 INFO - Running setup.py install for psutil 03:27:56 INFO - building 'psutil._psutil_linux' extension 03:27:56 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 03:27:57 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 03:27:57 INFO - building 'psutil._psutil_posix' extension 03:27:57 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 03:27:57 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 03:27:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:57 INFO - Successfully installed psutil 03:27:57 INFO - Cleaning up... 03:27:57 INFO - Return code: 0 03:27:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:57 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 0x7f6724205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d751c0>, '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 0x1d760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76550>, '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': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', '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 03:27:57 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 03:27:57 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 03:27:57 INFO - Using env: {'DISPLAY': ':0', 03:27:57 INFO - 'HOME': '/home/cltbld', 03:27:57 INFO - 'LANG': 'en_US.UTF-8', 03:27:57 INFO - 'LANGUAGE': 'en_US:en', 03:27:57 INFO - 'LOGNAME': 'cltbld', 03:27:57 INFO - 'MAIL': '/var/mail/cltbld', 03:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:57 INFO - 'MOZ_NO_REMOTE': '1', 03:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:57 INFO - 'NO_EM_RESTART': '1', 03:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:57 INFO - 'PWD': '/builds/slave/test', 03:27:57 INFO - 'SHELL': '/bin/bash', 03:27:57 INFO - 'SHLVL': '1', 03:27:57 INFO - 'TERM': 'linux', 03:27:57 INFO - 'TMOUT': '86400', 03:27:57 INFO - 'USER': 'cltbld', 03:27:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', 03:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:57 INFO - '_': '/tools/buildbot/bin/python'} 03:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:27:57 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 03:27:57 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 03:27:57 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 03:27:57 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 03:27:57 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 03:27:57 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 03:27:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:27:59 INFO - Installing collected packages: mozsystemmonitor 03:27:59 INFO - Running setup.py install for mozsystemmonitor 03:27:59 INFO - Successfully installed mozsystemmonitor 03:27:59 INFO - Cleaning up... 03:27:59 INFO - Return code: 0 03:27:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:59 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 0x7f6724205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d751c0>, '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 0x1d760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76550>, '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': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', '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 03:27:59 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 03:27:59 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 03:27:59 INFO - Using env: {'DISPLAY': ':0', 03:27:59 INFO - 'HOME': '/home/cltbld', 03:27:59 INFO - 'LANG': 'en_US.UTF-8', 03:27:59 INFO - 'LANGUAGE': 'en_US:en', 03:27:59 INFO - 'LOGNAME': 'cltbld', 03:27:59 INFO - 'MAIL': '/var/mail/cltbld', 03:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:59 INFO - 'MOZ_NO_REMOTE': '1', 03:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:59 INFO - 'NO_EM_RESTART': '1', 03:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:59 INFO - 'PWD': '/builds/slave/test', 03:27:59 INFO - 'SHELL': '/bin/bash', 03:27:59 INFO - 'SHLVL': '1', 03:27:59 INFO - 'TERM': 'linux', 03:27:59 INFO - 'TMOUT': '86400', 03:27:59 INFO - 'USER': 'cltbld', 03:27:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', 03:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:59 INFO - '_': '/tools/buildbot/bin/python'} 03:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:00 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:00 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 03:28:00 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 03:28:00 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 03:28:00 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 03:28:00 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 03:28:00 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 03:28:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:02 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 03:28:02 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 03:28:02 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 03:28:02 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 03:28:02 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 03:28:02 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 03:28:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:02 INFO - warning: no files found matching '*.txt' 03:28:02 INFO - no previously-included directories found matching 'build' 03:28:02 INFO - no previously-included directories found matching 'dist' 03:28:02 INFO - no previously-included directories found matching '.git*' 03:28:02 INFO - Installing collected packages: jsonschema, functools32 03:28:02 INFO - Running setup.py install for functools32 03:28:02 INFO - warning: no files found matching '*.txt' 03:28:02 INFO - no previously-included directories found matching 'build' 03:28:02 INFO - no previously-included directories found matching 'dist' 03:28:02 INFO - no previously-included directories found matching '.git*' 03:28:02 INFO - Successfully installed jsonschema functools32 03:28:02 INFO - Cleaning up... 03:28:02 INFO - Return code: 0 03:28:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:02 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 0x7f6724205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d751c0>, '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 0x1d760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76550>, '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': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', '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 03:28:02 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 03:28:02 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 03:28:02 INFO - Using env: {'DISPLAY': ':0', 03:28:02 INFO - 'HOME': '/home/cltbld', 03:28:02 INFO - 'LANG': 'en_US.UTF-8', 03:28:02 INFO - 'LANGUAGE': 'en_US:en', 03:28:02 INFO - 'LOGNAME': 'cltbld', 03:28:02 INFO - 'MAIL': '/var/mail/cltbld', 03:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:02 INFO - 'MOZ_NO_REMOTE': '1', 03:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:02 INFO - 'NO_EM_RESTART': '1', 03:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:02 INFO - 'PWD': '/builds/slave/test', 03:28:02 INFO - 'SHELL': '/bin/bash', 03:28:02 INFO - 'SHLVL': '1', 03:28:02 INFO - 'TERM': 'linux', 03:28:02 INFO - 'TMOUT': '86400', 03:28:02 INFO - 'USER': 'cltbld', 03:28:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', 03:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:02 INFO - '_': '/tools/buildbot/bin/python'} 03:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:02 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 03:28:02 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 03:28:02 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 03:28:02 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 03:28:02 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 03:28:02 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 03:28:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:04 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 03:28:04 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 03:28:04 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 03:28:04 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 03:28:04 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 03:28:04 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 03:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:05 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 03:28:05 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 03:28:05 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 03:28:05 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 03:28:05 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 03:28:05 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 03:28:05 INFO - Downloading docopt-0.6.1.tar.gz 03:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:05 INFO - Running setup.py install for blobuploader 03:28:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:05 INFO - Running setup.py install for requests 03:28:05 INFO - Running setup.py install for docopt 03:28:05 INFO - Successfully installed blobuploader requests docopt 03:28:05 INFO - Cleaning up... 03:28:06 INFO - Return code: 0 03:28:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:06 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 0x7f6724205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d751c0>, '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 0x1d760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76550>, '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': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', '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 03:28:06 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 03:28:06 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 03:28:06 INFO - Using env: {'DISPLAY': ':0', 03:28:06 INFO - 'HOME': '/home/cltbld', 03:28:06 INFO - 'LANG': 'en_US.UTF-8', 03:28:06 INFO - 'LANGUAGE': 'en_US:en', 03:28:06 INFO - 'LOGNAME': 'cltbld', 03:28:06 INFO - 'MAIL': '/var/mail/cltbld', 03:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:06 INFO - 'MOZ_NO_REMOTE': '1', 03:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:06 INFO - 'NO_EM_RESTART': '1', 03:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:06 INFO - 'PWD': '/builds/slave/test', 03:28:06 INFO - 'SHELL': '/bin/bash', 03:28:06 INFO - 'SHLVL': '1', 03:28:06 INFO - 'TERM': 'linux', 03:28:06 INFO - 'TMOUT': '86400', 03:28:06 INFO - 'USER': 'cltbld', 03:28:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', 03:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:06 INFO - '_': '/tools/buildbot/bin/python'} 03:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:06 INFO - Running setup.py (path:/tmp/pip-b4VHKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:06 INFO - Running setup.py (path:/tmp/pip-D1bmdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:06 INFO - Running setup.py (path:/tmp/pip-nSUDn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:06 INFO - Running setup.py (path:/tmp/pip-7WWjHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:06 INFO - Running setup.py (path:/tmp/pip-GlDJwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:06 INFO - Running setup.py (path:/tmp/pip-fr1V_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:06 INFO - Running setup.py (path:/tmp/pip-OwpMlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:06 INFO - Running setup.py (path:/tmp/pip-9EcDy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:06 INFO - Running setup.py (path:/tmp/pip-8vykkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:06 INFO - Running setup.py (path:/tmp/pip-njnLsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:06 INFO - Running setup.py (path:/tmp/pip-iYAQ5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:07 INFO - Running setup.py (path:/tmp/pip-pgnzTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:07 INFO - Running setup.py (path:/tmp/pip-Fu2grH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:07 INFO - Running setup.py (path:/tmp/pip-oB_rm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:07 INFO - Running setup.py (path:/tmp/pip-dZ7rYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:07 INFO - Running setup.py (path:/tmp/pip-_vuSfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:07 INFO - Running setup.py (path:/tmp/pip-gvMjFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:07 INFO - Running setup.py install for manifestparser 03:28:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:07 INFO - Running setup.py install for mozcrash 03:28:07 INFO - Running setup.py install for mozdebug 03:28:07 INFO - Running setup.py install for mozdevice 03:28:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:07 INFO - Running setup.py install for mozfile 03:28:07 INFO - Running setup.py install for mozhttpd 03:28:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Running setup.py install for mozinfo 03:28:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Running setup.py install for mozInstall 03:28:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Running setup.py install for mozleak 03:28:08 INFO - Running setup.py install for mozlog 03:28:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Running setup.py install for moznetwork 03:28:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Running setup.py install for mozprocess 03:28:08 INFO - Running setup.py install for mozprofile 03:28:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Running setup.py install for mozrunner 03:28:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:08 INFO - Running setup.py install for mozscreenshot 03:28:09 INFO - Running setup.py install for moztest 03:28:09 INFO - Running setup.py install for mozversion 03:28:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:09 INFO - Cleaning up... 03:28:09 INFO - Return code: 0 03:28:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:09 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 0x7f6724205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d751c0>, '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 0x1d760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76550>, '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': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', '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 03:28:09 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 03:28:09 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 03:28:09 INFO - Using env: {'DISPLAY': ':0', 03:28:09 INFO - 'HOME': '/home/cltbld', 03:28:09 INFO - 'LANG': 'en_US.UTF-8', 03:28:09 INFO - 'LANGUAGE': 'en_US:en', 03:28:09 INFO - 'LOGNAME': 'cltbld', 03:28:09 INFO - 'MAIL': '/var/mail/cltbld', 03:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:09 INFO - 'MOZ_NO_REMOTE': '1', 03:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:09 INFO - 'NO_EM_RESTART': '1', 03:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:09 INFO - 'PWD': '/builds/slave/test', 03:28:09 INFO - 'SHELL': '/bin/bash', 03:28:09 INFO - 'SHLVL': '1', 03:28:09 INFO - 'TERM': 'linux', 03:28:09 INFO - 'TMOUT': '86400', 03:28:09 INFO - 'USER': 'cltbld', 03:28:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', 03:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:09 INFO - '_': '/tools/buildbot/bin/python'} 03:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:09 INFO - Running setup.py (path:/tmp/pip-LxJP86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:09 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)) 03:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:09 INFO - Running setup.py (path:/tmp/pip-9imGzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:09 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)) 03:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:09 INFO - Running setup.py (path:/tmp/pip-jTDw9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:09 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)) 03:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:09 INFO - Running setup.py (path:/tmp/pip-0lGAyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:09 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)) 03:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:09 INFO - Running setup.py (path:/tmp/pip-V90b81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:09 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)) 03:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:09 INFO - Running setup.py (path:/tmp/pip-xjNwQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:09 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)) 03:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:09 INFO - Running setup.py (path:/tmp/pip-vprdmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:09 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)) 03:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:09 INFO - Running setup.py (path:/tmp/pip-qxm42p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:10 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)) 03:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:10 INFO - Running setup.py (path:/tmp/pip-C3BROH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:10 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)) 03:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:10 INFO - Running setup.py (path:/tmp/pip-spq66E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:10 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)) 03:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:10 INFO - Running setup.py (path:/tmp/pip-5SUnXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:10 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)) 03:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:10 INFO - Running setup.py (path:/tmp/pip-6ydPoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:10 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)) 03:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:10 INFO - Running setup.py (path:/tmp/pip-rL1jpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:10 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)) 03:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:10 INFO - Running setup.py (path:/tmp/pip-vbN0Gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:10 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)) 03:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:10 INFO - Running setup.py (path:/tmp/pip-eQT8rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:10 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)) 03:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:10 INFO - Running setup.py (path:/tmp/pip-LsD_ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:10 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)) 03:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:10 INFO - Running setup.py (path:/tmp/pip-bSRPN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:10 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)) 03:28:10 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)) 03:28:10 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)) 03:28:10 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)) 03:28:10 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)) 03:28:10 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)) 03:28:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:10 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 03:28:10 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 03:28:10 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 03:28:10 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 03:28:10 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 03:28:10 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 03:28:12 INFO - Downloading blessings-1.6.tar.gz 03:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:12 INFO - Installing collected packages: blessings 03:28:12 INFO - Running setup.py install for blessings 03:28:12 INFO - Successfully installed blessings 03:28:12 INFO - Cleaning up... 03:28:12 INFO - Return code: 0 03:28:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:13 INFO - Reading from file tmpfile_stdout 03:28:13 INFO - Current package versions: 03:28:13 INFO - argparse == 1.2.1 03:28:13 INFO - blessings == 1.6 03:28:13 INFO - blobuploader == 1.2.4 03:28:13 INFO - docopt == 0.6.1 03:28:13 INFO - functools32 == 3.2.3-2 03:28:13 INFO - jsonschema == 2.5.1 03:28:13 INFO - manifestparser == 1.1 03:28:13 INFO - mozInstall == 1.12 03:28:13 INFO - mozcrash == 0.17 03:28:13 INFO - mozdebug == 0.1 03:28:13 INFO - mozdevice == 0.48 03:28:13 INFO - mozfile == 1.2 03:28:13 INFO - mozhttpd == 0.7 03:28:13 INFO - mozinfo == 0.9 03:28:13 INFO - mozleak == 0.1 03:28:13 INFO - mozlog == 3.2 03:28:13 INFO - moznetwork == 0.27 03:28:13 INFO - mozprocess == 0.22 03:28:13 INFO - mozprofile == 0.28 03:28:13 INFO - mozrunner == 6.11 03:28:13 INFO - mozscreenshot == 0.1 03:28:13 INFO - mozsystemmonitor == 0.3 03:28:13 INFO - moztest == 0.7 03:28:13 INFO - mozversion == 1.4 03:28:13 INFO - psutil == 3.1.1 03:28:13 INFO - requests == 1.2.3 03:28:13 INFO - wsgiref == 0.1.2 03:28:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:13 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 0x7f6724205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d751c0>, '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 0x1d760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76550>, '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': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', '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 03:28:13 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 03:28:13 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 03:28:13 INFO - Using env: {'DISPLAY': ':0', 03:28:13 INFO - 'HOME': '/home/cltbld', 03:28:13 INFO - 'LANG': 'en_US.UTF-8', 03:28:13 INFO - 'LANGUAGE': 'en_US:en', 03:28:13 INFO - 'LOGNAME': 'cltbld', 03:28:13 INFO - 'MAIL': '/var/mail/cltbld', 03:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:13 INFO - 'MOZ_NO_REMOTE': '1', 03:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:13 INFO - 'NO_EM_RESTART': '1', 03:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:13 INFO - 'PWD': '/builds/slave/test', 03:28:13 INFO - 'SHELL': '/bin/bash', 03:28:13 INFO - 'SHLVL': '1', 03:28:13 INFO - 'TERM': 'linux', 03:28:13 INFO - 'TMOUT': '86400', 03:28:13 INFO - 'USER': 'cltbld', 03:28:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', 03:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:13 INFO - '_': '/tools/buildbot/bin/python'} 03:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:13 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)) 03:28:13 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)) 03:28:13 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)) 03:28:13 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)) 03:28:13 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)) 03:28:13 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)) 03:28:13 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)) 03:28:13 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)) 03:28:13 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)) 03:28:13 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)) 03:28:13 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)) 03:28:13 INFO - Cleaning up... 03:28:13 INFO - Return code: 0 03:28:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:13 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 0x7f6724205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d751c0>, '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 0x1d760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76550>, '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': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', '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 03:28:13 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 03:28:13 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 03:28:13 INFO - Using env: {'DISPLAY': ':0', 03:28:13 INFO - 'HOME': '/home/cltbld', 03:28:13 INFO - 'LANG': 'en_US.UTF-8', 03:28:13 INFO - 'LANGUAGE': 'en_US:en', 03:28:13 INFO - 'LOGNAME': 'cltbld', 03:28:13 INFO - 'MAIL': '/var/mail/cltbld', 03:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:13 INFO - 'MOZ_NO_REMOTE': '1', 03:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:13 INFO - 'NO_EM_RESTART': '1', 03:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:13 INFO - 'PWD': '/builds/slave/test', 03:28:13 INFO - 'SHELL': '/bin/bash', 03:28:13 INFO - 'SHLVL': '1', 03:28:13 INFO - 'TERM': 'linux', 03:28:13 INFO - 'TMOUT': '86400', 03:28:13 INFO - 'USER': 'cltbld', 03:28:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', 03:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:13 INFO - '_': '/tools/buildbot/bin/python'} 03:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:13 INFO - Cleaning up... 03:28:13 INFO - Return code: 0 03:28:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:13 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 0x7f6724205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d751c0>, '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 0x1d760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76550>, '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': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', '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 03:28:13 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 03:28:13 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 03:28:13 INFO - Using env: {'DISPLAY': ':0', 03:28:13 INFO - 'HOME': '/home/cltbld', 03:28:13 INFO - 'LANG': 'en_US.UTF-8', 03:28:13 INFO - 'LANGUAGE': 'en_US:en', 03:28:13 INFO - 'LOGNAME': 'cltbld', 03:28:13 INFO - 'MAIL': '/var/mail/cltbld', 03:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:13 INFO - 'MOZ_NO_REMOTE': '1', 03:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:13 INFO - 'NO_EM_RESTART': '1', 03:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:13 INFO - 'PWD': '/builds/slave/test', 03:28:13 INFO - 'SHELL': '/bin/bash', 03:28:13 INFO - 'SHLVL': '1', 03:28:13 INFO - 'TERM': 'linux', 03:28:13 INFO - 'TMOUT': '86400', 03:28:13 INFO - 'USER': 'cltbld', 03:28:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', 03:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:13 INFO - '_': '/tools/buildbot/bin/python'} 03:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:13 INFO - Downloading/unpacking flake8 03:28:13 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 03:28:13 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 03:28:13 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 03:28:13 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 03:28:13 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 03:28:13 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 03:28:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:28:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:28:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:28:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:16 INFO - no previously-included directories found matching 'docs/_build' 03:28:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:28:16 INFO - Running setup.py install for pep8 03:28:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:16 INFO - no previously-included directories found matching 'docs/_build' 03:28:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:28:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:28:16 INFO - Cleaning up... 03:28:16 INFO - Return code: 0 03:28:16 INFO - Running post-action listener: _resource_record_post_action 03:28:16 INFO - Running post-action listener: _start_resource_monitoring 03:28:16 INFO - Starting resource monitoring. 03:28:16 INFO - ##### 03:28:16 INFO - ##### Finished create-virtualenv step (success) 03:28:16 INFO - ##### 03:28:16 INFO - ##### 03:28:16 INFO - ##### Running install step. 03:28:16 INFO - ##### 03:28:16 INFO - Running pre-action listener: _resource_record_pre_action 03:28:16 INFO - Running main action method: install 03:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:16 INFO - Reading from file tmpfile_stdout 03:28:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:16 INFO - Reading from file tmpfile_stdout 03:28:16 INFO - Output received: 03:28:16 INFO - Usage: mozinstall [options] installer 03:28:16 INFO - Options: 03:28:16 INFO - -h, --help show this help message and exit 03:28:16 INFO - -d DEST, --destination=DEST 03:28:16 INFO - Directory to install application into. [default: 03:28:16 INFO - "/builds/slave/test"] 03:28:16 INFO - --app=APP Application being installed. [default: firefox] 03:28:16 INFO - mkdir: /builds/slave/test/build/application 03:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:28:32 INFO - Reading from file tmpfile_stdout 03:28:32 INFO - Output received: 03:28:32 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:32 INFO - Running post-action listener: _resource_record_post_action 03:28:32 INFO - ##### 03:28:32 INFO - ##### Finished install step (success) 03:28:32 INFO - ##### 03:28:32 INFO - ##### 03:28:32 INFO - ##### Running run-tests step. 03:28:32 INFO - ##### 03:28:32 INFO - Running pre-action listener: _resource_record_pre_action 03:28:32 INFO - Running main action method: run_tests 03:28:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:32 INFO - Python 2.7.3 03:28:32 INFO - Return code: 0 03:28:32 INFO - grabbing minidump binary from tooltool 03:28: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')]} 03:28:32 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 0x1d751c0>, '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 0x1d760c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d76550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:32 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 03:28:32 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 03:28:32 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 03:28:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:32 INFO - Return code: 0 03:28:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:28:33 INFO - Return code: 0 03:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:28:33 INFO - Using env: {'DISPLAY': ':0', 03:28:33 INFO - 'HOME': '/home/cltbld', 03:28:33 INFO - 'LANG': 'en_US.UTF-8', 03:28:33 INFO - 'LANGUAGE': 'en_US:en', 03:28:33 INFO - 'LOGNAME': 'cltbld', 03:28:33 INFO - 'MAIL': '/var/mail/cltbld', 03:28:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:33 INFO - 'MOZ_NO_REMOTE': '1', 03:28:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:33 INFO - 'NO_EM_RESTART': '1', 03:28:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:33 INFO - 'PWD': '/builds/slave/test', 03:28:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:33 INFO - 'SHELL': '/bin/bash', 03:28:33 INFO - 'SHLVL': '1', 03:28:33 INFO - 'TERM': 'linux', 03:28:33 INFO - 'TMOUT': '86400', 03:28:33 INFO - 'USER': 'cltbld', 03:28:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775', 03:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:33 INFO - '_': '/tools/buildbot/bin/python'} 03:28:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:28:34 INFO - mozversion application_buildid: 20160617004051 03:28:34 INFO - mozversion application_changeset: 541035fe27cb71fd6fdcd273c5190edd688f0731 03:28:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:28:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:34 INFO - mozversion application_name: Firefox 03:28:34 INFO - mozversion application_remotingname: firefox-dev 03:28:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:34 INFO - mozversion application_vendor: Mozilla 03:28:34 INFO - mozversion application_version: 49.0a2 03:28:34 INFO - mozversion platform_buildid: 20160617004051 03:28:34 INFO - mozversion platform_changeset: 541035fe27cb71fd6fdcd273c5190edd688f0731 03:28:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:34 INFO - mozversion platform_version: 49.0a2 03:28:34 INFO - using testdate: 1466159314 03:28:34 INFO - actual date: 1466159314 03:28:34 INFO - starting webserver on 'localhost:38491' 03:28:34 INFO - SUITE-START | Running 2 tests 03:28:34 INFO - TEST-START | dromaeo_css 03:28:34 INFO - operating with platform_type : linux_ 03:28:34 INFO - Initialising browser for dromaeo_css test... 03:28:34 INFO - TEST-INFO | started process 3379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJCro0H/profile http://localhost:38491/getInfo.html) 03:28:39 INFO - PROCESS | 3379 | __metrics Screen width/height:1600/1200 03:28:39 INFO - PROCESS | 3379 | colorDepth:24 03:28:39 INFO - PROCESS | 3379 | Browser inner width/height: 1024/697 03:28:39 INFO - PROCESS | 3379 | __metrics 03:28:40 ERROR - PROCESS | 3379 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:28:41 INFO - TEST-INFO | 3379: exit 0 03:28:41 INFO - Browser initialized. 03:28:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:41 INFO - TEST-INFO | started process 3512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJCro0H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:53 INFO - PROCESS | 3512 | RSS: Main: 155541504 03:28:53 INFO - PROCESS | 3512 | 03:29:42 INFO - PROCESS | 3512 | 1466159382745 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] 03:31:50 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:38491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38491/tests/dromaeo/cssquery-ext.html) 03:31:51 INFO - PROCESS | 3512 | RSS: Main: 158904320 03:31:51 INFO - PROCESS | 3512 | 03:34:53 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:38491/tests/dromaeo/cssquery-ext.html (next: http://localhost:38491/tests/dromaeo/cssquery-jquery.html) 03:34:54 INFO - PROCESS | 3512 | RSS: Main: 157437952 03:34:54 INFO - PROCESS | 3512 | 03:37:56 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:38491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38491/tests/dromaeo/cssquery-mootools.html) 03:37:56 INFO - PROCESS | 3512 | RSS: Main: 156766208 03:37:56 INFO - PROCESS | 3512 | 03:40:58 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:38491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38491/tests/dromaeo/cssquery-prototype.html) 03:40:59 INFO - PROCESS | 3512 | RSS: Main: 156659712 03:40:59 INFO - PROCESS | 3512 | 03:44:01 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:38491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38491/tests/dromaeo/cssquery-yui.html) 03:44:02 INFO - PROCESS | 3512 | RSS: Main: 158973952 03:44:02 INFO - PROCESS | 3512 | 03:47:04 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:38491/tests/dromaeo/cssquery-yui.html (next: http://localhost:38491/tests/dromaeo/cssquery-dojo.html) 03:47:04 INFO - PROCESS | 3512 | RSS: Main: 159133696 03:47:04 INFO - PROCESS | 3512 | 03:47:04 INFO - PROCESS | 3512 | __start_tp_report 03:47:04 INFO - PROCESS | 3512 | _x_x_mozilla_page_load 03:47:04 INFO - PROCESS | 3512 | _x_x_mozilla_page_load_details 03:47:04 INFO - PROCESS | 3512 | |i|pagename|runs| 03:47:04 INFO - PROCESS | 3512 | |0;dojo.html;3333.9498058111694;3368.4610462326027;3374.0383990562677;3377.8986630401096;3403.4894765785116;5510.118381059031;5521.25463062487;5527.723613819308;5587.580931430149;5611.579131565129;5568.3596386415575;5585.804496842601;5619.213310136574;5627.577931655122;5641.5204707599905;5032.11937910866;5094.898102037957;5140.563052140554;5148.073346797575;5160.406553246387;5032.4967503249745;5047.64666473347;5135.948640513584;5155.9484405155845;5158.148905430599;5081.364829396325;5106.9489305106845;5110.7700153493;5133.024725302199;5143.125668636322;5093.286939828427;5155.793768249284;5185.922211166836;5194.065068287707;5225.895482090375;4890.217565189588;5104.336436263299;5126.2054381570915;5150.175971844525;5174.275601415805;5321.122014867542;5437.646552974044;5443.972780136113;5456.890862182774;5468.2891224141;5951.732172052268;5978.581499295051;5992;6008.609440386361;6019.909701354483;5919.378465261128;5946.732397042144;6030.276366835964;6037;6041.577089603729;5547.5007249347345;5651.9717401413145;5654.953833540808;5655.321361436654;5682.090865461548;6131.540134489931;6157.076438534255;6160.10678451622;6160.9383906160365;6164;5738.282714660668;5753.079507278815;5766.942330576724;5877.706114694248;5885.411458854081;5924.674142922181;5937.52499800015;5940;5940.584159108907;5968.432998865101;5887.852803679943;5895.64626122434;5908.20239267702;5915.970420147958;5942.524598032147;5721.971390143022;5882.764619429968;5902.527797776168;5914.378990206053;5959.106134079922;4578.2903649934315;4596.7931443085145;4599.448066232074;4607.285870690049;4629.120467111238;4103.9179216416105;4104.610062044101;4135.56576559463;4137.131202447459;4161.334186530141;5665.12190610456;5713.8285851424525;5723.6851973141875;5775.364709881909;5800.59395842287;5975.462208401264;5998.4601385875485;5999.460048595647;6027.7287522061615;6087.269527656621;5674.716264186774;5778;5779.624324418984;5781.161731548902;5789.160571717078;5164.04465173944;5170.870728231749;5179.61152913533;5209.739513024334;5251.317328747238;6193.504519638418;6251.874962500725;6255.24937007562;6272.874542509125;6296.779612713533;5908.763649453974;6001.939980600138;6132.080187971751;6146.477549408351;6151.32335443092;6114.388561144028;6225.31521532622;6233.781817636361;6235.781747638811;6239.688015599293;5937.228160339128;5941.67320797343;5945;5960.403959604005;5980.073088671263;5899.46904778572;5913.70431478433;5917.526597872246;6047.274327080779;6048.78829240992;5821.79623713168;5848.356680765198;5849.64902105875;5855.94144058571;5871.236739223874;5779.2486976694445;5805.448482394166;5813.3895940925595;5832.679202643895;5838.299404071538;5510;5657.8019769307875;5673.375928647928;5703.287089113861;5745.9425405745405;5918.881622367442;5941.049432090845;5953.583249172516;5961.463468287875;5962.582619216613;5810.564207684356;5819.0689489681445;5821.476067153976;5823.18475413451;5826.679532625746 03:47:04 INFO - PROCESS | 3512 | |1;ext.html;596.9761209551618;634.1185751804991;659.587757651468;662.6686656671665;673.9991113196902;45052;45930.3110453343;46051.30923036157;46242.30636540455;49092.75453622727;47851.76074119633;48510.27234591475;48673.269900951425;48755.51244487554;48772.268415973704;8824.51465169417;8963.193312601898;8969.77575560613;8982.730518084436;9014.2788576914;9099.499527525983;9211.723648290563;9215.308851836138;9237.307201959846;9255.39839910407;9251.306152038624;9263.212626926686;9276.211522020603;9301.813963720722;9321.207697345733;9153.954230228874;9197.494137822418;9216.769580760467;9219.308551858638;9245.491497967643;9074.591643375998;9079.909200907972;9130.77173070672;9168.587413566405;9172.816543669156;45110.77444612756;45302.77348613269;45591.77204113958;45704.3144352835;45794.77102614499;3514.297140571896;3532.258225772591;3711.3505136601257;3894.883153505399;4313.698041137121;33696;33964.32071358559;34020.829895850366;35003.824980875186;36314.092147696254;4159.667226621863;4217.051163488221;4248.171606536726;4257.318828987378;4330.523642399334;358737;360846;362087;363791;363882;36024;36235.456468152996;65807.67096164584;66329.6683516589;66391.33608663948;39354;39610.20779584392;39788.403173952414;39791.40312895309;39999.60000400017;14282.500112496013;14417.92791036038;14419.711605767827;14442.638934026734;14453.132812031312;11280.661580152608;11471.139664525193;11473.082153427873;11477.885221147682;11494.367809770376;9251.121143491358;9258.074192580689;9335.346525743269;9340.252779777602;9372.437653740797;3574.285142971416;3579.5167652367118;3599.532060832075;3600.3519366513756;3682.4108142697573;1137.4710759496875;1140.1391949078559;1167.416291854073;1197.6107764976418;1272.0713878868478;34837.47743783845;35512.822435887654;35525.111872202884;37749.433758493644;37936.74383347144;1153.8615366156116;1205.7588482303574;1260.9495620175273;1261.892739117167;1267.2269915351628;17257.56856078608;17473.38843140484;17618.735718964224;17706.5573360667;17752.55618609545;510027;629726;639066;649617;650377;60418.0937285941;65095.34904650987;65121;65327;65457;1453.542134227715;1470.2575199524172;1475.8155230596176;1478.9852101479062;1494.6562290673205;34051.14872128217;34393.656063440045;34565.13587160341;34572.13569660779;34672.30655386828;57296.42703572911;57322.71338643447;57810.421895780506;58094.4190558089;58226;513015;527094;527208;528793;528934;31444.68555314509;31821.20446988844;31904.202394940312;32054;32277.35445291128;52064.739676301375;52956.73521632367;53307;53610.463895360546;53623.19565206447;44160.33759493546;44602;45090.09819803651;45338.773306133255;46237;44090.55909440864;44138;44367.33448998203;45488;45943;40030;43942;44709.32936006028;45187.54812451833;45441.09117817691;38416.61583384242;38464.80767596144;38571;39409.40885886657;39645;29708.405831883672;30004.765970967743;30440.391192176474;30535;30764.230894226926 03:47:04 INFO - PROCESS | 3512 | |2;jquery.html;417.32601848015463;424.76850116686404;426.36471657230726;429.5833041949312;431.69781153192775;18390.632187356245;19404.32084877028;20145.29491467799;20965.580688386224;21191.258305959294;20981;21304.89347553264;22014.33956981293;22175.889120554373;22338.553228935412;6624.966875165617;6683.164604424447;6863.313668633146;6878.243393226741;6978.476614253926;6785.52501324905;6805.965970170142;6832;6856.52004359695;6870.072540207083;6629.801105966829;6802.727890884359;6823.658817059152;6824.761133360334;6831.4534837212905;6595.53831231814;6766.526343155956;6786.864262714743;6800.149981252343;6825.1809782825885;6578.868422631568;6580.93419065808;6618.536702430832;6658.733650654017;6662;26628;27149.45701085987;27838.443231135465;28314.858425707946;28497.430051399064;2600.700919394275;2667.6398686177504;2668.866556672159;2720.5239083160563;2747.986260068707;16714.498565043068;17286.740698889527;17307.53849230159;17415.65168696619;17746.645067098587;2183.6069507488646;2202.922897698573;2270.5345404192267;2326.8720220387872;2335.8364914455997;99050.0094999048;99363.50318248362;101453;101986;102899;17965.281388744304;18476.630467390576;18631.720524192147;19216;19308.8069119307;11297.49161287744;35270.8236458816;35302.47046294308;35337.64662353395;35345.29309413849;5815.331236907725;5911.438413350725;6848.9657551711925;7833.589953808255;7951.125376208613;7707.190744971809;7777.650005749755;7809.609519524001;7817.921820781833;7908.5650289234645;4015.638592526628;4137.50349958001;4284.014676624394;4381.452318460192;4432.955670443319;2025.584755125196;2100.705901173837;2112.8309735221146;2132.632777616844;2144.7962443567835;1029.7013865978931;1034.4517405774952;1067.3755852826027;1083.3012706804068;1175.1127898436625;19160.137793799313;19592.608147836963;19659.60680786405;19999.400017999484;20223.191072357236;1075.9623413180502;1081.6322450366913;1085.6091806949491;1094.7427354571669;1101.895319944604;10577.947110264553;11043.116550675926;11058.944705276423;11083.72290692723;11140.108791296676;489921;498698;500847;501416;503934;73725.26274737185;92107.5394623036;99020;99192.5040374808;99653.50173249232;1029.120102312527;1029.2692188546066;1054.5254635414094;1059.5285098131412;1061.7823346213854;17538.649227015132;17802.37691680785;17830.286788528832;17953;18137.818621813614;40803.38794918019;41235.587644124374;42640.78679606582;42871.57128428676;43366.56633433751;51907;52917.20624190717;59164.112538312824;59630.40369596422;61301.38698612957;7774.844503110019;7908.762737117896;7932.365410767009;7999.920000800151;8592.226699597066;13042.869571304545;13618.114822536503;13805.309734513436;13860.514881979083;14099.718005639625;11910.285382877055;12037.277763334228;12099.213551119148;12198.878011219775;12251.69370765738;11949.283043017447;12103.576374826838;12116.818247726114;12185.512579497075;12246.265224086583;12100.092493062879;12258.693532661755;12334.629961101182;12388.070894683115;12504.499820007099;7875.684972601031;7963.761087167394;7996.92003079985;8055.597220139087;8372.748817535483;10117.038881306264;12275.2021118627;12427.254364738144;12479.251244925334;12492.625221243377 03:47:04 INFO - PROCESS | 3512 | |3;mootools.html;1481.4740767027708;1552.5264794237758;1664.1928664597667;1790.7672002639663;1807.7830660320762;8416.45293055951;9094.49980251086;9157.587908544116;9839.950800245988;9844.114029737322;9432.339736218468;9509.667161649344;9525;9533.47565883876;9552.474613896251;2419.5523828091773;2489.352768280251;2490.5267999080206;2491.862947537885;2493.1024831060804;2297.655351697242;2436.1838784007377;2442.4016116051594;2444.767747064026;2446;2427.6890479141243;2429.5019520998153;2441.914532991346;2448.2410452759614;2448.9877550612223;2439.231642032763;2448.045262347686;2456.6929133858266;2478.5910324796387;2483.6522886795865;2474.381404648838;2483.466054798227;2499.2877030046347;2505.185814610241;2512.773850353459;9447.385919915183;9522.904770952271;9525.095115963972;9539.90460095397;9543.427394356291;5455.618106732531;5521.116621340566;5562.499375056264;5562.582806289544;5592.916106258409;3432.982835085809;3571.23218508022;3627.093226693327;3657.3416784978695;3661.176235347052;1125.1729978465821;1126.752114534801;1133.7449073958376;1135.477680267078;1140.389891408101;13375.531856385078;13457.86542134576;13491.123076999964;13500;13527.32363381827;4971.527704868032;5001.899962000813;5049.116404629175;5057.367829021372;5086.059079070384;11359.772804544029;11404.201705880509;11430.428478576037;11458.026067784333;11462.713432164262;5686.9715651421475;5703.62926409782;5705.058665320259;5725.227094342211;5727.083666613322;4664.137134630104;5094.643374963791;5253.789848406097;5260.316158899395;5267;4442.644588432918;4449.911001779947;4452.9554704453185;4483.775811209426;4499.032707967803;1366.842813076489;1390.7566175919173;1400.9579712608638;1409.1474657832068;1419.233613848531;855.7988872614931;965.1795973422535;1036.8859425463193;1045.560864436923;1059.6079450603327;6325.96837015812;6359.268684101295;6390.520710946697;6396.5202609804455;6401.58389704677;497.19702680171264;507.14039702703565;513.3557385481197;519.4026869100489;525.7423862307518;4440.578145076212;4457.576530229688;4503.369528266046;4509.323601459741;4553.317002449659;11285.605003824827;11453;11639.59261425846;11647.71875093739;11647.76704465923;11366.204365694488;11702;11954.103442241867;11987.52049918011;12060.51757929673;8928.330375221884;9146.954265228764;9159.267258619428;9201.815963680689;9208;6300.369963003663;6411.967940160456;6451.612903225821;6533.18335208099;6535.509836762357;10885.238033337908;11051.502682379152;11203.551857925591;11245.606403775828;11255.437228138397;11353.772924541629;11373.715657108638;11415.828762568734;11484.081273497934;11491.310521368745;7774.144844067035;8261.38039647041;8509.10654381281;8589.398742088244;8635.568221589021;9540.713778586654;9547.33168678186;9584.472853993097;9633.614655413985;9671.564779584794;8075.788631705056;8134.837303253784;8163.755087347389;8251.381146413923;8282.296004839656;8115.147909469657;8162.387820913574;8169.836603268021;8225;8288.792780180544;7258.383037441666;7285.526440781332;7359.77920662381;7385.667644956097;7391.371733402721;5496.203050557727;5503.724813759216;5576.442355764391;5577.135543990688;5603.7758489659955;5444.346678398618;5454.318210223722;5524.309461317335;5602.887942241214;5753.798617048383 03:47:04 INFO - PROCESS | 3512 | |4;prototype.html;339.26887557313995;354.40283122937853;358.74349839864493;361.3621957245464;370.14496513054826;5705.857353566163;5742.942570574293;5907.350191478939;5907.409259074096;5927.525797936171;5717.742096738722;5744.4829965303115;5754.568407369443;5770.682612456313;5784.363719990798;4492.236319825637;4505.414296141514;4506.143832671798;4527.56988086133;4553.977230113845;4470.742275151044;4525.208088584501;4552.453705555338;4554.84058057968;4575.565321294472;4442.97778511107;4454.109178164364;4475.1049790042125;4476.798544065525;4478.507364189936;4323;4487.237169681146;4515.209838278321;4519.615832654228;4526.253168227238;3940.5862384449506;3942.940855887164;3946.7039972002217;3947.2500224957453;3957.406389041638;5558.638688485276;5567.081431563787;5588.357338905997;5595.076812325961;5596.132599447093;5070.873228169326;5124.4875512448825;5133.512316329943;5170.121079416471;5181.792728290864;5954.910676339859;5973.940260597382;5977.0114942528735;6014.548908831812;6022.578419510636;4315.870523884289;4319.913601727979;4357.760323182224;4372.956270437287;4378.671599630041;6164.229471316085;6289.937100628981;6324.525660575475;6361.713722882481;6363.904541431929;4471.5528447155675;4488.3940668010055;4500.707454015478;4502.5047244803045;4506.233940230169;4552.544745525487;4553.089382123589;4553.772311384418;4559.589636932692;4575.496695363508;4783.679915241105;5042.420121686053;5094.974525127424;5147.485251474897;5166.147585648401;5961.463468287789;6041.855141424819;6051.939480605226;6066.787662431882;6122.8876037766895;1536.7694845773224;1548.3419546692835;1550.2016461522326;1559.7755761727217;1569.285974881449;950.5342382232794;953.7172502983476;956.3018996132723;958.8561715742694;962.6630679262203;5248.580113590903;5251.212318152231;5251.2123181523075;5270.341207349082;5344.465553444702;5412.646838290428;5511.311086114236;5655.830325090254;5678.914816277759;5704.286964129484;4983.277424773388;5272.894542109137;5283.260343551906;5283.682979021194;5294.41761406245;2849.344650730344;2926.326944802665;2960.7927445079067;2976.9283058099068;3000.354923691373;5709.8287051388525;5739.5695322850115;5742.54059675225;5807.854803629859;5823.213866128103;5875.853103672357;6374.872502549923;6397;6414.941534646824;6426.3573642635365;6433.228012638513;6451.161349024596;6483.481321494363;6520.794087813429;6532.738690452328;6044.879102418015;6248.250209974832;6274;6290.308066112815;6299.511692881195;6166.383361663798;6183.752649893954;6202.7208775606105;6206.348333425106;6257.812265632038;6233.379321376384;6467.385598368148;6512.055751915851;6525;6525.282218956006;4456.7548784817145;4474.574915383034;4484.417025786627;4487.551244875486;4521.480029796484;6069.605475644069;6316.263027667428;6330.8100756977365;6368.426841584094;6368.490520758421;6083.756649733961;6132.693365331805;6141.420603346516;6151.784687535915;6179.876402471836;6016.157737916783;6101.542384321282;6120.867639486709;6137.815865524041;6143.139960405458;5826.271716035496;5873.765049397976;5905.202797622266;5954.434328738763;6001.219841420588;6028.939710602838;6088.908666369919;6129.601575897553;6185.165002724574;6218.813435596759;5806.709664516673;5999.940000600112;6035.336113027652;6046.818595442144;6065.423784740443 03:47:04 INFO - PROCESS | 3512 | |5;yui.html;657.700746160497;750.5271678842329;753.3069575990089;760.6539024743743;846.5809424334954;13643.454261829527;14236.644083897894;15134.848651513495;15247.771283430757;15268.618284542892;13033.218006919591;13078;13097.47610095595;13130.277834719087;13138.934305328485;726.8073960400499;846.2130218896424;846.3356265331701;857.7469646454311;866.6446756829702;863.4258218284833;869.3740506835101;869.4696235296464;873.6505397840851;875.689130358723;914.7713071732067;917.3716004536881;918.5590916360151;921.0237148622448;923.8798956135693;916.5554705967601;918.3433844800966;918.8300164469562;921.4333185091187;921.5115988526092;674.3627272227747;677.1738479055545;677.3869647968596;677.4614181725491;679.8708245433402;14392.136471811726;14398.064125831788;14433.278336083154;14442;14475.276236188254;14041.78937315941;14256.14463132205;14299.714005719932;14340.211288379134;14348;11759.294442333487;11938.940305298418;11942.164048516608;11997.040236781037;12021.278723276631;3604.981975090134;3606.495090687306;3620.837062332201;3849.30712471755;3948.8617898373705;77216;78604.60697696474;81325.9999999994;81554;81578.59210703909;11353.716157095974;11648;11678.416079196006;11901.750316216672;11976.52093916251;18247.81752182461;18739.34412295563;18864.245430182913;19576.608467830563;19595.11821967986;7956.482828616122;8039.15588863161;8055.395845311625;8085.110637829834;8125.228103330174;4589;4639;4685.367475390779;4731.739754313477;4753.35829662998;3518.313928783914;3673.779573225615;3683.0239986403626;3693.2059607184046;3717.182219911615;661.4476911778719;667.1194023888518;668.9698963546653;684.5721424109931;689.7034275261685;608.7139044649008;663.5023732200849;723.5405517496428;734.6840858430926;751.6918063593901;9176.265898728087;9570.712878613653;9765.804683906283;9789.804203915883;9798.363106398061;610.7770663707714;656.0945894665426;711.9679614417364;774.1716363491123;799.3205775091126;4623.838165664186;4719.811207551728;4779.3070004849105;4852.684575502581;4888.26675998596;116339.41830290794;119957.40021299837;120200.39899800446;120698;120744.39627801804;62899.685501572196;65037.67481162564;77289;81680.59159704282;96976.03023969811;85825;91132.54433727922;92062;93097;93910.53044734869;9104.908950910407;9154.40496367734;9189.172974432333;9299.209567186594;9399.919009314017;42708.78645606752;53945;54243.186352205536;55430;57075;47074;66521.66739166273;71968;78953;79431.20568794238;12616.495340186657;13063.085584009408;13136;14050.718985620026;14311.427542898167;13738.519151829638;14199.64500887486;14845.40618375253;14911.552653420415;15290.464833730766;12890.29103399322;14326.283685815875;14834.035787673767;15007.549773506813;15176.468823591122;13552.186868787905;13861.168329900238;14111.858881411465;14253.35859886287;14581.562553123424;13060.738785224052;13340.86659133435;13940;14417.207053612152;14542.85457145415;11499.94250028778;11543.249688770204;11664.6500604982;11682.824757628472;11788.997935175606;11319;11544.093760152069;11768.293902365886;11774.411279436164;11837.763244734884 03:47:04 INFO - PROCESS | 3512 | __end_tp_report 03:47:04 INFO - PROCESS | 3512 | __start_cc_report 03:47:04 INFO - PROCESS | 3512 | _x_x_mozilla_cycle_collect,334 03:47:04 INFO - PROCESS | 3512 | __end_cc_report 03:47:04 INFO - PROCESS | 3512 | __startTimestamp1466160424859__endTimestamp 03:47:04 INFO - PROCESS | 3512 | 03:47:04 INFO - PROCESS | 3512 | ------- Summary: start ------- 03:47:04 INFO - PROCESS | 3512 | Number of tests: 6 03:47:04 INFO - PROCESS | 3512 | 03:47:04 INFO - PROCESS | 3512 | [#0] dojo.html Cycles:165 Average:5571.02 Median:5781.16 stddev:611.20 (10.6%) stddev-sans-first:587.34 03:47:04 INFO - PROCESS | 3512 | Values: 3333.9 3368.5 3374.0 3377.9 3403.5 5510.1 5521.3 5527.7 5587.6 5611.6 5568.4 5585.8 5619.2 5627.6 5641.5 5032.1 5094.9 5140.6 5148.1 5160.4 5032.5 5047.6 5135.9 5155.9 5158.1 5081.4 5106.9 5110.8 5133.0 5143.1 5093.3 5155.8 5185.9 5194.1 5225.9 4890.2 5104.3 5126.2 5150.2 5174.3 5321.1 5437.6 5444.0 5456.9 5468.3 5951.7 5978.6 5992.0 6008.6 6019.9 5919.4 5946.7 6030.3 6037.0 6041.6 5547.5 5652.0 5655.0 5655.3 5682.1 6131.5 6157.1 6160.1 6160.9 6164.0 5738.3 5753.1 5766.9 5877.7 5885.4 5924.7 5937.5 5940.0 5940.6 5968.4 5887.9 5895.6 5908.2 5916.0 5942.5 5722.0 5882.8 5902.5 5914.4 5959.1 4578.3 4596.8 4599.4 4607.3 4629.1 4103.9 4104.6 4135.6 4137.1 4161.3 5665.1 5713.8 5723.7 5775.4 5800.6 5975.5 5998.5 5999.5 6027.7 6087.3 5674.7 5778.0 5779.6 5781.2 5789.2 5164.0 5170.9 5179.6 5209.7 5251.3 6193.5 6251.9 6255.2 6272.9 6296.8 5908.8 6001.9 6132.1 6146.5 6151.3 6114.4 6225.3 6233.8 6235.8 6239.7 5937.2 5941.7 5945.0 5960.4 5980.1 5899.5 5913.7 5917.5 6047.3 6048.8 5821.8 5848.4 5849.6 5855.9 5871.2 5779.2 5805.4 5813.4 5832.7 5838.3 5510.0 5657.8 5673.4 5703.3 5745.9 5918.9 5941.0 5953.6 5961.5 5962.6 5810.6 5819.1 5821.5 5823.2 5826.7 03:47:04 INFO - PROCESS | 3512 | 03:47:04 INFO - PROCESS | 3512 | [#1] ext.html Cycles:180 Average:65750.26 Median:44149.17 stddev:136694.79 (309.6%) stddev-sans-first:136990.73 03:47:04 INFO - PROCESS | 3512 | Values: 597.0 634.1 659.6 662.7 674.0 45052.0 45930.3 46051.3 46242.3 49092.8 47851.8 48510.3 48673.3 48755.5 48772.3 8824.5 8963.2 8969.8 8982.7 9014.3 9099.5 9211.7 9215.3 9237.3 9255.4 9251.3 9263.2 9276.2 9301.8 9321.2 9154.0 9197.5 9216.8 9219.3 9245.5 9074.6 9079.9 9130.8 9168.6 9172.8 45110.8 45302.8 45591.8 45704.3 45794.8 3514.3 3532.3 3711.4 3894.9 4313.7 33696.0 33964.3 34020.8 35003.8 36314.1 4159.7 4217.1 4248.2 4257.3 4330.5 358737.0 360846.0 362087.0 363791.0 363882.0 36024.0 36235.5 65807.7 66329.7 66391.3 39354.0 39610.2 39788.4 39791.4 39999.6 14282.5 14417.9 14419.7 14442.6 14453.1 11280.7 11471.1 11473.1 11477.9 11494.4 9251.1 9258.1 9335.3 9340.3 9372.4 3574.3 3579.5 3599.5 3600.4 3682.4 1137.5 1140.1 1167.4 1197.6 1272.1 34837.5 35512.8 35525.1 37749.4 37936.7 1153.9 1205.8 1260.9 1261.9 1267.2 17257.6 17473.4 17618.7 17706.6 17752.6 510027.0 629726.0 639066.0 649617.0 650377.0 60418.1 65095.3 65121.0 65327.0 65457.0 1453.5 1470.3 1475.8 1479.0 1494.7 34051.1 34393.7 34565.1 34572.1 34672.3 57296.4 57322.7 57810.4 58094.4 58226.0 513015.0 527094.0 527208.0 528793.0 528934.0 31444.7 31821.2 31904.2 32054.0 32277.4 52064.7 52956.7 53307.0 53610.5 53623.2 44160.3 44602.0 45090.1 45338.8 46237.0 44090.6 44138.0 44367.3 45488.0 45943.0 40030.0 43942.0 44709.3 45187.5 45441.1 38416.6 38464.8 38571.0 39409.4 39645.0 29708.4 30004.8 30440.4 30535.0 30764.2 03:47:04 INFO - PROCESS | 3512 | 03:47:04 INFO - PROCESS | 3512 | [#2] jquery.html Cycles:180 Average:31057.09 Median:14647.82 stddev:82493.34 (563.2%) stddev-sans-first:82692.68 03:47:04 INFO - PROCESS | 3512 | Values: 417.3 424.8 426.4 429.6 431.7 18390.6 19404.3 20145.3 20965.6 21191.3 20981.0 21304.9 22014.3 22175.9 22338.6 6625.0 6683.2 6863.3 6878.2 6978.5 6785.5 6806.0 6832.0 6856.5 6870.1 6629.8 6802.7 6823.7 6824.8 6831.5 6595.5 6766.5 6786.9 6800.1 6825.2 6578.9 6580.9 6618.5 6658.7 6662.0 26628.0 27149.5 27838.4 28314.9 28497.4 2600.7 2667.6 2668.9 2720.5 2748.0 16714.5 17286.7 17307.5 17415.7 17746.6 2183.6 2202.9 2270.5 2326.9 2335.8 99050.0 99363.5 101453.0 101986.0 102899.0 17965.3 18476.6 18631.7 19216.0 19308.8 11297.5 35270.8 35302.5 35337.6 35345.3 5815.3 5911.4 6849.0 7833.6 7951.1 7707.2 7777.7 7809.6 7817.9 7908.6 4015.6 4137.5 4284.0 4381.5 4433.0 2025.6 2100.7 2112.8 2132.6 2144.8 1029.7 1034.5 1067.4 1083.3 1175.1 19160.1 19592.6 19659.6 19999.4 20223.2 1076.0 1081.6 1085.6 1094.7 1101.9 10577.9 11043.1 11058.9 11083.7 11140.1 489921.0 498698.0 500847.0 501416.0 503934.0 73725.3 92107.5 99020.0 99192.5 99653.5 1029.1 1029.3 1054.5 1059.5 1061.8 17538.6 17802.4 17830.3 17953.0 18137.8 40803.4 41235.6 42640.8 42871.6 43366.6 51907.0 52917.2 59164.1 59630.4 61301.4 7774.8 7908.8 7932.4 7999.9 8592.2 13042.9 13618.1 13805.3 13860.5 14099.7 11910.3 12037.3 12099.2 12198.9 12251.7 11949.3 12103.6 12116.8 12185.5 12246.3 12100.1 12258.7 12334.6 12388.1 12504.5 7875.7 7963.8 7996.9 8055.6 8372.7 10117.0 12275.2 12427.3 12479.3 12492.6 03:47:04 INFO - PROCESS | 3512 | 03:47:04 INFO - PROCESS | 3512 | [#3] mootools.html Cycles:180 Average:6270.17 Median:4986.71 stddev:3635.81 (72.9%) stddev-sans-first:3628.20 03:47:04 INFO - PROCESS | 3512 | Values: 1481.5 1552.5 1664.2 1790.8 1807.8 8416.5 9094.5 9157.6 9840.0 9844.1 9432.3 9509.7 9525.0 9533.5 9552.5 2419.6 2489.4 2490.5 2491.9 2493.1 2297.7 2436.2 2442.4 2444.8 2446.0 2427.7 2429.5 2441.9 2448.2 2449.0 2439.2 2448.0 2456.7 2478.6 2483.7 2474.4 2483.5 2499.3 2505.2 2512.8 9447.4 9522.9 9525.1 9539.9 9543.4 5455.6 5521.1 5562.5 5562.6 5592.9 3433.0 3571.2 3627.1 3657.3 3661.2 1125.2 1126.8 1133.7 1135.5 1140.4 13375.5 13457.9 13491.1 13500.0 13527.3 4971.5 5001.9 5049.1 5057.4 5086.1 11359.8 11404.2 11430.4 11458.0 11462.7 5687.0 5703.6 5705.1 5725.2 5727.1 4664.1 5094.6 5253.8 5260.3 5267.0 4442.6 4449.9 4453.0 4483.8 4499.0 1366.8 1390.8 1401.0 1409.1 1419.2 855.8 965.2 1036.9 1045.6 1059.6 6326.0 6359.3 6390.5 6396.5 6401.6 497.2 507.1 513.4 519.4 525.7 4440.6 4457.6 4503.4 4509.3 4553.3 11285.6 11453.0 11639.6 11647.7 11647.8 11366.2 11702.0 11954.1 11987.5 12060.5 8928.3 9147.0 9159.3 9201.8 9208.0 6300.4 6412.0 6451.6 6533.2 6535.5 10885.2 11051.5 11203.6 11245.6 11255.4 11353.8 11373.7 11415.8 11484.1 11491.3 7774.1 8261.4 8509.1 8589.4 8635.6 9540.7 9547.3 9584.5 9633.6 9671.6 8075.8 8134.8 8163.8 8251.4 8282.3 8115.1 8162.4 8169.8 8225.0 8288.8 7258.4 7285.5 7359.8 7385.7 7391.4 5496.2 5503.7 5576.4 5577.1 5603.8 5444.3 5454.3 5524.3 5602.9 5753.8 03:47:04 INFO - PROCESS | 3512 | 03:47:04 INFO - PROCESS | 3512 | [#4] prototype.html Cycles:180 Average:5039.43 Median:5707.84 stddev:1495.85 (26.2%) stddev-sans-first:1457.85 03:47:04 INFO - PROCESS | 3512 | Values: 339.3 354.4 358.7 361.4 370.1 5705.9 5742.9 5907.4 5907.4 5927.5 5717.7 5744.5 5754.6 5770.7 5784.4 4492.2 4505.4 4506.1 4527.6 4554.0 4470.7 4525.2 4552.5 4554.8 4575.6 4443.0 4454.1 4475.1 4476.8 4478.5 4323.0 4487.2 4515.2 4519.6 4526.3 3940.6 3942.9 3946.7 3947.3 3957.4 5558.6 5567.1 5588.4 5595.1 5596.1 5070.9 5124.5 5133.5 5170.1 5181.8 5954.9 5973.9 5977.0 6014.5 6022.6 4315.9 4319.9 4357.8 4373.0 4378.7 6164.2 6289.9 6324.5 6361.7 6363.9 4471.6 4488.4 4500.7 4502.5 4506.2 4552.5 4553.1 4553.8 4559.6 4575.5 4783.7 5042.4 5095.0 5147.5 5166.1 5961.5 6041.9 6051.9 6066.8 6122.9 1536.8 1548.3 1550.2 1559.8 1569.3 950.5 953.7 956.3 958.9 962.7 5248.6 5251.2 5251.2 5270.3 5344.5 5412.6 5511.3 5655.8 5678.9 5704.3 4983.3 5272.9 5283.3 5283.7 5294.4 2849.3 2926.3 2960.8 2976.9 3000.4 5709.8 5739.6 5742.5 5807.9 5823.2 5875.9 6374.9 6397.0 6414.9 6426.4 6433.2 6451.2 6483.5 6520.8 6532.7 6044.9 6248.3 6274.0 6290.3 6299.5 6166.4 6183.8 6202.7 6206.3 6257.8 6233.4 6467.4 6512.1 6525.0 6525.3 4456.8 4474.6 4484.4 4487.6 4521.5 6069.6 6316.3 6330.8 6368.4 6368.5 6083.8 6132.7 6141.4 6151.8 6179.9 6016.2 6101.5 6120.9 6137.8 6143.1 5826.3 5873.8 5905.2 5954.4 6001.2 6028.9 6088.9 6129.6 6185.2 6218.8 5806.7 5999.9 6035.3 6046.8 6065.4 03:47:04 INFO - PROCESS | 3512 | 03:47:04 INFO - PROCESS | 3512 | [#5] yui.html Cycles:180 Average:20353.19 Median:25896.91 stddev:29368.19 (113.4%) stddev-sans-first:29413.34 03:47:04 INFO - PROCESS | 3512 | Values: 657.7 750.5 753.3 760.7 846.6 13643.5 14236.6 15134.8 15247.8 15268.6 13033.2 13078.0 13097.5 13130.3 13138.9 726.8 846.2 846.3 857.7 866.6 863.4 869.4 869.5 873.7 875.7 914.8 917.4 918.6 921.0 923.9 916.6 918.3 918.8 921.4 921.5 674.4 677.2 677.4 677.5 679.9 14392.1 14398.1 14433.3 14442.0 14475.3 14041.8 14256.1 14299.7 14340.2 14348.0 11759.3 11938.9 11942.2 11997.0 12021.3 3605.0 3606.5 3620.8 3849.3 3948.9 77216.0 78604.6 81326.0 81554.0 81578.6 11353.7 11648.0 11678.4 11901.8 11976.5 18247.8 18739.3 18864.2 19576.6 19595.1 7956.5 8039.2 8055.4 8085.1 8125.2 4589.0 4639.0 4685.4 4731.7 4753.4 3518.3 3673.8 3683.0 3693.2 3717.2 661.4 667.1 669.0 684.6 689.7 608.7 663.5 723.5 734.7 751.7 9176.3 9570.7 9765.8 9789.8 9798.4 610.8 656.1 712.0 774.2 799.3 4623.8 4719.8 4779.3 4852.7 4888.3 116339.4 119957.4 120200.4 120698.0 120744.4 62899.7 65037.7 77289.0 81680.6 96976.0 85825.0 91132.5 92062.0 93097.0 93910.5 9104.9 9154.4 9189.2 9299.2 9399.9 42708.8 53945.0 54243.2 55430.0 57075.0 47074.0 66521.7 71968.0 78953.0 79431.2 12616.5 13063.1 13136.0 14050.7 14311.4 13738.5 14199.6 14845.4 14911.6 15290.5 12890.3 14326.3 14834.0 15007.5 15176.5 13552.2 13861.2 14111.9 14253.4 14581.6 13060.7 13340.9 13940.0 14417.2 14542.9 11499.9 11543.2 11664.7 11682.8 11789.0 11319.0 11544.1 11768.3 11774.4 11837.8 03:47:04 INFO - PROCESS | 3512 | -------- Summary: end -------- 03:47:04 INFO - PROCESS | 3512 | 03:47:05 INFO - TEST-INFO | 3512: exit 0 03:47:05 INFO - TEST-OK | dromaeo_css | took 1111207ms 03:47:05 INFO - TEST-START | kraken 03:47:05 INFO - operating with platform_type : linux_ 03:47:05 INFO - Initialising browser for kraken test... 03:47:05 INFO - TEST-INFO | started process 3756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNzMz84/profile http://localhost:38491/getInfo.html) 03:47:10 INFO - PROCESS | 3756 | __metrics Screen width/height:1600/1200 03:47:10 INFO - PROCESS | 3756 | colorDepth:24 03:47:10 INFO - PROCESS | 3756 | Browser inner width/height: 1024/697 03:47:10 INFO - PROCESS | 3756 | __metrics 03:47:10 ERROR - PROCESS | 3756 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:47:11 INFO - TEST-INFO | 3756: exit 0 03:47:11 INFO - Browser initialized. 03:47:11 INFO - Running cycle 1/1 for kraken test... 03:47:11 INFO - TEST-INFO | started process 3884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNzMz84/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:23 INFO - PROCESS | 3884 | RSS: Main: 156160000 03:47:23 INFO - PROCESS | 3884 | 03:47:25 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38491/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:26 INFO - PROCESS | 3884 | RSS: Main: 161431552 03:47:26 INFO - PROCESS | 3884 | 03:47:29 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38491/tests/kraken/driver.html?testName=audio-dft) 03:47:30 INFO - PROCESS | 3884 | RSS: Main: 160464896 03:47:30 INFO - PROCESS | 3884 | 03:47:32 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38491/tests/kraken/driver.html?testName=audio-fft) 03:47:33 INFO - PROCESS | 3884 | RSS: Main: 161271808 03:47:33 INFO - PROCESS | 3884 | 03:47:35 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38491/tests/kraken/driver.html?testName=audio-oscillator) 03:47:36 INFO - PROCESS | 3884 | RSS: Main: 161198080 03:47:36 INFO - PROCESS | 3884 | 03:47:38 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:39 INFO - PROCESS | 3884 | RSS: Main: 160997376 03:47:39 INFO - PROCESS | 3884 | 03:47:42 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38491/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:42 INFO - PROCESS | 3884 | RSS: Main: 160583680 03:47:42 INFO - PROCESS | 3884 | 03:47:46 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38491/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:46 INFO - PROCESS | 3884 | RSS: Main: 161443840 03:47:46 INFO - PROCESS | 3884 | 03:47:49 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38491/tests/kraken/driver.html?testName=json-parse-financial) 03:47:50 INFO - PROCESS | 3884 | RSS: Main: 161132544 03:47:50 INFO - PROCESS | 3884 | 03:47:51 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:52 INFO - PROCESS | 3884 | RSS: Main: 161079296 03:47:52 INFO - PROCESS | 3884 | 03:47:54 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38491/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:54 INFO - PROCESS | 3884 | RSS: Main: 160727040 03:47:54 INFO - PROCESS | 3884 | 03:47:56 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:57 INFO - PROCESS | 3884 | RSS: Main: 161116160 03:47:57 INFO - PROCESS | 3884 | 03:47:59 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:00 INFO - PROCESS | 3884 | RSS: Main: 161501184 03:48:00 INFO - PROCESS | 3884 | 03:48:03 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:03 INFO - PROCESS | 3884 | RSS: Main: 161542144 03:48:03 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | Cycle 1(1): loaded http://localhost:38491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38491/tests/kraken/driver.html?testName=ai-astar) 03:48:05 INFO - PROCESS | 3884 | RSS: Main: 161890304 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | __start_tp_report 03:48:05 INFO - PROCESS | 3884 | _x_x_mozilla_page_load 03:48:05 INFO - PROCESS | 3884 | _x_x_mozilla_page_load_details 03:48:05 INFO - PROCESS | 3884 | |i|pagename|runs| 03:48:05 INFO - PROCESS | 3884 | |0;ai-astar;111;104;109;108;110;110;109;110;109;110 03:48:05 INFO - PROCESS | 3884 | |1;audio-beat-detection;151;126;158;176;125;156;149;127;189;123 03:48:05 INFO - PROCESS | 3884 | |2;audio-dft;165;163;165;161;163;163;161;161;162;161 03:48:05 INFO - PROCESS | 3884 | |3;audio-fft;74;73;76;171;75;75;75;74;175;77 03:48:05 INFO - PROCESS | 3884 | |4;audio-oscillator;85;85;147;85;84;85;132;84;85;135 03:48:05 INFO - PROCESS | 3884 | |5;imaging-gaussian-blur;117;117;118;117;118;118;118;117;117;117 03:48:05 INFO - PROCESS | 3884 | |6;imaging-darkroom;147;147;147;148;147;147;147;149;147;146 03:48:05 INFO - PROCESS | 3884 | |7;imaging-desaturate;96;95;95;99;95;96;95;96;95;96 03:48:05 INFO - PROCESS | 3884 | |8;json-parse-financial;62;53;53;54;52;53;55;53;52;54 03:48:05 INFO - PROCESS | 3884 | |9;json-stringify-tinderbox;60;60;59;60;60;60;60;60;60;60 03:48:05 INFO - PROCESS | 3884 | |10;stanford-crypto-aes;83;77;82;79;84;79;78;78;105;77 03:48:05 INFO - PROCESS | 3884 | |11;stanford-crypto-ccm;119;130;130;126;117;126;120;127;123;119 03:48:05 INFO - PROCESS | 3884 | |12;stanford-crypto-pbkdf2;159;154;156;158;160;161;155;156;155;153 03:48:05 INFO - PROCESS | 3884 | |13;stanford-crypto-sha256-iterative;65;63;63;62;62;66;64;62;60;60 03:48:05 INFO - PROCESS | 3884 | __end_tp_report 03:48:05 INFO - PROCESS | 3884 | __start_cc_report 03:48:05 INFO - PROCESS | 3884 | _x_x_mozilla_cycle_collect,855 03:48:05 INFO - PROCESS | 3884 | __end_cc_report 03:48:05 INFO - PROCESS | 3884 | __startTimestamp1466160485718__endTimestamp 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | ------- Summary: start ------- 03:48:05 INFO - PROCESS | 3884 | Number of tests: 14 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:1.94 (1.8%) stddev-sans-first:1.92 03:48:05 INFO - PROCESS | 3884 | Values: 111.0 104.0 109.0 108.0 110.0 110.0 109.0 110.0 109.0 110.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:153.50 stddev:22.90 (14.9%) stddev-sans-first:24.26 03:48:05 INFO - PROCESS | 3884 | Values: 151.0 126.0 158.0 176.0 125.0 156.0 149.0 127.0 189.0 123.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.58 (1.0%) stddev-sans-first:1.39 03:48:05 INFO - PROCESS | 3884 | Values: 165.0 163.0 165.0 161.0 163.0 163.0 161.0 161.0 162.0 161.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.00 stddev:41.40 (55.2%) stddev-sans-first:43.24 03:48:05 INFO - PROCESS | 3884 | Values: 74.0 73.0 76.0 171.0 75.0 75.0 75.0 74.0 175.0 77.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:85.00 stddev:26.01 (30.6%) stddev-sans-first:26.96 03:48:05 INFO - PROCESS | 3884 | Values: 85.0 85.0 147.0 85.0 84.0 85.0 132.0 84.0 85.0 135.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:48:05 INFO - PROCESS | 3884 | Values: 117.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:48:05 INFO - PROCESS | 3884 | Values: 147.0 147.0 147.0 148.0 147.0 147.0 147.0 149.0 147.0 146.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.23 (1.3%) stddev-sans-first:1.30 03:48:05 INFO - PROCESS | 3884 | Values: 96.0 95.0 95.0 99.0 95.0 96.0 95.0 96.0 95.0 96.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:53.50 stddev:2.92 (5.5%) stddev-sans-first:0.97 03:48:05 INFO - PROCESS | 3884 | Values: 62.0 53.0 53.0 54.0 52.0 53.0 55.0 53.0 52.0 54.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 03:48:05 INFO - PROCESS | 3884 | Values: 60.0 60.0 59.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:79.00 stddev:8.39 (10.6%) stddev-sans-first:8.89 03:48:05 INFO - PROCESS | 3884 | Values: 83.0 77.0 82.0 79.0 84.0 79.0 78.0 78.0 105.0 77.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:126.00 stddev:4.76 (3.8%) stddev-sans-first:4.74 03:48:05 INFO - PROCESS | 3884 | Values: 119.0 130.0 130.0 126.0 117.0 126.0 120.0 127.0 123.0 119.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:157.00 stddev:2.67 (1.7%) stddev-sans-first:2.70 03:48:05 INFO - PROCESS | 3884 | Values: 159.0 154.0 156.0 158.0 160.0 161.0 155.0 156.0 155.0 153.0 03:48:05 INFO - PROCESS | 3884 | 03:48:05 INFO - PROCESS | 3884 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.95 (3.1%) stddev-sans-first:1.88 03:48:05 INFO - PROCESS | 3884 | Values: 65.0 63.0 63.0 62.0 62.0 66.0 64.0 62.0 60.0 60.0 03:48:05 INFO - PROCESS | 3884 | -------- Summary: end -------- 03:48:05 INFO - PROCESS | 3884 | 03:48:06 INFO - TEST-INFO | 3884: exit 0 03:48:06 INFO - TEST-OK | kraken | took 61151ms 03:48:06 INFO - SUITE-END | took 1172s 03:48:06 INFO - Completed test suite (00:19:32) 03:48:06 INFO - javascript benchmark 03:48:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7603.210874455554, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.9498058111694, 3368.4610462326027, 3374.0383990562677, 3377.8986630401096, 3403.4894765785116, 5510.118381059031, 5521.25463062487, 5527.723613819308, 5587.580931430149, 5611.579131565129, 5568.3596386415575, 5585.804496842601, 5619.213310136574, 5627.577931655122, 5641.5204707599905, 5032.11937910866, 5094.898102037957, 5140.563052140554, 5148.073346797575, 5160.406553246387, 5032.4967503249745, 5047.64666473347, 5135.948640513584, 5155.9484405155845, 5158.148905430599, 5081.364829396325, 5106.9489305106845, 5110.7700153493, 5133.024725302199, 5143.125668636322, 5093.286939828427, 5155.793768249284, 5185.922211166836, 5194.065068287707, 5225.895482090375, 4890.217565189588, 5104.336436263299, 5126.2054381570915, 5150.175971844525, 5174.275601415805, 5321.122014867542, 5437.646552974044, 5443.972780136113, 5456.890862182774, 5468.2891224141, 5951.732172052268, 5978.581499295051, 5992.0, 6008.609440386361, 6019.909701354483, 5919.378465261128, 5946.732397042144, 6030.276366835964, 6037.0, 6041.577089603729, 5547.5007249347345, 5651.9717401413145, 5654.953833540808, 5655.321361436654, 5682.090865461548, 6131.540134489931, 6157.076438534255, 6160.10678451622, 6160.9383906160365, 6164.0, 5738.282714660668, 5753.079507278815, 5766.942330576724, 5877.706114694248, 5885.411458854081, 5924.674142922181, 5937.52499800015, 5940.0, 5940.584159108907, 5968.432998865101, 5887.852803679943, 5895.64626122434, 5908.20239267702, 5915.970420147958, 5942.524598032147, 5721.971390143022, 5882.764619429968, 5902.527797776168, 5914.378990206053, 5959.106134079922, 4578.2903649934315, 4596.7931443085145, 4599.448066232074, 4607.285870690049, 4629.120467111238, 4103.9179216416105, 4104.610062044101, 4135.56576559463, 4137.131202447459, 4161.334186530141, 5665.12190610456, 5713.8285851424525, 5723.6851973141875, 5775.364709881909, 5800.59395842287, 5975.462208401264, 5998.4601385875485, 5999.460048595647, 6027.7287522061615, 6087.269527656621, 5674.716264186774, 5778.0, 5779.624324418984, 5781.161731548902, 5789.160571717078, 5164.04465173944, 5170.870728231749, 5179.61152913533, 5209.739513024334, 5251.317328747238, 6193.504519638418, 6251.874962500725, 6255.24937007562, 6272.874542509125, 6296.779612713533, 5908.763649453974, 6001.939980600138, 6132.080187971751, 6146.477549408351, 6151.32335443092, 6114.388561144028, 6225.31521532622, 6233.781817636361, 6235.781747638811, 6239.688015599293, 5937.228160339128, 5941.67320797343, 5945.0, 5960.403959604005, 5980.073088671263, 5899.46904778572, 5913.70431478433, 5917.526597872246, 6047.274327080779, 6048.78829240992, 5821.79623713168, 5848.356680765198, 5849.64902105875, 5855.94144058571, 5871.236739223874, 5779.2486976694445, 5805.448482394166, 5813.3895940925595, 5832.679202643895, 5838.299404071538, 5510.0, 5657.8019769307875, 5673.375928647928, 5703.287089113861, 5745.9425405745405, 5918.881622367442, 5941.049432090845, 5953.583249172516, 5961.463468287875, 5962.582619216613, 5810.564207684356, 5819.0689489681445, 5821.476067153976, 5823.18475413451, 5826.679532625746], "value": 5531.783643744179, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.9761209551618, 634.1185751804991, 659.587757651468, 662.6686656671665, 673.9991113196902, 45052.0, 45930.3110453343, 46051.30923036157, 46242.30636540455, 49092.75453622727, 47851.76074119633, 48510.27234591475, 48673.269900951425, 48755.51244487554, 48772.268415973704, 8824.51465169417, 8963.193312601898, 8969.77575560613, 8982.730518084436, 9014.2788576914, 9099.499527525983, 9211.723648290563, 9215.308851836138, 9237.307201959846, 9255.39839910407, 9251.306152038624, 9263.212626926686, 9276.211522020603, 9301.813963720722, 9321.207697345733, 9153.954230228874, 9197.494137822418, 9216.769580760467, 9219.308551858638, 9245.491497967643, 9074.591643375998, 9079.909200907972, 9130.77173070672, 9168.587413566405, 9172.816543669156, 45110.77444612756, 45302.77348613269, 45591.77204113958, 45704.3144352835, 45794.77102614499, 3514.297140571896, 3532.258225772591, 3711.3505136601257, 3894.883153505399, 4313.698041137121, 33696.0, 33964.32071358559, 34020.829895850366, 35003.824980875186, 36314.092147696254, 4159.667226621863, 4217.051163488221, 4248.171606536726, 4257.318828987378, 4330.523642399334, 358737.0, 360846.0, 362087.0, 363791.0, 363882.0, 36024.0, 36235.456468152996, 65807.67096164584, 66329.6683516589, 66391.33608663948, 39354.0, 39610.20779584392, 39788.403173952414, 39791.40312895309, 39999.60000400017, 14282.500112496013, 14417.92791036038, 14419.711605767827, 14442.638934026734, 14453.132812031312, 11280.661580152608, 11471.139664525193, 11473.082153427873, 11477.885221147682, 11494.367809770376, 9251.121143491358, 9258.074192580689, 9335.346525743269, 9340.252779777602, 9372.437653740797, 3574.285142971416, 3579.5167652367118, 3599.532060832075, 3600.3519366513756, 3682.4108142697573, 1137.4710759496875, 1140.1391949078559, 1167.416291854073, 1197.6107764976418, 1272.0713878868478, 34837.47743783845, 35512.822435887654, 35525.111872202884, 37749.433758493644, 37936.74383347144, 1153.8615366156116, 1205.7588482303574, 1260.9495620175273, 1261.892739117167, 1267.2269915351628, 17257.56856078608, 17473.38843140484, 17618.735718964224, 17706.5573360667, 17752.55618609545, 510027.0, 629726.0, 639066.0, 649617.0, 650377.0, 60418.0937285941, 65095.34904650987, 65121.0, 65327.0, 65457.0, 1453.542134227715, 1470.2575199524172, 1475.8155230596176, 1478.9852101479062, 1494.6562290673205, 34051.14872128217, 34393.656063440045, 34565.13587160341, 34572.13569660779, 34672.30655386828, 57296.42703572911, 57322.71338643447, 57810.421895780506, 58094.4190558089, 58226.0, 513015.0, 527094.0, 527208.0, 528793.0, 528934.0, 31444.68555314509, 31821.20446988844, 31904.202394940312, 32054.0, 32277.35445291128, 52064.739676301375, 52956.73521632367, 53307.0, 53610.463895360546, 53623.19565206447, 44160.33759493546, 44602.0, 45090.09819803651, 45338.773306133255, 46237.0, 44090.55909440864, 44138.0, 44367.33448998203, 45488.0, 45943.0, 40030.0, 43942.0, 44709.32936006028, 45187.54812451833, 45441.09117817691, 38416.61583384242, 38464.80767596144, 38571.0, 39409.40885886657, 39645.0, 29708.405831883672, 30004.765970967743, 30440.391192176474, 30535.0, 30764.230894226926], "value": 20223.465517011166, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.32601848015463, 424.76850116686404, 426.36471657230726, 429.5833041949312, 431.69781153192775, 18390.632187356245, 19404.32084877028, 20145.29491467799, 20965.580688386224, 21191.258305959294, 20981.0, 21304.89347553264, 22014.33956981293, 22175.889120554373, 22338.553228935412, 6624.966875165617, 6683.164604424447, 6863.313668633146, 6878.243393226741, 6978.476614253926, 6785.52501324905, 6805.965970170142, 6832.0, 6856.52004359695, 6870.072540207083, 6629.801105966829, 6802.727890884359, 6823.658817059152, 6824.761133360334, 6831.4534837212905, 6595.53831231814, 6766.526343155956, 6786.864262714743, 6800.149981252343, 6825.1809782825885, 6578.868422631568, 6580.93419065808, 6618.536702430832, 6658.733650654017, 6662.0, 26628.0, 27149.45701085987, 27838.443231135465, 28314.858425707946, 28497.430051399064, 2600.700919394275, 2667.6398686177504, 2668.866556672159, 2720.5239083160563, 2747.986260068707, 16714.498565043068, 17286.740698889527, 17307.53849230159, 17415.65168696619, 17746.645067098587, 2183.6069507488646, 2202.922897698573, 2270.5345404192267, 2326.8720220387872, 2335.8364914455997, 99050.0094999048, 99363.50318248362, 101453.0, 101986.0, 102899.0, 17965.281388744304, 18476.630467390576, 18631.720524192147, 19216.0, 19308.8069119307, 11297.49161287744, 35270.8236458816, 35302.47046294308, 35337.64662353395, 35345.29309413849, 5815.331236907725, 5911.438413350725, 6848.9657551711925, 7833.589953808255, 7951.125376208613, 7707.190744971809, 7777.650005749755, 7809.609519524001, 7817.921820781833, 7908.5650289234645, 4015.638592526628, 4137.50349958001, 4284.014676624394, 4381.452318460192, 4432.955670443319, 2025.584755125196, 2100.705901173837, 2112.8309735221146, 2132.632777616844, 2144.7962443567835, 1029.7013865978931, 1034.4517405774952, 1067.3755852826027, 1083.3012706804068, 1175.1127898436625, 19160.137793799313, 19592.608147836963, 19659.60680786405, 19999.400017999484, 20223.191072357236, 1075.9623413180502, 1081.6322450366913, 1085.6091806949491, 1094.7427354571669, 1101.895319944604, 10577.947110264553, 11043.116550675926, 11058.944705276423, 11083.72290692723, 11140.108791296676, 489921.0, 498698.0, 500847.0, 501416.0, 503934.0, 73725.26274737185, 92107.5394623036, 99020.0, 99192.5040374808, 99653.50173249232, 1029.120102312527, 1029.2692188546066, 1054.5254635414094, 1059.5285098131412, 1061.7823346213854, 17538.649227015132, 17802.37691680785, 17830.286788528832, 17953.0, 18137.818621813614, 40803.38794918019, 41235.587644124374, 42640.78679606582, 42871.57128428676, 43366.56633433751, 51907.0, 52917.20624190717, 59164.112538312824, 59630.40369596422, 61301.38698612957, 7774.844503110019, 7908.762737117896, 7932.365410767009, 7999.920000800151, 8592.226699597066, 13042.869571304545, 13618.114822536503, 13805.309734513436, 13860.514881979083, 14099.718005639625, 11910.285382877055, 12037.277763334228, 12099.213551119148, 12198.878011219775, 12251.69370765738, 11949.283043017447, 12103.576374826838, 12116.818247726114, 12185.512579497075, 12246.265224086583, 12100.092493062879, 12258.693532661755, 12334.629961101182, 12388.070894683115, 12504.499820007099, 7875.684972601031, 7963.761087167394, 7996.92003079985, 8055.597220139087, 8372.748817535483, 10117.038881306264, 12275.2021118627, 12427.254364738144, 12479.251244925334, 12492.625221243377], "value": 10213.104072794567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.4740767027708, 1552.5264794237758, 1664.1928664597667, 1790.7672002639663, 1807.7830660320762, 8416.45293055951, 9094.49980251086, 9157.587908544116, 9839.950800245988, 9844.114029737322, 9432.339736218468, 9509.667161649344, 9525.0, 9533.47565883876, 9552.474613896251, 2419.5523828091773, 2489.352768280251, 2490.5267999080206, 2491.862947537885, 2493.1024831060804, 2297.655351697242, 2436.1838784007377, 2442.4016116051594, 2444.767747064026, 2446.0, 2427.6890479141243, 2429.5019520998153, 2441.914532991346, 2448.2410452759614, 2448.9877550612223, 2439.231642032763, 2448.045262347686, 2456.6929133858266, 2478.5910324796387, 2483.6522886795865, 2474.381404648838, 2483.466054798227, 2499.2877030046347, 2505.185814610241, 2512.773850353459, 9447.385919915183, 9522.904770952271, 9525.095115963972, 9539.90460095397, 9543.427394356291, 5455.618106732531, 5521.116621340566, 5562.499375056264, 5562.582806289544, 5592.916106258409, 3432.982835085809, 3571.23218508022, 3627.093226693327, 3657.3416784978695, 3661.176235347052, 1125.1729978465821, 1126.752114534801, 1133.7449073958376, 1135.477680267078, 1140.389891408101, 13375.531856385078, 13457.86542134576, 13491.123076999964, 13500.0, 13527.32363381827, 4971.527704868032, 5001.899962000813, 5049.116404629175, 5057.367829021372, 5086.059079070384, 11359.772804544029, 11404.201705880509, 11430.428478576037, 11458.026067784333, 11462.713432164262, 5686.9715651421475, 5703.62926409782, 5705.058665320259, 5725.227094342211, 5727.083666613322, 4664.137134630104, 5094.643374963791, 5253.789848406097, 5260.316158899395, 5267.0, 4442.644588432918, 4449.911001779947, 4452.9554704453185, 4483.775811209426, 4499.032707967803, 1366.842813076489, 1390.7566175919173, 1400.9579712608638, 1409.1474657832068, 1419.233613848531, 855.7988872614931, 965.1795973422535, 1036.8859425463193, 1045.560864436923, 1059.6079450603327, 6325.96837015812, 6359.268684101295, 6390.520710946697, 6396.5202609804455, 6401.58389704677, 497.19702680171264, 507.14039702703565, 513.3557385481197, 519.4026869100489, 525.7423862307518, 4440.578145076212, 4457.576530229688, 4503.369528266046, 4509.323601459741, 4553.317002449659, 11285.605003824827, 11453.0, 11639.59261425846, 11647.71875093739, 11647.76704465923, 11366.204365694488, 11702.0, 11954.103442241867, 11987.52049918011, 12060.51757929673, 8928.330375221884, 9146.954265228764, 9159.267258619428, 9201.815963680689, 9208.0, 6300.369963003663, 6411.967940160456, 6451.612903225821, 6533.18335208099, 6535.509836762357, 10885.238033337908, 11051.502682379152, 11203.551857925591, 11245.606403775828, 11255.437228138397, 11353.772924541629, 11373.715657108638, 11415.828762568734, 11484.081273497934, 11491.310521368745, 7774.144844067035, 8261.38039647041, 8509.10654381281, 8589.398742088244, 8635.568221589021, 9540.713778586654, 9547.33168678186, 9584.472853993097, 9633.614655413985, 9671.564779584794, 8075.788631705056, 8134.837303253784, 8163.755087347389, 8251.381146413923, 8282.296004839656, 8115.147909469657, 8162.387820913574, 8169.836603268021, 8225.0, 8288.792780180544, 7258.383037441666, 7285.526440781332, 7359.77920662381, 7385.667644956097, 7391.371733402721, 5496.203050557727, 5503.724813759216, 5576.442355764391, 5577.135543990688, 5603.7758489659955, 5444.346678398618, 5454.318210223722, 5524.309461317335, 5602.887942241214, 5753.798617048383], "value": 4902.654582920594, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.26887557313995, 354.40283122937853, 358.74349839864493, 361.3621957245464, 370.14496513054826, 5705.857353566163, 5742.942570574293, 5907.350191478939, 5907.409259074096, 5927.525797936171, 5717.742096738722, 5744.4829965303115, 5754.568407369443, 5770.682612456313, 5784.363719990798, 4492.236319825637, 4505.414296141514, 4506.143832671798, 4527.56988086133, 4553.977230113845, 4470.742275151044, 4525.208088584501, 4552.453705555338, 4554.84058057968, 4575.565321294472, 4442.97778511107, 4454.109178164364, 4475.1049790042125, 4476.798544065525, 4478.507364189936, 4323.0, 4487.237169681146, 4515.209838278321, 4519.615832654228, 4526.253168227238, 3940.5862384449506, 3942.940855887164, 3946.7039972002217, 3947.2500224957453, 3957.406389041638, 5558.638688485276, 5567.081431563787, 5588.357338905997, 5595.076812325961, 5596.132599447093, 5070.873228169326, 5124.4875512448825, 5133.512316329943, 5170.121079416471, 5181.792728290864, 5954.910676339859, 5973.940260597382, 5977.0114942528735, 6014.548908831812, 6022.578419510636, 4315.870523884289, 4319.913601727979, 4357.760323182224, 4372.956270437287, 4378.671599630041, 6164.229471316085, 6289.937100628981, 6324.525660575475, 6361.713722882481, 6363.904541431929, 4471.5528447155675, 4488.3940668010055, 4500.707454015478, 4502.5047244803045, 4506.233940230169, 4552.544745525487, 4553.089382123589, 4553.772311384418, 4559.589636932692, 4575.496695363508, 4783.679915241105, 5042.420121686053, 5094.974525127424, 5147.485251474897, 5166.147585648401, 5961.463468287789, 6041.855141424819, 6051.939480605226, 6066.787662431882, 6122.8876037766895, 1536.7694845773224, 1548.3419546692835, 1550.2016461522326, 1559.7755761727217, 1569.285974881449, 950.5342382232794, 953.7172502983476, 956.3018996132723, 958.8561715742694, 962.6630679262203, 5248.580113590903, 5251.212318152231, 5251.2123181523075, 5270.341207349082, 5344.465553444702, 5412.646838290428, 5511.311086114236, 5655.830325090254, 5678.914816277759, 5704.286964129484, 4983.277424773388, 5272.894542109137, 5283.260343551906, 5283.682979021194, 5294.41761406245, 2849.344650730344, 2926.326944802665, 2960.7927445079067, 2976.9283058099068, 3000.354923691373, 5709.8287051388525, 5739.5695322850115, 5742.54059675225, 5807.854803629859, 5823.213866128103, 5875.853103672357, 6374.872502549923, 6397.0, 6414.941534646824, 6426.3573642635365, 6433.228012638513, 6451.161349024596, 6483.481321494363, 6520.794087813429, 6532.738690452328, 6044.879102418015, 6248.250209974832, 6274.0, 6290.308066112815, 6299.511692881195, 6166.383361663798, 6183.752649893954, 6202.7208775606105, 6206.348333425106, 6257.812265632038, 6233.379321376384, 6467.385598368148, 6512.055751915851, 6525.0, 6525.282218956006, 4456.7548784817145, 4474.574915383034, 4484.417025786627, 4487.551244875486, 4521.480029796484, 6069.605475644069, 6316.263027667428, 6330.8100756977365, 6368.426841584094, 6368.490520758421, 6083.756649733961, 6132.693365331805, 6141.420603346516, 6151.784687535915, 6179.876402471836, 6016.157737916783, 6101.542384321282, 6120.867639486709, 6137.815865524041, 6143.139960405458, 5826.271716035496, 5873.765049397976, 5905.202797622266, 5954.434328738763, 6001.219841420588, 6028.939710602838, 6088.908666369919, 6129.601575897553, 6185.165002724574, 6218.813435596759, 5806.709664516673, 5999.940000600112, 6035.336113027652, 6046.818595442144, 6065.423784740443], "value": 4557.663358317416, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.700746160497, 750.5271678842329, 753.3069575990089, 760.6539024743743, 846.5809424334954, 13643.454261829527, 14236.644083897894, 15134.848651513495, 15247.771283430757, 15268.618284542892, 13033.218006919591, 13078.0, 13097.47610095595, 13130.277834719087, 13138.934305328485, 726.8073960400499, 846.2130218896424, 846.3356265331701, 857.7469646454311, 866.6446756829702, 863.4258218284833, 869.3740506835101, 869.4696235296464, 873.6505397840851, 875.689130358723, 914.7713071732067, 917.3716004536881, 918.5590916360151, 921.0237148622448, 923.8798956135693, 916.5554705967601, 918.3433844800966, 918.8300164469562, 921.4333185091187, 921.5115988526092, 674.3627272227747, 677.1738479055545, 677.3869647968596, 677.4614181725491, 679.8708245433402, 14392.136471811726, 14398.064125831788, 14433.278336083154, 14442.0, 14475.276236188254, 14041.78937315941, 14256.14463132205, 14299.714005719932, 14340.211288379134, 14348.0, 11759.294442333487, 11938.940305298418, 11942.164048516608, 11997.040236781037, 12021.278723276631, 3604.981975090134, 3606.495090687306, 3620.837062332201, 3849.30712471755, 3948.8617898373705, 77216.0, 78604.60697696474, 81325.9999999994, 81554.0, 81578.59210703909, 11353.716157095974, 11648.0, 11678.416079196006, 11901.750316216672, 11976.52093916251, 18247.81752182461, 18739.34412295563, 18864.245430182913, 19576.608467830563, 19595.11821967986, 7956.482828616122, 8039.15588863161, 8055.395845311625, 8085.110637829834, 8125.228103330174, 4589.0, 4639.0, 4685.367475390779, 4731.739754313477, 4753.35829662998, 3518.313928783914, 3673.779573225615, 3683.0239986403626, 3693.2059607184046, 3717.182219911615, 661.4476911778719, 667.1194023888518, 668.9698963546653, 684.5721424109931, 689.7034275261685, 608.7139044649008, 663.5023732200849, 723.5405517496428, 734.6840858430926, 751.6918063593901, 9176.265898728087, 9570.712878613653, 9765.804683906283, 9789.804203915883, 9798.363106398061, 610.7770663707714, 656.0945894665426, 711.9679614417364, 774.1716363491123, 799.3205775091126, 4623.838165664186, 4719.811207551728, 4779.3070004849105, 4852.684575502581, 4888.26675998596, 116339.41830290794, 119957.40021299837, 120200.39899800446, 120698.0, 120744.39627801804, 62899.685501572196, 65037.67481162564, 77289.0, 81680.59159704282, 96976.03023969811, 85825.0, 91132.54433727922, 92062.0, 93097.0, 93910.53044734869, 9104.908950910407, 9154.40496367734, 9189.172974432333, 9299.209567186594, 9399.919009314017, 42708.78645606752, 53945.0, 54243.186352205536, 55430.0, 57075.0, 47074.0, 66521.66739166273, 71968.0, 78953.0, 79431.20568794238, 12616.495340186657, 13063.085584009408, 13136.0, 14050.718985620026, 14311.427542898167, 13738.519151829638, 14199.64500887486, 14845.40618375253, 14911.552653420415, 15290.464833730766, 12890.29103399322, 14326.283685815875, 14834.035787673767, 15007.549773506813, 15176.468823591122, 13552.186868787905, 13861.168329900238, 14111.858881411465, 14253.35859886287, 14581.562553123424, 13060.738785224052, 13340.86659133435, 13940.0, 14417.207053612152, 14542.85457145415, 11499.94250028778, 11543.249688770204, 11664.6500604982, 11682.824757628472, 11788.997935175606, 11319.0, 11544.093760152069, 11768.293902365886, 11774.411279436164, 11837.763244734884], "value": 7566.396663647523, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 109.0, 108.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 158.0, 176.0, 125.0, 156.0, 149.0, 127.0, 189.0, 123.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 165.0, 161.0, 163.0, 163.0, 161.0, 161.0, 162.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 171.0, 75.0, 75.0, 75.0, 74.0, 175.0, 77.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 147.0, 85.0, 84.0, 85.0, 132.0, 84.0, 85.0, 135.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 149.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 99.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 53.0, 53.0, 54.0, 52.0, 53.0, 55.0, 53.0, 52.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 82.0, 79.0, 84.0, 79.0, 78.0, 78.0, 105.0, 77.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 130.0, 130.0, 126.0, 117.0, 126.0, 120.0, 127.0, 123.0, 119.0], "value": 123.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 154.0, 156.0, 158.0, 160.0, 161.0, 155.0, 156.0, 155.0, 153.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 62.0, 62.0, 66.0, 64.0, 62.0, 60.0, 60.0], "value": 62.7, "unit": "score"}]}]} 03:48:06 INFO - Return code: 0 03:48:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:07 ERROR - # TBPL SUCCESS # 03:48:07 INFO - Running post-action listener: _resource_record_post_action 03:48:07 INFO - ##### 03:48:07 INFO - ##### Finished run-tests step (success) 03:48:07 INFO - ##### 03:48:07 INFO - Running post-run listener: _resource_record_post_run 03:48:07 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 7925760; Write bytes: 384888832; Read time: 2264; Write time: 383228 03:48:07 INFO - TinderboxPrint: CPU usage
13.4% 03:48:07 INFO - TinderboxPrint: I/O read bytes / time
7,925,760 / 2,264 03:48:07 INFO - TinderboxPrint: I/O write bytes / time
384,888,832 / 383,228 03:48:07 INFO - TinderboxPrint: CPU idle
8,221.0 (86.6%) 03:48:07 INFO - TinderboxPrint: CPU user
1,212.8 (12.8%) 03:48:07 INFO - TinderboxPrint: Swap in / out
0 / 0 03:48:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 8810496; Read time: 0; Write time: 13936 03:48:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 6160384; Write bytes: 310566912; Read time: 1984; Write time: 316096 03:48:07 INFO - Running post-run listener: _upload_blobber_files 03:48:07 INFO - Blob upload gear active. 03:48:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:07 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 03:48:07 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:48:07 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:48:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:48:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:48:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:12 INFO - (blobuploader) - INFO - Done attempting. 03:48:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:48:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:48:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:13 INFO - (blobuploader) - INFO - Done attempting. 03:48:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:48:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:48:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:13 INFO - (blobuploader) - INFO - Done attempting. 03:48:13 INFO - (blobuploader) - INFO - Iteration through files over. 03:48:13 INFO - Return code: 0 03:48:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:48:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:48:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a8df78ca057bdccbfb21be0ecf3349ef5ba037df6ac8afc10b9ccc4a77d5d75815f8df3f724f5c7ef5f09dae2c343d835c3f18e2389af9e7df40f563d629710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a8b51dfed9906a9fae2220af6fae272f420490d9a2aadced2e769e9525c1a4822cd7711e01770d1039be191b8a30649dd8dc916bb504c564f49af9d4c758152", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f9cd8d45791effc781cc13574de5d6003df1f55636c690863391d8243a939bda3e0f22859d097b92435ae08cea8170dea3a04c3648e606ebe61e19d2d264cc9"} 03:48:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:48:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:48:13 INFO - Contents: 03:48:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a8df78ca057bdccbfb21be0ecf3349ef5ba037df6ac8afc10b9ccc4a77d5d75815f8df3f724f5c7ef5f09dae2c343d835c3f18e2389af9e7df40f563d629710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a8b51dfed9906a9fae2220af6fae272f420490d9a2aadced2e769e9525c1a4822cd7711e01770d1039be191b8a30649dd8dc916bb504c564f49af9d4c758152", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f9cd8d45791effc781cc13574de5d6003df1f55636c690863391d8243a939bda3e0f22859d097b92435ae08cea8170dea3a04c3648e606ebe61e19d2d264cc9"} 03:48:13 INFO - Running post-run listener: copy_logs_to_upload_dir 03:48:13 INFO - Copying logs to upload dir... 03:48:13 INFO - mkdir: /builds/slave/test/build/upload/logs 03:48:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.186312 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-17 03:48:13.806833) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 03:48:13.813956) ========= 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=232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a8df78ca057bdccbfb21be0ecf3349ef5ba037df6ac8afc10b9ccc4a77d5d75815f8df3f724f5c7ef5f09dae2c343d835c3f18e2389af9e7df40f563d629710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a8b51dfed9906a9fae2220af6fae272f420490d9a2aadced2e769e9525c1a4822cd7711e01770d1039be191b8a30649dd8dc916bb504c564f49af9d4c758152", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f9cd8d45791effc781cc13574de5d6003df1f55636c690863391d8243a939bda3e0f22859d097b92435ae08cea8170dea3a04c3648e606ebe61e19d2d264cc9"} build_url:https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/BQ0Qe_RhSfqnmAjp5-zxPQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a8df78ca057bdccbfb21be0ecf3349ef5ba037df6ac8afc10b9ccc4a77d5d75815f8df3f724f5c7ef5f09dae2c343d835c3f18e2389af9e7df40f563d629710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a8b51dfed9906a9fae2220af6fae272f420490d9a2aadced2e769e9525c1a4822cd7711e01770d1039be191b8a30649dd8dc916bb504c564f49af9d4c758152", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f9cd8d45791effc781cc13574de5d6003df1f55636c690863391d8243a939bda3e0f22859d097b92435ae08cea8170dea3a04c3648e606ebe61e19d2d264cc9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 03:48:13.842280) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 03:48:13.842637) ========= 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=232498196343f89f466a4a9a000001c8-1466156839.307885-1327140775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 03:48:13.923409) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 03:48:13.926770) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 03:48:13.927083) ========= ========= Total master_lag: 0.17 =========