builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1467740087.83 results: success (0) buildid: 20160705075627 builduid: 2c8fae7d84bc4a0aaf8e24287f8e3068 revision: 7a72bfa56d502710aed70440c5da165a9fecb36b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:47.833679) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:47.834129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:47.834414) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:47.849039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:47.849867) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 10:34:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-07-05 10:34:47 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087253 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:47.951326) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:47.951621) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016447 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:48.000539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:48.000851) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 10:34:48,087 truncating revision to first 12 chars 2016-07-05 10:34:48,087 Setting DEBUG logging. 2016-07-05 10:34:48,087 attempt 1/10 2016-07-05 10:34:48,087 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:34:48,367 unpacking tar archive at: mozilla-aurora-7a72bfa56d50/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:48.636825) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:48.637165) ========= script_repo_revision: 7a72bfa56d502710aed70440c5da165a9fecb36b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:48.637563) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:48.637838) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:34:48.649300) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-05 10:34:48.649574) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:34:48 INFO - MultiFileLogger online at 20160705 10:34:48 in /builds/slave/test 10:34:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:34:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:34:48 INFO - {'append_to_log': False, 10:34:48 INFO - 'base_work_dir': '/builds/slave/test', 10:34:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:34:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:34:48 INFO - 'branch': 'Mozilla-Aurora', 10:34:48 INFO - 'buildbot_json_path': 'buildprops.json', 10:34:48 INFO - 'config_files': ('talos/linux_config.py',), 10:34:48 INFO - 'default_actions': ('clobber', 10:34:48 INFO - 'read-buildbot-config', 10:34:48 INFO - 'download-and-extract', 10:34:48 INFO - 'populate-webroot', 10:34:48 INFO - 'create-virtualenv', 10:34:48 INFO - 'install', 10:34:48 INFO - 'run-tests'), 10:34:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:34:48 INFO - 'download_minidump_stackwalk': True, 10:34:48 INFO - 'download_symbols': 'ondemand', 10:34:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:34:48 INFO - 'tooltool.py': '/tools/tooltool.py', 10:34:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:34:48 INFO - '/tools/misc-python/virtualenv.py')}, 10:34:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:34:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:34:48 INFO - 'installer_path': 'installer.exe', 10:34:48 INFO - 'log_level': 'info', 10:34:48 INFO - 'log_name': 'talos', 10:34:48 INFO - 'log_to_console': True, 10:34:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:34:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:34:48 INFO - 'opt_config_files': (), 10:34:48 INFO - 'pip_index': False, 10:34:48 INFO - 'sps_profile': False, 10:34:48 INFO - 'sps_profile_interval': 0, 10:34:48 INFO - 'suite': 'dromaeojs', 10:34:48 INFO - 'system_bits': '32', 10:34:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:34:48 INFO - 'title': 'talos-linux64-ix-009', 10:34:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:34:48 INFO - 'use_talos_json': True, 10:34:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:34:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:34:48 INFO - 'work_dir': 'build'} 10:34:48 INFO - ##### 10:34:48 INFO - ##### Running clobber step. 10:34:48 INFO - ##### 10:34:48 INFO - Running pre-action listener: _resource_record_pre_action 10:34:48 INFO - Running main action method: clobber 10:34:48 INFO - rmtree: /builds/slave/test/build 10:34:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:34:49 INFO - Running post-action listener: _resource_record_post_action 10:34:49 INFO - ##### 10:34:49 INFO - ##### Finished clobber step (success) 10:34:49 INFO - ##### 10:34:49 INFO - ##### 10:34:49 INFO - ##### Running read-buildbot-config step. 10:34:49 INFO - ##### 10:34:49 INFO - Running pre-action listener: _resource_record_pre_action 10:34:49 INFO - Running main action method: read_buildbot_config 10:34:49 INFO - Using buildbot properties: 10:34:49 INFO - { 10:34:49 INFO - "project": "", 10:34:49 INFO - "product": "firefox", 10:34:49 INFO - "script_repo_revision": "production", 10:34:49 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:34:49 INFO - "repository": "", 10:34:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:34:49 INFO - "buildid": "20160705075627", 10:34:49 INFO - "pgo_build": "True", 10:34:49 INFO - "basedir": "/builds/slave/test", 10:34:49 INFO - "buildnumber": 591, 10:34:49 INFO - "slavename": "talos-linux64-ix-009", 10:34:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:34:49 INFO - "platform": "ubuntu64_hw", 10:34:49 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:34:49 INFO - "branch": "mozilla-aurora", 10:34:49 INFO - "repo_path": "releases/mozilla-aurora", 10:34:49 INFO - "revision": "7a72bfa56d502710aed70440c5da165a9fecb36b", 10:34:49 INFO - "stage_platform": "linux64-pgo", 10:34:49 INFO - "builduid": "2c8fae7d84bc4a0aaf8e24287f8e3068", 10:34:49 INFO - "slavebuilddir": "test" 10:34:49 INFO - } 10:34:49 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:34:49 INFO - Running post-action listener: _resource_record_post_action 10:34:49 INFO - ##### 10:34:49 INFO - ##### Finished read-buildbot-config step (success) 10:34:49 INFO - ##### 10:34:49 INFO - ##### 10:34:49 INFO - ##### Running download-and-extract step. 10:34:49 INFO - ##### 10:34:49 INFO - Running pre-action listener: _resource_record_pre_action 10:34:49 INFO - Running main action method: download_and_extract 10:34:49 INFO - mkdir: /builds/slave/test/build/tests 10:34:49 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:34:49 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:34:49 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:34:49 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:34:49 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:34:49 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:34:50 INFO - Downloaded 1361 bytes. 10:34:50 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:34:50 INFO - Using the following test package requirements: 10:34:50 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:34:50 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:34:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:34:50 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:34:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:34:50 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:34:50 INFO - u'jsshell-linux-x86_64.zip'], 10:34:50 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:34:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:34:50 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:34:50 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:34:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:34:50 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:34:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:34:50 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:34:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:34:50 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:34:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:34:50 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:34: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:34: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:34: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:34: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:34: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:34: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:34:51 INFO - Downloaded 24526733 bytes. 10:34: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:34: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:34:53 INFO - Return code: 0 10:34:53 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:34: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:34:53 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:34: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.common.tests.zip 10:34: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.common.tests.zip 10:34: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.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:34: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.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:34:54 INFO - Downloaded 24526733 bytes. 10:34:54 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:34:54 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:34:55 INFO - Return code: 0 10:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:56 INFO - Downloaded 10833369 bytes. 10:34:56 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:34:56 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:34:56 INFO - Return code: 0 10:34:56 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:34:56 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:34:56 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:34:56 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:34:56 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:34:56 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:34:58 INFO - Downloaded 63640537 bytes. 10:34:58 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:34:58 INFO - mkdir: /builds/slave/test/properties 10:34:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:34:58 INFO - Writing to file /builds/slave/test/properties/build_url 10:34:58 INFO - Contents: 10:34:58 INFO - build_url:https://queue.taskcluster.net/v1/task/CYkbnanSTemai3t21O6ahg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:34:58 INFO - Running post-action listener: _resource_record_post_action 10:34:58 INFO - Running post-action listener: set_extra_try_arguments 10:34:58 INFO - ##### 10:34:58 INFO - ##### Finished download-and-extract step (success) 10:34:58 INFO - ##### 10:34:58 INFO - ##### 10:34:58 INFO - ##### Running populate-webroot step. 10:34:58 INFO - ##### 10:34:58 INFO - Running pre-action listener: _resource_record_pre_action 10:34:58 INFO - Running main action method: populate_webroot 10:34:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:34:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:34:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:34:58 INFO - '--tppagecycles', 10:34:58 INFO - '7'], 10:34:58 INFO - 'tests': ['tsvgm']}}, 10:34:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:34:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:34:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:34:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:34:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:34:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:34:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:58 INFO - 'talos_options': ['--disable-e10s'], 10:34:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:58 INFO - 'talos_options': ['--disable-e10s'], 10:34:58 INFO - 'tests': ['damp', 'tps']}, 10:34:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:58 INFO - 'tests': ['damp', 'tps']}, 10:34:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:34:58 INFO - 'tests': ['dromaeo_dom']}, 10:34:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:34:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:34:58 INFO - 'tests': ['a11yr', 10:34:58 INFO - 'ts_paint', 10:34:58 INFO - 'tpaint', 10:34:58 INFO - 'sessionrestore', 10:34:58 INFO - 'sessionrestore_no_auto_restore', 10:34:58 INFO - 'tabpaint']}, 10:34:58 INFO - 'other-e10s': {'tests': ['a11yr', 10:34:58 INFO - 'ts_paint', 10:34:58 INFO - 'tpaint', 10:34:58 INFO - 'sessionrestore', 10:34:58 INFO - 'sessionrestore_no_auto_restore', 10:34:58 INFO - 'tabpaint']}, 10:34:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:34:58 INFO - 'ts_paint', 10:34:58 INFO - 'tpaint', 10:34:58 INFO - 'sessionrestore', 10:34:58 INFO - 'sessionrestore_no_auto_restore', 10:34:58 INFO - 'tabpaint']}, 10:34:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:34:58 INFO - 'ts_paint', 10:34:58 INFO - 'tpaint', 10:34:58 INFO - 'sessionrestore', 10:34:58 INFO - 'sessionrestore_no_auto_restore', 10:34:58 INFO - 'tabpaint']}, 10:34:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:34:58 INFO - 'tests': ['a11yr', 10:34:58 INFO - 'ts_paint', 10:34:58 INFO - 'tpaint', 10:34:58 INFO - 'sessionrestore', 10:34:58 INFO - 'sessionrestore_no_auto_restore', 10:34:58 INFO - 'tabpaint']}, 10:34:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:34:58 INFO - 'tests': ['a11yr', 10:34:58 INFO - 'ts_paint', 10:34:58 INFO - 'tpaint', 10:34:58 INFO - 'sessionrestore', 10:34:58 INFO - 'sessionrestore_no_auto_restore', 10:34:58 INFO - 'tabpaint']}, 10:34:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:34:58 INFO - 'tests': ['tsvgx', 10:34:58 INFO - 'tsvgr_opacity', 10:34:58 INFO - 'tart', 10:34:58 INFO - 'tscrollx', 10:34:58 INFO - 'cart']}, 10:34:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:34:58 INFO - 'tsvgr_opacity', 10:34:58 INFO - 'tart', 10:34:58 INFO - 'tscrollx', 10:34:58 INFO - 'cart']}, 10:34:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:58 INFO - 'talos_options': ['--disable-e10s'], 10:34:58 INFO - 'tests': ['tp5o']}, 10:34:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:58 INFO - 'tests': ['tp5o']}, 10:34:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:58 INFO - 'talos_options': ['--disable-e10s', 10:34:58 INFO - '--xperf_path', 10:34:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:58 INFO - 'tests': ['tp5n']}, 10:34:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:58 INFO - 'talos_options': ['--xperf_path', 10:34:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:58 INFO - 'tests': ['tp5n']}}, 10:34:58 INFO - 'talos.zip': {'path': '', 10:34:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:34:58 INFO - Running post-action listener: _resource_record_post_action 10:34:58 INFO - ##### 10:34:58 INFO - ##### Finished populate-webroot step (success) 10:34:58 INFO - ##### 10:34:58 INFO - ##### 10:34:58 INFO - ##### Running create-virtualenv step. 10:34:58 INFO - ##### 10:34:58 INFO - Running pre-action listener: _resource_record_pre_action 10:34:58 INFO - Running main action method: create_virtualenv 10:34:58 INFO - Creating virtualenv /builds/slave/test/build/venv 10:34:58 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:34:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:34:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:34:59 INFO - Using real prefix '/usr' 10:34:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:34:59 INFO - Installing distribute.............................................................................................................................................................................................done. 10:35:01 INFO - Installing pip.................done. 10:35:01 INFO - Return code: 0 10:35:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:01 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 0x7f158f290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f1c0>, '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 0x18700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1870550>, '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': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', '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:01 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:01 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:01 INFO - Using env: {'DISPLAY': ':0', 10:35:01 INFO - 'HOME': '/home/cltbld', 10:35:01 INFO - 'LANG': 'en_US.UTF-8', 10:35:01 INFO - 'LANGUAGE': 'en_US:en', 10:35:01 INFO - 'LOGNAME': 'cltbld', 10:35:01 INFO - 'MAIL': '/var/mail/cltbld', 10:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:01 INFO - 'MOZ_NO_REMOTE': '1', 10:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:01 INFO - 'NO_EM_RESTART': '1', 10:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:01 INFO - 'PWD': '/builds/slave/test', 10:35:01 INFO - 'SHELL': '/bin/bash', 10:35:01 INFO - 'SHLVL': '1', 10:35:01 INFO - 'TERM': 'linux', 10:35:01 INFO - 'TMOUT': '86400', 10:35:01 INFO - 'USER': 'cltbld', 10:35:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', 10:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:01 INFO - '_': '/tools/buildbot/bin/python'} 10:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:01 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:01 INFO - Cleaning up... 10:35:01 INFO - Return code: 0 10:35:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:01 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 0x7f158f290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f1c0>, '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 0x18700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1870550>, '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': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', '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:01 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:01 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:01 INFO - Using env: {'DISPLAY': ':0', 10:35:01 INFO - 'HOME': '/home/cltbld', 10:35:01 INFO - 'LANG': 'en_US.UTF-8', 10:35:01 INFO - 'LANGUAGE': 'en_US:en', 10:35:01 INFO - 'LOGNAME': 'cltbld', 10:35:01 INFO - 'MAIL': '/var/mail/cltbld', 10:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:01 INFO - 'MOZ_NO_REMOTE': '1', 10:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:01 INFO - 'NO_EM_RESTART': '1', 10:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:01 INFO - 'PWD': '/builds/slave/test', 10:35:01 INFO - 'SHELL': '/bin/bash', 10:35:01 INFO - 'SHLVL': '1', 10:35:01 INFO - 'TERM': 'linux', 10:35:01 INFO - 'TMOUT': '86400', 10:35:01 INFO - 'USER': 'cltbld', 10:35:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', 10:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:01 INFO - '_': '/tools/buildbot/bin/python'} 10:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:01 INFO - Downloading/unpacking psutil>=3.1.1 10:35:01 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:01 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:01 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:01 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:01 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:01 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:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:35:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:04 INFO - Installing collected packages: psutil 10:35:04 INFO - Running setup.py install for psutil 10:35:04 INFO - building 'psutil._psutil_linux' extension 10:35:04 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:35:04 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:35:04 INFO - building 'psutil._psutil_posix' extension 10:35:04 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:35:04 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:35:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:04 INFO - Successfully installed psutil 10:35:04 INFO - Cleaning up... 10:35:04 INFO - Return code: 0 10:35:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:35: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:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f158f290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f1c0>, '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 0x18700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1870550>, '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': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', '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: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:35: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 mozsystemmonitor==0.3 10:35:04 INFO - Using env: {'DISPLAY': ':0', 10:35:04 INFO - 'HOME': '/home/cltbld', 10:35:04 INFO - 'LANG': 'en_US.UTF-8', 10:35:04 INFO - 'LANGUAGE': 'en_US:en', 10:35:04 INFO - 'LOGNAME': 'cltbld', 10:35:04 INFO - 'MAIL': '/var/mail/cltbld', 10:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:04 INFO - 'MOZ_NO_REMOTE': '1', 10:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:04 INFO - 'NO_EM_RESTART': '1', 10:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:04 INFO - 'PWD': '/builds/slave/test', 10:35:04 INFO - 'SHELL': '/bin/bash', 10:35:04 INFO - 'SHLVL': '1', 10:35:04 INFO - 'TERM': 'linux', 10:35:04 INFO - 'TMOUT': '86400', 10:35:04 INFO - 'USER': 'cltbld', 10:35:04 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', 10:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:04 INFO - '_': '/tools/buildbot/bin/python'} 10:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:35: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:35: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:35: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:35: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:35: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:35: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:35:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:35:06 INFO - Installing collected packages: mozsystemmonitor 10:35:06 INFO - Running setup.py install for mozsystemmonitor 10:35:06 INFO - Successfully installed mozsystemmonitor 10:35:06 INFO - Cleaning up... 10:35:06 INFO - Return code: 0 10:35:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:06 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 0x7f158f290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f1c0>, '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 0x18700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1870550>, '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': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', '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:06 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:35:06 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:35:06 INFO - Using env: {'DISPLAY': ':0', 10:35:06 INFO - 'HOME': '/home/cltbld', 10:35:06 INFO - 'LANG': 'en_US.UTF-8', 10:35:06 INFO - 'LANGUAGE': 'en_US:en', 10:35:06 INFO - 'LOGNAME': 'cltbld', 10:35:06 INFO - 'MAIL': '/var/mail/cltbld', 10:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:06 INFO - 'MOZ_NO_REMOTE': '1', 10:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:06 INFO - 'NO_EM_RESTART': '1', 10:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:06 INFO - 'PWD': '/builds/slave/test', 10:35:06 INFO - 'SHELL': '/bin/bash', 10:35:06 INFO - 'SHLVL': '1', 10:35:06 INFO - 'TERM': 'linux', 10:35:06 INFO - 'TMOUT': '86400', 10:35:06 INFO - 'USER': 'cltbld', 10:35:06 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', 10:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:06 INFO - '_': '/tools/buildbot/bin/python'} 10:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:07 INFO - Downloading/unpacking jsonschema==2.5.1 10:35: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:35: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:35: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:35: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:35: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:35: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:35:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:35:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:35:08 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:08 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:08 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:08 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:08 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:08 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:09 INFO - Downloading functools32-3.2.3-2.tar.gz 10:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:35:09 INFO - warning: no files found matching '*.txt' 10:35:09 INFO - no previously-included directories found matching 'build' 10:35:09 INFO - no previously-included directories found matching 'dist' 10:35:09 INFO - no previously-included directories found matching '.git*' 10:35:09 INFO - Installing collected packages: jsonschema, functools32 10:35:09 INFO - Running setup.py install for functools32 10:35:09 INFO - warning: no files found matching '*.txt' 10:35:09 INFO - no previously-included directories found matching 'build' 10:35:09 INFO - no previously-included directories found matching 'dist' 10:35:09 INFO - no previously-included directories found matching '.git*' 10:35:09 INFO - Successfully installed jsonschema functools32 10:35:09 INFO - Cleaning up... 10:35:09 INFO - Return code: 0 10:35:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:09 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 0x7f158f290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f1c0>, '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 0x18700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1870550>, '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': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', '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:09 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:35:09 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:35:09 INFO - Using env: {'DISPLAY': ':0', 10:35:09 INFO - 'HOME': '/home/cltbld', 10:35:09 INFO - 'LANG': 'en_US.UTF-8', 10:35:09 INFO - 'LANGUAGE': 'en_US:en', 10:35:09 INFO - 'LOGNAME': 'cltbld', 10:35:09 INFO - 'MAIL': '/var/mail/cltbld', 10:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:09 INFO - 'MOZ_NO_REMOTE': '1', 10:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:09 INFO - 'NO_EM_RESTART': '1', 10:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:09 INFO - 'PWD': '/builds/slave/test', 10:35:09 INFO - 'SHELL': '/bin/bash', 10:35:09 INFO - 'SHLVL': '1', 10:35:09 INFO - 'TERM': 'linux', 10:35:09 INFO - 'TMOUT': '86400', 10:35:09 INFO - 'USER': 'cltbld', 10:35:09 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', 10:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:09 INFO - '_': '/tools/buildbot/bin/python'} 10:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:09 INFO - Downloading/unpacking blobuploader==1.2.4 10:35: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:35: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:35: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:35: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:35: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:35: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:35:11 INFO - Downloading blobuploader-1.2.4.tar.gz 10:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:35:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:35:11 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:11 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:11 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:11 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:11 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:11 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:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:35:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:35:12 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:12 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:12 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:12 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:12 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:12 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:12 INFO - Downloading docopt-0.6.1.tar.gz 10:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:35:12 INFO - Installing collected packages: blobuploader, requests, docopt 10:35:12 INFO - Running setup.py install for blobuploader 10:35:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:35:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:35:12 INFO - Running setup.py install for requests 10:35:12 INFO - Running setup.py install for docopt 10:35:12 INFO - Successfully installed blobuploader requests docopt 10:35:12 INFO - Cleaning up... 10:35:12 INFO - Return code: 0 10:35:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:12 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 0x7f158f290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f1c0>, '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 0x18700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1870550>, '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': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', '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:12 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:35:12 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:35:12 INFO - Using env: {'DISPLAY': ':0', 10:35:12 INFO - 'HOME': '/home/cltbld', 10:35:12 INFO - 'LANG': 'en_US.UTF-8', 10:35:12 INFO - 'LANGUAGE': 'en_US:en', 10:35:12 INFO - 'LOGNAME': 'cltbld', 10:35:12 INFO - 'MAIL': '/var/mail/cltbld', 10:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:12 INFO - 'MOZ_NO_REMOTE': '1', 10:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:12 INFO - 'NO_EM_RESTART': '1', 10:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:12 INFO - 'PWD': '/builds/slave/test', 10:35:12 INFO - 'SHELL': '/bin/bash', 10:35:12 INFO - 'SHLVL': '1', 10:35:12 INFO - 'TERM': 'linux', 10:35:12 INFO - 'TMOUT': '86400', 10:35:12 INFO - 'USER': 'cltbld', 10:35:12 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', 10:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:12 INFO - '_': '/tools/buildbot/bin/python'} 10:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:13 INFO - Running setup.py (path:/tmp/pip-5Ju_1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:13 INFO - Running setup.py (path:/tmp/pip-FiYW4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:13 INFO - Running setup.py (path:/tmp/pip-LEasOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:13 INFO - Running setup.py (path:/tmp/pip-eTHyis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:13 INFO - Running setup.py (path:/tmp/pip-iSmBH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:13 INFO - Running setup.py (path:/tmp/pip-jE4xvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:13 INFO - Running setup.py (path:/tmp/pip-SL2eCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:13 INFO - Running setup.py (path:/tmp/pip-p3Rh13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:13 INFO - Running setup.py (path:/tmp/pip-_aIrq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:13 INFO - Running setup.py (path:/tmp/pip-5JvPUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:13 INFO - Running setup.py (path:/tmp/pip-VWmKMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:13 INFO - Running setup.py (path:/tmp/pip-hhGics-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:14 INFO - Running setup.py (path:/tmp/pip-MYTZgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:14 INFO - Running setup.py (path:/tmp/pip-ITTQkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:14 INFO - Running setup.py (path:/tmp/pip-Bh9XbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:14 INFO - Running setup.py (path:/tmp/pip-wiG6iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:14 INFO - Running setup.py (path:/tmp/pip-Gvzk7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:35:14 INFO - Running setup.py install for manifestparser 10:35:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:35:14 INFO - Running setup.py install for mozcrash 10:35:14 INFO - Running setup.py install for mozdebug 10:35:14 INFO - Running setup.py install for mozdevice 10:35:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:35:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:35:14 INFO - Running setup.py install for mozfile 10:35:14 INFO - Running setup.py install for mozhttpd 10:35:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:35:14 INFO - Running setup.py install for mozinfo 10:35:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:35:15 INFO - Running setup.py install for mozInstall 10:35:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:35:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:35:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:35:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:35:15 INFO - Running setup.py install for mozleak 10:35:15 INFO - Running setup.py install for mozlog 10:35:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:35:15 INFO - Running setup.py install for moznetwork 10:35:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:35:15 INFO - Running setup.py install for mozprocess 10:35:15 INFO - Running setup.py install for mozprofile 10:35:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:35:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:35:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:35:15 INFO - Running setup.py install for mozrunner 10:35:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:35:15 INFO - Running setup.py install for mozscreenshot 10:35:15 INFO - Running setup.py install for moztest 10:35:16 INFO - Running setup.py install for mozversion 10:35:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:35:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:35:16 INFO - Cleaning up... 10:35:16 INFO - Return code: 0 10:35:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:16 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 0x7f158f290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f1c0>, '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 0x18700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1870550>, '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': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', '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:16 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:35:16 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:35:16 INFO - Using env: {'DISPLAY': ':0', 10:35:16 INFO - 'HOME': '/home/cltbld', 10:35:16 INFO - 'LANG': 'en_US.UTF-8', 10:35:16 INFO - 'LANGUAGE': 'en_US:en', 10:35:16 INFO - 'LOGNAME': 'cltbld', 10:35:16 INFO - 'MAIL': '/var/mail/cltbld', 10:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:16 INFO - 'MOZ_NO_REMOTE': '1', 10:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:16 INFO - 'NO_EM_RESTART': '1', 10:35:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:16 INFO - 'PWD': '/builds/slave/test', 10:35:16 INFO - 'SHELL': '/bin/bash', 10:35:16 INFO - 'SHLVL': '1', 10:35:16 INFO - 'TERM': 'linux', 10:35:16 INFO - 'TMOUT': '86400', 10:35:16 INFO - 'USER': 'cltbld', 10:35:16 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', 10:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:16 INFO - '_': '/tools/buildbot/bin/python'} 10:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:16 INFO - Running setup.py (path:/tmp/pip-leb4Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:16 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:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:16 INFO - Running setup.py (path:/tmp/pip-yITfaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:16 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:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:16 INFO - Running setup.py (path:/tmp/pip-zP_4Yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:16 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:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:16 INFO - Running setup.py (path:/tmp/pip-SASexH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:16 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:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:16 INFO - Running setup.py (path:/tmp/pip-BNNrrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:16 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:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:16 INFO - Running setup.py (path:/tmp/pip-6ocnnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:16 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:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:16 INFO - Running setup.py (path:/tmp/pip-aDcKm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:16 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:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:16 INFO - Running setup.py (path:/tmp/pip-SGo1Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:16 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:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:16 INFO - Running setup.py (path:/tmp/pip-cT9sD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:17 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:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:17 INFO - Running setup.py (path:/tmp/pip-K_qFjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:17 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:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:17 INFO - Running setup.py (path:/tmp/pip-M0m6Cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:17 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:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:17 INFO - Running setup.py (path:/tmp/pip-q3z_0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:17 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:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:17 INFO - Running setup.py (path:/tmp/pip-fgBHvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:17 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:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:17 INFO - Running setup.py (path:/tmp/pip-3UeujA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:17 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:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:17 INFO - Running setup.py (path:/tmp/pip-t1ZpRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:17 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:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:17 INFO - Running setup.py (path:/tmp/pip-GhoGkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:17 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:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:17 INFO - Running setup.py (path:/tmp/pip-KosnfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:17 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:35:17 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:35:17 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:35:17 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:35:17 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:35:17 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:35:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:35:17 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:17 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:17 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:17 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:17 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:17 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:19 INFO - Downloading blessings-1.6.tar.gz 10:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:35:19 INFO - Installing collected packages: blessings 10:35:19 INFO - Running setup.py install for blessings 10:35:19 INFO - Successfully installed blessings 10:35:19 INFO - Cleaning up... 10:35:19 INFO - Return code: 0 10:35:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:35:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:19 INFO - Reading from file tmpfile_stdout 10:35:19 INFO - Current package versions: 10:35:19 INFO - argparse == 1.2.1 10:35:19 INFO - blessings == 1.6 10:35:19 INFO - blobuploader == 1.2.4 10:35:19 INFO - docopt == 0.6.1 10:35:19 INFO - functools32 == 3.2.3-2 10:35:19 INFO - jsonschema == 2.5.1 10:35:19 INFO - manifestparser == 1.1 10:35:19 INFO - mozInstall == 1.12 10:35:19 INFO - mozcrash == 0.17 10:35:19 INFO - mozdebug == 0.1 10:35:19 INFO - mozdevice == 0.48 10:35:19 INFO - mozfile == 1.2 10:35:19 INFO - mozhttpd == 0.7 10:35:19 INFO - mozinfo == 0.9 10:35:19 INFO - mozleak == 0.1 10:35:19 INFO - mozlog == 3.2 10:35:19 INFO - moznetwork == 0.27 10:35:19 INFO - mozprocess == 0.22 10:35:19 INFO - mozprofile == 0.28 10:35:19 INFO - mozrunner == 6.11 10:35:19 INFO - mozscreenshot == 0.1 10:35:19 INFO - mozsystemmonitor == 0.3 10:35:19 INFO - moztest == 0.7 10:35:19 INFO - mozversion == 1.4 10:35:19 INFO - psutil == 3.1.1 10:35:19 INFO - requests == 1.2.3 10:35:19 INFO - wsgiref == 0.1.2 10:35:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:19 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 0x7f158f290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f1c0>, '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 0x18700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1870550>, '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': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', '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:19 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:35:19 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:35:19 INFO - Using env: {'DISPLAY': ':0', 10:35:19 INFO - 'HOME': '/home/cltbld', 10:35:19 INFO - 'LANG': 'en_US.UTF-8', 10:35:19 INFO - 'LANGUAGE': 'en_US:en', 10:35:19 INFO - 'LOGNAME': 'cltbld', 10:35:19 INFO - 'MAIL': '/var/mail/cltbld', 10:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:19 INFO - 'MOZ_NO_REMOTE': '1', 10:35:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:19 INFO - 'NO_EM_RESTART': '1', 10:35:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:19 INFO - 'PWD': '/builds/slave/test', 10:35:19 INFO - 'SHELL': '/bin/bash', 10:35:19 INFO - 'SHLVL': '1', 10:35:19 INFO - 'TERM': 'linux', 10:35:19 INFO - 'TMOUT': '86400', 10:35:19 INFO - 'USER': 'cltbld', 10:35:19 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', 10:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:19 INFO - '_': '/tools/buildbot/bin/python'} 10:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:20 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:35:20 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:35:20 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:35:20 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:35:20 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:35:20 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:35:20 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:35:20 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:35:20 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:35:20 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:35:20 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:35:20 INFO - Cleaning up... 10:35:20 INFO - Return code: 0 10:35:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f158f290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f1c0>, '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 0x18700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1870550>, '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': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', '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:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:35:20 INFO - Using env: {'DISPLAY': ':0', 10:35:20 INFO - 'HOME': '/home/cltbld', 10:35:20 INFO - 'LANG': 'en_US.UTF-8', 10:35:20 INFO - 'LANGUAGE': 'en_US:en', 10:35:20 INFO - 'LOGNAME': 'cltbld', 10:35:20 INFO - 'MAIL': '/var/mail/cltbld', 10:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:20 INFO - 'MOZ_NO_REMOTE': '1', 10:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:20 INFO - 'NO_EM_RESTART': '1', 10:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:20 INFO - 'PWD': '/builds/slave/test', 10:35:20 INFO - 'SHELL': '/bin/bash', 10:35:20 INFO - 'SHLVL': '1', 10:35:20 INFO - 'TERM': 'linux', 10:35:20 INFO - 'TMOUT': '86400', 10:35:20 INFO - 'USER': 'cltbld', 10:35:20 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', 10:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:20 INFO - '_': '/tools/buildbot/bin/python'} 10:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:35:20 INFO - Cleaning up... 10:35:20 INFO - Return code: 0 10:35:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f158f290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f1c0>, '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 0x18700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1870550>, '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': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', '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:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:35:20 INFO - Using env: {'DISPLAY': ':0', 10:35:20 INFO - 'HOME': '/home/cltbld', 10:35:20 INFO - 'LANG': 'en_US.UTF-8', 10:35:20 INFO - 'LANGUAGE': 'en_US:en', 10:35:20 INFO - 'LOGNAME': 'cltbld', 10:35:20 INFO - 'MAIL': '/var/mail/cltbld', 10:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:20 INFO - 'MOZ_NO_REMOTE': '1', 10:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:20 INFO - 'NO_EM_RESTART': '1', 10:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:20 INFO - 'PWD': '/builds/slave/test', 10:35:20 INFO - 'SHELL': '/bin/bash', 10:35:20 INFO - 'SHLVL': '1', 10:35:20 INFO - 'TERM': 'linux', 10:35:20 INFO - 'TMOUT': '86400', 10:35:20 INFO - 'USER': 'cltbld', 10:35:20 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', 10:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:20 INFO - '_': '/tools/buildbot/bin/python'} 10:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:20 INFO - Downloading/unpacking flake8 10:35: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:35: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:35: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:35: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:35: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:35: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:35:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:35:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:35:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:35:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:35:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:35:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:35:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:35:23 INFO - no previously-included directories found matching 'docs/_build' 10:35:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:35:23 INFO - Running setup.py install for pep8 10:35:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:35:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:35:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:35:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:35:23 INFO - no previously-included directories found matching 'docs/_build' 10:35:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:35:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:35:23 INFO - Cleaning up... 10:35:23 INFO - Return code: 0 10:35:23 INFO - Running post-action listener: _resource_record_post_action 10:35:23 INFO - Running post-action listener: _start_resource_monitoring 10:35:23 INFO - Starting resource monitoring. 10:35:23 INFO - ##### 10:35:23 INFO - ##### Finished create-virtualenv step (success) 10:35:23 INFO - ##### 10:35:23 INFO - ##### 10:35:23 INFO - ##### Running install step. 10:35:23 INFO - ##### 10:35:23 INFO - Running pre-action listener: _resource_record_pre_action 10:35:23 INFO - Running main action method: install 10:35:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:23 INFO - Reading from file tmpfile_stdout 10:35:23 INFO - Detecting whether we're running mozinstall >=1.0... 10:35:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:35:23 INFO - Reading from file tmpfile_stdout 10:35:23 INFO - Output received: 10:35:23 INFO - Usage: mozinstall [options] installer 10:35:23 INFO - Options: 10:35:23 INFO - -h, --help show this help message and exit 10:35:23 INFO - -d DEST, --destination=DEST 10:35:23 INFO - Directory to install application into. [default: 10:35:23 INFO - "/builds/slave/test"] 10:35:23 INFO - --app=APP Application being installed. [default: firefox] 10:35:23 INFO - mkdir: /builds/slave/test/build/application 10:35:23 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:35:23 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:35:39 INFO - Reading from file tmpfile_stdout 10:35:39 INFO - Output received: 10:35:39 INFO - /builds/slave/test/build/application/firefox/firefox 10:35:39 INFO - Running post-action listener: _resource_record_post_action 10:35:39 INFO - ##### 10:35:39 INFO - ##### Finished install step (success) 10:35:39 INFO - ##### 10:35:39 INFO - ##### 10:35:39 INFO - ##### Running run-tests step. 10:35:39 INFO - ##### 10:35:39 INFO - Running pre-action listener: _resource_record_pre_action 10:35:39 INFO - Running main action method: run_tests 10:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:35:39 INFO - Python 2.7.3 10:35:39 INFO - Return code: 0 10:35:39 INFO - grabbing minidump binary from tooltool 10:35:39 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:39 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 0x186f1c0>, '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 0x18700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1870550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:35:39 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:35:39 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:35:39 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:35:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:35:39 INFO - Return code: 0 10:35:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:35:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:35:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:35:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:35:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:35:40 INFO - Return code: 0 10:35:40 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', '--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-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:35:40 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 --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-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:35:40 INFO - Using env: {'DISPLAY': ':0', 10:35:40 INFO - 'HOME': '/home/cltbld', 10:35:40 INFO - 'LANG': 'en_US.UTF-8', 10:35:40 INFO - 'LANGUAGE': 'en_US:en', 10:35:40 INFO - 'LOGNAME': 'cltbld', 10:35:40 INFO - 'MAIL': '/var/mail/cltbld', 10:35:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:35:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:40 INFO - 'MOZ_NO_REMOTE': '1', 10:35:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:35:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:40 INFO - 'NO_EM_RESTART': '1', 10:35:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:40 INFO - 'PWD': '/builds/slave/test', 10:35:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:35:40 INFO - 'SHELL': '/bin/bash', 10:35:40 INFO - 'SHLVL': '1', 10:35:40 INFO - 'TERM': 'linux', 10:35:40 INFO - 'TMOUT': '86400', 10:35:40 INFO - 'USER': 'cltbld', 10:35:40 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439', 10:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:40 INFO - '_': '/tools/buildbot/bin/python'} 10:35:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--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-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:35:40 INFO - mozversion application_buildid: 20160705075627 10:35:40 INFO - mozversion application_changeset: 7a72bfa56d502710aed70440c5da165a9fecb36b 10:35:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:35:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:35:40 INFO - mozversion application_name: Firefox 10:35:40 INFO - mozversion application_remotingname: firefox-dev 10:35:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:35:40 INFO - mozversion application_vendor: Mozilla 10:35:40 INFO - mozversion application_version: 49.0a2 10:35:40 INFO - mozversion platform_buildid: 20160705075627 10:35:40 INFO - mozversion platform_changeset: 7a72bfa56d502710aed70440c5da165a9fecb36b 10:35:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:35:40 INFO - mozversion platform_version: 49.0a2 10:35:40 INFO - using testdate: 1467740140 10:35:40 INFO - actual date: 1467740140 10:35:40 INFO - starting webserver on 'localhost:55942' 10:35:40 INFO - SUITE-START | Running 2 tests 10:35:40 INFO - TEST-START | dromaeo_css 10:35:40 INFO - operating with platform_type : linux_ 10:35:40 INFO - Initialising browser for dromaeo_css test... 10:35:40 INFO - TEST-INFO | started process 19106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn7DgEO/profile http://localhost:55942/getInfo.html) 10:35:44 INFO - PROCESS | 19106 | __metrics Screen width/height:1600/1200 10:35:44 INFO - PROCESS | 19106 | colorDepth:24 10:35:44 INFO - PROCESS | 19106 | Browser inner width/height: 1024/697 10:35:44 INFO - PROCESS | 19106 | __metrics 10:35:45 ERROR - PROCESS | 19106 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:35:46 INFO - TEST-INFO | 19106: exit 0 10:35:46 INFO - Browser initialized. 10:35:46 INFO - Running cycle 1/1 for dromaeo_css test... 10:35:46 INFO - TEST-INFO | started process 19196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn7DgEO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:58 INFO - PROCESS | 19196 | RSS: Main: 149155840 10:35:58 INFO - PROCESS | 19196 | 10:36:49 INFO - PROCESS | 19196 | 1467740209843 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:38:57 INFO - PROCESS | 19196 | Cycle 1(1): loaded http://localhost:55942/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55942/tests/dromaeo/cssquery-ext.html) 10:38:58 INFO - PROCESS | 19196 | RSS: Main: 254074880 10:38:58 INFO - PROCESS | 19196 | 10:42:01 INFO - PROCESS | 19196 | Cycle 1(1): loaded http://localhost:55942/tests/dromaeo/cssquery-ext.html (next: http://localhost:55942/tests/dromaeo/cssquery-jquery.html) 10:42:01 INFO - PROCESS | 19196 | RSS: Main: 225243136 10:42:01 INFO - PROCESS | 19196 | 10:45:03 INFO - PROCESS | 19196 | Cycle 1(1): loaded http://localhost:55942/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55942/tests/dromaeo/cssquery-mootools.html) 10:45:04 INFO - PROCESS | 19196 | RSS: Main: 222568448 10:45:04 INFO - PROCESS | 19196 | 10:48:06 INFO - PROCESS | 19196 | Cycle 1(1): loaded http://localhost:55942/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55942/tests/dromaeo/cssquery-prototype.html) 10:48:06 INFO - PROCESS | 19196 | RSS: Main: 221523968 10:48:06 INFO - PROCESS | 19196 | 10:51:09 INFO - PROCESS | 19196 | Cycle 1(1): loaded http://localhost:55942/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55942/tests/dromaeo/cssquery-yui.html) 10:51:09 INFO - PROCESS | 19196 | RSS: Main: 197074944 10:51:09 INFO - PROCESS | 19196 | 10:54:12 INFO - PROCESS | 19196 | Cycle 1(1): loaded http://localhost:55942/tests/dromaeo/cssquery-yui.html (next: http://localhost:55942/tests/dromaeo/cssquery-dojo.html) 10:54:12 INFO - PROCESS | 19196 | RSS: Main: 260710400 10:54:12 INFO - PROCESS | 19196 | 10:54:12 INFO - PROCESS | 19196 | __start_tp_report 10:54:12 INFO - PROCESS | 19196 | _x_x_mozilla_page_load 10:54:12 INFO - PROCESS | 19196 | _x_x_mozilla_page_load_details 10:54:12 INFO - PROCESS | 19196 | |i|pagename|runs| 10:54:12 INFO - PROCESS | 19196 | |0;dojo.html;3332.6334103248637;3350.4806754952992;3354.0273320736974;3372.14010427341;3413.573303337083;5447.700376479292;5457.208704737815;5491.176323551469;5520.254765606647;5527.336719593644;5464.836054918359;5511.9724401377935;5514.531264842493;5517.806876759314;5552.805651802188;4945.901081978358;4958.330625365575;4962.5781808546135;4983.576396006326;5010.94770098278;4997.450280469146;5085.669431486942;5090.516400941905;5091.032703786287;5095.923561146586;4966.751662416865;5015.122353588125;5032.6477146599755;5045.066662667418;5045.34410526631;5108.233764935252;5110.8466745997675;5112.437631860493;5125.923111153335;5136.717480538588;4876.146674332013;4951.282064100686;4994.425641051253;5027.648064635477;5038.622103342264;5357.678539287655;5399.811006614789;5432.158015507603;5458.372287186945;5460.26286451328;5941.376155503696;5944.316403613597;5984.910226346608;5992.131140984577;5993.430624090704;5817.970910145465;5887.823365299005;5895.970520147372;5951.49412299955;6020;5512.173174023888;5548.334199895998;5561.805336813273;5572.080606699889;5578.804741834017;5877.5591830612875;6052.757889684452;6058.242719660043;6060.727267272983;6061.696915154224;5701.657900525982;5823.213866128103;5826.242588463472;5841.386654401312;5849.064149736022;5887.676177810262;5889.352171261158;5890.705464726747;5922.437368449991;5928.970355148197;5556.638818476786;5769.451902069297;5858.970705146447;5872.29532456108;5873.618214816023;5813.651180929158;5840.123981402823;5849.356570777211;5867.61860479076;5877.265341832271;4523.841665541756;4528.41130653013;4534.59188673021;4535.4103966484145;4564.360989461478;3973.7417067890497;3993.940090898639;4002.639762421396;4056.249593825152;4098.569650186747;5594.496495315359;5607.775688972477;5623.831285061373;5625.774969001194;5631.915521267184;5879.676617785977;5881.852953676193;5892.882142357129;5904.1734157218025;5909.349971503131;5409.918851217235;5542.806001789918;5607.80372686954;5617.438256174431;5635.042042852725;5024.246363045572;5040.949590504121;5048.6718363307;5056.84829455117;5064.215046667772;6164;6168.568200226031;6169.938300616936;6170.444659980623;6170.784022559189;5773.018586840163;5847.26909136358;5919.023361145535;5922.792702255572;5963.165156877953;6142.140100386039;6145.754169833157;6153.661548614869;6154.3845615438095;6161.630302181704;5656.773729050792;5816.82549523515;5824.21373114641;5824.94175058244;5825.330087039875;5820.476157145878;5865.296164460292;5898.233229680114;5934.050551911673;5940.46535811779;5752.539796816328;5781.017227071492;5785.479306862402;5785.739641716217;5793.420657934173;5532.28080349552;5651.152327150796;5770.047942089508;5774.884502310014;5779.075347944308;5519.116941289374;5634.0422128239115;5653.519450846724;5677.1768093627015;5685.346185188756;5785.161151632906;5786.218860453953;5811.79658711943;5818.912716309174;5829.271341082364;5515.09001014828;5561.4716601922755;5610.635308704921;5680.573956953328;5701.087825947829 10:54:12 INFO - PROCESS | 19196 | |1;ext.html;605.6910975402543;629.1757797285553;644.9677516124194;660.791850567071;668.6990854115646;33741.325173496516;36221.63778362216;47658.2851257231;49430;49445.25832112512;49703;49888.75055624717;50086;50093.24860127101;50108;8303.128171541992;9132.497712625804;9297.070292970682;9302.674406395778;10827.133829293638;10564.471776411187;10963.287386319904;10968.616098436556;10973.945130274378;10980.396078215696;11061.557537698482;11115.388653624048;11117.777644447106;11120.61077862275;11121.888781112166;8519.275861551776;10869.728256793644;10905.236633435623;11215.551377944872;11243.100551955824;10643.94678026605;10981.341119532854;11055.170862185369;11068.944655276753;11072.723181920435;46115.53884461146;46457.535424645655;46539.767301163614;46640.76679616614;46785;3798.392257238856;3832.885013449601;3862.8261728222296;3948.8420463181724;4293.570642935712;35246.295074098634;35440.64559354425;35779.82110089459;36250;36951.445728314095;4795.952040479586;4812.542808433193;4822.228443449067;4884.291777692215;4897.8285759998225;403215;404482;405230;406288;408283.9585802082;37851.810740946115;40465.59534404618;40481;69786.65106674535;71052;42146.78926605347;42201.577984219766;42292.15415691669;42426;42449;15078.698426031418;15169.924150379178;15178.848211517743;15179.392824287126;15184;10650.414227217578;11978.64064078079;12348.506059757508;12358.382080895919;12678.683032924251;9486.430814151174;9488.28837837165;9492.477913714674;9568.952155239318;9575.281853860988;3576.535050443426;3620.5293311869286;3635.7454978151804;3656.725745569093;3705.6109108543756;1084.2897901874285;1171.94140292985;1246.5823948977195;1258.182181581979;1261.394530625305;35081.64918350835;35114.64885351165;35304.470432943526;35507.11232219215;35860.103497412776;1204.6325870609548;1220.8412906322121;1221.4747658506928;1272.910896237273;1291.702908331089;18349.33354490625;18612.534686632942;18691.906540467484;18709.719354209697;18767.718484222747;619891;622302;624301;624969;625799;65847;66274.66862665655;66303.33696662972;66378;66444.66777666178;1336.4988129451456;1366.665167034083;1401.474447082344;1479.3195130239994;1493.6340596553914;31884.840575796974;35161.00263562956;35569.46645800264;35750.28499429945;35841.82079089588;55131.44868551424;55673.44326556683;55696.72151639378;55727;55736;417121;417970;418612;419436;421021;30714.385712286075;32197.67802321947;32406;32518.187045324055;32545.511817322287;52071.218931715295;52625.21062184147;53495.465045350604;53858.730706346214;53995;43801.56198437975;43972.909715652124;44044.77977610091;44250;44840.55159448494;43943.34084988664;44230.55769442264;44661;44960.550394495636;45779;44150.11699765922;44443.11113777642;45227;46673.29990050084;47024.529754702016;37761.62238377691;38259.234815304095;39699.007524812114;40094.39858402068;40938.795306023276;30700.385992279582;30806.76285031505;31158.376832463677;31302.373952521277;31566 10:54:12 INFO - PROCESS | 19196 | |2;jquery.html;431.3055979872407;433.27426560511145;435.31655301177165;435.3565291026375;438.31403852970107;19486;19781.802181978175;20497.795022049795;20546.38360849173;20572;17993.19030643621;18020.639587208247;18724.15741291642;18752.718709219374;19107.235710571596;5644.57665675074;5866.237389139406;5875.9118613220835;5878.559108066891;5880.764769409218;5753.309602847664;5820.156077368779;5886.381929897363;5889.646621202742;5902.527797776168;5702.1446782982675;5728.198052272685;5805.187273781674;5835.533157347402;5877.14781356703;5676.176954341618;5730.341010783751;5752.971235143818;5841;5862;5134.281200631877;5233.2935053768015;5242.947570524284;5247.527722504955;5269.6311258211945;22999.885000575057;23550.175743849053;24182.274531764077;24604.507909841883;24638.50722985548;2513.32140322112;2518.949621007588;2609.686837579484;2747.3131717070733;2932.926676833075;14465.927670361687;14791.778123328158;14966.251687415695;14997.550073497812;15278.847211527853;1967.5081229692578;2008.2970960163825;2039.9694004589944;2065.493953981284;2098.8845613491253;82334.58832705858;83288;84906.57546712227;85719.5714021426;86582.56708716416;11769.352685602375;12033.63899083029;12041.879581204252;12049.096317776202;12129.454174562166;16758.162091895356;16783.916080419764;16840.915795421188;16853.831461685473;16896.239669214916;8021.919780802234;8113.797155071053;8317.542535160625;8370.455920365157;8567.871481927776;7636.7399379102935;7647.923520764833;7729.458937874295;7743;7743.264389882952;4950.628702847301;5004.3994720633755;5111.539961403491;5163.070647283525;5233.2935053768015;2053.3429302623017;2088.822450091759;2112.503561663008;2113.989430052871;2126.138913739938;945.7257395355407;1045.362328979322;1113.1062808162721;1114.0864491117206;1124.6907100547414;19427.708584371245;19477;19630.080456016287;19792.60414791696;20341.79658203399;1007.7581380468635;1054.288355360129;1074.8387741838787;1089.6948854320644;1138.2544433396138;11018.283811552385;11202.271852329572;11356.791449192151;11669.649910502698;11696.941515292368;500933;502202.44493887946;503541;509292;510912;60560.697196513735;66845.6657716718;74538;94435.055649444;96314.51842740881;984.8030393921244;997.9301448898508;1017.7710015246511;1028.0644613401769;1038.5586125896464;18099.276028958695;18488.537786554905;18569.687524974415;18644.161012754186;18651.720224196375;41832;42328.57671423246;43071.35392969171;43505.78247108744;44259.11481770411;58815.11777323429;58960.70519647374;59559.10661339997;59958.40041599528;61105.38894611175;8035;8350.457220280663;8381.413301068867;8530.829383412422;9090.045545217657;9574.234061275221;13088.149270297401;13710.108842925178;13847.238401887993;13957.302134893418;11254.493547790533;11679.941600291944;12018.939905300767;12073.335966521925;12133.02935765119;11290.887091128983;11517.308961462339;11935.940320298343;12068.879311206776;12252;12244.326562039174;12483.812742809047;12529.49882004746;12683.239005659321;13003.219806811621;8178.304844088319;8244.093149753402;12573.93713031429;13597.79603305971;13863.930680346533;12363;12553.372331383212;12559.623211303675;12727.23636581808;12937.935310323388 10:54:12 INFO - PROCESS | 19196 | |3;mootools.html;1372.368710393219;1588.3646541383441;1644.2600829626667;1870.4014715291103;1951.3462989898392;9164.58759355829;9568.378055426401;9605.855912161305;9880.802383952318;9908.653197138101;9609.759756006104;9803.166730827888;9815.312928095018;9821.508924553762;9824.115829575354;2221.566794475078;2435.342457536473;2513.40934880303;2549.8852551635223;2579.6775403074616;2524.798016158703;2568.4221050263727;2579.432524844531;2581.6256642786784;2583.5349637065415;2519.4709111086604;2549.1332946798084;2550.502651982864;2550.8469491830456;2552.5660637691635;2202.603531364354;2466.851988880664;2518.496300739859;2527.721950585434;2550.9362265943314;2414.4084699248797;2457.9754202457925;2463.987680061606;2491.9252422427357;2497.051120574188;9520.285978551636;9546.61813527458;9559.61761529538;9560.426374417488;9574.760630984212;5474.72626368684;5600.187972743929;5608.5793565482345;5608.579356548275;5613.887722245532;3589.10272431892;3658.762180458262;3726.795026273554;3787.1857550626473;3787.3561494545993;1316.9078164528487;1342.1745626439767;1359.5173713331822;1364.6451922500123;1381.1920026784344;13914.860851391457;13918.791218131737;13921.721565568732;13930.930345348208;13942.790858137136;5038.193888977819;5066.721330326794;5113.207452844815;5116.258142569381;5192.636515443958;11328.2070255083;11437.828432573519;11498.827517587242;11500.88499115015;11503.482343294572;4811.639127065484;5633.605647604711;5637.9718101409235;5637.9718101409235;5639.295088113986;4916.336294600254;5027.1705168647495;5035.7985680572365;5052.520010598987;5068.771905264272;4370.2570563004365;4422.823087076546;4485.573870482299;4530.22986092365;4539.886502837456;1368.719412520431;1385.6120286319847;1388.9097208681605;1402.0466083063616;1417.376354404059;885.2608072259607;992.0922356044139;993.9933832975452;999.7600575861741;1037.8495118207818;6082.9695851520455;6380.78867947162;6386.233651961795;6405.711742971577;6512.381323774234;467.8011844965876;482.11050611621505;488.52709082117445;496.55558275343367;505.4162442379058;4307.913841723148;4358.978205108954;4397.73613583186;4440.511543730187;4462.241418958784;11926.522939082513;12272;12447.93776031114;12507.56223532172;12528;11997.40012999364;12314.938425307817;12546.05904557162;12636.81044784329;12661.36693165338;8289.875651865106;8596.355273354524;8738.519381434082;8756.737297881074;8771.91228087711;6350.872982540416;6493;6527.2167339919515;6615.966920165369;6617.602943823386;10771.784564308826;11103.111751060058;11343.659690209306;11439.370834604177;11444.656660299872;11477.253978491372;11482.540698372306;11488.597899073826;11508.136889733136;11607.76784464323;7600.50596711212;7810.843783124192;8409;8424.368172386972;8572.27135693473;9480.525973701426;9670.226381889574;9771.560279787569;9800.901990979999;9809.607615695293;8529.104444033535;8634.56827158652;8686.261667758312;8708.216260536583;8793.076726943578;8342.541160236246;8466.788330291793;8546.059933407196;8581.95709021451;8655.610497527501;7714.190010049088;7787.4548781584745;7827.9608601956625;7867.685292588232;7869.370450364072;5526.419725928719;5533.529649979797;5605.24329215567;5716.54267658578;5784.4504772046585;5431.049566325956;5484.533814625642;5617.297837770278;5619.960307343154;5754.827355179351 10:54:12 INFO - PROCESS | 19196 | |4;prototype.html;338.4601560510985;357.5602009528281;364.7009452249157;373.0747745590936;374.36918791835757;5433.212184233284;5516.124517663993;5516.365617953931;5517.503424691777;5543.501084902358;5410;5446.1558458439;5480;5481.725913704318;5489.258950041743;4158.106007208457;4228.281192197319;4279.40088387626;4281.400603915455;4310.698251122422;4211.410402543631;4225.6830737694645;4227.556106608808;4284.078923031548;4284.421603083575;4201.222773786844;4209;4210.736778966313;4232.9788351058205;4256.318988961767;4086.366613174963;4213.157368526292;4220.944763809048;4223.556526564697;4267.893302667442;3741.8129093545213;3742.644448777362;3762.8682996095004;3763.34141525232;3766.3032339017095;5218.799676074486;5280.656757310762;5286.440500052494;5318.893622127536;5322.467753224685;4771.427428708543;4838.830640927586;4862.270659401082;4885.7312847793355;4886.706797592155;5627.409122042168;5632.127020311858;5638.830835074954;5654.6324488908085;5663.773449062074;4131.566185550504;4132.566080561558;4149.564295748933;4150.564190759957;4161.667066634662;5638;5854.941450585525;5910.556708246856;5934.465898069151;5981.401859814027;4185.100203456272;4188.832446702158;4191.559886211965;4207.368894665763;4217.683673724483;4243.724157929724;4250.341197114452;4253.532111467736;4269.210196113729;4272.829086836554;4579.771011449414;4858.6356023298395;4877.634177436636;4891.779869905863;4904.607631389552;5739.253896993364;5763.740631671585;5772.278465191851;5775.711214439345;5796.449337313033;1436.705475377545;1447.1100273331824;1447.3631602095045;1453.738327101132;1454.8326942401548;920.4523308631487;944.6127087894068;948.7950303115006;954.355809828363;962.8459446488528;4896.6572339935865;4984.675996060317;4992.226204938241;5005.924911126336;5056.165732654144;5177.886754347758;5200.869978250574;5226.817061402909;5243.239730239094;5339.946600533945;5087.771050302746;5104.804933878394;5120.899006713575;5219.16493361068;5688.829335119953;3138.8430578470984;3157;3167.841607919641;3168.6197656280933;3173.539836723662;6086.573939824169;6098.32918378978;6137.202163718777;6185.659788711574;6188.659623720739;5626.708375600238;5674.659520428788;5813.593048486566;5931.406859314034;5949.702514874239;5997.301214453426;6027.758889644365;6062.818115456544;6113.144159817629;6125.326214116443;5616.8876622466505;5832.358440571618;5850.853728656818;5918.911216331672;5928.822135335947;5544.695041772741;5797.246357973437;5848.385919478564;5851.327097383855;5861.882762344644;6052.485538729257;6061.72722227492;6078.206928956057;6099.664518451527;6109.327973922776;4112.259793237246;4214.367844823301;4219.97890010548;4223.345381465878;4235.534091250021;5826.621269617462;5830.47525722687;5862.325832529314;5865.354810970704;5872.706364681663;5691.630044047124;5716.02766561394;5729.512991395612;5737.713114344183;5773.162891380643;5474.452554744494;5683.77264909399;5695.174199741097;5709.571782116275;5720.656760594377;5582.8325150245555;5602.9719851402115;5603.719814009201;5643.322801263875;5646.830595082154;5455.8363249102595;5664.413964090061;5698.601097923106;5731.398203188605;5789.334226563999;5642.956053130184;5678.914816277676;5689.630174038674;5699.544036477155;5703.543716502752 10:54:12 INFO - PROCESS | 19196 | |5;yui.html;818.9140140285274;833.2500749325607;868.7741187291304;889.0442774017924;907.9105172909375;14258.572242832719;15198.924005379971;15250.6949861003;15262.160581168031;15285.235738213087;14263.215523146222;14365.49720759771;14374.137551746902;14383.20892350923;14389.064710793817;705.100996229806;826.8181000179951;856;858.669412276275;864.8962124545031;845.5898889038812;849.4733265375445;850.961706723199;852.2457625001856;853.1638993786094;905.0316161706976;905.85053466178;907.0974380491388;907.1065000974069;907.2333877873219;757.413004921185;892.8749975003504;914.1041779056562;916.9083091690811;919.3886065766258;676.922153952292;677.5832862789398;678.2505331608551;678.3996163395382;678.5996262205273;13834.93082534581;13851.16892986414;13888.305584720723;13901.652458688513;13905.513307034307;14757;15352.846471535366;15441.30514126867;15560.766588501181;15658.138802365866;13736.725265494633;13895.374708138057;13925;13949.860501394958;14005.55475220516;4632.86101416958;4670.626349892034;4788.592969597588;4805.135075686375;4814.903701925942;71107.64446177788;71910.64044679744;72233.27766722318;72856.6357168216;73104.26895731028;11831.290122592673;11988.820167697491;12196.81704774429;12256.693582660326;12396.504139834306;22295.219667311892;22304.553908922055;22312.330630081124;22506.774932250468;22590.322290331318;8809.33929955256;8860.955695221612;8889.244414224733;9082.954585227031;9183.357164998519;4938;5037.102094384479;5076.314697515862;5134.768935397916;5153.175491921274;3660.743747937672;3753.9061523462133;3773.396256598931;3774.1885494618787;3774.2074164425776;628.4972022382076;637.6620391192582;724.3517052238323;732.1836152689713;740;624.6501958903029;625.7184267079832;656.1797752808989;750.740994356946;762.9122650895218;10995;11249.887501125047;11363.943180284046;11487.19589628718;11587.826182607268;740.9777706668808;743.3012967810241;751.2449987762263;757.5757575757483;758.852023855354;5040.294358789773;5094.388673359146;5115.974420127875;5128.282040514331;5206.401263854629;117870.4106479462;119049;120901.39549302198;129904;130151.34924325507;107905.46047269713;108374.45812770886;108934;111189.44405277922;112697;55090.449095508535;55633.16550251749;57586.42413575894;83543.16456835475;84586.5770671155;10267.94866025665;10311.896881031094;10442.53008614599;10607.734806629587;10697.358158510515;39359.60640393559;48436.273455898896;51376.229356558935;52071.47928520666;53118.468815312895;69717;71615.28384716086;72491.63754181196;72851.63574182095;73918.26081739328;14147.080439771793;14189.972934656347;14290.35693393779;14341.282935852956;14516.564503064925;10960.28758130719;15199;15410.691786164438;15643;16187.190640468165;9703.514824258618;14095.224762637743;14147;15227.92386038107;16062.036277823368;13755.10591811529;13951.441942322193;14182.503612373517;14692.118472891661;14766.48317308889;11568.768624627628;11961.342126183143;13592.728145437233;14889.478868239992;15188.772168417703;11258.831117533407;11695.181337306307;11753.823692644788;12263.38683065861;12464.750704985669;12677.619671409873;12735.490580376681;12746.426410811351;12777.93611031939;13162.47350105985 10:54:12 INFO - PROCESS | 19196 | __end_tp_report 10:54:12 INFO - PROCESS | 19196 | __start_cc_report 10:54:12 INFO - PROCESS | 19196 | _x_x_mozilla_cycle_collect,949 10:54:12 INFO - PROCESS | 19196 | __end_cc_report 10:54:12 INFO - PROCESS | 19196 | __startTimestamp1467741252787__endTimestamp 10:54:12 INFO - PROCESS | 19196 | 10:54:12 INFO - PROCESS | 19196 | ------- Summary: start ------- 10:54:12 INFO - PROCESS | 19196 | Number of tests: 6 10:54:12 INFO - PROCESS | 19196 | 10:54:12 INFO - PROCESS | 19196 | [#0] dojo.html Cycles:165 Average:5480.72 Median:5651.15 stddev:601.19 (10.6%) stddev-sans-first:578.94 10:54:12 INFO - PROCESS | 19196 | Values: 3332.6 3350.5 3354.0 3372.1 3413.6 5447.7 5457.2 5491.2 5520.3 5527.3 5464.8 5512.0 5514.5 5517.8 5552.8 4945.9 4958.3 4962.6 4983.6 5010.9 4997.5 5085.7 5090.5 5091.0 5095.9 4966.8 5015.1 5032.6 5045.1 5045.3 5108.2 5110.8 5112.4 5125.9 5136.7 4876.1 4951.3 4994.4 5027.6 5038.6 5357.7 5399.8 5432.2 5458.4 5460.3 5941.4 5944.3 5984.9 5992.1 5993.4 5818.0 5887.8 5896.0 5951.5 6020.0 5512.2 5548.3 5561.8 5572.1 5578.8 5877.6 6052.8 6058.2 6060.7 6061.7 5701.7 5823.2 5826.2 5841.4 5849.1 5887.7 5889.4 5890.7 5922.4 5929.0 5556.6 5769.5 5859.0 5872.3 5873.6 5813.7 5840.1 5849.4 5867.6 5877.3 4523.8 4528.4 4534.6 4535.4 4564.4 3973.7 3993.9 4002.6 4056.2 4098.6 5594.5 5607.8 5623.8 5625.8 5631.9 5879.7 5881.9 5892.9 5904.2 5909.3 5409.9 5542.8 5607.8 5617.4 5635.0 5024.2 5040.9 5048.7 5056.8 5064.2 6164.0 6168.6 6169.9 6170.4 6170.8 5773.0 5847.3 5919.0 5922.8 5963.2 6142.1 6145.8 6153.7 6154.4 6161.6 5656.8 5816.8 5824.2 5824.9 5825.3 5820.5 5865.3 5898.2 5934.1 5940.5 5752.5 5781.0 5785.5 5785.7 5793.4 5532.3 5651.2 5770.0 5774.9 5779.1 5519.1 5634.0 5653.5 5677.2 5685.3 5785.2 5786.2 5811.8 5818.9 5829.3 5515.1 5561.5 5610.6 5680.6 5701.1 10:54:12 INFO - PROCESS | 19196 | 10:54:12 INFO - PROCESS | 19196 | [#1] ext.html Cycles:180 Average:64585.00 Median:221654.70 stddev:131042.28 (59.1%) stddev-sans-first:131321.84 10:54:12 INFO - PROCESS | 19196 | Values: 605.7 629.2 645.0 660.8 668.7 33741.3 36221.6 47658.3 49430.0 49445.3 49703.0 49888.8 50086.0 50093.2 50108.0 8303.1 9132.5 9297.1 9302.7 10827.1 10564.5 10963.3 10968.6 10973.9 10980.4 11061.6 11115.4 11117.8 11120.6 11121.9 8519.3 10869.7 10905.2 11215.6 11243.1 10643.9 10981.3 11055.2 11068.9 11072.7 46115.5 46457.5 46539.8 46640.8 46785.0 3798.4 3832.9 3862.8 3948.8 4293.6 35246.3 35440.6 35779.8 36250.0 36951.4 4796.0 4812.5 4822.2 4884.3 4897.8 403215.0 404482.0 405230.0 406288.0 408284.0 37851.8 40465.6 40481.0 69786.7 71052.0 42146.8 42201.6 42292.2 42426.0 42449.0 15078.7 15169.9 15178.8 15179.4 15184.0 10650.4 11978.6 12348.5 12358.4 12678.7 9486.4 9488.3 9492.5 9569.0 9575.3 3576.5 3620.5 3635.7 3656.7 3705.6 1084.3 1171.9 1246.6 1258.2 1261.4 35081.6 35114.6 35304.5 35507.1 35860.1 1204.6 1220.8 1221.5 1272.9 1291.7 18349.3 18612.5 18691.9 18709.7 18767.7 619891.0 622302.0 624301.0 624969.0 625799.0 65847.0 66274.7 66303.3 66378.0 66444.7 1336.5 1366.7 1401.5 1479.3 1493.6 31884.8 35161.0 35569.5 35750.3 35841.8 55131.4 55673.4 55696.7 55727.0 55736.0 417121.0 417970.0 418612.0 419436.0 421021.0 30714.4 32197.7 32406.0 32518.2 32545.5 52071.2 52625.2 53495.5 53858.7 53995.0 43801.6 43972.9 44044.8 44250.0 44840.6 43943.3 44230.6 44661.0 44960.6 45779.0 44150.1 44443.1 45227.0 46673.3 47024.5 37761.6 38259.2 39699.0 40094.4 40938.8 30700.4 30806.8 31158.4 31302.4 31566.0 10:54:12 INFO - PROCESS | 19196 | 10:54:12 INFO - PROCESS | 19196 | [#2] jquery.html Cycles:180 Average:29683.07 Median:23866.23 stddev:83027.37 (347.9%) stddev-sans-first:83231.24 10:54:12 INFO - PROCESS | 19196 | Values: 431.3 433.3 435.3 435.4 438.3 19486.0 19781.8 20497.8 20546.4 20572.0 17993.2 18020.6 18724.2 18752.7 19107.2 5644.6 5866.2 5875.9 5878.6 5880.8 5753.3 5820.2 5886.4 5889.6 5902.5 5702.1 5728.2 5805.2 5835.5 5877.1 5676.2 5730.3 5753.0 5841.0 5862.0 5134.3 5233.3 5242.9 5247.5 5269.6 22999.9 23550.2 24182.3 24604.5 24638.5 2513.3 2518.9 2609.7 2747.3 2932.9 14465.9 14791.8 14966.3 14997.6 15278.8 1967.5 2008.3 2040.0 2065.5 2098.9 82334.6 83288.0 84906.6 85719.6 86582.6 11769.4 12033.6 12041.9 12049.1 12129.5 16758.2 16783.9 16840.9 16853.8 16896.2 8021.9 8113.8 8317.5 8370.5 8567.9 7636.7 7647.9 7729.5 7743.0 7743.3 4950.6 5004.4 5111.5 5163.1 5233.3 2053.3 2088.8 2112.5 2114.0 2126.1 945.7 1045.4 1113.1 1114.1 1124.7 19427.7 19477.0 19630.1 19792.6 20341.8 1007.8 1054.3 1074.8 1089.7 1138.3 11018.3 11202.3 11356.8 11669.6 11696.9 500933.0 502202.4 503541.0 509292.0 510912.0 60560.7 66845.7 74538.0 94435.1 96314.5 984.8 997.9 1017.8 1028.1 1038.6 18099.3 18488.5 18569.7 18644.2 18651.7 41832.0 42328.6 43071.4 43505.8 44259.1 58815.1 58960.7 59559.1 59958.4 61105.4 8035.0 8350.5 8381.4 8530.8 9090.0 9574.2 13088.1 13710.1 13847.2 13957.3 11254.5 11679.9 12018.9 12073.3 12133.0 11290.9 11517.3 11935.9 12068.9 12252.0 12244.3 12483.8 12529.5 12683.2 13003.2 8178.3 8244.1 12573.9 13597.8 13863.9 12363.0 12553.4 12559.6 12727.2 12937.9 10:54:12 INFO - PROCESS | 19196 | 10:54:12 INFO - PROCESS | 19196 | [#3] mootools.html Cycles:180 Average:6376.91 Median:2706.45 stddev:3740.50 (138.2%) stddev-sans-first:3732.08 10:54:12 INFO - PROCESS | 19196 | Values: 1372.4 1588.4 1644.3 1870.4 1951.3 9164.6 9568.4 9605.9 9880.8 9908.7 9609.8 9803.2 9815.3 9821.5 9824.1 2221.6 2435.3 2513.4 2549.9 2579.7 2524.8 2568.4 2579.4 2581.6 2583.5 2519.5 2549.1 2550.5 2550.8 2552.6 2202.6 2466.9 2518.5 2527.7 2550.9 2414.4 2458.0 2464.0 2491.9 2497.1 9520.3 9546.6 9559.6 9560.4 9574.8 5474.7 5600.2 5608.6 5608.6 5613.9 3589.1 3658.8 3726.8 3787.2 3787.4 1316.9 1342.2 1359.5 1364.6 1381.2 13914.9 13918.8 13921.7 13930.9 13942.8 5038.2 5066.7 5113.2 5116.3 5192.6 11328.2 11437.8 11498.8 11500.9 11503.5 4811.6 5633.6 5638.0 5638.0 5639.3 4916.3 5027.2 5035.8 5052.5 5068.8 4370.3 4422.8 4485.6 4530.2 4539.9 1368.7 1385.6 1388.9 1402.0 1417.4 885.3 992.1 994.0 999.8 1037.8 6083.0 6380.8 6386.2 6405.7 6512.4 467.8 482.1 488.5 496.6 505.4 4307.9 4359.0 4397.7 4440.5 4462.2 11926.5 12272.0 12447.9 12507.6 12528.0 11997.4 12314.9 12546.1 12636.8 12661.4 8289.9 8596.4 8738.5 8756.7 8771.9 6350.9 6493.0 6527.2 6616.0 6617.6 10771.8 11103.1 11343.7 11439.4 11444.7 11477.3 11482.5 11488.6 11508.1 11607.8 7600.5 7810.8 8409.0 8424.4 8572.3 9480.5 9670.2 9771.6 9800.9 9809.6 8529.1 8634.6 8686.3 8708.2 8793.1 8342.5 8466.8 8546.1 8582.0 8655.6 7714.2 7787.5 7828.0 7867.7 7869.4 5526.4 5533.5 5605.2 5716.5 5784.5 5431.0 5484.5 5617.3 5620.0 5754.8 10:54:12 INFO - PROCESS | 19196 | 10:54:12 INFO - PROCESS | 19196 | [#4] prototype.html Cycles:180 Average:4776.83 Median:5439.68 stddev:1396.32 (25.7%) stddev-sans-first:1359.92 10:54:12 INFO - PROCESS | 19196 | Values: 338.5 357.6 364.7 373.1 374.4 5433.2 5516.1 5516.4 5517.5 5543.5 5410.0 5446.2 5480.0 5481.7 5489.3 4158.1 4228.3 4279.4 4281.4 4310.7 4211.4 4225.7 4227.6 4284.1 4284.4 4201.2 4209.0 4210.7 4233.0 4256.3 4086.4 4213.2 4220.9 4223.6 4267.9 3741.8 3742.6 3762.9 3763.3 3766.3 5218.8 5280.7 5286.4 5318.9 5322.5 4771.4 4838.8 4862.3 4885.7 4886.7 5627.4 5632.1 5638.8 5654.6 5663.8 4131.6 4132.6 4149.6 4150.6 4161.7 5638.0 5854.9 5910.6 5934.5 5981.4 4185.1 4188.8 4191.6 4207.4 4217.7 4243.7 4250.3 4253.5 4269.2 4272.8 4579.8 4858.6 4877.6 4891.8 4904.6 5739.3 5763.7 5772.3 5775.7 5796.4 1436.7 1447.1 1447.4 1453.7 1454.8 920.5 944.6 948.8 954.4 962.8 4896.7 4984.7 4992.2 5005.9 5056.2 5177.9 5200.9 5226.8 5243.2 5339.9 5087.8 5104.8 5120.9 5219.2 5688.8 3138.8 3157.0 3167.8 3168.6 3173.5 6086.6 6098.3 6137.2 6185.7 6188.7 5626.7 5674.7 5813.6 5931.4 5949.7 5997.3 6027.8 6062.8 6113.1 6125.3 5616.9 5832.4 5850.9 5918.9 5928.8 5544.7 5797.2 5848.4 5851.3 5861.9 6052.5 6061.7 6078.2 6099.7 6109.3 4112.3 4214.4 4220.0 4223.3 4235.5 5826.6 5830.5 5862.3 5865.4 5872.7 5691.6 5716.0 5729.5 5737.7 5773.2 5474.5 5683.8 5695.2 5709.6 5720.7 5582.8 5603.0 5603.7 5643.3 5646.8 5455.8 5664.4 5698.6 5731.4 5789.3 5643.0 5678.9 5689.6 5699.5 5703.5 10:54:12 INFO - PROCESS | 19196 | 10:54:12 INFO - PROCESS | 19196 | [#5] yui.html Cycles:180 Average:20911.19 Median:3763.65 stddev:30177.47 (801.8%) stddev-sans-first:30224.42 10:54:12 INFO - PROCESS | 19196 | Values: 818.9 833.3 868.8 889.0 907.9 14258.6 15198.9 15250.7 15262.2 15285.2 14263.2 14365.5 14374.1 14383.2 14389.1 705.1 826.8 856.0 858.7 864.9 845.6 849.5 851.0 852.2 853.2 905.0 905.9 907.1 907.1 907.2 757.4 892.9 914.1 916.9 919.4 676.9 677.6 678.3 678.4 678.6 13834.9 13851.2 13888.3 13901.7 13905.5 14757.0 15352.8 15441.3 15560.8 15658.1 13736.7 13895.4 13925.0 13949.9 14005.6 4632.9 4670.6 4788.6 4805.1 4814.9 71107.6 71910.6 72233.3 72856.6 73104.3 11831.3 11988.8 12196.8 12256.7 12396.5 22295.2 22304.6 22312.3 22506.8 22590.3 8809.3 8861.0 8889.2 9083.0 9183.4 4938.0 5037.1 5076.3 5134.8 5153.2 3660.7 3753.9 3773.4 3774.2 3774.2 628.5 637.7 724.4 732.2 740.0 624.7 625.7 656.2 750.7 762.9 10995.0 11249.9 11363.9 11487.2 11587.8 741.0 743.3 751.2 757.6 758.9 5040.3 5094.4 5116.0 5128.3 5206.4 117870.4 119049.0 120901.4 129904.0 130151.3 107905.5 108374.5 108934.0 111189.4 112697.0 55090.4 55633.2 57586.4 83543.2 84586.6 10267.9 10311.9 10442.5 10607.7 10697.4 39359.6 48436.3 51376.2 52071.5 53118.5 69717.0 71615.3 72491.6 72851.6 73918.3 14147.1 14190.0 14290.4 14341.3 14516.6 10960.3 15199.0 15410.7 15643.0 16187.2 9703.5 14095.2 14147.0 15227.9 16062.0 13755.1 13951.4 14182.5 14692.1 14766.5 11568.8 11961.3 13592.7 14889.5 15188.8 11258.8 11695.2 11753.8 12263.4 12464.8 12677.6 12735.5 12746.4 12777.9 13162.5 10:54:12 INFO - PROCESS | 19196 | -------- Summary: end -------- 10:54:12 INFO - PROCESS | 19196 | 10:54:13 INFO - TEST-INFO | 19196: exit 0 10:54:13 INFO - TEST-OK | dromaeo_css | took 1112595ms 10:54:13 INFO - TEST-START | kraken 10:54:13 INFO - operating with platform_type : linux_ 10:54:13 INFO - Initialising browser for kraken test... 10:54:13 INFO - TEST-INFO | started process 19382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkFCmTK/profile http://localhost:55942/getInfo.html) 10:54:17 INFO - PROCESS | 19382 | __metrics Screen width/height:1600/1200 10:54:17 INFO - PROCESS | 19382 | colorDepth:24 10:54:17 INFO - PROCESS | 19382 | Browser inner width/height: 1024/697 10:54:17 INFO - PROCESS | 19382 | __metrics 10:54:18 ERROR - PROCESS | 19382 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:54:19 INFO - TEST-INFO | 19382: exit 0 10:54:19 INFO - Browser initialized. 10:54:19 INFO - Running cycle 1/1 for kraken test... 10:54:19 INFO - TEST-INFO | started process 19475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkFCmTK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:31 INFO - PROCESS | 19475 | RSS: Main: 144900096 10:54:31 INFO - PROCESS | 19475 | 10:54:33 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55942/tests/kraken/driver.html?testName=audio-beat-detection) 10:54:34 INFO - PROCESS | 19475 | RSS: Main: 193982464 10:54:34 INFO - PROCESS | 19475 | 10:54:36 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55942/tests/kraken/driver.html?testName=audio-dft) 10:54:37 INFO - PROCESS | 19475 | RSS: Main: 193060864 10:54:37 INFO - PROCESS | 19475 | 10:54:40 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55942/tests/kraken/driver.html?testName=audio-fft) 10:54:41 INFO - PROCESS | 19475 | RSS: Main: 279044096 10:54:41 INFO - PROCESS | 19475 | 10:54:43 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55942/tests/kraken/driver.html?testName=audio-oscillator) 10:54:43 INFO - PROCESS | 19475 | RSS: Main: 187424768 10:54:43 INFO - PROCESS | 19475 | 10:54:45 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55942/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:54:46 INFO - PROCESS | 19475 | RSS: Main: 188280832 10:54:46 INFO - PROCESS | 19475 | 10:54:49 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55942/tests/kraken/driver.html?testName=imaging-darkroom) 10:54:49 INFO - PROCESS | 19475 | RSS: Main: 223637504 10:54:49 INFO - PROCESS | 19475 | 10:54:53 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55942/tests/kraken/driver.html?testName=imaging-desaturate) 10:54:53 INFO - PROCESS | 19475 | RSS: Main: 220958720 10:54:53 INFO - PROCESS | 19475 | 10:54:56 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55942/tests/kraken/driver.html?testName=json-parse-financial) 10:54:57 INFO - PROCESS | 19475 | RSS: Main: 220934144 10:54:57 INFO - PROCESS | 19475 | 10:54:58 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55942/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:54:59 INFO - PROCESS | 19475 | RSS: Main: 199585792 10:54:59 INFO - PROCESS | 19475 | 10:55:01 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55942/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:55:01 INFO - PROCESS | 19475 | RSS: Main: 200413184 10:55:01 INFO - PROCESS | 19475 | 10:55:03 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55942/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:55:04 INFO - PROCESS | 19475 | RSS: Main: 210120704 10:55:04 INFO - PROCESS | 19475 | 10:55:06 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:55:07 INFO - PROCESS | 19475 | RSS: Main: 217509888 10:55:07 INFO - PROCESS | 19475 | 10:55:10 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:55:10 INFO - PROCESS | 19475 | RSS: Main: 217411584 10:55:10 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:55942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55942/tests/kraken/driver.html?testName=ai-astar) 10:55:12 INFO - PROCESS | 19475 | RSS: Main: 260571136 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | __start_tp_report 10:55:12 INFO - PROCESS | 19475 | _x_x_mozilla_page_load 10:55:12 INFO - PROCESS | 19475 | _x_x_mozilla_page_load_details 10:55:12 INFO - PROCESS | 19475 | |i|pagename|runs| 10:55:12 INFO - PROCESS | 19475 | |0;ai-astar;110;106;111;109;110;109;108;110;109;109 10:55:12 INFO - PROCESS | 19475 | |1;audio-beat-detection;158;126;127;171;127;129;126;157;166;123 10:55:12 INFO - PROCESS | 19475 | |2;audio-dft;161;163;163;160;160;162;160;161;160;159 10:55:12 INFO - PROCESS | 19475 | |3;audio-fft;73;75;74;124;78;77;75;75;100;75 10:55:12 INFO - PROCESS | 19475 | |4;audio-oscillator;84;83;117;83;85;85;111;84;85;119 10:55:12 INFO - PROCESS | 19475 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 10:55:12 INFO - PROCESS | 19475 | |6;imaging-darkroom;145;145;146;146;145;145;146;146;144;145 10:55:12 INFO - PROCESS | 19475 | |7;imaging-desaturate;95;95;95;94;94;95;94;95;94;95 10:55:12 INFO - PROCESS | 19475 | |8;json-parse-financial;52;50;50;51;50;51;52;51;51;52 10:55:12 INFO - PROCESS | 19475 | |9;json-stringify-tinderbox;59;59;59;60;60;60;59;60;59;60 10:55:12 INFO - PROCESS | 19475 | |10;stanford-crypto-aes;76;76;81;75;76;76;77;79;115;77 10:55:12 INFO - PROCESS | 19475 | |11;stanford-crypto-ccm;118;118;120;116;118;117;116;124;134;121 10:55:12 INFO - PROCESS | 19475 | |12;stanford-crypto-pbkdf2;158;149;155;152;151;152;151;154;151;152 10:55:12 INFO - PROCESS | 19475 | |13;stanford-crypto-sha256-iterative;61;62;65;61;61;60;60;61;59;59 10:55:12 INFO - PROCESS | 19475 | __end_tp_report 10:55:12 INFO - PROCESS | 19475 | __start_cc_report 10:55:12 INFO - PROCESS | 19475 | _x_x_mozilla_cycle_collect,1559 10:55:12 INFO - PROCESS | 19475 | __end_cc_report 10:55:12 INFO - PROCESS | 19475 | __startTimestamp1467741312516__endTimestamp 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | ------- Summary: start ------- 10:55:12 INFO - PROCESS | 19475 | Number of tests: 14 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.50 stddev:1.37 (1.3%) stddev-sans-first:1.41 10:55:12 INFO - PROCESS | 19475 | Values: 110.0 106.0 111.0 109.0 110.0 109.0 108.0 110.0 109.0 109.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:143.00 stddev:19.38 (13.6%) stddev-sans-first:19.55 10:55:12 INFO - PROCESS | 19475 | Values: 158.0 126.0 127.0 171.0 127.0 129.0 126.0 157.0 166.0 123.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.37 (0.9%) stddev-sans-first:1.45 10:55:12 INFO - PROCESS | 19475 | Values: 161.0 163.0 163.0 160.0 160.0 162.0 160.0 161.0 160.0 159.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:16.55 (22.1%) stddev-sans-first:17.19 10:55:12 INFO - PROCESS | 19475 | Values: 73.0 75.0 74.0 124.0 78.0 77.0 75.0 75.0 100.0 75.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:84.00 stddev:15.37 (18.3%) stddev-sans-first:15.91 10:55:12 INFO - PROCESS | 19475 | Values: 84.0 83.0 117.0 83.0 85.0 85.0 111.0 84.0 85.0 119.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:55:12 INFO - PROCESS | 19475 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:55:12 INFO - PROCESS | 19475 | Values: 145.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 144.0 145.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:55:12 INFO - PROCESS | 19475 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 95.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:0.82 (1.6%) stddev-sans-first:0.78 10:55:12 INFO - PROCESS | 19475 | Values: 52.0 50.0 50.0 51.0 50.0 51.0 52.0 51.0 51.0 52.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 10:55:12 INFO - PROCESS | 19475 | Values: 59.0 59.0 59.0 60.0 60.0 60.0 59.0 60.0 59.0 60.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:76.50 stddev:12.15 (15.9%) stddev-sans-first:12.76 10:55:12 INFO - PROCESS | 19475 | Values: 76.0 76.0 81.0 75.0 76.0 76.0 77.0 79.0 115.0 77.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:119.00 stddev:5.43 (4.6%) stddev-sans-first:5.70 10:55:12 INFO - PROCESS | 19475 | Values: 118.0 118.0 120.0 116.0 118.0 117.0 116.0 124.0 134.0 121.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:152.00 stddev:2.55 (1.7%) stddev-sans-first:1.76 10:55:12 INFO - PROCESS | 19475 | Values: 158.0 149.0 155.0 152.0 151.0 152.0 151.0 154.0 151.0 152.0 10:55:12 INFO - PROCESS | 19475 | 10:55:12 INFO - PROCESS | 19475 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.00 stddev:1.73 (2.8%) stddev-sans-first:1.83 10:55:12 INFO - PROCESS | 19475 | Values: 61.0 62.0 65.0 61.0 61.0 60.0 60.0 61.0 59.0 59.0 10:55:12 INFO - PROCESS | 19475 | -------- Summary: end -------- 10:55:12 INFO - PROCESS | 19475 | 10:55:13 INFO - TEST-INFO | 19475: exit 0 10:55:13 INFO - TEST-OK | kraken | took 60035ms 10:55:13 INFO - SUITE-END | took 1172s 10:55:13 INFO - Completed test suite (00:19:32) 10:55:13 INFO - javascript benchmark 10:55:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3332.6334103248637, 3350.4806754952992, 3354.0273320736974, 3372.14010427341, 3413.573303337083, 5447.700376479292, 5457.208704737815, 5491.176323551469, 5520.254765606647, 5527.336719593644, 5464.836054918359, 5511.9724401377935, 5514.531264842493, 5517.806876759314, 5552.805651802188, 4945.901081978358, 4958.330625365575, 4962.5781808546135, 4983.576396006326, 5010.94770098278, 4997.450280469146, 5085.669431486942, 5090.516400941905, 5091.032703786287, 5095.923561146586, 4966.751662416865, 5015.122353588125, 5032.6477146599755, 5045.066662667418, 5045.34410526631, 5108.233764935252, 5110.8466745997675, 5112.437631860493, 5125.923111153335, 5136.717480538588, 4876.146674332013, 4951.282064100686, 4994.425641051253, 5027.648064635477, 5038.622103342264, 5357.678539287655, 5399.811006614789, 5432.158015507603, 5458.372287186945, 5460.26286451328, 5941.376155503696, 5944.316403613597, 5984.910226346608, 5992.131140984577, 5993.430624090704, 5817.970910145465, 5887.823365299005, 5895.970520147372, 5951.49412299955, 6020.0, 5512.173174023888, 5548.334199895998, 5561.805336813273, 5572.080606699889, 5578.804741834017, 5877.5591830612875, 6052.757889684452, 6058.242719660043, 6060.727267272983, 6061.696915154224, 5701.657900525982, 5823.213866128103, 5826.242588463472, 5841.386654401312, 5849.064149736022, 5887.676177810262, 5889.352171261158, 5890.705464726747, 5922.437368449991, 5928.970355148197, 5556.638818476786, 5769.451902069297, 5858.970705146447, 5872.29532456108, 5873.618214816023, 5813.651180929158, 5840.123981402823, 5849.356570777211, 5867.61860479076, 5877.265341832271, 4523.841665541756, 4528.41130653013, 4534.59188673021, 4535.4103966484145, 4564.360989461478, 3973.7417067890497, 3993.940090898639, 4002.639762421396, 4056.249593825152, 4098.569650186747, 5594.496495315359, 5607.775688972477, 5623.831285061373, 5625.774969001194, 5631.915521267184, 5879.676617785977, 5881.852953676193, 5892.882142357129, 5904.1734157218025, 5909.349971503131, 5409.918851217235, 5542.806001789918, 5607.80372686954, 5617.438256174431, 5635.042042852725, 5024.246363045572, 5040.949590504121, 5048.6718363307, 5056.84829455117, 5064.215046667772, 6164.0, 6168.568200226031, 6169.938300616936, 6170.444659980623, 6170.784022559189, 5773.018586840163, 5847.26909136358, 5919.023361145535, 5922.792702255572, 5963.165156877953, 6142.140100386039, 6145.754169833157, 6153.661548614869, 6154.3845615438095, 6161.630302181704, 5656.773729050792, 5816.82549523515, 5824.21373114641, 5824.94175058244, 5825.330087039875, 5820.476157145878, 5865.296164460292, 5898.233229680114, 5934.050551911673, 5940.46535811779, 5752.539796816328, 5781.017227071492, 5785.479306862402, 5785.739641716217, 5793.420657934173, 5532.28080349552, 5651.152327150796, 5770.047942089508, 5774.884502310014, 5779.075347944308, 5519.116941289374, 5634.0422128239115, 5653.519450846724, 5677.1768093627015, 5685.346185188756, 5785.161151632906, 5786.218860453953, 5811.79658711943, 5818.912716309174, 5829.271341082364, 5515.09001014828, 5561.4716601922755, 5610.635308704921, 5680.573956953328, 5701.087825947829], "value": 5442.420593352431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.6910975402543, 629.1757797285553, 644.9677516124194, 660.791850567071, 668.6990854115646, 33741.325173496516, 36221.63778362216, 47658.2851257231, 49430.0, 49445.25832112512, 49703.0, 49888.75055624717, 50086.0, 50093.24860127101, 50108.0, 8303.128171541992, 9132.497712625804, 9297.070292970682, 9302.674406395778, 10827.133829293638, 10564.471776411187, 10963.287386319904, 10968.616098436556, 10973.945130274378, 10980.396078215696, 11061.557537698482, 11115.388653624048, 11117.777644447106, 11120.61077862275, 11121.888781112166, 8519.275861551776, 10869.728256793644, 10905.236633435623, 11215.551377944872, 11243.100551955824, 10643.94678026605, 10981.341119532854, 11055.170862185369, 11068.944655276753, 11072.723181920435, 46115.53884461146, 46457.535424645655, 46539.767301163614, 46640.76679616614, 46785.0, 3798.392257238856, 3832.885013449601, 3862.8261728222296, 3948.8420463181724, 4293.570642935712, 35246.295074098634, 35440.64559354425, 35779.82110089459, 36250.0, 36951.445728314095, 4795.952040479586, 4812.542808433193, 4822.228443449067, 4884.291777692215, 4897.8285759998225, 403215.0, 404482.0, 405230.0, 406288.0, 408283.9585802082, 37851.810740946115, 40465.59534404618, 40481.0, 69786.65106674535, 71052.0, 42146.78926605347, 42201.577984219766, 42292.15415691669, 42426.0, 42449.0, 15078.698426031418, 15169.924150379178, 15178.848211517743, 15179.392824287126, 15184.0, 10650.414227217578, 11978.64064078079, 12348.506059757508, 12358.382080895919, 12678.683032924251, 9486.430814151174, 9488.28837837165, 9492.477913714674, 9568.952155239318, 9575.281853860988, 3576.535050443426, 3620.5293311869286, 3635.7454978151804, 3656.725745569093, 3705.6109108543756, 1084.2897901874285, 1171.94140292985, 1246.5823948977195, 1258.182181581979, 1261.394530625305, 35081.64918350835, 35114.64885351165, 35304.470432943526, 35507.11232219215, 35860.103497412776, 1204.6325870609548, 1220.8412906322121, 1221.4747658506928, 1272.910896237273, 1291.702908331089, 18349.33354490625, 18612.534686632942, 18691.906540467484, 18709.719354209697, 18767.718484222747, 619891.0, 622302.0, 624301.0, 624969.0, 625799.0, 65847.0, 66274.66862665655, 66303.33696662972, 66378.0, 66444.66777666178, 1336.4988129451456, 1366.665167034083, 1401.474447082344, 1479.3195130239994, 1493.6340596553914, 31884.840575796974, 35161.00263562956, 35569.46645800264, 35750.28499429945, 35841.82079089588, 55131.44868551424, 55673.44326556683, 55696.72151639378, 55727.0, 55736.0, 417121.0, 417970.0, 418612.0, 419436.0, 421021.0, 30714.385712286075, 32197.67802321947, 32406.0, 32518.187045324055, 32545.511817322287, 52071.218931715295, 52625.21062184147, 53495.465045350604, 53858.730706346214, 53995.0, 43801.56198437975, 43972.909715652124, 44044.77977610091, 44250.0, 44840.55159448494, 43943.34084988664, 44230.55769442264, 44661.0, 44960.550394495636, 45779.0, 44150.11699765922, 44443.11113777642, 45227.0, 46673.29990050084, 47024.529754702016, 37761.62238377691, 38259.234815304095, 39699.007524812114, 40094.39858402068, 40938.795306023276, 30700.385992279582, 30806.76285031505, 31158.376832463677, 31302.373952521277, 31566.0], "value": 20812.48526120286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.3055979872407, 433.27426560511145, 435.31655301177165, 435.3565291026375, 438.31403852970107, 19486.0, 19781.802181978175, 20497.795022049795, 20546.38360849173, 20572.0, 17993.19030643621, 18020.639587208247, 18724.15741291642, 18752.718709219374, 19107.235710571596, 5644.57665675074, 5866.237389139406, 5875.9118613220835, 5878.559108066891, 5880.764769409218, 5753.309602847664, 5820.156077368779, 5886.381929897363, 5889.646621202742, 5902.527797776168, 5702.1446782982675, 5728.198052272685, 5805.187273781674, 5835.533157347402, 5877.14781356703, 5676.176954341618, 5730.341010783751, 5752.971235143818, 5841.0, 5862.0, 5134.281200631877, 5233.2935053768015, 5242.947570524284, 5247.527722504955, 5269.6311258211945, 22999.885000575057, 23550.175743849053, 24182.274531764077, 24604.507909841883, 24638.50722985548, 2513.32140322112, 2518.949621007588, 2609.686837579484, 2747.3131717070733, 2932.926676833075, 14465.927670361687, 14791.778123328158, 14966.251687415695, 14997.550073497812, 15278.847211527853, 1967.5081229692578, 2008.2970960163825, 2039.9694004589944, 2065.493953981284, 2098.8845613491253, 82334.58832705858, 83288.0, 84906.57546712227, 85719.5714021426, 86582.56708716416, 11769.352685602375, 12033.63899083029, 12041.879581204252, 12049.096317776202, 12129.454174562166, 16758.162091895356, 16783.916080419764, 16840.915795421188, 16853.831461685473, 16896.239669214916, 8021.919780802234, 8113.797155071053, 8317.542535160625, 8370.455920365157, 8567.871481927776, 7636.7399379102935, 7647.923520764833, 7729.458937874295, 7743.0, 7743.264389882952, 4950.628702847301, 5004.3994720633755, 5111.539961403491, 5163.070647283525, 5233.2935053768015, 2053.3429302623017, 2088.822450091759, 2112.503561663008, 2113.989430052871, 2126.138913739938, 945.7257395355407, 1045.362328979322, 1113.1062808162721, 1114.0864491117206, 1124.6907100547414, 19427.708584371245, 19477.0, 19630.080456016287, 19792.60414791696, 20341.79658203399, 1007.7581380468635, 1054.288355360129, 1074.8387741838787, 1089.6948854320644, 1138.2544433396138, 11018.283811552385, 11202.271852329572, 11356.791449192151, 11669.649910502698, 11696.941515292368, 500933.0, 502202.44493887946, 503541.0, 509292.0, 510912.0, 60560.697196513735, 66845.6657716718, 74538.0, 94435.055649444, 96314.51842740881, 984.8030393921244, 997.9301448898508, 1017.7710015246511, 1028.0644613401769, 1038.5586125896464, 18099.276028958695, 18488.537786554905, 18569.687524974415, 18644.161012754186, 18651.720224196375, 41832.0, 42328.57671423246, 43071.35392969171, 43505.78247108744, 44259.11481770411, 58815.11777323429, 58960.70519647374, 59559.10661339997, 59958.40041599528, 61105.38894611175, 8035.0, 8350.457220280663, 8381.413301068867, 8530.829383412422, 9090.045545217657, 9574.234061275221, 13088.149270297401, 13710.108842925178, 13847.238401887993, 13957.302134893418, 11254.493547790533, 11679.941600291944, 12018.939905300767, 12073.335966521925, 12133.02935765119, 11290.887091128983, 11517.308961462339, 11935.940320298343, 12068.879311206776, 12252.0, 12244.326562039174, 12483.812742809047, 12529.49882004746, 12683.239005659321, 13003.219806811621, 8178.304844088319, 8244.093149753402, 12573.93713031429, 13597.79603305971, 13863.930680346533, 12363.0, 12553.372331383212, 12559.623211303675, 12727.23636581808, 12937.935310323388], "value": 9666.42112433296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.368710393219, 1588.3646541383441, 1644.2600829626667, 1870.4014715291103, 1951.3462989898392, 9164.58759355829, 9568.378055426401, 9605.855912161305, 9880.802383952318, 9908.653197138101, 9609.759756006104, 9803.166730827888, 9815.312928095018, 9821.508924553762, 9824.115829575354, 2221.566794475078, 2435.342457536473, 2513.40934880303, 2549.8852551635223, 2579.6775403074616, 2524.798016158703, 2568.4221050263727, 2579.432524844531, 2581.6256642786784, 2583.5349637065415, 2519.4709111086604, 2549.1332946798084, 2550.502651982864, 2550.8469491830456, 2552.5660637691635, 2202.603531364354, 2466.851988880664, 2518.496300739859, 2527.721950585434, 2550.9362265943314, 2414.4084699248797, 2457.9754202457925, 2463.987680061606, 2491.9252422427357, 2497.051120574188, 9520.285978551636, 9546.61813527458, 9559.61761529538, 9560.426374417488, 9574.760630984212, 5474.72626368684, 5600.187972743929, 5608.5793565482345, 5608.579356548275, 5613.887722245532, 3589.10272431892, 3658.762180458262, 3726.795026273554, 3787.1857550626473, 3787.3561494545993, 1316.9078164528487, 1342.1745626439767, 1359.5173713331822, 1364.6451922500123, 1381.1920026784344, 13914.860851391457, 13918.791218131737, 13921.721565568732, 13930.930345348208, 13942.790858137136, 5038.193888977819, 5066.721330326794, 5113.207452844815, 5116.258142569381, 5192.636515443958, 11328.2070255083, 11437.828432573519, 11498.827517587242, 11500.88499115015, 11503.482343294572, 4811.639127065484, 5633.605647604711, 5637.9718101409235, 5637.9718101409235, 5639.295088113986, 4916.336294600254, 5027.1705168647495, 5035.7985680572365, 5052.520010598987, 5068.771905264272, 4370.2570563004365, 4422.823087076546, 4485.573870482299, 4530.22986092365, 4539.886502837456, 1368.719412520431, 1385.6120286319847, 1388.9097208681605, 1402.0466083063616, 1417.376354404059, 885.2608072259607, 992.0922356044139, 993.9933832975452, 999.7600575861741, 1037.8495118207818, 6082.9695851520455, 6380.78867947162, 6386.233651961795, 6405.711742971577, 6512.381323774234, 467.8011844965876, 482.11050611621505, 488.52709082117445, 496.55558275343367, 505.4162442379058, 4307.913841723148, 4358.978205108954, 4397.73613583186, 4440.511543730187, 4462.241418958784, 11926.522939082513, 12272.0, 12447.93776031114, 12507.56223532172, 12528.0, 11997.40012999364, 12314.938425307817, 12546.05904557162, 12636.81044784329, 12661.36693165338, 8289.875651865106, 8596.355273354524, 8738.519381434082, 8756.737297881074, 8771.91228087711, 6350.872982540416, 6493.0, 6527.2167339919515, 6615.966920165369, 6617.602943823386, 10771.784564308826, 11103.111751060058, 11343.659690209306, 11439.370834604177, 11444.656660299872, 11477.253978491372, 11482.540698372306, 11488.597899073826, 11508.136889733136, 11607.76784464323, 7600.50596711212, 7810.843783124192, 8409.0, 8424.368172386972, 8572.27135693473, 9480.525973701426, 9670.226381889574, 9771.560279787569, 9800.901990979999, 9809.607615695293, 8529.104444033535, 8634.56827158652, 8686.261667758312, 8708.216260536583, 8793.076726943578, 8342.541160236246, 8466.788330291793, 8546.059933407196, 8581.95709021451, 8655.610497527501, 7714.190010049088, 7787.4548781584745, 7827.9608601956625, 7867.685292588232, 7869.370450364072, 5526.419725928719, 5533.529649979797, 5605.24329215567, 5716.54267658578, 5784.4504772046585, 5431.049566325956, 5484.533814625642, 5617.297837770278, 5619.960307343154, 5754.827355179351], "value": 4977.33791729838, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.4601560510985, 357.5602009528281, 364.7009452249157, 373.0747745590936, 374.36918791835757, 5433.212184233284, 5516.124517663993, 5516.365617953931, 5517.503424691777, 5543.501084902358, 5410.0, 5446.1558458439, 5480.0, 5481.725913704318, 5489.258950041743, 4158.106007208457, 4228.281192197319, 4279.40088387626, 4281.400603915455, 4310.698251122422, 4211.410402543631, 4225.6830737694645, 4227.556106608808, 4284.078923031548, 4284.421603083575, 4201.222773786844, 4209.0, 4210.736778966313, 4232.9788351058205, 4256.318988961767, 4086.366613174963, 4213.157368526292, 4220.944763809048, 4223.556526564697, 4267.893302667442, 3741.8129093545213, 3742.644448777362, 3762.8682996095004, 3763.34141525232, 3766.3032339017095, 5218.799676074486, 5280.656757310762, 5286.440500052494, 5318.893622127536, 5322.467753224685, 4771.427428708543, 4838.830640927586, 4862.270659401082, 4885.7312847793355, 4886.706797592155, 5627.409122042168, 5632.127020311858, 5638.830835074954, 5654.6324488908085, 5663.773449062074, 4131.566185550504, 4132.566080561558, 4149.564295748933, 4150.564190759957, 4161.667066634662, 5638.0, 5854.941450585525, 5910.556708246856, 5934.465898069151, 5981.401859814027, 4185.100203456272, 4188.832446702158, 4191.559886211965, 4207.368894665763, 4217.683673724483, 4243.724157929724, 4250.341197114452, 4253.532111467736, 4269.210196113729, 4272.829086836554, 4579.771011449414, 4858.6356023298395, 4877.634177436636, 4891.779869905863, 4904.607631389552, 5739.253896993364, 5763.740631671585, 5772.278465191851, 5775.711214439345, 5796.449337313033, 1436.705475377545, 1447.1100273331824, 1447.3631602095045, 1453.738327101132, 1454.8326942401548, 920.4523308631487, 944.6127087894068, 948.7950303115006, 954.355809828363, 962.8459446488528, 4896.6572339935865, 4984.675996060317, 4992.226204938241, 5005.924911126336, 5056.165732654144, 5177.886754347758, 5200.869978250574, 5226.817061402909, 5243.239730239094, 5339.946600533945, 5087.771050302746, 5104.804933878394, 5120.899006713575, 5219.16493361068, 5688.829335119953, 3138.8430578470984, 3157.0, 3167.841607919641, 3168.6197656280933, 3173.539836723662, 6086.573939824169, 6098.32918378978, 6137.202163718777, 6185.659788711574, 6188.659623720739, 5626.708375600238, 5674.659520428788, 5813.593048486566, 5931.406859314034, 5949.702514874239, 5997.301214453426, 6027.758889644365, 6062.818115456544, 6113.144159817629, 6125.326214116443, 5616.8876622466505, 5832.358440571618, 5850.853728656818, 5918.911216331672, 5928.822135335947, 5544.695041772741, 5797.246357973437, 5848.385919478564, 5851.327097383855, 5861.882762344644, 6052.485538729257, 6061.72722227492, 6078.206928956057, 6099.664518451527, 6109.327973922776, 4112.259793237246, 4214.367844823301, 4219.97890010548, 4223.345381465878, 4235.534091250021, 5826.621269617462, 5830.47525722687, 5862.325832529314, 5865.354810970704, 5872.706364681663, 5691.630044047124, 5716.02766561394, 5729.512991395612, 5737.713114344183, 5773.162891380643, 5474.452554744494, 5683.77264909399, 5695.174199741097, 5709.571782116275, 5720.656760594377, 5582.8325150245555, 5602.9719851402115, 5603.719814009201, 5643.322801263875, 5646.830595082154, 5455.8363249102595, 5664.413964090061, 5698.601097923106, 5731.398203188605, 5789.334226563999, 5642.956053130184, 5678.914816277676, 5689.630174038674, 5699.544036477155, 5703.543716502752], "value": 4336.883656360922, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.9140140285274, 833.2500749325607, 868.7741187291304, 889.0442774017924, 907.9105172909375, 14258.572242832719, 15198.924005379971, 15250.6949861003, 15262.160581168031, 15285.235738213087, 14263.215523146222, 14365.49720759771, 14374.137551746902, 14383.20892350923, 14389.064710793817, 705.100996229806, 826.8181000179951, 856.0, 858.669412276275, 864.8962124545031, 845.5898889038812, 849.4733265375445, 850.961706723199, 852.2457625001856, 853.1638993786094, 905.0316161706976, 905.85053466178, 907.0974380491388, 907.1065000974069, 907.2333877873219, 757.413004921185, 892.8749975003504, 914.1041779056562, 916.9083091690811, 919.3886065766258, 676.922153952292, 677.5832862789398, 678.2505331608551, 678.3996163395382, 678.5996262205273, 13834.93082534581, 13851.16892986414, 13888.305584720723, 13901.652458688513, 13905.513307034307, 14757.0, 15352.846471535366, 15441.30514126867, 15560.766588501181, 15658.138802365866, 13736.725265494633, 13895.374708138057, 13925.0, 13949.860501394958, 14005.55475220516, 4632.86101416958, 4670.626349892034, 4788.592969597588, 4805.135075686375, 4814.903701925942, 71107.64446177788, 71910.64044679744, 72233.27766722318, 72856.6357168216, 73104.26895731028, 11831.290122592673, 11988.820167697491, 12196.81704774429, 12256.693582660326, 12396.504139834306, 22295.219667311892, 22304.553908922055, 22312.330630081124, 22506.774932250468, 22590.322290331318, 8809.33929955256, 8860.955695221612, 8889.244414224733, 9082.954585227031, 9183.357164998519, 4938.0, 5037.102094384479, 5076.314697515862, 5134.768935397916, 5153.175491921274, 3660.743747937672, 3753.9061523462133, 3773.396256598931, 3774.1885494618787, 3774.2074164425776, 628.4972022382076, 637.6620391192582, 724.3517052238323, 732.1836152689713, 740.0, 624.6501958903029, 625.7184267079832, 656.1797752808989, 750.740994356946, 762.9122650895218, 10995.0, 11249.887501125047, 11363.943180284046, 11487.19589628718, 11587.826182607268, 740.9777706668808, 743.3012967810241, 751.2449987762263, 757.5757575757483, 758.852023855354, 5040.294358789773, 5094.388673359146, 5115.974420127875, 5128.282040514331, 5206.401263854629, 117870.4106479462, 119049.0, 120901.39549302198, 129904.0, 130151.34924325507, 107905.46047269713, 108374.45812770886, 108934.0, 111189.44405277922, 112697.0, 55090.449095508535, 55633.16550251749, 57586.42413575894, 83543.16456835475, 84586.5770671155, 10267.94866025665, 10311.896881031094, 10442.53008614599, 10607.734806629587, 10697.358158510515, 39359.60640393559, 48436.273455898896, 51376.229356558935, 52071.47928520666, 53118.468815312895, 69717.0, 71615.28384716086, 72491.63754181196, 72851.63574182095, 73918.26081739328, 14147.080439771793, 14189.972934656347, 14290.35693393779, 14341.282935852956, 14516.564503064925, 10960.28758130719, 15199.0, 15410.691786164438, 15643.0, 16187.190640468165, 9703.514824258618, 14095.224762637743, 14147.0, 15227.92386038107, 16062.036277823368, 13755.10591811529, 13951.441942322193, 14182.503612373517, 14692.118472891661, 14766.48317308889, 11568.768624627628, 11961.342126183143, 13592.728145437233, 14889.478868239992, 15188.772168417703, 11258.831117533407, 11695.181337306307, 11753.823692644788, 12263.38683065861, 12464.750704985669, 12677.619671409873, 12735.490580376681, 12746.426410811351, 12777.93611031939, 13162.47350105985], "value": 7890.20816982961, "unit": "score"}], "name": "dromaeo_css", "value": 7558.7166638289245, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 109.0, 110.0, 109.0, 108.0, 110.0, 109.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 127.0, 171.0, 127.0, 129.0, 126.0, 157.0, 166.0, 123.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 160.0, 160.0, 162.0, 160.0, 161.0, 160.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 124.0, 78.0, 77.0, 75.0, 75.0, 100.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 117.0, 83.0, 85.0, 85.0, 111.0, 84.0, 85.0, 119.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 144.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 51.0, 50.0, 51.0, 52.0, 51.0, 51.0, 52.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 81.0, 75.0, 76.0, 76.0, 77.0, 79.0, 115.0, 77.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 120.0, 116.0, 118.0, 117.0, 116.0, 124.0, 134.0, 121.0], "value": 120.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 149.0, 155.0, 152.0, 151.0, 152.0, 151.0, 154.0, 151.0, 152.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 65.0, 61.0, 61.0, 60.0, 60.0, 61.0, 59.0, 59.0], "value": 60.9, "unit": "score"}], "name": "kraken", "value": 1468.9, "alertThreshold": 2.0}]} 10:55:13 INFO - Return code: 0 10:55:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:55:13 ERROR - # TBPL SUCCESS # 10:55:13 INFO - Running post-action listener: _resource_record_post_action 10:55:13 INFO - ##### 10:55:13 INFO - ##### Finished run-tests step (success) 10:55:13 INFO - ##### 10:55:13 INFO - Running post-run listener: _resource_record_post_run 10:55:13 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 286720; Write bytes: 512421888; Read time: 40; Write time: 630944 10:55:13 INFO - TinderboxPrint: CPU usage
13.1% 10:55:13 INFO - TinderboxPrint: I/O read bytes / time
286,720 / 40 10:55:13 INFO - TinderboxPrint: I/O write bytes / time
512,421,888 / 630,944 10:55:13 INFO - TinderboxPrint: CPU idle
8,255.6 (86.9%) 10:55:13 INFO - TinderboxPrint: CPU user
1,195.7 (12.6%) 10:55:13 INFO - TinderboxPrint: Swap in / out
0 / 0 10:55:13 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 259842048; Read time: 0; Write time: 397144 10:55:13 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 252579840; Read time: 28; Write time: 233800 10:55:14 INFO - Running post-run listener: _upload_blobber_files 10:55:14 INFO - Blob upload gear active. 10:55:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:55:14 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:55:14 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:55:14 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:55:14 INFO - (blobuploader) - INFO - Open directory for files ... 10:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:15 INFO - (blobuploader) - INFO - Done attempting. 10:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:55:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:16 INFO - (blobuploader) - INFO - Done attempting. 10:55:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:55:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:55:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:20 INFO - (blobuploader) - INFO - Done attempting. 10:55:20 INFO - (blobuploader) - INFO - Iteration through files over. 10:55:20 INFO - Return code: 0 10:55:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:55:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:55:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e72cf5f7d57a2f37d6c66589d35e31671c59e4aa90be7783af81ef6b44d2c7a0cf4f54b0780965f2e9978bc85132fc0387cf9cded35a6b267bcb77b93b677987", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f02f94a8e93f94b88cc073985a8165fa3dac67cda287a0af310fc9174f3fe51e83184973d1aa19ade41431279423e763014338c297e668ce29f8bb9d66b9642", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6d8172ceaf5153758241411234780c35b014a719db895e666a1c8db6ca16af3364a78405908542bb55617f02c4db46e953622aef457f02d66b2470fc09a7d13"} 10:55:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:55:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:55:20 INFO - Contents: 10:55:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e72cf5f7d57a2f37d6c66589d35e31671c59e4aa90be7783af81ef6b44d2c7a0cf4f54b0780965f2e9978bc85132fc0387cf9cded35a6b267bcb77b93b677987", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f02f94a8e93f94b88cc073985a8165fa3dac67cda287a0af310fc9174f3fe51e83184973d1aa19ade41431279423e763014338c297e668ce29f8bb9d66b9642", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6d8172ceaf5153758241411234780c35b014a719db895e666a1c8db6ca16af3364a78405908542bb55617f02c4db46e953622aef457f02d66b2470fc09a7d13"} 10:55:20 INFO - Running post-run listener: copy_logs_to_upload_dir 10:55:20 INFO - Copying logs to upload dir... 10:55:20 INFO - mkdir: /builds/slave/test/build/upload/logs 10:55:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.357178 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-05 10:55:20.192547) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:55:20.196373) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e72cf5f7d57a2f37d6c66589d35e31671c59e4aa90be7783af81ef6b44d2c7a0cf4f54b0780965f2e9978bc85132fc0387cf9cded35a6b267bcb77b93b677987", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f02f94a8e93f94b88cc073985a8165fa3dac67cda287a0af310fc9174f3fe51e83184973d1aa19ade41431279423e763014338c297e668ce29f8bb9d66b9642", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6d8172ceaf5153758241411234780c35b014a719db895e666a1c8db6ca16af3364a78405908542bb55617f02c4db46e953622aef457f02d66b2470fc09a7d13"} 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.011287 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e72cf5f7d57a2f37d6c66589d35e31671c59e4aa90be7783af81ef6b44d2c7a0cf4f54b0780965f2e9978bc85132fc0387cf9cded35a6b267bcb77b93b677987", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f02f94a8e93f94b88cc073985a8165fa3dac67cda287a0af310fc9174f3fe51e83184973d1aa19ade41431279423e763014338c297e668ce29f8bb9d66b9642", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6d8172ceaf5153758241411234780c35b014a719db895e666a1c8db6ca16af3364a78405908542bb55617f02c4db46e953622aef457f02d66b2470fc09a7d13"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:55:20.229595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:55:20.229879) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467740086.943091-282491439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:55:20.279470) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:55:20.279748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:55:20.280010) ========= ========= Total master_lag: 0.31 =========