builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1467740145.62 results: success (0) buildid: 20160705075627 builduid: 2c8fae7d84bc4a0aaf8e24287f8e3068 revision: 7a72bfa56d502710aed70440c5da165a9fecb36b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:45.617433) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:45.617944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:45.618330) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:45.636289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:45.636602) ========= 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=4300f881736b422476174874000001bc-1467740144.883864-1162193712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 10:35:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-07-05 10:35:45 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:45.737594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:45.737950) ========= 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=4300f881736b422476174874000001bc-1467740144.883864-1162193712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019280 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:45.787183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:45.787558) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7a72bfa56d502710aed70440c5da165a9fecb36b --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 7a72bfa56d502710aed70440c5da165a9fecb36b --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=4300f881736b422476174874000001bc-1467740144.883864-1162193712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 10:35:46,097 truncating revision to first 12 chars 2016-07-05 10:35:46,097 Setting DEBUG logging. 2016-07-05 10:35:46,097 attempt 1/10 2016-07-05 10:35:46,097 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7a72bfa56d50?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 10:35:46,412 unpacking tar archive at: mozilla-aurora-7a72bfa56d50/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684845 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:46.490668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:46.491499) ========= script_repo_revision: 7a72bfa56d502710aed70440c5da165a9fecb36b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:46.492517) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:46.493182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:35:46.514806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-05 10:35:46.515525) ========= /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=4300f881736b422476174874000001bc-1467740144.883864-1162193712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:35:46 INFO - MultiFileLogger online at 20160705 10:35:46 in /builds/slave/test 10:35:46 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 10:35:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:35:46 INFO - {'append_to_log': False, 10:35:46 INFO - 'base_work_dir': '/builds/slave/test', 10:35:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:35:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:35:46 INFO - 'branch': 'Mozilla-Aurora', 10:35:46 INFO - 'buildbot_json_path': 'buildprops.json', 10:35:46 INFO - 'config_files': ('talos/linux_config.py',), 10:35:46 INFO - 'default_actions': ('clobber', 10:35:46 INFO - 'read-buildbot-config', 10:35:46 INFO - 'download-and-extract', 10:35:46 INFO - 'populate-webroot', 10:35:46 INFO - 'create-virtualenv', 10:35:46 INFO - 'install', 10:35:46 INFO - 'run-tests'), 10:35:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:35:46 INFO - 'download_minidump_stackwalk': True, 10:35:46 INFO - 'download_symbols': 'ondemand', 10:35:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:35:46 INFO - 'tooltool.py': '/tools/tooltool.py', 10:35:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:35:46 INFO - '/tools/misc-python/virtualenv.py')}, 10:35:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:35:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:35:46 INFO - 'installer_path': 'installer.exe', 10:35:46 INFO - 'log_level': 'info', 10:35:46 INFO - 'log_name': 'talos', 10:35:46 INFO - 'log_to_console': True, 10:35:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:35:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:35:46 INFO - 'opt_config_files': (), 10:35:46 INFO - 'pip_index': False, 10:35:46 INFO - 'sps_profile': False, 10:35:46 INFO - 'sps_profile_interval': 0, 10:35:46 INFO - 'suite': 'dromaeojs-e10s', 10:35:46 INFO - 'system_bits': '32', 10:35:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:35:46 INFO - 'title': 'talos-linux64-ix-045', 10:35:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:35:46 INFO - 'use_talos_json': True, 10:35:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:35:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:35:46 INFO - 'work_dir': 'build'} 10:35:46 INFO - ##### 10:35:46 INFO - ##### Running clobber step. 10:35:46 INFO - ##### 10:35:46 INFO - Running pre-action listener: _resource_record_pre_action 10:35:46 INFO - Running main action method: clobber 10:35:46 INFO - rmtree: /builds/slave/test/build 10:35:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:35:47 INFO - Running post-action listener: _resource_record_post_action 10:35:47 INFO - ##### 10:35:47 INFO - ##### Finished clobber step (success) 10:35:47 INFO - ##### 10:35:47 INFO - ##### 10:35:47 INFO - ##### Running read-buildbot-config step. 10:35:47 INFO - ##### 10:35:47 INFO - Running pre-action listener: _resource_record_pre_action 10:35:47 INFO - Running main action method: read_buildbot_config 10:35:47 INFO - Using buildbot properties: 10:35:47 INFO - { 10:35:47 INFO - "project": "", 10:35:47 INFO - "product": "firefox", 10:35:47 INFO - "script_repo_revision": "production", 10:35:47 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:35:47 INFO - "repository": "", 10:35:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:35:47 INFO - "buildid": "20160705075627", 10:35:47 INFO - "pgo_build": "True", 10:35:47 INFO - "basedir": "/builds/slave/test", 10:35:47 INFO - "buildnumber": 386, 10:35:47 INFO - "slavename": "talos-linux64-ix-045", 10:35:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:35:47 INFO - "platform": "ubuntu64_hw", 10:35:47 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:35:47 INFO - "branch": "mozilla-aurora", 10:35:47 INFO - "repo_path": "releases/mozilla-aurora", 10:35:47 INFO - "revision": "7a72bfa56d502710aed70440c5da165a9fecb36b", 10:35:47 INFO - "stage_platform": "linux64-pgo", 10:35:47 INFO - "builduid": "2c8fae7d84bc4a0aaf8e24287f8e3068", 10:35:47 INFO - "slavebuilddir": "test" 10:35:47 INFO - } 10:35:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 10:35:47 INFO - Running post-action listener: _resource_record_post_action 10:35:47 INFO - ##### 10:35:47 INFO - ##### Finished read-buildbot-config step (success) 10:35:47 INFO - ##### 10:35:47 INFO - ##### 10:35:47 INFO - ##### Running download-and-extract step. 10:35:47 INFO - ##### 10:35:47 INFO - Running pre-action listener: _resource_record_pre_action 10:35:47 INFO - Running main action method: download_and_extract 10:35:47 INFO - mkdir: /builds/slave/test/build/tests 10:35: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')]} 10:35:47 INFO - https://queue.taskcluster.net/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:35:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:35:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:35:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/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 10:35:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/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 10:35:48 INFO - Downloaded 1361 bytes. 10:35:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:35:48 INFO - Using the following test package requirements: 10:35:48 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:35:48 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:35:48 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:35:48 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:48 INFO - u'jsshell-linux-x86_64.zip'], 10:35:48 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:35:48 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:35:48 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:35:48 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:35:48 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:35:48 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:35:48 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:35: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')]} 10:35:48 INFO - https://queue.taskcluster.net/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/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 10:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/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 10:35:49 INFO - Downloaded 24526733 bytes. 10:35:49 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'] 10:35:49 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 10:35:50 INFO - Return code: 0 10:35:50 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 10:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:50 INFO - https://queue.taskcluster.net/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:35:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:35:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:35:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/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 10:35:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/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 10:35:51 INFO - Downloaded 24526733 bytes. 10:35:51 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'] 10:35:51 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 10:35:53 INFO - Return code: 0 10:35: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')]} 10:35:53 INFO - https://queue.taskcluster.net/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:35:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:35:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:35:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/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 10:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/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 10:35:54 INFO - Downloaded 10833369 bytes. 10:35:54 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'] 10:35:54 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 10:35:54 INFO - Return code: 0 10:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:54 INFO - https://queue.taskcluster.net/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/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 10:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CYkbnanSTemai3t21O6ahg/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 10:35:55 INFO - Downloaded 63640537 bytes. 10:35:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:35:55 INFO - mkdir: /builds/slave/test/properties 10:35:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:35:55 INFO - Writing to file /builds/slave/test/properties/build_url 10:35:55 INFO - Contents: 10:35:55 INFO - build_url:https://queue.taskcluster.net/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:35:56 INFO - Running post-action listener: _resource_record_post_action 10:35:56 INFO - Running post-action listener: set_extra_try_arguments 10:35:56 INFO - ##### 10:35:56 INFO - ##### Finished download-and-extract step (success) 10:35:56 INFO - ##### 10:35:56 INFO - ##### 10:35:56 INFO - ##### Running populate-webroot step. 10:35:56 INFO - ##### 10:35:56 INFO - Running pre-action listener: _resource_record_pre_action 10:35:56 INFO - Running main action method: populate_webroot 10:35:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:35:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:35:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:35:56 INFO - '--tppagecycles', 10:35:56 INFO - '7'], 10:35:56 INFO - 'tests': ['tsvgm']}}, 10:35:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:35:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:35:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:35:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:35:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:35:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:35:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:56 INFO - 'talos_options': ['--disable-e10s'], 10:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:56 INFO - 'talos_options': ['--disable-e10s'], 10:35:56 INFO - 'tests': ['damp', 'tps']}, 10:35:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:56 INFO - 'tests': ['damp', 'tps']}, 10:35:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:35:56 INFO - 'tests': ['dromaeo_dom']}, 10:35:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:35:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:35:56 INFO - 'tests': ['a11yr', 10:35:56 INFO - 'ts_paint', 10:35:56 INFO - 'tpaint', 10:35:56 INFO - 'sessionrestore', 10:35:56 INFO - 'sessionrestore_no_auto_restore', 10:35:56 INFO - 'tabpaint']}, 10:35:56 INFO - 'other-e10s': {'tests': ['a11yr', 10:35:56 INFO - 'ts_paint', 10:35:56 INFO - 'tpaint', 10:35:56 INFO - 'sessionrestore', 10:35:56 INFO - 'sessionrestore_no_auto_restore', 10:35:56 INFO - 'tabpaint']}, 10:35:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:35:56 INFO - 'ts_paint', 10:35:56 INFO - 'tpaint', 10:35:56 INFO - 'sessionrestore', 10:35:56 INFO - 'sessionrestore_no_auto_restore', 10:35:56 INFO - 'tabpaint']}, 10:35:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:35:56 INFO - 'ts_paint', 10:35:56 INFO - 'tpaint', 10:35:56 INFO - 'sessionrestore', 10:35:56 INFO - 'sessionrestore_no_auto_restore', 10:35:56 INFO - 'tabpaint']}, 10:35:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:35:56 INFO - 'tests': ['a11yr', 10:35:56 INFO - 'ts_paint', 10:35:56 INFO - 'tpaint', 10:35:56 INFO - 'sessionrestore', 10:35:56 INFO - 'sessionrestore_no_auto_restore', 10:35:56 INFO - 'tabpaint']}, 10:35:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:35:56 INFO - 'tests': ['a11yr', 10:35:56 INFO - 'ts_paint', 10:35:56 INFO - 'tpaint', 10:35:56 INFO - 'sessionrestore', 10:35:56 INFO - 'sessionrestore_no_auto_restore', 10:35:56 INFO - 'tabpaint']}, 10:35:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:35:56 INFO - 'tests': ['tsvgx', 10:35:56 INFO - 'tsvgr_opacity', 10:35:56 INFO - 'tart', 10:35:56 INFO - 'tscrollx', 10:35:56 INFO - 'cart']}, 10:35:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:35:56 INFO - 'tsvgr_opacity', 10:35:56 INFO - 'tart', 10:35:56 INFO - 'tscrollx', 10:35:56 INFO - 'cart']}, 10:35:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:56 INFO - 'talos_options': ['--disable-e10s'], 10:35:56 INFO - 'tests': ['tp5o']}, 10:35:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:56 INFO - 'tests': ['tp5o']}, 10:35:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:56 INFO - 'talos_options': ['--disable-e10s', 10:35:56 INFO - '--xperf_path', 10:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:56 INFO - 'tests': ['tp5n']}, 10:35:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:56 INFO - 'talos_options': ['--xperf_path', 10:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:56 INFO - 'tests': ['tp5n']}}, 10:35:56 INFO - 'talos.zip': {'path': '', 10:35:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:35:56 INFO - Running post-action listener: _resource_record_post_action 10:35:56 INFO - ##### 10:35:56 INFO - ##### Finished populate-webroot step (success) 10:35:56 INFO - ##### 10:35:56 INFO - ##### 10:35:56 INFO - ##### Running create-virtualenv step. 10:35:56 INFO - ##### 10:35:56 INFO - Running pre-action listener: _resource_record_pre_action 10:35:56 INFO - Running main action method: create_virtualenv 10:35:56 INFO - Creating virtualenv /builds/slave/test/build/venv 10:35:56 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 10:35:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:35:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:35:56 INFO - Using real prefix '/usr' 10:35:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:35:57 INFO - Installing distribute.............................................................................................................................................................................................done. 10:35:59 INFO - Installing pip.................done. 10:35:59 INFO - Return code: 0 10:35:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:35: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')]} 10:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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')]} 10:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe4d00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e02e0>, '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 0x194c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194c5d0>, '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': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', '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 10:35: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', 'pip>=1.5'] in /builds/slave/test/build 10:35: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 pip>=1.5 10:35:59 INFO - Using env: {'DISPLAY': ':0', 10:35:59 INFO - 'HOME': '/home/cltbld', 10:35:59 INFO - 'LANG': 'en_US.UTF-8', 10:35:59 INFO - 'LANGUAGE': 'en_US:en', 10:35:59 INFO - 'LOGNAME': 'cltbld', 10:35:59 INFO - 'MAIL': '/var/mail/cltbld', 10:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:59 INFO - 'MOZ_NO_REMOTE': '1', 10:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:59 INFO - 'NO_EM_RESTART': '1', 10:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:59 INFO - 'PWD': '/builds/slave/test', 10:35:59 INFO - 'SHELL': '/bin/bash', 10:35:59 INFO - 'SHLVL': '1', 10:35:59 INFO - 'TERM': 'linux', 10:35:59 INFO - 'TMOUT': '86400', 10:35:59 INFO - 'USER': 'cltbld', 10:35:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', 10:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:59 INFO - '_': '/tools/buildbot/bin/python'} 10:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:59 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 10:35:59 INFO - Cleaning up... 10:35:59 INFO - Return code: 0 10:35:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:35: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')]} 10:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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')]} 10:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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', '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 0x7fbe4d00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e02e0>, '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 0x194c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194c5d0>, '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': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', '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 10:35: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:35: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 psutil>=3.1.1 10:35:59 INFO - Using env: {'DISPLAY': ':0', 10:35:59 INFO - 'HOME': '/home/cltbld', 10:35:59 INFO - 'LANG': 'en_US.UTF-8', 10:35:59 INFO - 'LANGUAGE': 'en_US:en', 10:35:59 INFO - 'LOGNAME': 'cltbld', 10:35:59 INFO - 'MAIL': '/var/mail/cltbld', 10:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:59 INFO - 'MOZ_NO_REMOTE': '1', 10:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:59 INFO - 'NO_EM_RESTART': '1', 10:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:59 INFO - 'PWD': '/builds/slave/test', 10:35:59 INFO - 'SHELL': '/bin/bash', 10:35:59 INFO - 'SHLVL': '1', 10:35:59 INFO - 'TERM': 'linux', 10:35:59 INFO - 'TMOUT': '86400', 10:35:59 INFO - 'USER': 'cltbld', 10:35:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', 10:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:59 INFO - '_': '/tools/buildbot/bin/python'} 10:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:59 INFO - Downloading/unpacking psutil>=3.1.1 10:35:59 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 10:35:59 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 10:35:59 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 10:35:59 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 10:35:59 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 10:35:59 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 10:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:36:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:01 INFO - Installing collected packages: psutil 10:36:01 INFO - Running setup.py install for psutil 10:36:01 INFO - building 'psutil._psutil_linux' extension 10:36:01 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 10:36:01 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 10:36:01 INFO - building 'psutil._psutil_posix' extension 10:36:01 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 10:36:02 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 10:36:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:02 INFO - Successfully installed psutil 10:36:02 INFO - Cleaning up... 10:36:02 INFO - Return code: 0 10:36:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:36: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')]} 10:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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')]} 10:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe4d00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e02e0>, '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 0x194c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194c5d0>, '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': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', '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 10:36: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:36: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 mozsystemmonitor==0.3 10:36:02 INFO - Using env: {'DISPLAY': ':0', 10:36:02 INFO - 'HOME': '/home/cltbld', 10:36:02 INFO - 'LANG': 'en_US.UTF-8', 10:36:02 INFO - 'LANGUAGE': 'en_US:en', 10:36:02 INFO - 'LOGNAME': 'cltbld', 10:36:02 INFO - 'MAIL': '/var/mail/cltbld', 10:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:02 INFO - 'MOZ_NO_REMOTE': '1', 10:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:02 INFO - 'NO_EM_RESTART': '1', 10:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:02 INFO - 'PWD': '/builds/slave/test', 10:36:02 INFO - 'SHELL': '/bin/bash', 10:36:02 INFO - 'SHLVL': '1', 10:36:02 INFO - 'TERM': 'linux', 10:36:02 INFO - 'TMOUT': '86400', 10:36:02 INFO - 'USER': 'cltbld', 10:36:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', 10:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:02 INFO - '_': '/tools/buildbot/bin/python'} 10:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:36:04 INFO - Installing collected packages: mozsystemmonitor 10:36:04 INFO - Running setup.py install for mozsystemmonitor 10:36:04 INFO - Successfully installed mozsystemmonitor 10:36:04 INFO - Cleaning up... 10:36:04 INFO - Return code: 0 10:36:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:04 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 0x7fbe4d00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e02e0>, '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 0x194c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194c5d0>, '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': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', '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 10:36:04 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 10:36:04 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 10:36:04 INFO - Using env: {'DISPLAY': ':0', 10:36:04 INFO - 'HOME': '/home/cltbld', 10:36:04 INFO - 'LANG': 'en_US.UTF-8', 10:36:04 INFO - 'LANGUAGE': 'en_US:en', 10:36:04 INFO - 'LOGNAME': 'cltbld', 10:36:04 INFO - 'MAIL': '/var/mail/cltbld', 10:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:04 INFO - 'MOZ_NO_REMOTE': '1', 10:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:04 INFO - 'NO_EM_RESTART': '1', 10:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:04 INFO - 'PWD': '/builds/slave/test', 10:36:04 INFO - 'SHELL': '/bin/bash', 10:36:04 INFO - 'SHLVL': '1', 10:36:04 INFO - 'TERM': 'linux', 10:36:04 INFO - 'TMOUT': '86400', 10:36:04 INFO - 'USER': 'cltbld', 10:36:04 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', 10:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:04 INFO - '_': '/tools/buildbot/bin/python'} 10:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:04 INFO - Downloading/unpacking jsonschema==2.5.1 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:36:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:36:06 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 10:36:06 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 10:36:06 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 10:36:06 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 10:36:06 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 10:36:06 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 10:36:06 INFO - Downloading functools32-3.2.3-2.tar.gz 10:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:36:06 INFO - warning: no files found matching '*.txt' 10:36:06 INFO - no previously-included directories found matching 'build' 10:36:06 INFO - no previously-included directories found matching 'dist' 10:36:06 INFO - no previously-included directories found matching '.git*' 10:36:06 INFO - Installing collected packages: jsonschema, functools32 10:36:06 INFO - Running setup.py install for functools32 10:36:07 INFO - warning: no files found matching '*.txt' 10:36:07 INFO - no previously-included directories found matching 'build' 10:36:07 INFO - no previously-included directories found matching 'dist' 10:36:07 INFO - no previously-included directories found matching '.git*' 10:36:07 INFO - Successfully installed jsonschema functools32 10:36:07 INFO - Cleaning up... 10:36:07 INFO - Return code: 0 10:36:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:07 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 0x7fbe4d00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e02e0>, '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 0x194c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194c5d0>, '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': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', '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 10:36:07 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 10:36:07 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 10:36:07 INFO - Using env: {'DISPLAY': ':0', 10:36:07 INFO - 'HOME': '/home/cltbld', 10:36:07 INFO - 'LANG': 'en_US.UTF-8', 10:36:07 INFO - 'LANGUAGE': 'en_US:en', 10:36:07 INFO - 'LOGNAME': 'cltbld', 10:36:07 INFO - 'MAIL': '/var/mail/cltbld', 10:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:07 INFO - 'MOZ_NO_REMOTE': '1', 10:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:07 INFO - 'NO_EM_RESTART': '1', 10:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:07 INFO - 'PWD': '/builds/slave/test', 10:36:07 INFO - 'SHELL': '/bin/bash', 10:36:07 INFO - 'SHLVL': '1', 10:36:07 INFO - 'TERM': 'linux', 10:36:07 INFO - 'TMOUT': '86400', 10:36:07 INFO - 'USER': 'cltbld', 10:36:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', 10:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:07 INFO - '_': '/tools/buildbot/bin/python'} 10:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:07 INFO - Downloading/unpacking blobuploader==1.2.4 10:36:07 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 10:36:07 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 10:36:07 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 10:36:07 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 10:36:07 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 10:36:07 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 10:36:09 INFO - Downloading blobuploader-1.2.4.tar.gz 10:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:36:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:36:09 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 10:36:09 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 10:36:09 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 10:36:09 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 10:36:09 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 10:36:09 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 10:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:36:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:36:09 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 10:36:09 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 10:36:09 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 10:36:09 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 10:36:09 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 10:36:09 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 10:36:09 INFO - Downloading docopt-0.6.1.tar.gz 10:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:36:10 INFO - Installing collected packages: blobuploader, requests, docopt 10:36:10 INFO - Running setup.py install for blobuploader 10:36:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:36:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:36:10 INFO - Running setup.py install for requests 10:36:10 INFO - Running setup.py install for docopt 10:36:10 INFO - Successfully installed blobuploader requests docopt 10:36:10 INFO - Cleaning up... 10:36:10 INFO - Return code: 0 10:36:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:10 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 0x7fbe4d00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e02e0>, '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 0x194c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194c5d0>, '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': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', '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 10:36:10 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 10:36:10 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 10:36:10 INFO - Using env: {'DISPLAY': ':0', 10:36:10 INFO - 'HOME': '/home/cltbld', 10:36:10 INFO - 'LANG': 'en_US.UTF-8', 10:36:10 INFO - 'LANGUAGE': 'en_US:en', 10:36:10 INFO - 'LOGNAME': 'cltbld', 10:36:10 INFO - 'MAIL': '/var/mail/cltbld', 10:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:10 INFO - 'MOZ_NO_REMOTE': '1', 10:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:10 INFO - 'NO_EM_RESTART': '1', 10:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:10 INFO - 'PWD': '/builds/slave/test', 10:36:10 INFO - 'SHELL': '/bin/bash', 10:36:10 INFO - 'SHLVL': '1', 10:36:10 INFO - 'TERM': 'linux', 10:36:10 INFO - 'TMOUT': '86400', 10:36:10 INFO - 'USER': 'cltbld', 10:36:10 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', 10:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:10 INFO - '_': '/tools/buildbot/bin/python'} 10:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:36:10 INFO - Running setup.py (path:/tmp/pip-Zec7yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:36:10 INFO - Running setup.py (path:/tmp/pip-YuO_SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:36:11 INFO - Running setup.py (path:/tmp/pip-sOO94Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:36:11 INFO - Running setup.py (path:/tmp/pip-6BNjVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:36:11 INFO - Running setup.py (path:/tmp/pip-yh3VEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:36:11 INFO - Running setup.py (path:/tmp/pip-Yu3c8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:36:11 INFO - Running setup.py (path:/tmp/pip-V8QVjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:36:11 INFO - Running setup.py (path:/tmp/pip-7UTWwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:36:11 INFO - Running setup.py (path:/tmp/pip-0WfCEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:36:11 INFO - Running setup.py (path:/tmp/pip-xoZnZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:36:11 INFO - Running setup.py (path:/tmp/pip-pTqfrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:36:11 INFO - Running setup.py (path:/tmp/pip-rmRXeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:36:11 INFO - Running setup.py (path:/tmp/pip-AVZPEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:36:11 INFO - Running setup.py (path:/tmp/pip-7wMaPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:11 INFO - Running setup.py (path:/tmp/pip-3MYQlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:36:11 INFO - Running setup.py (path:/tmp/pip-0_v9zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:36:12 INFO - Running setup.py (path:/tmp/pip-Z3cNDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:36:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:36:12 INFO - Running setup.py install for manifestparser 10:36:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:36:12 INFO - Running setup.py install for mozcrash 10:36:12 INFO - Running setup.py install for mozdebug 10:36:12 INFO - Running setup.py install for mozdevice 10:36:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:36:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:36:12 INFO - Running setup.py install for mozfile 10:36:12 INFO - Running setup.py install for mozhttpd 10:36:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:36:12 INFO - Running setup.py install for mozinfo 10:36:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:36:12 INFO - Running setup.py install for mozInstall 10:36:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:36:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:36:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:36:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:36:12 INFO - Running setup.py install for mozleak 10:36:12 INFO - Running setup.py install for mozlog 10:36:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:36:13 INFO - Running setup.py install for moznetwork 10:36:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:36:13 INFO - Running setup.py install for mozprocess 10:36:13 INFO - Running setup.py install for mozprofile 10:36:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:36:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:36:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:36:13 INFO - Running setup.py install for mozrunner 10:36:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:36:13 INFO - Running setup.py install for mozscreenshot 10:36:13 INFO - Running setup.py install for moztest 10:36:13 INFO - Running setup.py install for mozversion 10:36:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:36:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:36:13 INFO - Cleaning up... 10:36:13 INFO - Return code: 0 10:36:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36: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')]} 10:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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')]} 10:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:13 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 0x7fbe4d00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e02e0>, '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 0x194c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194c5d0>, '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': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', '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 10:36:13 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 10:36:13 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 10:36:13 INFO - Using env: {'DISPLAY': ':0', 10:36:13 INFO - 'HOME': '/home/cltbld', 10:36:13 INFO - 'LANG': 'en_US.UTF-8', 10:36:13 INFO - 'LANGUAGE': 'en_US:en', 10:36:13 INFO - 'LOGNAME': 'cltbld', 10:36:13 INFO - 'MAIL': '/var/mail/cltbld', 10:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:13 INFO - 'MOZ_NO_REMOTE': '1', 10:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:13 INFO - 'NO_EM_RESTART': '1', 10:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:13 INFO - 'PWD': '/builds/slave/test', 10:36:13 INFO - 'SHELL': '/bin/bash', 10:36:13 INFO - 'SHLVL': '1', 10:36:13 INFO - 'TERM': 'linux', 10:36:13 INFO - 'TMOUT': '86400', 10:36:13 INFO - 'USER': 'cltbld', 10:36:13 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', 10:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:13 INFO - '_': '/tools/buildbot/bin/python'} 10:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:36:14 INFO - Running setup.py (path:/tmp/pip-8SQQJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:36:14 INFO - Running setup.py (path:/tmp/pip-iF1xCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:36:14 INFO - Running setup.py (path:/tmp/pip-H85Nn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:36:14 INFO - Running setup.py (path:/tmp/pip-69nrQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:36:14 INFO - Running setup.py (path:/tmp/pip-pCHr7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:36:14 INFO - Running setup.py (path:/tmp/pip-MaSYBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:36:14 INFO - Running setup.py (path:/tmp/pip-kSKvJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:36:14 INFO - Running setup.py (path:/tmp/pip-tPfzlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:36:14 INFO - Running setup.py (path:/tmp/pip-j2YOPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:36:14 INFO - Running setup.py (path:/tmp/pip-FLhUA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:36:14 INFO - Running setup.py (path:/tmp/pip-h27pTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:36:14 INFO - Running setup.py (path:/tmp/pip-zYdj_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:36:14 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)) 10:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:36:14 INFO - Running setup.py (path:/tmp/pip-yZBWBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:36:15 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)) 10:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:36:15 INFO - Running setup.py (path:/tmp/pip-hg0nI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:36:15 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)) 10:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:15 INFO - Running setup.py (path:/tmp/pip-rojEOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:15 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)) 10:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:36:15 INFO - Running setup.py (path:/tmp/pip-QIaH4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:36:15 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)) 10:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:36:15 INFO - Running setup.py (path:/tmp/pip-68xO4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:36:15 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)) 10:36:15 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)) 10:36:15 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)) 10:36:15 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)) 10:36:15 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)) 10:36:15 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)) 10:36:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36:17 INFO - Downloading blessings-1.6.tar.gz 10:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:36:17 INFO - Installing collected packages: blessings 10:36:17 INFO - Running setup.py install for blessings 10:36:17 INFO - Successfully installed blessings 10:36:17 INFO - Cleaning up... 10:36:17 INFO - Return code: 0 10:36:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:36:17 INFO - Reading from file tmpfile_stdout 10:36:17 INFO - Current package versions: 10:36:17 INFO - argparse == 1.2.1 10:36:17 INFO - blessings == 1.6 10:36:17 INFO - blobuploader == 1.2.4 10:36:17 INFO - docopt == 0.6.1 10:36:17 INFO - functools32 == 3.2.3-2 10:36:17 INFO - jsonschema == 2.5.1 10:36:17 INFO - manifestparser == 1.1 10:36:17 INFO - mozInstall == 1.12 10:36:17 INFO - mozcrash == 0.17 10:36:17 INFO - mozdebug == 0.1 10:36:17 INFO - mozdevice == 0.48 10:36:17 INFO - mozfile == 1.2 10:36:17 INFO - mozhttpd == 0.7 10:36:17 INFO - mozinfo == 0.9 10:36:17 INFO - mozleak == 0.1 10:36:17 INFO - mozlog == 3.2 10:36:17 INFO - moznetwork == 0.27 10:36:17 INFO - mozprocess == 0.22 10:36:17 INFO - mozprofile == 0.28 10:36:17 INFO - mozrunner == 6.11 10:36:17 INFO - mozscreenshot == 0.1 10:36:17 INFO - mozsystemmonitor == 0.3 10:36:17 INFO - moztest == 0.7 10:36:17 INFO - mozversion == 1.4 10:36:17 INFO - psutil == 3.1.1 10:36:17 INFO - requests == 1.2.3 10:36:17 INFO - wsgiref == 0.1.2 10:36:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36:17 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')]} 10:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:17 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')]} 10:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:17 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 0x7fbe4d00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e02e0>, '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 0x194c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194c5d0>, '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': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', '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 10:36:17 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 10:36:17 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 10:36:17 INFO - Using env: {'DISPLAY': ':0', 10:36:17 INFO - 'HOME': '/home/cltbld', 10:36:17 INFO - 'LANG': 'en_US.UTF-8', 10:36:17 INFO - 'LANGUAGE': 'en_US:en', 10:36:17 INFO - 'LOGNAME': 'cltbld', 10:36:17 INFO - 'MAIL': '/var/mail/cltbld', 10:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:17 INFO - 'MOZ_NO_REMOTE': '1', 10:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:17 INFO - 'NO_EM_RESTART': '1', 10:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:17 INFO - 'PWD': '/builds/slave/test', 10:36:17 INFO - 'SHELL': '/bin/bash', 10:36:17 INFO - 'SHLVL': '1', 10:36:17 INFO - 'TERM': 'linux', 10:36:17 INFO - 'TMOUT': '86400', 10:36:17 INFO - 'USER': 'cltbld', 10:36:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', 10:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:17 INFO - '_': '/tools/buildbot/bin/python'} 10:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:17 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)) 10:36:17 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)) 10:36:17 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)) 10:36:17 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)) 10:36:17 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)) 10:36:17 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)) 10:36:17 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)) 10:36:17 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)) 10:36:17 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)) 10:36:17 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)) 10:36:17 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)) 10:36:17 INFO - Cleaning up... 10:36:17 INFO - Return code: 0 10:36:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:36:17 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')]} 10:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:17 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')]} 10:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:17 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 0x7fbe4d00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e02e0>, '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 0x194c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194c5d0>, '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': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', '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 10:36:17 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 10:36:17 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 10:36:17 INFO - Using env: {'DISPLAY': ':0', 10:36:17 INFO - 'HOME': '/home/cltbld', 10:36:17 INFO - 'LANG': 'en_US.UTF-8', 10:36:17 INFO - 'LANGUAGE': 'en_US:en', 10:36:17 INFO - 'LOGNAME': 'cltbld', 10:36:17 INFO - 'MAIL': '/var/mail/cltbld', 10:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:17 INFO - 'MOZ_NO_REMOTE': '1', 10:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:17 INFO - 'NO_EM_RESTART': '1', 10:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:17 INFO - 'PWD': '/builds/slave/test', 10:36:17 INFO - 'SHELL': '/bin/bash', 10:36:17 INFO - 'SHLVL': '1', 10:36:17 INFO - 'TERM': 'linux', 10:36:17 INFO - 'TMOUT': '86400', 10:36:17 INFO - 'USER': 'cltbld', 10:36:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', 10:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:17 INFO - '_': '/tools/buildbot/bin/python'} 10:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:36:18 INFO - Cleaning up... 10:36:18 INFO - Return code: 0 10:36:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe4d00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e02e0>, '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 0x194c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194c5d0>, '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': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', '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 10:36:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:36:18 INFO - Using env: {'DISPLAY': ':0', 10:36:18 INFO - 'HOME': '/home/cltbld', 10:36:18 INFO - 'LANG': 'en_US.UTF-8', 10:36:18 INFO - 'LANGUAGE': 'en_US:en', 10:36:18 INFO - 'LOGNAME': 'cltbld', 10:36:18 INFO - 'MAIL': '/var/mail/cltbld', 10:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:18 INFO - 'MOZ_NO_REMOTE': '1', 10:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:18 INFO - 'NO_EM_RESTART': '1', 10:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:18 INFO - 'PWD': '/builds/slave/test', 10:36:18 INFO - 'SHELL': '/bin/bash', 10:36:18 INFO - 'SHLVL': '1', 10:36:18 INFO - 'TERM': 'linux', 10:36:18 INFO - 'TMOUT': '86400', 10:36:18 INFO - 'USER': 'cltbld', 10:36:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', 10:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:18 INFO - '_': '/tools/buildbot/bin/python'} 10:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:18 INFO - Downloading/unpacking flake8 10:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:36:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:36:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:36:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:36:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:36:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:36:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:36:20 INFO - no previously-included directories found matching 'docs/_build' 10:36:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:36:21 INFO - Running setup.py install for pep8 10:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:36:21 INFO - no previously-included directories found matching 'docs/_build' 10:36:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:36:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:36:21 INFO - Cleaning up... 10:36:21 INFO - Return code: 0 10:36:21 INFO - Running post-action listener: _resource_record_post_action 10:36:21 INFO - Running post-action listener: _start_resource_monitoring 10:36:21 INFO - Starting resource monitoring. 10:36:21 INFO - ##### 10:36:21 INFO - ##### Finished create-virtualenv step (success) 10:36:21 INFO - ##### 10:36:21 INFO - ##### 10:36:21 INFO - ##### Running install step. 10:36:21 INFO - ##### 10:36:21 INFO - Running pre-action listener: _resource_record_pre_action 10:36:21 INFO - Running main action method: install 10:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:36:21 INFO - Reading from file tmpfile_stdout 10:36:21 INFO - Detecting whether we're running mozinstall >=1.0... 10:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:36:21 INFO - Reading from file tmpfile_stdout 10:36:21 INFO - Output received: 10:36:21 INFO - Usage: mozinstall [options] installer 10:36:21 INFO - Options: 10:36:21 INFO - -h, --help show this help message and exit 10:36:21 INFO - -d DEST, --destination=DEST 10:36:21 INFO - Directory to install application into. [default: 10:36:21 INFO - "/builds/slave/test"] 10:36:21 INFO - --app=APP Application being installed. [default: firefox] 10:36:21 INFO - mkdir: /builds/slave/test/build/application 10:36:21 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'] 10:36:21 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 10:36:37 INFO - Reading from file tmpfile_stdout 10:36:37 INFO - Output received: 10:36:37 INFO - /builds/slave/test/build/application/firefox/firefox 10:36:37 INFO - Running post-action listener: _resource_record_post_action 10:36:37 INFO - ##### 10:36:37 INFO - ##### Finished install step (success) 10:36:37 INFO - ##### 10:36:37 INFO - ##### 10:36:37 INFO - ##### Running run-tests step. 10:36:37 INFO - ##### 10:36:37 INFO - Running pre-action listener: _resource_record_pre_action 10:36:37 INFO - Running main action method: run_tests 10:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:36:37 INFO - Python 2.7.3 10:36:37 INFO - Return code: 0 10:36:37 INFO - grabbing minidump binary from tooltool 10:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:37 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 0x19e02e0>, '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 0x194c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:36:37 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 10:36:37 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 10:36:37 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 10:36:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:36:37 INFO - Return code: 0 10:36:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:36:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:36:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:36:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:36:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:36:38 INFO - Return code: 0 10:36:38 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/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 10:36:38 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/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 10:36:38 INFO - Using env: {'DISPLAY': ':0', 10:36:38 INFO - 'HOME': '/home/cltbld', 10:36:38 INFO - 'LANG': 'en_US.UTF-8', 10:36:38 INFO - 'LANGUAGE': 'en_US:en', 10:36:38 INFO - 'LOGNAME': 'cltbld', 10:36:38 INFO - 'MAIL': '/var/mail/cltbld', 10:36:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:36:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:38 INFO - 'MOZ_NO_REMOTE': '1', 10:36:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:38 INFO - 'NO_EM_RESTART': '1', 10:36:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:38 INFO - 'PWD': '/builds/slave/test', 10:36:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:36:38 INFO - 'SHELL': '/bin/bash', 10:36:38 INFO - 'SHLVL': '1', 10:36:38 INFO - 'TERM': 'linux', 10:36:38 INFO - 'TMOUT': '86400', 10:36:38 INFO - 'USER': 'cltbld', 10:36:38 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467740144.883864-1162193712', 10:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:38 INFO - '_': '/tools/buildbot/bin/python'} 10:36:38 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/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 10:36:38 INFO - mozversion application_buildid: 20160705075627 10:36:38 INFO - mozversion application_changeset: 7a72bfa56d502710aed70440c5da165a9fecb36b 10:36:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:36:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:36:38 INFO - mozversion application_name: Firefox 10:36:38 INFO - mozversion application_remotingname: firefox-dev 10:36:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:36:38 INFO - mozversion application_vendor: Mozilla 10:36:38 INFO - mozversion application_version: 49.0a2 10:36:38 INFO - mozversion platform_buildid: 20160705075627 10:36:38 INFO - mozversion platform_changeset: 7a72bfa56d502710aed70440c5da165a9fecb36b 10:36:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:36:38 INFO - mozversion platform_version: 49.0a2 10:36:38 INFO - using testdate: 1467740198 10:36:38 INFO - actual date: 1467740198 10:36:38 INFO - starting webserver on 'localhost:37952' 10:36:38 INFO - SUITE-START | Running 2 tests 10:36:38 INFO - TEST-START | dromaeo_css 10:36:38 INFO - operating with platform_type : linux_ 10:36:38 INFO - Initialising browser for dromaeo_css test... 10:36:38 INFO - TEST-INFO | started process 14660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplxc9Nq/profile http://localhost:37952/getInfo.html) 10:36:43 INFO - PROCESS | 14660 | __metrics Screen width/height:1600/1200 10:36:43 INFO - PROCESS | 14660 | colorDepth:24 10:36:43 INFO - PROCESS | 14660 | Browser inner width/height: 1024/697 10:36:43 INFO - PROCESS | 14660 | __metrics 10:36:44 ERROR - PROCESS | 14660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:36:45 INFO - TEST-INFO | 14660: exit 0 10:36:45 INFO - Browser initialized. 10:36:45 INFO - Running cycle 1/1 for dromaeo_css test... 10:36:45 INFO - TEST-INFO | started process 14788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplxc9Nq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:56 INFO - PROCESS | 14788 | RSS: Main: 155553792 10:36:56 INFO - PROCESS | 14788 | 10:37:46 INFO - PROCESS | 14788 | 1467740266394 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] 10:39:54 INFO - PROCESS | 14788 | Cycle 1(1): loaded http://localhost:37952/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37952/tests/dromaeo/cssquery-ext.html) 10:39:55 INFO - PROCESS | 14788 | RSS: Main: 160718848 10:39:55 INFO - PROCESS | 14788 | 10:42:57 INFO - PROCESS | 14788 | Cycle 1(1): loaded http://localhost:37952/tests/dromaeo/cssquery-ext.html (next: http://localhost:37952/tests/dromaeo/cssquery-jquery.html) 10:42:57 INFO - PROCESS | 14788 | RSS: Main: 157933568 10:42:57 INFO - PROCESS | 14788 | 10:45:59 INFO - PROCESS | 14788 | Cycle 1(1): loaded http://localhost:37952/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37952/tests/dromaeo/cssquery-mootools.html) 10:46:00 INFO - PROCESS | 14788 | RSS: Main: 157220864 10:46:00 INFO - PROCESS | 14788 | 10:49:02 INFO - PROCESS | 14788 | Cycle 1(1): loaded http://localhost:37952/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37952/tests/dromaeo/cssquery-prototype.html) 10:49:02 INFO - PROCESS | 14788 | RSS: Main: 157528064 10:49:02 INFO - PROCESS | 14788 | 10:52:04 INFO - PROCESS | 14788 | Cycle 1(1): loaded http://localhost:37952/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37952/tests/dromaeo/cssquery-yui.html) 10:52:05 INFO - PROCESS | 14788 | RSS: Main: 159150080 10:52:05 INFO - PROCESS | 14788 | 10:55:07 INFO - PROCESS | 14788 | Cycle 1(1): loaded http://localhost:37952/tests/dromaeo/cssquery-yui.html (next: http://localhost:37952/tests/dromaeo/cssquery-dojo.html) 10:55:07 INFO - PROCESS | 14788 | RSS: Main: 159571968 10:55:07 INFO - PROCESS | 14788 | 10:55:07 INFO - PROCESS | 14788 | __start_tp_report 10:55:07 INFO - PROCESS | 14788 | _x_x_mozilla_page_load 10:55:07 INFO - PROCESS | 14788 | _x_x_mozilla_page_load_details 10:55:07 INFO - PROCESS | 14788 | |i|pagename|runs| 10:55:07 INFO - PROCESS | 14788 | |0;dojo.html;3380.2225488137724;3400.5579274694287;3427.8286085695718;3432.759706820522;3437.2609888873903;5605.131204663278;5622.634528755628;5638.210650508932;5699.202111704365;5702.087665973445;5696.08862581987;5734.5125664318475;5734.856628584287;5735;5737.3688894221605;5099.974500127503;5132.307138536287;5177.326947496839;5209.843704688866;5227.712475813829;5064.3922729272535;5094.745262736867;5222.451642577532;5224.3730752309775;5228.058949389108;5192.532672059514;5196.29849970253;5212.244224587433;5213.165893457048;5229.895402091975;5201.427842937273;5256.185291279839;5268.5521730652945;5269.1832765921345;5299.8410047698635;4951.752412379366;5091.185410334366;5117.667351622133;5231.921521177185;5252.395974462947;5431.4840090191365;5561.58288128392;5585.525230355424;5606.859828504279;5622.49397554218;6112.235970503687;6151.446369826737;6159.630422174684;6162.137300777895;6164.260288765377;5927.703614819285;6124.755009799603;6204.100405441231;6209.565330426872;6230.2523697156175;5737.942620573783;5773.653580785166;5791.855203619901;5805.564582656276;5847.210626565402;6305.873882522415;6306.716197771111;6310.7791227306825;6333.1766870306565;6348.968255158787;5846.883062338729;5934.673592952343;5978.043513037893;6073.5748497604745;6089.117078023662;6126.363745354285;6136.12084543884;6138.938610613836;6151.5386346024225;6154.1999540059505;6037.305709843336;6038.516918646497;6124.938750612526;6137.877242455215;6145.293291271471;5930.614510056833;5987.700614969234;6027;6047.12316714074;6140.508759299245;4625.699329543569;4634.119517291771;4638.907221855544;4641.837535686234;4646.97676511622;4145.813438395279;4146.626803587692;4149.170165966759;4158.022864626811;4186.28833098374;5749.683767392834;5846.181534585162;5881.264841894763;5907.084401917624;5972.283326000907;6026.54800889935;6029.125776762433;6098.54260930432;6124.5712800103565;6133.355997620275;5869.559783016291;5870.823875283749;5877.764889404461;5883.588148829541;5886.6173698709445;5054.974725126351;5149.150390185578;5152.690838549699;5186.40356359016;5194.766235519411;6407.103005579223;6407.519436042316;6426.164598602152;6447.2907980122145;6448.065030570541;6129.478994285358;6155.1382806406245;6157.568970172045;6165.10605962133;6187.876242475035;6155.84610384744;6205.441510264098;6260.217472815898;6283.214598175228;6382.042693595998;6010.669413182317;6026.457618814327;6034.125051867542;6034.879302414015;6044.455998959938;6128.4790792783115;6129.908051379322;6131.63210207389;6132.356102609162;6133.202683651097;5897.469227769521;5929.229200203946;5945.256842894638;5980.102984552352;6025.156478092983;6017.819465416044;6024.3975602439405;6024.939750602438;6036.185115009417;6037.939620603738;5745.91381129275;5867.73595188209;5935.317438494629;5948.434898684618;5949.970250148722;5879.20630714848;5879.412058794086;5887.1757953887345;5937.554683398849;5965.28416590012;5756.856078598069;5792.189093526826;5842.269716285465;5859;5859.589828711949 10:55:07 INFO - PROCESS | 14788 | |1;ext.html;642.1331202876117;659.584461789073;675.6790524500863;685.6092027544302;687.1479365586674;37679.4348084779;39703.20593588126;42703;42805.99999999996;42840.57159428405;44261;45134.774326128405;45209;45209.321860172124;45256.32115518262;8611.26804221642;8826.073262307462;8836.204741573258;8843.292536597057;8851.46891186531;8726.38915275931;8749.693760718375;8753.299736021103;8756;8791.692290769824;8771.78070548235;8834.072422395653;8845.292376609856;8905.821883562325;8920.330975176856;8785.692500762443;8792.42849214799;8804.735857924272;8825.205731484166;8874.245689116433;8720;8723.432976856548;8767.079456657022;8808.11918808114;8830.293576513928;35105;41302.79348603238;41858.58141418577;41889.37165942513;41971.160576788294;3521.1901262709466;3672.3573374659595;3760.417135344026;3850.9807450962567;3914.0606254498716;32049.6795032049;32322.191945201324;32592.837035814908;32625.6737432625;32809.67190328114;4368.432103826514;4429.313456414261;4471.731696098244;4513.887152821173;4625.444946606395;321600;322737;322894.3855280732;322993;323134;37257.44113838294;38220.61779382226;38223.426648600296;38463.807680961414;38492.80753596214;39213.41179882304;40943.38584921229;41049.79475102665;41069.79465102715;41108.1778364431;16172.272247748879;16195.595110122342;16251.431199907947;16264;16266.918665406834;14004.29978501071;14054.086484378482;14067;14089.295535223198;14092.154470731584;9216.170544651013;9223.308251881135;9242.445453272825;9257.39826911262;9345.112214339626;3332.4668053111873;3411.8976430707116;3423.6576342365565;3426.126337783899;3440.82795860206;1079.1906070447164;1114.1087130295732;1156.9652910412701;1193.4689063366893;1204.1631066408936;33794.66205337915;34227.624397753;34705.30589388198;34731.30537389238;34911.30177396438;1152.6945359479744;1186.851643544557;1195.0499353014375;1226.6136167107334;1234.5802427174804;17628.383006594708;17818.10909454522;17962.730559041625;18210.726839097424;18472.907635461735;582942;884378;891498;964046;975852;60145;60149;60613.393866061655;60728;60735.39264607386;1439.3019385597977;1448.826140863103;1456.7596346602693;1466.2961778346453;1474.3807600807686;32460.51309230316;33372.66627333696;33684.66315336913;33872.120155289966;33923.3215335687;52462.47537524576;52852.735736321076;52932;52957.7352113237;53229.46770532245;373116;376385;377014;378119;378473;29850;29925.251868703457;30054.84972575123;30332;30406.543901841047;48335;48492;49100.75449622872;49483.50516494789;49968;42146.57853421426;42846;42884.14231715286;43374.13251735011;43540;42302.153956920076;42374;42442.15115697731;42686.14627707366;42979.35530966976;43402.56597433985;43536;43556.34665480084;44028.77985610051;44413.33379999238;36571.26857462889;36935.63064369429;37017.62982370142;37121.25757484889;37748.2450350986;28338;28933.276668082624;28985.275368115967;28992.710072899845;29131 10:55:07 INFO - PROCESS | 14788 | |2;jquery.html;430.3566168577975;430.44472630306905;436.23876335794034;436.3177930002019;444.9310356894683;18488.445346639604;19192.71210931837;20272.391828245138;20425.080871360788;20438.795612043876;19017.904910475463;19467;19815.30646427375;19951.50121246966;20176.495587610316;5323.467653234665;5416.295881535415;5428;5456.672599644034;5486.423925487826;5148.150555158394;5275.57795376369;5338.386085600167;5393.164059570773;5396.541293990015;5206.583473322125;5215.243789650498;5218.765155568009;5271.9472805272035;5289.523942845143;5185.792568297301;5207.817726379578;5226.137687281594;5256.999999999981;5427.538659213971;5258.132408152688;5277.419483856773;5297.12597421425;5302.0721373759825;5313.0967735485065;13879.236641984688;14088.154710717286;14405.711885762226;14502.492412765609;14516.927415362856;2268.7164104486938;2435.0625009371342;2514.6856642919633;2591.896324147032;2637.406583518712;10929.890701092967;10966.396848173346;14458.927705361406;14963.177025263607;15277.6180595486;1898.686716691744;1964.9705254421194;1979.6040791841544;2003.0885946894127;2041.193728477258;62944.37055629431;87802;88352.67470987876;88822.55588722015;89726;11634.476448559835;11824.349660768741;11838.644840654793;11918.642440726791;12098.213616114925;16907.661846763243;17049.7442538362;17111.887727297686;17171.31314747421;17197.656046878994;8917.152870477294;8943.776405589782;9027.052159523155;9053.456792592466;9077.682281120262;8774.464468718077;8814.471131732116;8863.778405539913;8948.791913091649;9008.279337652972;5074.213496907912;5098.643094983389;5142.228665700175;5162.5611822994715;5234.26720259164;1986.662267414543;2051.569170474187;2070.6272870883386;2112.8732276063483;2162.6864104704728;443.33057083803044;444.05416462933744;979.4221409368507;1020.882598501167;1109.8668159820872;11154.776904461865;12113.515459381526;12249.816252756216;12515;12665.430055647517;467.8175511550498;485.14614278868737;485.37871524448764;508.0093817056754;509.02013623774087;6378.457831084317;6810.795676129724;6846.075779769767;6883.8967415488805;6886.449084073262;517669;528558;530480;531352;545269;101185;101457.49271253597;103393;105312;105406.47296763468;493.29458873810796;500.122285389147;501.11803226321206;501.1505498180622;501.77420160927727;11504.424778760862;11625.418729063344;11631.185816992729;11682.299062056303;11757;39317.41023884701;41964.3705344414;45257.77371113123;45871.31193032041;46078.769606151756;60404.39595603988;60914;61662;61889;62618;8766.079561646191;8900.154485323885;9087.182153606207;9148.725538233864;9223.631054757734;14225.715485690022;14270.429182832986;14341.64145896361;14383.28083595795;14585.854141458449;12071.57749478764;12147;12435.93782031084;12772.297523636289;12777.552785652457;11733.765324693288;11825.526978920747;11919.94040029829;12263.325517096646;12594.622161335175;12720.236785792882;12870.099093063396;12874.227546347249;12941.482340706267;13058.542950996669;9082.772930676785;9094.136057074567;9096.1813436791;9317.16145546877;9461.810763784548;12315.93842030784;12484.43820028119;12831;12831.743365132832;12877.227366358049 10:55:07 INFO - PROCESS | 14788 | |3;mootools.html;1579.1551519936831;1589.7774311596377;1831.972520412194;1923.7402950601665;1924.2591602233144;8527.488350698946;9239.307051971113;9252.814943701122;9994.450305233218;10007.449590272532;9629.374090684101;9653.08295711908;9730.172935300508;9757.756056098584;9775.266854985886;2485.937851553712;2498.850068995866;2508.949821003579;2514.9874250628723;2523.8611876346795;2460.6309053641917;2513.987430062847;2514.233158886539;2514.6982362116482;2517.8237523373373;2478.50429914017;2523.8611876346795;2535.759102885223;2536.759007894247;2540.9237722868343;2470.1601455505033;2472.6043832986725;2480.2435257246534;2492.6136448850457;2493.4389762303335;2368.2066507719933;2391.210900402863;2396.281115665311;2404.651325557802;2450.6079027355536;9592.040795920422;9626.278029147772;9693.951530242304;9698.224142068617;9720.173785228264;5693.5445164387165;5774.960507108719;5829.446202610745;5843.620164689281;5855.590108692393;3696.6303369663087;3742.8689995850013;3826.4260360945805;3864.942025869614;3876.2247550490015;1278.1180985120238;1290.6837824732906;1304.2761267496535;1328.382302229468;1354.2010213973704;13901.443942242298;13994.230317332542;14002.019858609901;14041.297935103205;14073.36669849849;5061.342025536656;5067.037262920034;5148.253503242009;5173.1722924331925;5192.299039629677;11554.306741595532;11561.595344162914;11623.6512904613;11684.766304673858;11687.707807304716;5449.727513624303;5505.091659876076;5520.447955204528;5531.6957567333375;5563.13771365439;4548.090381923628;5123.487651234846;5164.586833053347;5285.814996475105;5354.250404943311;4366.912661746811;4380.67144964129;4440.933385999213;4459.866204013885;4487.798049087799;1401.1382999455261;1414.6887684709554;1427.129451034868;1434.075021611055;1445.2484707951805;987.1263931420744;1021.0810270756378;1041.557338131291;1052.8999745024364;1089.2756317049232;6526.379993900572;6607.141071660653;6615.636140012345;6737.797866064026;6979.267176946348;1004.8342023566175;1040.1159014837478;1054.177741361739;1079.9730006749894;1114.4316398636754;4613.515580864028;4701.271302948048;4733.911200423921;4737.763111844394;4747.643926705511;12171.208871423329;12428.316442595744;12467.563635272722;12470.750584988431;12502.187357821713;11433.428328583537;11838.348890810916;11854.703632409086;12210.877891220975;12257.080718945936;8740.912590874137;8817.426867253607;8823.338249631302;8841.292696584258;8893.555322233862;6514.283428822731;6524.380183882524;6630.104935833793;6634.83412914681;6936.618485983319;11138.27601205919;11150.052245559218;11205.66383008511;11339.092872570009;11512.942435288105;11291.830622540505;11417.657470275904;11479.08167346627;11682.532698691957;11739.119566032752;7845.097813751491;7933.325667318342;8140.430169888051;8698.434601750865;8857.778555535906;9482.905170948477;9572.521373931137;9573.664921727706;9602.567884445078;9646.9035309646;8388.622511987098;8645.913540864762;8657.264132548804;8743.737687869374;8762.123787621187;8453.66185352579;8486.702965396182;8579.399442038997;8623.137686231326;8698.086700896567;7791.0650721913735;7803.453758236869;7880.487768295043;7884.97495325604;7893.526388416713;5628.831135065954;5656.886862262814;5725;5736.0248757712125;5784.248047753765;5732.684702341411;5771.134329850556;5782.681952492653;5859.121131830259;5934.139549765174 10:55:07 INFO - PROCESS | 14788 | |4;prototype.html;342.9245565975485;344.03669724770634;344.7242206235013;358.62523662772406;359.8830380126459;5660.490555849972;5772.624779389337;5789.565782566314;5799.840031993597;5842.620229685068;5673;5686.573506986972;5708.1152421374645;5740.368559458456;5788.884222315552;4102.159057393242;4405.80173892174;4428.97785511072;4436.6672499562665;4448.621867141281;4398.714083584573;4407.427034485529;4420.40324556184;4431.556844315559;4448.442145766181;4405.911881762363;4415.66882483815;4436;4438;4439.2675208590545;4275.893102672442;4368.912621747547;4381.474223093217;4403.405540252057;4410.713303635253;3869.3808990561374;3869.3808990561374;3879.612038796126;3885.42640230707;3911.9804400977814;5443.339781366682;5453.645513041679;5465.6447330923365;5484.972575137099;5490.764577969965;4776.522347765195;4952.182889823175;5036.521530454601;5057.49425057495;5066.51740647084;5935.970320148414;5996.13056106862;6004.219451471281;6040.395960403968;6068.393160683941;4274.358846173068;4280.6789490788315;4283.164782867342;4290.849820256307;4297.119090586422;6027.427394397525;6082.330943596201;6157.568970172045;6194.659293738842;6216.378362163793;4288.635465985426;4331.285337919208;4335.783210839509;4339.7396156230725;4339.783010849508;4337.327714204303;4351.325544540601;4395.538468460765;4404.801783919667;4414.977925110354;4802.327674125625;5021.924671129936;5052.852537671475;5059.645824792229;5066.82266120684;5957.821265362046;5958.761649534057;5963.465527150944;6004.159417681528;6062.181605483292;1475.9335829887682;1509.388697577461;1531.6170957260686;1538.5691307084296;1538.9461368852037;952.6951375559754;966.9806603867884;968.7384406210284;1020.1430798129607;1034.984475232872;5716.342620598602;5809.2738407699035;5834.8038652077075;5841.328247251536;5847.619904706181;6009.278886533644;6028.306744724325;6048.727807248684;6055.909161362583;6063.302720187146;5609.214709940612;5687.345955215121;5775.393583673654;5820.185174075633;5824.417558244142;3264.183954011497;3265.151060724229;3281.868725250963;3289.4572395554464;3293.522439246296;6121.724522396503;6253.9362010536415;6311.589746666452;6325.209348831396;6417.197850268716;6102;6179.227596550431;6193.6903154842075;6204.224471941007;6236.532260080512;6111.6027458214185;6290.521727394059;6308.589941653778;6324.968375158095;6458.095866578683;6035.698215089315;6101.938980610137;6105.664188469676;6117.265928088658;6117.480014198665;5917.106525911667;5998.430149135826;6019.6990150493175;6057.757689692539;6063.302720187235;6055.364186760503;6278.780242691484;6309.558330916791;6327.588706734047;6357.459615932513;4329.567043295645;4337.587929146726;4346.565633340927;4364.301711726109;4400.69195156336;5865.618734782225;6064.514838812796;6145.907811382744;6154.599951003171;6165.136880836776;5881.2942446906645;5933.199018132669;5933.614315069507;5934.783369409347;5971.462568368867;5892.322382926019;5922.763089476372;5931.495822854933;5938.940610593839;5986.521078313812;5755.798547050833;5847.766089356548;5876.706164691663;5994.220751302303;6026.6082704625815;6120.204373431426;6122.632642041492;6124.8775024500155;6192.380761923771;6197.225346831646;5895.616784908967;5940.257467816523;5969.313528944227;5985.191999080243;6047.153398524122 10:55:07 INFO - PROCESS | 14788 | |5;yui.html;772.9497582657127;787.4291138924281;801.6112185589991;904.8054668246327;920.6317473010797;14457.855421445782;15020.699586008273;15053.62365940852;15067.698646027087;15628.2967266473;17170.141492925366;17511.474655760347;17521.386751463702;17539.38612148575;17541.912290438562;861.7845538615346;878.4334104502592;882.1222883231162;883.337496877342;893.8614514750192;890.0254221627308;894.0746327550986;895.5835536475538;897.685809966513;899.3479727197762;933.4119504712022;937.2876613773514;937.4843835890233;938.366602543284;939.0797018921461;922.0318665401302;922.202295014814;926.2219735422244;926.7497775600584;928.9628414863397;678.6708446403491;680.1124532485105;684.2985939412092;685.475611157465;686.4336922039338;14939;14954.62613434662;14964.625884352869;14974.251287435585;15017.399304027826;15922.601934951603;15938.601534961603;15980.600484987852;15994.360225590963;16105.91947040269;12710.682232944158;12719.872801271962;12757.55348562796;12795.424205910756;12836.1014728969;4054.5337286212166;4067.1052368478886;4121.5466298707115;4128.793560321972;4162.375643653446;78415;78518;79137;79714.20285797126;79952;12202.450889709984;12390.75218495625;12417.62747117588;12458.501659933683;12663.810042849365;22353.217637382615;22468.55062898733;22505.549889002457;22584.0966361347;23355.182568610016;9046.592903319366;9049.683261085831;9080.364374493854;9131.26949844011;9230.169284764403;5134.486551344836;5183.585313174937;5195.454477279907;5290.867728306823;5320.76056577455;3937.409388591677;4061.939070913939;4073.2057248836786;4137.80003798901;4309.655227581786;723.9420846332281;737.6569894998852;744.2148533297424;748.1844789179711;749.9887501687479;642.4057746584391;658.5357323087308;685.239384283445;710.573655806512;721.6499997501207;10908.890911090788;11106.167037472222;11173.150876491936;11441.54233830654;11533.308001519936;737.6864832446189;754.8565772503207;761.6001599160485;763.5952944939191;776.2586729673149;5111.8722031948755;5192.818251361185;5208.869778255574;5265.578753699695;5287.365516138088;83111.58444207741;113779.43110284396;134172;135674;138663;71759.60457877135;72562;72656.63671681608;82662;100814;75408.24591754122;75744.9999999989;76160.61919690366;86058.56970715107;102291;10187.286889917634;10514;10533.631322903662;10749.19381046409;11082.501287441923;47973;52477.7376113117;52801;54069;55613;71308.64345678239;78208.60895695485;80222.5988870052;80537;84103.5794821022;13233.3383330835;13339.733205336033;13540.526081587097;13745.862541374458;13893.791593126314;14857.702845943237;15249.16129612882;15273.770893436385;15406.845931540542;15781.447649332218;15119.697606048037;15167.848321516643;15299.158546280061;15402.15288159162;16002.919985399998;14140.646483837987;14211.28943552839;14376.712465750836;14420.711585768435;14585.781213282022;13982.65043373883;14489.492867749577;14914.552563423114;15003.324850381541;15011.849881501044;12056.156069075081;12312.753744924872;12467.579017588343;12543.498260069495;12737;12382.195157314745;12965.15726477776;13015.47938082504;13149.948004159836;13271.734565308832 10:55:07 INFO - PROCESS | 14788 | __end_tp_report 10:55:07 INFO - PROCESS | 14788 | __start_cc_report 10:55:07 INFO - PROCESS | 14788 | _x_x_mozilla_cycle_collect,347 10:55:07 INFO - PROCESS | 14788 | __end_cc_report 10:55:07 INFO - PROCESS | 14788 | __startTimestamp1467741307981__endTimestamp 10:55:07 INFO - PROCESS | 14788 | 10:55:07 INFO - PROCESS | 14788 | ------- Summary: start ------- 10:55:07 INFO - PROCESS | 14788 | Number of tests: 6 10:55:07 INFO - PROCESS | 14788 | 10:55:07 INFO - PROCESS | 14788 | [#0] dojo.html Cycles:165 Average:5676.54 Median:5886.62 stddev:643.88 (10.9%) stddev-sans-first:620.14 10:55:07 INFO - PROCESS | 14788 | Values: 3380.2 3400.6 3427.8 3432.8 3437.3 5605.1 5622.6 5638.2 5699.2 5702.1 5696.1 5734.5 5734.9 5735.0 5737.4 5100.0 5132.3 5177.3 5209.8 5227.7 5064.4 5094.7 5222.5 5224.4 5228.1 5192.5 5196.3 5212.2 5213.2 5229.9 5201.4 5256.2 5268.6 5269.2 5299.8 4951.8 5091.2 5117.7 5231.9 5252.4 5431.5 5561.6 5585.5 5606.9 5622.5 6112.2 6151.4 6159.6 6162.1 6164.3 5927.7 6124.8 6204.1 6209.6 6230.3 5737.9 5773.7 5791.9 5805.6 5847.2 6305.9 6306.7 6310.8 6333.2 6349.0 5846.9 5934.7 5978.0 6073.6 6089.1 6126.4 6136.1 6138.9 6151.5 6154.2 6037.3 6038.5 6124.9 6137.9 6145.3 5930.6 5987.7 6027.0 6047.1 6140.5 4625.7 4634.1 4638.9 4641.8 4647.0 4145.8 4146.6 4149.2 4158.0 4186.3 5749.7 5846.2 5881.3 5907.1 5972.3 6026.5 6029.1 6098.5 6124.6 6133.4 5869.6 5870.8 5877.8 5883.6 5886.6 5055.0 5149.2 5152.7 5186.4 5194.8 6407.1 6407.5 6426.2 6447.3 6448.1 6129.5 6155.1 6157.6 6165.1 6187.9 6155.8 6205.4 6260.2 6283.2 6382.0 6010.7 6026.5 6034.1 6034.9 6044.5 6128.5 6129.9 6131.6 6132.4 6133.2 5897.5 5929.2 5945.3 5980.1 6025.2 6017.8 6024.4 6024.9 6036.2 6037.9 5745.9 5867.7 5935.3 5948.4 5950.0 5879.2 5879.4 5887.2 5937.6 5965.3 5756.9 5792.2 5842.3 5859.0 5859.6 10:55:07 INFO - PROCESS | 14788 | 10:55:07 INFO - PROCESS | 14788 | [#1] ext.html Cycles:180 Average:65842.26 Median:41059.79 stddev:156807.87 (381.9%) stddev-sans-first:157171.34 10:55:07 INFO - PROCESS | 14788 | Values: 642.1 659.6 675.7 685.6 687.1 37679.4 39703.2 42703.0 42806.0 42840.6 44261.0 45134.8 45209.0 45209.3 45256.3 8611.3 8826.1 8836.2 8843.3 8851.5 8726.4 8749.7 8753.3 8756.0 8791.7 8771.8 8834.1 8845.3 8905.8 8920.3 8785.7 8792.4 8804.7 8825.2 8874.2 8720.0 8723.4 8767.1 8808.1 8830.3 35105.0 41302.8 41858.6 41889.4 41971.2 3521.2 3672.4 3760.4 3851.0 3914.1 32049.7 32322.2 32592.8 32625.7 32809.7 4368.4 4429.3 4471.7 4513.9 4625.4 321600.0 322737.0 322894.4 322993.0 323134.0 37257.4 38220.6 38223.4 38463.8 38492.8 39213.4 40943.4 41049.8 41069.8 41108.2 16172.3 16195.6 16251.4 16264.0 16266.9 14004.3 14054.1 14067.0 14089.3 14092.2 9216.2 9223.3 9242.4 9257.4 9345.1 3332.5 3411.9 3423.7 3426.1 3440.8 1079.2 1114.1 1157.0 1193.5 1204.2 33794.7 34227.6 34705.3 34731.3 34911.3 1152.7 1186.9 1195.0 1226.6 1234.6 17628.4 17818.1 17962.7 18210.7 18472.9 582942.0 884378.0 891498.0 964046.0 975852.0 60145.0 60149.0 60613.4 60728.0 60735.4 1439.3 1448.8 1456.8 1466.3 1474.4 32460.5 33372.7 33684.7 33872.1 33923.3 52462.5 52852.7 52932.0 52957.7 53229.5 373116.0 376385.0 377014.0 378119.0 378473.0 29850.0 29925.3 30054.8 30332.0 30406.5 48335.0 48492.0 49100.8 49483.5 49968.0 42146.6 42846.0 42884.1 43374.1 43540.0 42302.2 42374.0 42442.2 42686.1 42979.4 43402.6 43536.0 43556.3 44028.8 44413.3 36571.3 36935.6 37017.6 37121.3 37748.2 28338.0 28933.3 28985.3 28992.7 29131.0 10:55:07 INFO - PROCESS | 14788 | 10:55:07 INFO - PROCESS | 14788 | [#2] jquery.html Cycles:180 Average:30285.20 Median:433.34 stddev:87708.31 (20240.0%) stddev-sans-first:87925.70 10:55:07 INFO - PROCESS | 14788 | Values: 430.4 430.4 436.2 436.3 444.9 18488.4 19192.7 20272.4 20425.1 20438.8 19017.9 19467.0 19815.3 19951.5 20176.5 5323.5 5416.3 5428.0 5456.7 5486.4 5148.2 5275.6 5338.4 5393.2 5396.5 5206.6 5215.2 5218.8 5271.9 5289.5 5185.8 5207.8 5226.1 5257.0 5427.5 5258.1 5277.4 5297.1 5302.1 5313.1 13879.2 14088.2 14405.7 14502.5 14516.9 2268.7 2435.1 2514.7 2591.9 2637.4 10929.9 10966.4 14458.9 14963.2 15277.6 1898.7 1965.0 1979.6 2003.1 2041.2 62944.4 87802.0 88352.7 88822.6 89726.0 11634.5 11824.3 11838.6 11918.6 12098.2 16907.7 17049.7 17111.9 17171.3 17197.7 8917.2 8943.8 9027.1 9053.5 9077.7 8774.5 8814.5 8863.8 8948.8 9008.3 5074.2 5098.6 5142.2 5162.6 5234.3 1986.7 2051.6 2070.6 2112.9 2162.7 443.3 444.1 979.4 1020.9 1109.9 11154.8 12113.5 12249.8 12515.0 12665.4 467.8 485.1 485.4 508.0 509.0 6378.5 6810.8 6846.1 6883.9 6886.4 517669.0 528558.0 530480.0 531352.0 545269.0 101185.0 101457.5 103393.0 105312.0 105406.5 493.3 500.1 501.1 501.2 501.8 11504.4 11625.4 11631.2 11682.3 11757.0 39317.4 41964.4 45257.8 45871.3 46078.8 60404.4 60914.0 61662.0 61889.0 62618.0 8766.1 8900.2 9087.2 9148.7 9223.6 14225.7 14270.4 14341.6 14383.3 14585.9 12071.6 12147.0 12435.9 12772.3 12777.6 11733.8 11825.5 11919.9 12263.3 12594.6 12720.2 12870.1 12874.2 12941.5 13058.5 9082.8 9094.1 9096.2 9317.2 9461.8 12315.9 12484.4 12831.0 12831.7 12877.2 10:55:07 INFO - PROCESS | 14788 | 10:55:07 INFO - PROCESS | 14788 | [#3] mootools.html Cycles:180 Average:6434.21 Median:4580.80 stddev:3697.39 (80.7%) stddev-sans-first:3689.76 10:55:07 INFO - PROCESS | 14788 | Values: 1579.2 1589.8 1832.0 1923.7 1924.3 8527.5 9239.3 9252.8 9994.5 10007.4 9629.4 9653.1 9730.2 9757.8 9775.3 2485.9 2498.9 2508.9 2515.0 2523.9 2460.6 2514.0 2514.2 2514.7 2517.8 2478.5 2523.9 2535.8 2536.8 2540.9 2470.2 2472.6 2480.2 2492.6 2493.4 2368.2 2391.2 2396.3 2404.7 2450.6 9592.0 9626.3 9694.0 9698.2 9720.2 5693.5 5775.0 5829.4 5843.6 5855.6 3696.6 3742.9 3826.4 3864.9 3876.2 1278.1 1290.7 1304.3 1328.4 1354.2 13901.4 13994.2 14002.0 14041.3 14073.4 5061.3 5067.0 5148.3 5173.2 5192.3 11554.3 11561.6 11623.7 11684.8 11687.7 5449.7 5505.1 5520.4 5531.7 5563.1 4548.1 5123.5 5164.6 5285.8 5354.3 4366.9 4380.7 4440.9 4459.9 4487.8 1401.1 1414.7 1427.1 1434.1 1445.2 987.1 1021.1 1041.6 1052.9 1089.3 6526.4 6607.1 6615.6 6737.8 6979.3 1004.8 1040.1 1054.2 1080.0 1114.4 4613.5 4701.3 4733.9 4737.8 4747.6 12171.2 12428.3 12467.6 12470.8 12502.2 11433.4 11838.3 11854.7 12210.9 12257.1 8740.9 8817.4 8823.3 8841.3 8893.6 6514.3 6524.4 6630.1 6634.8 6936.6 11138.3 11150.1 11205.7 11339.1 11512.9 11291.8 11417.7 11479.1 11682.5 11739.1 7845.1 7933.3 8140.4 8698.4 8857.8 9482.9 9572.5 9573.7 9602.6 9646.9 8388.6 8645.9 8657.3 8743.7 8762.1 8453.7 8486.7 8579.4 8623.1 8698.1 7791.1 7803.5 7880.5 7885.0 7893.5 5628.8 5656.9 5725.0 5736.0 5784.2 5732.7 5771.1 5782.7 5859.1 5934.1 10:55:07 INFO - PROCESS | 14788 | 10:55:07 INFO - PROCESS | 14788 | [#4] prototype.html Cycles:180 Average:5020.01 Median:5804.56 stddev:1484.06 (25.6%) stddev-sans-first:1446.11 10:55:07 INFO - PROCESS | 14788 | Values: 342.9 344.0 344.7 358.6 359.9 5660.5 5772.6 5789.6 5799.8 5842.6 5673.0 5686.6 5708.1 5740.4 5788.9 4102.2 4405.8 4429.0 4436.7 4448.6 4398.7 4407.4 4420.4 4431.6 4448.4 4405.9 4415.7 4436.0 4438.0 4439.3 4275.9 4368.9 4381.5 4403.4 4410.7 3869.4 3869.4 3879.6 3885.4 3912.0 5443.3 5453.6 5465.6 5485.0 5490.8 4776.5 4952.2 5036.5 5057.5 5066.5 5936.0 5996.1 6004.2 6040.4 6068.4 4274.4 4280.7 4283.2 4290.8 4297.1 6027.4 6082.3 6157.6 6194.7 6216.4 4288.6 4331.3 4335.8 4339.7 4339.8 4337.3 4351.3 4395.5 4404.8 4415.0 4802.3 5021.9 5052.9 5059.6 5066.8 5957.8 5958.8 5963.5 6004.2 6062.2 1475.9 1509.4 1531.6 1538.6 1538.9 952.7 967.0 968.7 1020.1 1035.0 5716.3 5809.3 5834.8 5841.3 5847.6 6009.3 6028.3 6048.7 6055.9 6063.3 5609.2 5687.3 5775.4 5820.2 5824.4 3264.2 3265.2 3281.9 3289.5 3293.5 6121.7 6253.9 6311.6 6325.2 6417.2 6102.0 6179.2 6193.7 6204.2 6236.5 6111.6 6290.5 6308.6 6325.0 6458.1 6035.7 6101.9 6105.7 6117.3 6117.5 5917.1 5998.4 6019.7 6057.8 6063.3 6055.4 6278.8 6309.6 6327.6 6357.5 4329.6 4337.6 4346.6 4364.3 4400.7 5865.6 6064.5 6145.9 6154.6 6165.1 5881.3 5933.2 5933.6 5934.8 5971.5 5892.3 5922.8 5931.5 5938.9 5986.5 5755.8 5847.8 5876.7 5994.2 6026.6 6120.2 6122.6 6124.9 6192.4 6197.2 5895.6 5940.3 5969.3 5985.2 6047.2 10:55:07 INFO - PROCESS | 14788 | 10:55:07 INFO - PROCESS | 14788 | [#5] yui.html Cycles:180 Average:21162.03 Median:4097.38 stddev:29646.93 (723.6%) stddev-sans-first:29690.57 10:55:07 INFO - PROCESS | 14788 | Values: 772.9 787.4 801.6 904.8 920.6 14457.9 15020.7 15053.6 15067.7 15628.3 17170.1 17511.5 17521.4 17539.4 17541.9 861.8 878.4 882.1 883.3 893.9 890.0 894.1 895.6 897.7 899.3 933.4 937.3 937.5 938.4 939.1 922.0 922.2 926.2 926.7 929.0 678.7 680.1 684.3 685.5 686.4 14939.0 14954.6 14964.6 14974.3 15017.4 15922.6 15938.6 15980.6 15994.4 16105.9 12710.7 12719.9 12757.6 12795.4 12836.1 4054.5 4067.1 4121.5 4128.8 4162.4 78415.0 78518.0 79137.0 79714.2 79952.0 12202.5 12390.8 12417.6 12458.5 12663.8 22353.2 22468.6 22505.5 22584.1 23355.2 9046.6 9049.7 9080.4 9131.3 9230.2 5134.5 5183.6 5195.5 5290.9 5320.8 3937.4 4061.9 4073.2 4137.8 4309.7 723.9 737.7 744.2 748.2 750.0 642.4 658.5 685.2 710.6 721.6 10908.9 11106.2 11173.2 11441.5 11533.3 737.7 754.9 761.6 763.6 776.3 5111.9 5192.8 5208.9 5265.6 5287.4 83111.6 113779.4 134172.0 135674.0 138663.0 71759.6 72562.0 72656.6 82662.0 100814.0 75408.2 75745.0 76160.6 86058.6 102291.0 10187.3 10514.0 10533.6 10749.2 11082.5 47973.0 52477.7 52801.0 54069.0 55613.0 71308.6 78208.6 80222.6 80537.0 84103.6 13233.3 13339.7 13540.5 13745.9 13893.8 14857.7 15249.2 15273.8 15406.8 15781.4 15119.7 15167.8 15299.2 15402.2 16002.9 14140.6 14211.3 14376.7 14420.7 14585.8 13982.7 14489.5 14914.6 15003.3 15011.8 12056.2 12312.8 12467.6 12543.5 12737.0 12382.2 12965.2 13015.5 13149.9 13271.7 10:55:07 INFO - PROCESS | 14788 | -------- Summary: end -------- 10:55:07 INFO - PROCESS | 14788 | 10:55:08 INFO - TEST-INFO | 14788: exit 0 10:55:08 INFO - TEST-OK | dromaeo_css | took 1110040ms 10:55:08 INFO - TEST-START | kraken 10:55:08 INFO - operating with platform_type : linux_ 10:55:08 INFO - Initialising browser for kraken test... 10:55:08 INFO - TEST-INFO | started process 15029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp42_fXU/profile http://localhost:37952/getInfo.html) 10:55:13 INFO - PROCESS | 15029 | __metrics Screen width/height:1600/1200 10:55:13 INFO - PROCESS | 15029 | colorDepth:24 10:55:13 INFO - PROCESS | 15029 | Browser inner width/height: 1024/697 10:55:13 INFO - PROCESS | 15029 | __metrics 10:55:14 ERROR - PROCESS | 15029 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:55:14 INFO - TEST-INFO | 15029: exit 0 10:55:14 INFO - Browser initialized. 10:55:14 INFO - Running cycle 1/1 for kraken test... 10:55:14 INFO - TEST-INFO | started process 15161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp42_fXU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:26 INFO - PROCESS | 15161 | RSS: Main: 156192768 10:55:26 INFO - PROCESS | 15161 | 10:55:29 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37952/tests/kraken/driver.html?testName=audio-beat-detection) 10:55:29 INFO - PROCESS | 15161 | RSS: Main: 161038336 10:55:29 INFO - PROCESS | 15161 | 10:55:32 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37952/tests/kraken/driver.html?testName=audio-dft) 10:55:33 INFO - PROCESS | 15161 | RSS: Main: 160473088 10:55:33 INFO - PROCESS | 15161 | 10:55:36 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37952/tests/kraken/driver.html?testName=audio-fft) 10:55:36 INFO - PROCESS | 15161 | RSS: Main: 161185792 10:55:36 INFO - PROCESS | 15161 | 10:55:38 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37952/tests/kraken/driver.html?testName=audio-oscillator) 10:55:39 INFO - PROCESS | 15161 | RSS: Main: 161525760 10:55:39 INFO - PROCESS | 15161 | 10:55:41 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37952/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:55:42 INFO - PROCESS | 15161 | RSS: Main: 161177600 10:55:42 INFO - PROCESS | 15161 | 10:55:45 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37952/tests/kraken/driver.html?testName=imaging-darkroom) 10:55:45 INFO - PROCESS | 15161 | RSS: Main: 160759808 10:55:45 INFO - PROCESS | 15161 | 10:55:49 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37952/tests/kraken/driver.html?testName=imaging-desaturate) 10:55:50 INFO - PROCESS | 15161 | RSS: Main: 161439744 10:55:50 INFO - PROCESS | 15161 | 10:55:52 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37952/tests/kraken/driver.html?testName=json-parse-financial) 10:55:53 INFO - PROCESS | 15161 | RSS: Main: 160919552 10:55:53 INFO - PROCESS | 15161 | 10:55:54 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37952/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:55:55 INFO - PROCESS | 15161 | RSS: Main: 160858112 10:55:55 INFO - PROCESS | 15161 | 10:55:57 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37952/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:55:57 INFO - PROCESS | 15161 | RSS: Main: 160903168 10:55:57 INFO - PROCESS | 15161 | 10:55:59 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37952/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:56:00 INFO - PROCESS | 15161 | RSS: Main: 161144832 10:56:00 INFO - PROCESS | 15161 | 10:56:03 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:56:03 INFO - PROCESS | 15161 | RSS: Main: 161603584 10:56:03 INFO - PROCESS | 15161 | 10:56:06 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:56:07 INFO - PROCESS | 15161 | RSS: Main: 161288192 10:56:07 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | Cycle 1(1): loaded http://localhost:37952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37952/tests/kraken/driver.html?testName=ai-astar) 10:56:08 INFO - PROCESS | 15161 | RSS: Main: 161923072 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | __start_tp_report 10:56:08 INFO - PROCESS | 15161 | _x_x_mozilla_page_load 10:56:08 INFO - PROCESS | 15161 | _x_x_mozilla_page_load_details 10:56:08 INFO - PROCESS | 15161 | |i|pagename|runs| 10:56:08 INFO - PROCESS | 15161 | |0;ai-astar;111;106;111;111;113;112;111;110;112;111 10:56:08 INFO - PROCESS | 15161 | |1;audio-beat-detection;158;130;150;177;132;160;158;131;177;133 10:56:08 INFO - PROCESS | 15161 | |2;audio-dft;162;163;161;163;163;162;163;160;163;162 10:56:08 INFO - PROCESS | 15161 | |3;audio-fft;74;74;81;174;76;78;80;77;169;76 10:56:08 INFO - PROCESS | 15161 | |4;audio-oscillator;85;84;162;85;87;84;142;85;84;138 10:56:08 INFO - PROCESS | 15161 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;117;118;118 10:56:08 INFO - PROCESS | 15161 | |6;imaging-darkroom;150;150;150;149;152;149;147;147;147;147 10:56:08 INFO - PROCESS | 15161 | |7;imaging-desaturate;95;96;94;96;95;96;94;96;95;96 10:56:08 INFO - PROCESS | 15161 | |8;json-parse-financial;53;56;53;55;52;54;53;56;53;56 10:56:08 INFO - PROCESS | 15161 | |9;json-stringify-tinderbox;60;60;60;60;60;60;61;60;60;62 10:56:08 INFO - PROCESS | 15161 | |10;stanford-crypto-aes;77;81;76;76;76;77;77;78;105;77 10:56:08 INFO - PROCESS | 15161 | |11;stanford-crypto-ccm;131;118;124;122;125;126;131;127;125;126 10:56:08 INFO - PROCESS | 15161 | |12;stanford-crypto-pbkdf2;153;150;151;151;153;157;153;150;153;155 10:56:08 INFO - PROCESS | 15161 | |13;stanford-crypto-sha256-iterative;65;61;60;62;61;62;60;60;63;60 10:56:08 INFO - PROCESS | 15161 | __end_tp_report 10:56:08 INFO - PROCESS | 15161 | __start_cc_report 10:56:08 INFO - PROCESS | 15161 | _x_x_mozilla_cycle_collect,874 10:56:08 INFO - PROCESS | 15161 | __end_cc_report 10:56:08 INFO - PROCESS | 15161 | __startTimestamp1467741368919__endTimestamp 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | ------- Summary: start ------- 10:56:08 INFO - PROCESS | 15161 | Number of tests: 14 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.87 (1.7%) stddev-sans-first:1.99 10:56:08 INFO - PROCESS | 15161 | Values: 111.0 106.0 111.0 111.0 113.0 112.0 111.0 110.0 112.0 111.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:158.00 stddev:18.43 (11.7%) stddev-sans-first:19.35 10:56:08 INFO - PROCESS | 15161 | Values: 158.0 130.0 150.0 177.0 132.0 160.0 158.0 131.0 177.0 133.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 10:56:08 INFO - PROCESS | 15161 | Values: 162.0 163.0 161.0 163.0 163.0 162.0 163.0 160.0 163.0 162.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#3] audio-fft Cycles:10 Average:95.90 Median:76.50 stddev:39.93 (52.2%) stddev-sans-first:41.55 10:56:08 INFO - PROCESS | 15161 | Values: 74.0 74.0 81.0 174.0 76.0 78.0 80.0 77.0 169.0 76.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:84.50 stddev:30.79 (36.4%) stddev-sans-first:31.92 10:56:08 INFO - PROCESS | 15161 | Values: 85.0 84.0 162.0 85.0 87.0 84.0 142.0 85.0 84.0 138.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:56:08 INFO - PROCESS | 15161 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.50 stddev:1.75 (1.2%) stddev-sans-first:1.80 10:56:08 INFO - PROCESS | 15161 | Values: 150.0 150.0 150.0 149.0 152.0 149.0 147.0 147.0 147.0 147.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 10:56:08 INFO - PROCESS | 15161 | Values: 95.0 96.0 94.0 96.0 95.0 96.0 94.0 96.0 95.0 96.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:1.52 (2.8%) stddev-sans-first:1.56 10:56:08 INFO - PROCESS | 15161 | Values: 53.0 56.0 53.0 55.0 52.0 54.0 53.0 56.0 53.0 56.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 10:56:08 INFO - PROCESS | 15161 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 61.0 60.0 60.0 62.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:77.00 stddev:8.91 (11.6%) stddev-sans-first:9.38 10:56:08 INFO - PROCESS | 15161 | Values: 77.0 81.0 76.0 76.0 76.0 77.0 77.0 78.0 105.0 77.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:126.00 stddev:3.87 (3.1%) stddev-sans-first:3.55 10:56:08 INFO - PROCESS | 15161 | Values: 131.0 118.0 124.0 122.0 125.0 126.0 131.0 127.0 125.0 126.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:153.00 stddev:2.22 (1.5%) stddev-sans-first:2.35 10:56:08 INFO - PROCESS | 15161 | Values: 153.0 150.0 151.0 151.0 153.0 157.0 153.0 150.0 153.0 155.0 10:56:08 INFO - PROCESS | 15161 | 10:56:08 INFO - PROCESS | 15161 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.50 stddev:1.65 (2.7%) stddev-sans-first:1.12 10:56:08 INFO - PROCESS | 15161 | Values: 65.0 61.0 60.0 62.0 61.0 62.0 60.0 60.0 63.0 60.0 10:56:08 INFO - PROCESS | 15161 | -------- Summary: end -------- 10:56:08 INFO - PROCESS | 15161 | 10:56:09 INFO - TEST-INFO | 15161: exit 0 10:56:09 INFO - TEST-OK | kraken | took 61197ms 10:56:09 INFO - SUITE-END | took 1171s 10:56:10 INFO - Completed test suite (00:19:31) 10:56:10 INFO - javascript benchmark 10:56:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7523.913103243736, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3380.2225488137724, 3400.5579274694287, 3427.8286085695718, 3432.759706820522, 3437.2609888873903, 5605.131204663278, 5622.634528755628, 5638.210650508932, 5699.202111704365, 5702.087665973445, 5696.08862581987, 5734.5125664318475, 5734.856628584287, 5735.0, 5737.3688894221605, 5099.974500127503, 5132.307138536287, 5177.326947496839, 5209.843704688866, 5227.712475813829, 5064.3922729272535, 5094.745262736867, 5222.451642577532, 5224.3730752309775, 5228.058949389108, 5192.532672059514, 5196.29849970253, 5212.244224587433, 5213.165893457048, 5229.895402091975, 5201.427842937273, 5256.185291279839, 5268.5521730652945, 5269.1832765921345, 5299.8410047698635, 4951.752412379366, 5091.185410334366, 5117.667351622133, 5231.921521177185, 5252.395974462947, 5431.4840090191365, 5561.58288128392, 5585.525230355424, 5606.859828504279, 5622.49397554218, 6112.235970503687, 6151.446369826737, 6159.630422174684, 6162.137300777895, 6164.260288765377, 5927.703614819285, 6124.755009799603, 6204.100405441231, 6209.565330426872, 6230.2523697156175, 5737.942620573783, 5773.653580785166, 5791.855203619901, 5805.564582656276, 5847.210626565402, 6305.873882522415, 6306.716197771111, 6310.7791227306825, 6333.1766870306565, 6348.968255158787, 5846.883062338729, 5934.673592952343, 5978.043513037893, 6073.5748497604745, 6089.117078023662, 6126.363745354285, 6136.12084543884, 6138.938610613836, 6151.5386346024225, 6154.1999540059505, 6037.305709843336, 6038.516918646497, 6124.938750612526, 6137.877242455215, 6145.293291271471, 5930.614510056833, 5987.700614969234, 6027.0, 6047.12316714074, 6140.508759299245, 4625.699329543569, 4634.119517291771, 4638.907221855544, 4641.837535686234, 4646.97676511622, 4145.813438395279, 4146.626803587692, 4149.170165966759, 4158.022864626811, 4186.28833098374, 5749.683767392834, 5846.181534585162, 5881.264841894763, 5907.084401917624, 5972.283326000907, 6026.54800889935, 6029.125776762433, 6098.54260930432, 6124.5712800103565, 6133.355997620275, 5869.559783016291, 5870.823875283749, 5877.764889404461, 5883.588148829541, 5886.6173698709445, 5054.974725126351, 5149.150390185578, 5152.690838549699, 5186.40356359016, 5194.766235519411, 6407.103005579223, 6407.519436042316, 6426.164598602152, 6447.2907980122145, 6448.065030570541, 6129.478994285358, 6155.1382806406245, 6157.568970172045, 6165.10605962133, 6187.876242475035, 6155.84610384744, 6205.441510264098, 6260.217472815898, 6283.214598175228, 6382.042693595998, 6010.669413182317, 6026.457618814327, 6034.125051867542, 6034.879302414015, 6044.455998959938, 6128.4790792783115, 6129.908051379322, 6131.63210207389, 6132.356102609162, 6133.202683651097, 5897.469227769521, 5929.229200203946, 5945.256842894638, 5980.102984552352, 6025.156478092983, 6017.819465416044, 6024.3975602439405, 6024.939750602438, 6036.185115009417, 6037.939620603738, 5745.91381129275, 5867.73595188209, 5935.317438494629, 5948.434898684618, 5949.970250148722, 5879.20630714848, 5879.412058794086, 5887.1757953887345, 5937.554683398849, 5965.28416590012, 5756.856078598069, 5792.189093526826, 5842.269716285465, 5859.0, 5859.589828711949], "value": 5633.887415085105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.1331202876117, 659.584461789073, 675.6790524500863, 685.6092027544302, 687.1479365586674, 37679.4348084779, 39703.20593588126, 42703.0, 42805.99999999996, 42840.57159428405, 44261.0, 45134.774326128405, 45209.0, 45209.321860172124, 45256.32115518262, 8611.26804221642, 8826.073262307462, 8836.204741573258, 8843.292536597057, 8851.46891186531, 8726.38915275931, 8749.693760718375, 8753.299736021103, 8756.0, 8791.692290769824, 8771.78070548235, 8834.072422395653, 8845.292376609856, 8905.821883562325, 8920.330975176856, 8785.692500762443, 8792.42849214799, 8804.735857924272, 8825.205731484166, 8874.245689116433, 8720.0, 8723.432976856548, 8767.079456657022, 8808.11918808114, 8830.293576513928, 35105.0, 41302.79348603238, 41858.58141418577, 41889.37165942513, 41971.160576788294, 3521.1901262709466, 3672.3573374659595, 3760.417135344026, 3850.9807450962567, 3914.0606254498716, 32049.6795032049, 32322.191945201324, 32592.837035814908, 32625.6737432625, 32809.67190328114, 4368.432103826514, 4429.313456414261, 4471.731696098244, 4513.887152821173, 4625.444946606395, 321600.0, 322737.0, 322894.3855280732, 322993.0, 323134.0, 37257.44113838294, 38220.61779382226, 38223.426648600296, 38463.807680961414, 38492.80753596214, 39213.41179882304, 40943.38584921229, 41049.79475102665, 41069.79465102715, 41108.1778364431, 16172.272247748879, 16195.595110122342, 16251.431199907947, 16264.0, 16266.918665406834, 14004.29978501071, 14054.086484378482, 14067.0, 14089.295535223198, 14092.154470731584, 9216.170544651013, 9223.308251881135, 9242.445453272825, 9257.39826911262, 9345.112214339626, 3332.4668053111873, 3411.8976430707116, 3423.6576342365565, 3426.126337783899, 3440.82795860206, 1079.1906070447164, 1114.1087130295732, 1156.9652910412701, 1193.4689063366893, 1204.1631066408936, 33794.66205337915, 34227.624397753, 34705.30589388198, 34731.30537389238, 34911.30177396438, 1152.6945359479744, 1186.851643544557, 1195.0499353014375, 1226.6136167107334, 1234.5802427174804, 17628.383006594708, 17818.10909454522, 17962.730559041625, 18210.726839097424, 18472.907635461735, 582942.0, 884378.0, 891498.0, 964046.0, 975852.0, 60145.0, 60149.0, 60613.393866061655, 60728.0, 60735.39264607386, 1439.3019385597977, 1448.826140863103, 1456.7596346602693, 1466.2961778346453, 1474.3807600807686, 32460.51309230316, 33372.66627333696, 33684.66315336913, 33872.120155289966, 33923.3215335687, 52462.47537524576, 52852.735736321076, 52932.0, 52957.7352113237, 53229.46770532245, 373116.0, 376385.0, 377014.0, 378119.0, 378473.0, 29850.0, 29925.251868703457, 30054.84972575123, 30332.0, 30406.543901841047, 48335.0, 48492.0, 49100.75449622872, 49483.50516494789, 49968.0, 42146.57853421426, 42846.0, 42884.14231715286, 43374.13251735011, 43540.0, 42302.153956920076, 42374.0, 42442.15115697731, 42686.14627707366, 42979.35530966976, 43402.56597433985, 43536.0, 43556.34665480084, 44028.77985610051, 44413.33379999238, 36571.26857462889, 36935.63064369429, 37017.62982370142, 37121.25757484889, 37748.2450350986, 28338.0, 28933.276668082624, 28985.275368115967, 28992.710072899845, 29131.0], "value": 19517.972413631695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.3566168577975, 430.44472630306905, 436.23876335794034, 436.3177930002019, 444.9310356894683, 18488.445346639604, 19192.71210931837, 20272.391828245138, 20425.080871360788, 20438.795612043876, 19017.904910475463, 19467.0, 19815.30646427375, 19951.50121246966, 20176.495587610316, 5323.467653234665, 5416.295881535415, 5428.0, 5456.672599644034, 5486.423925487826, 5148.150555158394, 5275.57795376369, 5338.386085600167, 5393.164059570773, 5396.541293990015, 5206.583473322125, 5215.243789650498, 5218.765155568009, 5271.9472805272035, 5289.523942845143, 5185.792568297301, 5207.817726379578, 5226.137687281594, 5256.999999999981, 5427.538659213971, 5258.132408152688, 5277.419483856773, 5297.12597421425, 5302.0721373759825, 5313.0967735485065, 13879.236641984688, 14088.154710717286, 14405.711885762226, 14502.492412765609, 14516.927415362856, 2268.7164104486938, 2435.0625009371342, 2514.6856642919633, 2591.896324147032, 2637.406583518712, 10929.890701092967, 10966.396848173346, 14458.927705361406, 14963.177025263607, 15277.6180595486, 1898.686716691744, 1964.9705254421194, 1979.6040791841544, 2003.0885946894127, 2041.193728477258, 62944.37055629431, 87802.0, 88352.67470987876, 88822.55588722015, 89726.0, 11634.476448559835, 11824.349660768741, 11838.644840654793, 11918.642440726791, 12098.213616114925, 16907.661846763243, 17049.7442538362, 17111.887727297686, 17171.31314747421, 17197.656046878994, 8917.152870477294, 8943.776405589782, 9027.052159523155, 9053.456792592466, 9077.682281120262, 8774.464468718077, 8814.471131732116, 8863.778405539913, 8948.791913091649, 9008.279337652972, 5074.213496907912, 5098.643094983389, 5142.228665700175, 5162.5611822994715, 5234.26720259164, 1986.662267414543, 2051.569170474187, 2070.6272870883386, 2112.8732276063483, 2162.6864104704728, 443.33057083803044, 444.05416462933744, 979.4221409368507, 1020.882598501167, 1109.8668159820872, 11154.776904461865, 12113.515459381526, 12249.816252756216, 12515.0, 12665.430055647517, 467.8175511550498, 485.14614278868737, 485.37871524448764, 508.0093817056754, 509.02013623774087, 6378.457831084317, 6810.795676129724, 6846.075779769767, 6883.8967415488805, 6886.449084073262, 517669.0, 528558.0, 530480.0, 531352.0, 545269.0, 101185.0, 101457.49271253597, 103393.0, 105312.0, 105406.47296763468, 493.29458873810796, 500.122285389147, 501.11803226321206, 501.1505498180622, 501.77420160927727, 11504.424778760862, 11625.418729063344, 11631.185816992729, 11682.299062056303, 11757.0, 39317.41023884701, 41964.3705344414, 45257.77371113123, 45871.31193032041, 46078.769606151756, 60404.39595603988, 60914.0, 61662.0, 61889.0, 62618.0, 8766.079561646191, 8900.154485323885, 9087.182153606207, 9148.725538233864, 9223.631054757734, 14225.715485690022, 14270.429182832986, 14341.64145896361, 14383.28083595795, 14585.854141458449, 12071.57749478764, 12147.0, 12435.93782031084, 12772.297523636289, 12777.552785652457, 11733.765324693288, 11825.526978920747, 11919.94040029829, 12263.325517096646, 12594.622161335175, 12720.236785792882, 12870.099093063396, 12874.227546347249, 12941.482340706267, 13058.542950996669, 9082.772930676785, 9094.136057074567, 9096.1813436791, 9317.16145546877, 9461.810763784548, 12315.93842030784, 12484.43820028119, 12831.0, 12831.743365132832, 12877.227366358049], "value": 8740.223575677304, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1579.1551519936831, 1589.7774311596377, 1831.972520412194, 1923.7402950601665, 1924.2591602233144, 8527.488350698946, 9239.307051971113, 9252.814943701122, 9994.450305233218, 10007.449590272532, 9629.374090684101, 9653.08295711908, 9730.172935300508, 9757.756056098584, 9775.266854985886, 2485.937851553712, 2498.850068995866, 2508.949821003579, 2514.9874250628723, 2523.8611876346795, 2460.6309053641917, 2513.987430062847, 2514.233158886539, 2514.6982362116482, 2517.8237523373373, 2478.50429914017, 2523.8611876346795, 2535.759102885223, 2536.759007894247, 2540.9237722868343, 2470.1601455505033, 2472.6043832986725, 2480.2435257246534, 2492.6136448850457, 2493.4389762303335, 2368.2066507719933, 2391.210900402863, 2396.281115665311, 2404.651325557802, 2450.6079027355536, 9592.040795920422, 9626.278029147772, 9693.951530242304, 9698.224142068617, 9720.173785228264, 5693.5445164387165, 5774.960507108719, 5829.446202610745, 5843.620164689281, 5855.590108692393, 3696.6303369663087, 3742.8689995850013, 3826.4260360945805, 3864.942025869614, 3876.2247550490015, 1278.1180985120238, 1290.6837824732906, 1304.2761267496535, 1328.382302229468, 1354.2010213973704, 13901.443942242298, 13994.230317332542, 14002.019858609901, 14041.297935103205, 14073.36669849849, 5061.342025536656, 5067.037262920034, 5148.253503242009, 5173.1722924331925, 5192.299039629677, 11554.306741595532, 11561.595344162914, 11623.6512904613, 11684.766304673858, 11687.707807304716, 5449.727513624303, 5505.091659876076, 5520.447955204528, 5531.6957567333375, 5563.13771365439, 4548.090381923628, 5123.487651234846, 5164.586833053347, 5285.814996475105, 5354.250404943311, 4366.912661746811, 4380.67144964129, 4440.933385999213, 4459.866204013885, 4487.798049087799, 1401.1382999455261, 1414.6887684709554, 1427.129451034868, 1434.075021611055, 1445.2484707951805, 987.1263931420744, 1021.0810270756378, 1041.557338131291, 1052.8999745024364, 1089.2756317049232, 6526.379993900572, 6607.141071660653, 6615.636140012345, 6737.797866064026, 6979.267176946348, 1004.8342023566175, 1040.1159014837478, 1054.177741361739, 1079.9730006749894, 1114.4316398636754, 4613.515580864028, 4701.271302948048, 4733.911200423921, 4737.763111844394, 4747.643926705511, 12171.208871423329, 12428.316442595744, 12467.563635272722, 12470.750584988431, 12502.187357821713, 11433.428328583537, 11838.348890810916, 11854.703632409086, 12210.877891220975, 12257.080718945936, 8740.912590874137, 8817.426867253607, 8823.338249631302, 8841.292696584258, 8893.555322233862, 6514.283428822731, 6524.380183882524, 6630.104935833793, 6634.83412914681, 6936.618485983319, 11138.27601205919, 11150.052245559218, 11205.66383008511, 11339.092872570009, 11512.942435288105, 11291.830622540505, 11417.657470275904, 11479.08167346627, 11682.532698691957, 11739.119566032752, 7845.097813751491, 7933.325667318342, 8140.430169888051, 8698.434601750865, 8857.778555535906, 9482.905170948477, 9572.521373931137, 9573.664921727706, 9602.567884445078, 9646.9035309646, 8388.622511987098, 8645.913540864762, 8657.264132548804, 8743.737687869374, 8762.123787621187, 8453.66185352579, 8486.702965396182, 8579.399442038997, 8623.137686231326, 8698.086700896567, 7791.0650721913735, 7803.453758236869, 7880.487768295043, 7884.97495325604, 7893.526388416713, 5628.831135065954, 5656.886862262814, 5725.0, 5736.0248757712125, 5784.248047753765, 5732.684702341411, 5771.134329850556, 5782.681952492653, 5859.121131830259, 5934.139549765174], "value": 5134.2469701636155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.9245565975485, 344.03669724770634, 344.7242206235013, 358.62523662772406, 359.8830380126459, 5660.490555849972, 5772.624779389337, 5789.565782566314, 5799.840031993597, 5842.620229685068, 5673.0, 5686.573506986972, 5708.1152421374645, 5740.368559458456, 5788.884222315552, 4102.159057393242, 4405.80173892174, 4428.97785511072, 4436.6672499562665, 4448.621867141281, 4398.714083584573, 4407.427034485529, 4420.40324556184, 4431.556844315559, 4448.442145766181, 4405.911881762363, 4415.66882483815, 4436.0, 4438.0, 4439.2675208590545, 4275.893102672442, 4368.912621747547, 4381.474223093217, 4403.405540252057, 4410.713303635253, 3869.3808990561374, 3869.3808990561374, 3879.612038796126, 3885.42640230707, 3911.9804400977814, 5443.339781366682, 5453.645513041679, 5465.6447330923365, 5484.972575137099, 5490.764577969965, 4776.522347765195, 4952.182889823175, 5036.521530454601, 5057.49425057495, 5066.51740647084, 5935.970320148414, 5996.13056106862, 6004.219451471281, 6040.395960403968, 6068.393160683941, 4274.358846173068, 4280.6789490788315, 4283.164782867342, 4290.849820256307, 4297.119090586422, 6027.427394397525, 6082.330943596201, 6157.568970172045, 6194.659293738842, 6216.378362163793, 4288.635465985426, 4331.285337919208, 4335.783210839509, 4339.7396156230725, 4339.783010849508, 4337.327714204303, 4351.325544540601, 4395.538468460765, 4404.801783919667, 4414.977925110354, 4802.327674125625, 5021.924671129936, 5052.852537671475, 5059.645824792229, 5066.82266120684, 5957.821265362046, 5958.761649534057, 5963.465527150944, 6004.159417681528, 6062.181605483292, 1475.9335829887682, 1509.388697577461, 1531.6170957260686, 1538.5691307084296, 1538.9461368852037, 952.6951375559754, 966.9806603867884, 968.7384406210284, 1020.1430798129607, 1034.984475232872, 5716.342620598602, 5809.2738407699035, 5834.8038652077075, 5841.328247251536, 5847.619904706181, 6009.278886533644, 6028.306744724325, 6048.727807248684, 6055.909161362583, 6063.302720187146, 5609.214709940612, 5687.345955215121, 5775.393583673654, 5820.185174075633, 5824.417558244142, 3264.183954011497, 3265.151060724229, 3281.868725250963, 3289.4572395554464, 3293.522439246296, 6121.724522396503, 6253.9362010536415, 6311.589746666452, 6325.209348831396, 6417.197850268716, 6102.0, 6179.227596550431, 6193.6903154842075, 6204.224471941007, 6236.532260080512, 6111.6027458214185, 6290.521727394059, 6308.589941653778, 6324.968375158095, 6458.095866578683, 6035.698215089315, 6101.938980610137, 6105.664188469676, 6117.265928088658, 6117.480014198665, 5917.106525911667, 5998.430149135826, 6019.6990150493175, 6057.757689692539, 6063.302720187235, 6055.364186760503, 6278.780242691484, 6309.558330916791, 6327.588706734047, 6357.459615932513, 4329.567043295645, 4337.587929146726, 4346.565633340927, 4364.301711726109, 4400.69195156336, 5865.618734782225, 6064.514838812796, 6145.907811382744, 6154.599951003171, 6165.136880836776, 5881.2942446906645, 5933.199018132669, 5933.614315069507, 5934.783369409347, 5971.462568368867, 5892.322382926019, 5922.763089476372, 5931.495822854933, 5938.940610593839, 5986.521078313812, 5755.798547050833, 5847.766089356548, 5876.706164691663, 5994.220751302303, 6026.6082704625815, 6120.204373431426, 6122.632642041492, 6124.8775024500155, 6192.380761923771, 6197.225346831646, 5895.616784908967, 5940.257467816523, 5969.313528944227, 5985.191999080243, 6047.153398524122], "value": 4543.02299849554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.9497582657127, 787.4291138924281, 801.6112185589991, 904.8054668246327, 920.6317473010797, 14457.855421445782, 15020.699586008273, 15053.62365940852, 15067.698646027087, 15628.2967266473, 17170.141492925366, 17511.474655760347, 17521.386751463702, 17539.38612148575, 17541.912290438562, 861.7845538615346, 878.4334104502592, 882.1222883231162, 883.337496877342, 893.8614514750192, 890.0254221627308, 894.0746327550986, 895.5835536475538, 897.685809966513, 899.3479727197762, 933.4119504712022, 937.2876613773514, 937.4843835890233, 938.366602543284, 939.0797018921461, 922.0318665401302, 922.202295014814, 926.2219735422244, 926.7497775600584, 928.9628414863397, 678.6708446403491, 680.1124532485105, 684.2985939412092, 685.475611157465, 686.4336922039338, 14939.0, 14954.62613434662, 14964.625884352869, 14974.251287435585, 15017.399304027826, 15922.601934951603, 15938.601534961603, 15980.600484987852, 15994.360225590963, 16105.91947040269, 12710.682232944158, 12719.872801271962, 12757.55348562796, 12795.424205910756, 12836.1014728969, 4054.5337286212166, 4067.1052368478886, 4121.5466298707115, 4128.793560321972, 4162.375643653446, 78415.0, 78518.0, 79137.0, 79714.20285797126, 79952.0, 12202.450889709984, 12390.75218495625, 12417.62747117588, 12458.501659933683, 12663.810042849365, 22353.217637382615, 22468.55062898733, 22505.549889002457, 22584.0966361347, 23355.182568610016, 9046.592903319366, 9049.683261085831, 9080.364374493854, 9131.26949844011, 9230.169284764403, 5134.486551344836, 5183.585313174937, 5195.454477279907, 5290.867728306823, 5320.76056577455, 3937.409388591677, 4061.939070913939, 4073.2057248836786, 4137.80003798901, 4309.655227581786, 723.9420846332281, 737.6569894998852, 744.2148533297424, 748.1844789179711, 749.9887501687479, 642.4057746584391, 658.5357323087308, 685.239384283445, 710.573655806512, 721.6499997501207, 10908.890911090788, 11106.167037472222, 11173.150876491936, 11441.54233830654, 11533.308001519936, 737.6864832446189, 754.8565772503207, 761.6001599160485, 763.5952944939191, 776.2586729673149, 5111.8722031948755, 5192.818251361185, 5208.869778255574, 5265.578753699695, 5287.365516138088, 83111.58444207741, 113779.43110284396, 134172.0, 135674.0, 138663.0, 71759.60457877135, 72562.0, 72656.63671681608, 82662.0, 100814.0, 75408.24591754122, 75744.9999999989, 76160.61919690366, 86058.56970715107, 102291.0, 10187.286889917634, 10514.0, 10533.631322903662, 10749.19381046409, 11082.501287441923, 47973.0, 52477.7376113117, 52801.0, 54069.0, 55613.0, 71308.64345678239, 78208.60895695485, 80222.5988870052, 80537.0, 84103.5794821022, 13233.3383330835, 13339.733205336033, 13540.526081587097, 13745.862541374458, 13893.791593126314, 14857.702845943237, 15249.16129612882, 15273.770893436385, 15406.845931540542, 15781.447649332218, 15119.697606048037, 15167.848321516643, 15299.158546280061, 15402.15288159162, 16002.919985399998, 14140.646483837987, 14211.28943552839, 14376.712465750836, 14420.711585768435, 14585.781213282022, 13982.65043373883, 14489.492867749577, 14914.552563423114, 15003.324850381541, 15011.849881501044, 12056.156069075081, 12312.753744924872, 12467.579017588343, 12543.498260069495, 12737.0, 12382.195157314745, 12965.15726477776, 13015.47938082504, 13149.948004159836, 13271.734565308832], "value": 8091.685386010326, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 111.0, 113.0, 112.0, 111.0, 110.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 150.0, 177.0, 132.0, 160.0, 158.0, 131.0, 177.0, 133.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 163.0, 162.0, 163.0, 160.0, 163.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 81.0, 174.0, 76.0, 78.0, 80.0, 77.0, 169.0, 76.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 162.0, 85.0, 87.0, 84.0, 142.0, 85.0, 84.0, 138.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 149.0, 152.0, 149.0, 147.0, 147.0, 147.0, 147.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 96.0, 95.0, 96.0, 94.0, 96.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 53.0, 55.0, 52.0, 54.0, 53.0, 56.0, 53.0, 56.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 62.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 76.0, 76.0, 76.0, 77.0, 77.0, 78.0, 105.0, 77.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 118.0, 124.0, 122.0, 125.0, 126.0, 131.0, 127.0, 125.0, 126.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 151.0, 151.0, 153.0, 157.0, 153.0, 150.0, 153.0, 155.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 60.0, 62.0, 61.0, 62.0, 60.0, 60.0, 63.0, 60.0], "value": 61.4, "unit": "score"}]}]} 10:56:10 INFO - Return code: 0 10:56:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:56:10 ERROR - # TBPL SUCCESS # 10:56:10 INFO - Running post-action listener: _resource_record_post_action 10:56:10 INFO - ##### 10:56:10 INFO - ##### Finished run-tests step (success) 10:56:10 INFO - ##### 10:56:10 INFO - Running post-run listener: _resource_record_post_run 10:56:10 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 286720; Write bytes: 505655296; Read time: 36; Write time: 396756 10:56:10 INFO - TinderboxPrint: CPU usage
13.3% 10:56:10 INFO - TinderboxPrint: I/O read bytes / time
286,720 / 36 10:56:10 INFO - TinderboxPrint: I/O write bytes / time
505,655,296 / 396,756 10:56:10 INFO - TinderboxPrint: CPU idle
8,212.8 (86.6%) 10:56:10 INFO - TinderboxPrint: CPU user
1,211.0 (12.8%) 10:56:10 INFO - TinderboxPrint: Swap in / out
0 / 0 10:56:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252944384; Read time: 0; Write time: 245772 10:56:10 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 252710912; Read time: 20; Write time: 150984 10:56:10 INFO - Running post-run listener: _upload_blobber_files 10:56:10 INFO - Blob upload gear active. 10:56:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:56:10 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 10:56:10 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'] 10:56:10 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 10:56:11 INFO - (blobuploader) - INFO - Open directory for files ... 10:56:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:56:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:56:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:12 INFO - (blobuploader) - INFO - Done attempting. 10:56:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:56:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:56:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:15 INFO - (blobuploader) - INFO - Done attempting. 10:56:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:56:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:56:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:16 INFO - (blobuploader) - INFO - Done attempting. 10:56:16 INFO - (blobuploader) - INFO - Iteration through files over. 10:56:16 INFO - Return code: 0 10:56:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:56:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:56:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24b7bcf9c07ffeea40f6e9eeab920f1041bd371fd44da2dc9861051181d3640a89b6d4126573ca5b876f88317e7ccde8363b2aca6f9954c48708fb36f24027bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2b3bdaedeb418e5fe8c03166cda6f2df446dc95d4fb48a6a88dd7a118074f5716dbeab069241b868fdeae62155a2b86ae44738dc58a035325db5eba43356834", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0983ab2e49416f384d60a6173c1fd934cc052154f0f5decede8ad018ddd20531ecd8126b9e73a81edc8a2570ef95104de22ea911f4ebdce28b493db8c7f88ecc"} 10:56:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:56:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:56:16 INFO - Contents: 10:56:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24b7bcf9c07ffeea40f6e9eeab920f1041bd371fd44da2dc9861051181d3640a89b6d4126573ca5b876f88317e7ccde8363b2aca6f9954c48708fb36f24027bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2b3bdaedeb418e5fe8c03166cda6f2df446dc95d4fb48a6a88dd7a118074f5716dbeab069241b868fdeae62155a2b86ae44738dc58a035325db5eba43356834", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0983ab2e49416f384d60a6173c1fd934cc052154f0f5decede8ad018ddd20531ecd8126b9e73a81edc8a2570ef95104de22ea911f4ebdce28b493db8c7f88ecc"} 10:56:16 INFO - Running post-run listener: copy_logs_to_upload_dir 10:56:16 INFO - Copying logs to upload dir... 10:56:16 INFO - mkdir: /builds/slave/test/build/upload/logs 10:56:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.669395 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-05 10:56:16.218366) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:56:16.221729) ========= 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=4300f881736b422476174874000001bc-1467740144.883864-1162193712 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/24b7bcf9c07ffeea40f6e9eeab920f1041bd371fd44da2dc9861051181d3640a89b6d4126573ca5b876f88317e7ccde8363b2aca6f9954c48708fb36f24027bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2b3bdaedeb418e5fe8c03166cda6f2df446dc95d4fb48a6a88dd7a118074f5716dbeab069241b868fdeae62155a2b86ae44738dc58a035325db5eba43356834", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0983ab2e49416f384d60a6173c1fd934cc052154f0f5decede8ad018ddd20531ecd8126b9e73a81edc8a2570ef95104de22ea911f4ebdce28b493db8c7f88ecc"} build_url:https://queue.taskcluster.net/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/CYkbnanSTemai3t21O6ahg/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/24b7bcf9c07ffeea40f6e9eeab920f1041bd371fd44da2dc9861051181d3640a89b6d4126573ca5b876f88317e7ccde8363b2aca6f9954c48708fb36f24027bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2b3bdaedeb418e5fe8c03166cda6f2df446dc95d4fb48a6a88dd7a118074f5716dbeab069241b868fdeae62155a2b86ae44738dc58a035325db5eba43356834", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0983ab2e49416f384d60a6173c1fd934cc052154f0f5decede8ad018ddd20531ecd8126b9e73a81edc8a2570ef95104de22ea911f4ebdce28b493db8c7f88ecc"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:56:16.282075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:56:16.282475) ========= 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=4300f881736b422476174874000001bc-1467740144.883864-1162193712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:56:16.304333) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:56:16.304764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:56:16.305227) ========= ========= Total master_lag: 0.16 =========