builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1467135118.64 results: success (0) buildid: 20160628075250 builduid: 4abb371f23314e07bc4f5fa1a9000727 revision: af923f4926e7606c93218467f4de253c9a2bc783 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:58.636653) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:58.637725) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:58.638512) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:58.654924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:58.655400) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 10:31:59-- 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% 50.2M=0s 2016-06-28 10:31:59 (50.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098144 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:58.772841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:58.773524) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017390 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:58.826562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:58.827330) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af923f4926e7606c93218467f4de253c9a2bc783 --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 af923f4926e7606c93218467f4de253c9a2bc783 --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=20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 10:31:59,231 truncating revision to first 12 chars 2016-06-28 10:31:59,231 Setting DEBUG logging. 2016-06-28 10:31:59,232 attempt 1/10 2016-06-28 10:31:59,232 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/af923f4926e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 10:31:59,532 unpacking tar archive at: mozilla-aurora-af923f4926e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:59.516639) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:59.517328) ========= script_repo_revision: af923f4926e7606c93218467f4de253c9a2bc783 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:59.518259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:59.518948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 10:31:59.531713) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-28 10:31:59.532026) ========= /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=20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:32:00 INFO - MultiFileLogger online at 20160628 10:32:00 in /builds/slave/test 10:32:00 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:32:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:32:00 INFO - {'append_to_log': False, 10:32:00 INFO - 'base_work_dir': '/builds/slave/test', 10:32:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:32:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:32:00 INFO - 'branch': 'Mozilla-Aurora', 10:32:00 INFO - 'buildbot_json_path': 'buildprops.json', 10:32:00 INFO - 'config_files': ('talos/linux_config.py',), 10:32:00 INFO - 'default_actions': ('clobber', 10:32:00 INFO - 'read-buildbot-config', 10:32:00 INFO - 'download-and-extract', 10:32:00 INFO - 'populate-webroot', 10:32:00 INFO - 'create-virtualenv', 10:32:00 INFO - 'install', 10:32:00 INFO - 'run-tests'), 10:32:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:32:00 INFO - 'download_minidump_stackwalk': True, 10:32:00 INFO - 'download_symbols': 'ondemand', 10:32:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:32:00 INFO - 'tooltool.py': '/tools/tooltool.py', 10:32:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:32:00 INFO - '/tools/misc-python/virtualenv.py')}, 10:32:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:32:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:32:00 INFO - 'installer_path': 'installer.exe', 10:32:00 INFO - 'log_level': 'info', 10:32:00 INFO - 'log_name': 'talos', 10:32:00 INFO - 'log_to_console': True, 10:32:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:32:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:32:00 INFO - 'opt_config_files': (), 10:32:00 INFO - 'pip_index': False, 10:32:00 INFO - 'sps_profile': False, 10:32:00 INFO - 'sps_profile_interval': 0, 10:32:00 INFO - 'suite': 'dromaeojs', 10:32:00 INFO - 'system_bits': '32', 10:32:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:32:00 INFO - 'title': 'talos-linux64-ix-015', 10:32:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:32:00 INFO - 'use_talos_json': True, 10:32:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:32:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:32:00 INFO - 'work_dir': 'build'} 10:32:00 INFO - ##### 10:32:00 INFO - ##### Running clobber step. 10:32:00 INFO - ##### 10:32:00 INFO - Running pre-action listener: _resource_record_pre_action 10:32:00 INFO - Running main action method: clobber 10:32:00 INFO - rmtree: /builds/slave/test/build 10:32:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:32:00 INFO - Running post-action listener: _resource_record_post_action 10:32:00 INFO - ##### 10:32:00 INFO - ##### Finished clobber step (success) 10:32:00 INFO - ##### 10:32:00 INFO - ##### 10:32:00 INFO - ##### Running read-buildbot-config step. 10:32:00 INFO - ##### 10:32:00 INFO - Running pre-action listener: _resource_record_pre_action 10:32:00 INFO - Running main action method: read_buildbot_config 10:32:00 INFO - Using buildbot properties: 10:32:00 INFO - { 10:32:00 INFO - "project": "", 10:32:00 INFO - "product": "firefox", 10:32:00 INFO - "script_repo_revision": "production", 10:32:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:32:00 INFO - "repository": "", 10:32:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:32:00 INFO - "buildid": "20160628075250", 10:32:00 INFO - "pgo_build": "True", 10:32:00 INFO - "basedir": "/builds/slave/test", 10:32:00 INFO - "buildnumber": 585, 10:32:00 INFO - "slavename": "talos-linux64-ix-015", 10:32:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:32:00 INFO - "platform": "ubuntu64_hw", 10:32:00 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:32:00 INFO - "branch": "mozilla-aurora", 10:32:00 INFO - "repo_path": "releases/mozilla-aurora", 10:32:00 INFO - "revision": "af923f4926e7606c93218467f4de253c9a2bc783", 10:32:00 INFO - "stage_platform": "linux64-pgo", 10:32:00 INFO - "builduid": "4abb371f23314e07bc4f5fa1a9000727", 10:32:00 INFO - "slavebuilddir": "test" 10:32:00 INFO - } 10:32:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 10:32:00 INFO - Running post-action listener: _resource_record_post_action 10:32:00 INFO - ##### 10:32:00 INFO - ##### Finished read-buildbot-config step (success) 10:32:00 INFO - ##### 10:32:00 INFO - ##### 10:32:00 INFO - ##### Running download-and-extract step. 10:32:00 INFO - ##### 10:32:00 INFO - Running pre-action listener: _resource_record_pre_action 10:32:00 INFO - Running main action method: download_and_extract 10:32:00 INFO - mkdir: /builds/slave/test/build/tests 10:32:00 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:32:00 INFO - https://queue.taskcluster.net/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:32:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:32:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:32:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/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:32:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/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:32:01 INFO - Downloaded 1361 bytes. 10:32:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:32:01 INFO - Using the following test package requirements: 10:32:01 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:32:01 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:32:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:32:01 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:32:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:32:01 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:32:01 INFO - u'jsshell-linux-x86_64.zip'], 10:32:01 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:32:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:32:01 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:32:01 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:32:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:32:01 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:32:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:32:01 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:32:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:32:01 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:32:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:32:01 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:32: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:32:01 INFO - https://queue.taskcluster.net/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:32:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:32:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:32:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/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:32:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/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:32:02 INFO - Downloaded 24522704 bytes. 10:32:02 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:32:02 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:32:03 INFO - Return code: 0 10:32:03 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:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:03 INFO - https://queue.taskcluster.net/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:32:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:32:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:32:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/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:32:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/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:32:04 INFO - Downloaded 24522704 bytes. 10:32:04 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:32:04 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:32:06 INFO - Return code: 0 10:32: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:32:06 INFO - https://queue.taskcluster.net/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:32:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:32:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:32:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/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:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/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:32:07 INFO - Downloaded 10833369 bytes. 10:32:07 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:32:07 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:32:07 INFO - Return code: 0 10:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:07 INFO - https://queue.taskcluster.net/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:32:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:32:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:32:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/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:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fafIa-TZRraqkgNUYhdqRQ/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:32:12 INFO - Downloaded 63609465 bytes. 10:32:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:32:12 INFO - mkdir: /builds/slave/test/properties 10:32:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:32:12 INFO - Writing to file /builds/slave/test/properties/build_url 10:32:12 INFO - Contents: 10:32:12 INFO - build_url:https://queue.taskcluster.net/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:32:13 INFO - Running post-action listener: _resource_record_post_action 10:32:13 INFO - Running post-action listener: set_extra_try_arguments 10:32:13 INFO - ##### 10:32:13 INFO - ##### Finished download-and-extract step (success) 10:32:13 INFO - ##### 10:32:13 INFO - ##### 10:32:13 INFO - ##### Running populate-webroot step. 10:32:13 INFO - ##### 10:32:13 INFO - Running pre-action listener: _resource_record_pre_action 10:32:13 INFO - Running main action method: populate_webroot 10:32:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:32:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:32:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:32:13 INFO - '--tppagecycles', 10:32:13 INFO - '7'], 10:32:13 INFO - 'tests': ['tsvgm']}}, 10:32:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:32:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:32:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:32:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:32:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:32:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:32:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:13 INFO - 'talos_options': ['--disable-e10s'], 10:32:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:13 INFO - 'talos_options': ['--disable-e10s'], 10:32:13 INFO - 'tests': ['damp', 'tps']}, 10:32:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:13 INFO - 'tests': ['damp', 'tps']}, 10:32:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:32:13 INFO - 'tests': ['dromaeo_dom']}, 10:32:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:32:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:32:13 INFO - 'tests': ['a11yr', 10:32:13 INFO - 'ts_paint', 10:32:13 INFO - 'tpaint', 10:32:13 INFO - 'sessionrestore', 10:32:13 INFO - 'sessionrestore_no_auto_restore', 10:32:13 INFO - 'tabpaint']}, 10:32:13 INFO - 'other-e10s': {'tests': ['a11yr', 10:32:13 INFO - 'ts_paint', 10:32:13 INFO - 'tpaint', 10:32:13 INFO - 'sessionrestore', 10:32:13 INFO - 'sessionrestore_no_auto_restore', 10:32:13 INFO - 'tabpaint']}, 10:32:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:32:13 INFO - 'ts_paint', 10:32:13 INFO - 'tpaint', 10:32:13 INFO - 'sessionrestore', 10:32:13 INFO - 'sessionrestore_no_auto_restore', 10:32:13 INFO - 'tabpaint']}, 10:32:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:32:13 INFO - 'ts_paint', 10:32:13 INFO - 'tpaint', 10:32:13 INFO - 'sessionrestore', 10:32:13 INFO - 'sessionrestore_no_auto_restore', 10:32:13 INFO - 'tabpaint']}, 10:32:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:32:13 INFO - 'tests': ['a11yr', 10:32:13 INFO - 'ts_paint', 10:32:13 INFO - 'tpaint', 10:32:13 INFO - 'sessionrestore', 10:32:13 INFO - 'sessionrestore_no_auto_restore', 10:32:13 INFO - 'tabpaint']}, 10:32:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:32:13 INFO - 'tests': ['a11yr', 10:32:13 INFO - 'ts_paint', 10:32:13 INFO - 'tpaint', 10:32:13 INFO - 'sessionrestore', 10:32:13 INFO - 'sessionrestore_no_auto_restore', 10:32:13 INFO - 'tabpaint']}, 10:32:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:32:13 INFO - 'tests': ['tsvgx', 10:32:13 INFO - 'tsvgr_opacity', 10:32:13 INFO - 'tart', 10:32:13 INFO - 'tscrollx', 10:32:13 INFO - 'cart']}, 10:32:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:32:13 INFO - 'tsvgr_opacity', 10:32:13 INFO - 'tart', 10:32:13 INFO - 'tscrollx', 10:32:13 INFO - 'cart']}, 10:32:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:13 INFO - 'talos_options': ['--disable-e10s'], 10:32:13 INFO - 'tests': ['tp5o']}, 10:32:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:13 INFO - 'tests': ['tp5o']}, 10:32:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:13 INFO - 'talos_options': ['--disable-e10s', 10:32:13 INFO - '--xperf_path', 10:32:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:13 INFO - 'tests': ['tp5n']}, 10:32:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:13 INFO - 'talos_options': ['--xperf_path', 10:32:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:13 INFO - 'tests': ['tp5n']}}, 10:32:13 INFO - 'talos.zip': {'path': '', 10:32:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:32:13 INFO - Running post-action listener: _resource_record_post_action 10:32:13 INFO - ##### 10:32:13 INFO - ##### Finished populate-webroot step (success) 10:32:13 INFO - ##### 10:32:13 INFO - ##### 10:32:13 INFO - ##### Running create-virtualenv step. 10:32:13 INFO - ##### 10:32:13 INFO - Running pre-action listener: _resource_record_pre_action 10:32:13 INFO - Running main action method: create_virtualenv 10:32:13 INFO - Creating virtualenv /builds/slave/test/build/venv 10:32:13 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:32:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:32:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:32:13 INFO - Using real prefix '/usr' 10:32:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:32:13 INFO - Installing distribute.............................................................................................................................................................................................done. 10:32:15 INFO - Installing pip.................done. 10:32:15 INFO - Return code: 0 10:32:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86e758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2428350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b71c0>, '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 0x24b80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b8550>, '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': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', '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:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:32:15 INFO - Using env: {'DISPLAY': ':0', 10:32:15 INFO - 'HOME': '/home/cltbld', 10:32:15 INFO - 'LANG': 'en_US.UTF-8', 10:32:15 INFO - 'LANGUAGE': 'en_US:en', 10:32:15 INFO - 'LOGNAME': 'cltbld', 10:32:15 INFO - 'MAIL': '/var/mail/cltbld', 10:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:15 INFO - 'MOZ_NO_REMOTE': '1', 10:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:15 INFO - 'NO_EM_RESTART': '1', 10:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:15 INFO - 'PWD': '/builds/slave/test', 10:32:15 INFO - 'SHELL': '/bin/bash', 10:32:15 INFO - 'SHLVL': '1', 10:32:15 INFO - 'TERM': 'linux', 10:32:15 INFO - 'TMOUT': '86400', 10:32:15 INFO - 'USER': 'cltbld', 10:32:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', 10:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:15 INFO - '_': '/tools/buildbot/bin/python'} 10:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:32:15 INFO - Cleaning up... 10:32:15 INFO - Return code: 0 10:32:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86e758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2428350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b71c0>, '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 0x24b80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b8550>, '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': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', '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:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:32:15 INFO - Using env: {'DISPLAY': ':0', 10:32:15 INFO - 'HOME': '/home/cltbld', 10:32:15 INFO - 'LANG': 'en_US.UTF-8', 10:32:15 INFO - 'LANGUAGE': 'en_US:en', 10:32:15 INFO - 'LOGNAME': 'cltbld', 10:32:15 INFO - 'MAIL': '/var/mail/cltbld', 10:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:15 INFO - 'MOZ_NO_REMOTE': '1', 10:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:15 INFO - 'NO_EM_RESTART': '1', 10:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:15 INFO - 'PWD': '/builds/slave/test', 10:32:15 INFO - 'SHELL': '/bin/bash', 10:32:15 INFO - 'SHLVL': '1', 10:32:15 INFO - 'TERM': 'linux', 10:32:15 INFO - 'TMOUT': '86400', 10:32:15 INFO - 'USER': 'cltbld', 10:32:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', 10:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:15 INFO - '_': '/tools/buildbot/bin/python'} 10:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:16 INFO - Downloading/unpacking psutil>=3.1.1 10:32:16 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:32:16 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:32:16 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:32:16 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:32:16 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:32:16 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:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:32:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:18 INFO - Installing collected packages: psutil 10:32:18 INFO - Running setup.py install for psutil 10:32:18 INFO - building 'psutil._psutil_linux' extension 10:32:18 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:32:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:32:18 INFO - building 'psutil._psutil_posix' extension 10:32:18 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:32:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:32:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:18 INFO - Successfully installed psutil 10:32:18 INFO - Cleaning up... 10:32:18 INFO - Return code: 0 10:32:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86e758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2428350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b71c0>, '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 0x24b80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b8550>, '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': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', '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:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:32:18 INFO - Using env: {'DISPLAY': ':0', 10:32:18 INFO - 'HOME': '/home/cltbld', 10:32:18 INFO - 'LANG': 'en_US.UTF-8', 10:32:18 INFO - 'LANGUAGE': 'en_US:en', 10:32:18 INFO - 'LOGNAME': 'cltbld', 10:32:18 INFO - 'MAIL': '/var/mail/cltbld', 10:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:18 INFO - 'MOZ_NO_REMOTE': '1', 10:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:18 INFO - 'NO_EM_RESTART': '1', 10:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:18 INFO - 'PWD': '/builds/slave/test', 10:32:18 INFO - 'SHELL': '/bin/bash', 10:32:18 INFO - 'SHLVL': '1', 10:32:18 INFO - 'TERM': 'linux', 10:32:18 INFO - 'TMOUT': '86400', 10:32:18 INFO - 'USER': 'cltbld', 10:32:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', 10:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:18 INFO - '_': '/tools/buildbot/bin/python'} 10:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:32:20 INFO - Installing collected packages: mozsystemmonitor 10:32:20 INFO - Running setup.py install for mozsystemmonitor 10:32:20 INFO - Successfully installed mozsystemmonitor 10:32:20 INFO - Cleaning up... 10:32:20 INFO - Return code: 0 10:32:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:32: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:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32: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:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86e758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2428350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b71c0>, '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 0x24b80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b8550>, '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': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', '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:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:32:20 INFO - Using env: {'DISPLAY': ':0', 10:32:20 INFO - 'HOME': '/home/cltbld', 10:32:20 INFO - 'LANG': 'en_US.UTF-8', 10:32:20 INFO - 'LANGUAGE': 'en_US:en', 10:32:20 INFO - 'LOGNAME': 'cltbld', 10:32:20 INFO - 'MAIL': '/var/mail/cltbld', 10:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:20 INFO - 'MOZ_NO_REMOTE': '1', 10:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:20 INFO - 'NO_EM_RESTART': '1', 10:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:20 INFO - 'PWD': '/builds/slave/test', 10:32:20 INFO - 'SHELL': '/bin/bash', 10:32:20 INFO - 'SHLVL': '1', 10:32:20 INFO - 'TERM': 'linux', 10:32:20 INFO - 'TMOUT': '86400', 10:32:20 INFO - 'USER': 'cltbld', 10:32:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', 10:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:20 INFO - '_': '/tools/buildbot/bin/python'} 10:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:21 INFO - Downloading/unpacking jsonschema==2.5.1 10:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:32:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:23 INFO - Downloading functools32-3.2.3-2.tar.gz 10:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:32:23 INFO - warning: no files found matching '*.txt' 10:32:23 INFO - no previously-included directories found matching 'build' 10:32:23 INFO - no previously-included directories found matching 'dist' 10:32:23 INFO - no previously-included directories found matching '.git*' 10:32:23 INFO - Installing collected packages: jsonschema, functools32 10:32:23 INFO - Running setup.py install for functools32 10:32:23 INFO - warning: no files found matching '*.txt' 10:32:23 INFO - no previously-included directories found matching 'build' 10:32:23 INFO - no previously-included directories found matching 'dist' 10:32:23 INFO - no previously-included directories found matching '.git*' 10:32:23 INFO - Successfully installed jsonschema functools32 10:32:23 INFO - Cleaning up... 10:32:23 INFO - Return code: 0 10:32:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86e758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2428350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b71c0>, '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 0x24b80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b8550>, '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': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', '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:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:32:23 INFO - Using env: {'DISPLAY': ':0', 10:32:23 INFO - 'HOME': '/home/cltbld', 10:32:23 INFO - 'LANG': 'en_US.UTF-8', 10:32:23 INFO - 'LANGUAGE': 'en_US:en', 10:32:23 INFO - 'LOGNAME': 'cltbld', 10:32:23 INFO - 'MAIL': '/var/mail/cltbld', 10:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:23 INFO - 'MOZ_NO_REMOTE': '1', 10:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:23 INFO - 'NO_EM_RESTART': '1', 10:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:23 INFO - 'PWD': '/builds/slave/test', 10:32:23 INFO - 'SHELL': '/bin/bash', 10:32:23 INFO - 'SHLVL': '1', 10:32:23 INFO - 'TERM': 'linux', 10:32:23 INFO - 'TMOUT': '86400', 10:32:23 INFO - 'USER': 'cltbld', 10:32:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', 10:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:23 INFO - '_': '/tools/buildbot/bin/python'} 10:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:23 INFO - Downloading/unpacking blobuploader==1.2.4 10:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:25 INFO - Downloading blobuploader-1.2.4.tar.gz 10:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:32:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:32:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:26 INFO - Downloading docopt-0.6.1.tar.gz 10:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:32:26 INFO - Installing collected packages: blobuploader, requests, docopt 10:32:26 INFO - Running setup.py install for blobuploader 10:32:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:32:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:32:26 INFO - Running setup.py install for requests 10:32:26 INFO - Running setup.py install for docopt 10:32:26 INFO - Successfully installed blobuploader requests docopt 10:32:26 INFO - Cleaning up... 10:32:27 INFO - Return code: 0 10:32:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:27 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:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:27 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:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:27 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 0x7fd86e758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2428350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b71c0>, '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 0x24b80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b8550>, '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': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', '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:32:27 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:32:27 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:32:27 INFO - Using env: {'DISPLAY': ':0', 10:32:27 INFO - 'HOME': '/home/cltbld', 10:32:27 INFO - 'LANG': 'en_US.UTF-8', 10:32:27 INFO - 'LANGUAGE': 'en_US:en', 10:32:27 INFO - 'LOGNAME': 'cltbld', 10:32:27 INFO - 'MAIL': '/var/mail/cltbld', 10:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:27 INFO - 'MOZ_NO_REMOTE': '1', 10:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:27 INFO - 'NO_EM_RESTART': '1', 10:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:27 INFO - 'PWD': '/builds/slave/test', 10:32:27 INFO - 'SHELL': '/bin/bash', 10:32:27 INFO - 'SHLVL': '1', 10:32:27 INFO - 'TERM': 'linux', 10:32:27 INFO - 'TMOUT': '86400', 10:32:27 INFO - 'USER': 'cltbld', 10:32:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', 10:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:27 INFO - '_': '/tools/buildbot/bin/python'} 10:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:27 INFO - Running setup.py (path:/tmp/pip-MlVshu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:27 INFO - Running setup.py (path:/tmp/pip-Sh4dK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:27 INFO - Running setup.py (path:/tmp/pip-p3bWni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:27 INFO - Running setup.py (path:/tmp/pip-vLwH6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:27 INFO - Running setup.py (path:/tmp/pip-x9l79T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:27 INFO - Running setup.py (path:/tmp/pip-pChnP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:27 INFO - Running setup.py (path:/tmp/pip-201l72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:27 INFO - Running setup.py (path:/tmp/pip-A6hBEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:27 INFO - Running setup.py (path:/tmp/pip-AR7twU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:27 INFO - Running setup.py (path:/tmp/pip-864rsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:27 INFO - Running setup.py (path:/tmp/pip-FskMux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:28 INFO - Running setup.py (path:/tmp/pip-TOpq6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:28 INFO - Running setup.py (path:/tmp/pip-QDRyA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:28 INFO - Running setup.py (path:/tmp/pip-t8yIuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:28 INFO - Running setup.py (path:/tmp/pip-2zfHyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:28 INFO - Running setup.py (path:/tmp/pip-CSwkfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:28 INFO - Running setup.py (path:/tmp/pip-8xOBsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:32:28 INFO - Running setup.py install for manifestparser 10:32:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:32:28 INFO - Running setup.py install for mozcrash 10:32:28 INFO - Running setup.py install for mozdebug 10:32:28 INFO - Running setup.py install for mozdevice 10:32:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:32:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:32:28 INFO - Running setup.py install for mozfile 10:32:28 INFO - Running setup.py install for mozhttpd 10:32:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Running setup.py install for mozinfo 10:32:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Running setup.py install for mozInstall 10:32:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Running setup.py install for mozleak 10:32:29 INFO - Running setup.py install for mozlog 10:32:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Running setup.py install for moznetwork 10:32:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Running setup.py install for mozprocess 10:32:29 INFO - Running setup.py install for mozprofile 10:32:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Running setup.py install for mozrunner 10:32:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:32:29 INFO - Running setup.py install for mozscreenshot 10:32:30 INFO - Running setup.py install for moztest 10:32:30 INFO - Running setup.py install for mozversion 10:32:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:32:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:32:30 INFO - Cleaning up... 10:32:30 INFO - Return code: 0 10:32:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:30 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 0x7fd86e758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2428350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b71c0>, '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 0x24b80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b8550>, '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': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', '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:32:30 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:32:30 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:32:30 INFO - Using env: {'DISPLAY': ':0', 10:32:30 INFO - 'HOME': '/home/cltbld', 10:32:30 INFO - 'LANG': 'en_US.UTF-8', 10:32:30 INFO - 'LANGUAGE': 'en_US:en', 10:32:30 INFO - 'LOGNAME': 'cltbld', 10:32:30 INFO - 'MAIL': '/var/mail/cltbld', 10:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:30 INFO - 'MOZ_NO_REMOTE': '1', 10:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:30 INFO - 'NO_EM_RESTART': '1', 10:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:30 INFO - 'PWD': '/builds/slave/test', 10:32:30 INFO - 'SHELL': '/bin/bash', 10:32:30 INFO - 'SHLVL': '1', 10:32:30 INFO - 'TERM': 'linux', 10:32:30 INFO - 'TMOUT': '86400', 10:32:30 INFO - 'USER': 'cltbld', 10:32:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', 10:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:30 INFO - '_': '/tools/buildbot/bin/python'} 10:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:30 INFO - Running setup.py (path:/tmp/pip-Wx58UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:30 INFO - Running setup.py (path:/tmp/pip-Ba8RBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:30 INFO - Running setup.py (path:/tmp/pip-rIsm7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:30 INFO - Running setup.py (path:/tmp/pip-LMlzzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:30 INFO - Running setup.py (path:/tmp/pip-9qjjAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:30 INFO - Running setup.py (path:/tmp/pip-JmKsMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:30 INFO - Running setup.py (path:/tmp/pip-vhJpPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:30 INFO - Running setup.py (path:/tmp/pip-tVwb6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:31 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:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:31 INFO - Running setup.py (path:/tmp/pip-i9s7qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:31 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:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:31 INFO - Running setup.py (path:/tmp/pip-TKUVCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:31 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:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:31 INFO - Running setup.py (path:/tmp/pip-P8HueR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:31 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:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:31 INFO - Running setup.py (path:/tmp/pip-Cf1Dz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:31 INFO - Running setup.py (path:/tmp/pip-AQ1CnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:31 INFO - Running setup.py (path:/tmp/pip-G8vOqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:31 INFO - Running setup.py (path:/tmp/pip-hutk0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:31 INFO - Running setup.py (path:/tmp/pip-w5x1KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:31 INFO - Running setup.py (path:/tmp/pip-g6mWUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:32:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:33 INFO - Downloading blessings-1.6.tar.gz 10:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:32:33 INFO - Installing collected packages: blessings 10:32:33 INFO - Running setup.py install for blessings 10:32:33 INFO - Successfully installed blessings 10:32:33 INFO - Cleaning up... 10:32:33 INFO - Return code: 0 10:32:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:34 INFO - Reading from file tmpfile_stdout 10:32:34 INFO - Current package versions: 10:32:34 INFO - argparse == 1.2.1 10:32:34 INFO - blessings == 1.6 10:32:34 INFO - blobuploader == 1.2.4 10:32:34 INFO - docopt == 0.6.1 10:32:34 INFO - functools32 == 3.2.3-2 10:32:34 INFO - jsonschema == 2.5.1 10:32:34 INFO - manifestparser == 1.1 10:32:34 INFO - mozInstall == 1.12 10:32:34 INFO - mozcrash == 0.17 10:32:34 INFO - mozdebug == 0.1 10:32:34 INFO - mozdevice == 0.48 10:32:34 INFO - mozfile == 1.2 10:32:34 INFO - mozhttpd == 0.7 10:32:34 INFO - mozinfo == 0.9 10:32:34 INFO - mozleak == 0.1 10:32:34 INFO - mozlog == 3.2 10:32:34 INFO - moznetwork == 0.27 10:32:34 INFO - mozprocess == 0.22 10:32:34 INFO - mozprofile == 0.28 10:32:34 INFO - mozrunner == 6.11 10:32:34 INFO - mozscreenshot == 0.1 10:32:34 INFO - mozsystemmonitor == 0.3 10:32:34 INFO - moztest == 0.7 10:32:34 INFO - mozversion == 1.4 10:32:34 INFO - psutil == 3.1.1 10:32:34 INFO - requests == 1.2.3 10:32:34 INFO - wsgiref == 0.1.2 10:32:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:34 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 0x7fd86e758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2428350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b71c0>, '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 0x24b80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b8550>, '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': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', '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:32:34 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:32:34 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:32:34 INFO - Using env: {'DISPLAY': ':0', 10:32:34 INFO - 'HOME': '/home/cltbld', 10:32:34 INFO - 'LANG': 'en_US.UTF-8', 10:32:34 INFO - 'LANGUAGE': 'en_US:en', 10:32:34 INFO - 'LOGNAME': 'cltbld', 10:32:34 INFO - 'MAIL': '/var/mail/cltbld', 10:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:34 INFO - 'MOZ_NO_REMOTE': '1', 10:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:34 INFO - 'NO_EM_RESTART': '1', 10:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:34 INFO - 'PWD': '/builds/slave/test', 10:32:34 INFO - 'SHELL': '/bin/bash', 10:32:34 INFO - 'SHLVL': '1', 10:32:34 INFO - 'TERM': 'linux', 10:32:34 INFO - 'TMOUT': '86400', 10:32:34 INFO - 'USER': 'cltbld', 10:32:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', 10:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:34 INFO - '_': '/tools/buildbot/bin/python'} 10:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:34 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:32:34 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:32:34 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:32:34 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:32:34 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:32:34 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:32:34 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:32:34 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:32:34 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:32:34 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:32:34 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:32:34 INFO - Cleaning up... 10:32:34 INFO - Return code: 0 10:32:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86e758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2428350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b71c0>, '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 0x24b80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b8550>, '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': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', '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:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:32:34 INFO - Using env: {'DISPLAY': ':0', 10:32:34 INFO - 'HOME': '/home/cltbld', 10:32:34 INFO - 'LANG': 'en_US.UTF-8', 10:32:34 INFO - 'LANGUAGE': 'en_US:en', 10:32:34 INFO - 'LOGNAME': 'cltbld', 10:32:34 INFO - 'MAIL': '/var/mail/cltbld', 10:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:34 INFO - 'MOZ_NO_REMOTE': '1', 10:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:34 INFO - 'NO_EM_RESTART': '1', 10:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:34 INFO - 'PWD': '/builds/slave/test', 10:32:34 INFO - 'SHELL': '/bin/bash', 10:32:34 INFO - 'SHLVL': '1', 10:32:34 INFO - 'TERM': 'linux', 10:32:34 INFO - 'TMOUT': '86400', 10:32:34 INFO - 'USER': 'cltbld', 10:32:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', 10:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:34 INFO - '_': '/tools/buildbot/bin/python'} 10:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:32:34 INFO - Cleaning up... 10:32:34 INFO - Return code: 0 10:32:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86e758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2428350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b71c0>, '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 0x24b80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b8550>, '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': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', '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:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:32:34 INFO - Using env: {'DISPLAY': ':0', 10:32:34 INFO - 'HOME': '/home/cltbld', 10:32:34 INFO - 'LANG': 'en_US.UTF-8', 10:32:34 INFO - 'LANGUAGE': 'en_US:en', 10:32:34 INFO - 'LOGNAME': 'cltbld', 10:32:34 INFO - 'MAIL': '/var/mail/cltbld', 10:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:34 INFO - 'MOZ_NO_REMOTE': '1', 10:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:34 INFO - 'NO_EM_RESTART': '1', 10:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:34 INFO - 'PWD': '/builds/slave/test', 10:32:34 INFO - 'SHELL': '/bin/bash', 10:32:34 INFO - 'SHLVL': '1', 10:32:34 INFO - 'TERM': 'linux', 10:32:34 INFO - 'TMOUT': '86400', 10:32:34 INFO - 'USER': 'cltbld', 10:32:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', 10:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:34 INFO - '_': '/tools/buildbot/bin/python'} 10:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:34 INFO - Downloading/unpacking flake8 10:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:32:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:32:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:32:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:32:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:32:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:32:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:32:37 INFO - no previously-included directories found matching 'docs/_build' 10:32:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:32:37 INFO - Running setup.py install for pep8 10:32:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:32:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:32:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:32:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:32:37 INFO - no previously-included directories found matching 'docs/_build' 10:32:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:32:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:32:37 INFO - Cleaning up... 10:32:37 INFO - Return code: 0 10:32:37 INFO - Running post-action listener: _resource_record_post_action 10:32:37 INFO - Running post-action listener: _start_resource_monitoring 10:32:37 INFO - Starting resource monitoring. 10:32:37 INFO - ##### 10:32:37 INFO - ##### Finished create-virtualenv step (success) 10:32:37 INFO - ##### 10:32:37 INFO - ##### 10:32:37 INFO - ##### Running install step. 10:32:37 INFO - ##### 10:32:37 INFO - Running pre-action listener: _resource_record_pre_action 10:32:37 INFO - Running main action method: install 10:32:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:37 INFO - Reading from file tmpfile_stdout 10:32:37 INFO - Detecting whether we're running mozinstall >=1.0... 10:32:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:32:37 INFO - Reading from file tmpfile_stdout 10:32:37 INFO - Output received: 10:32:37 INFO - Usage: mozinstall [options] installer 10:32:37 INFO - Options: 10:32:37 INFO - -h, --help show this help message and exit 10:32:37 INFO - -d DEST, --destination=DEST 10:32:37 INFO - Directory to install application into. [default: 10:32:37 INFO - "/builds/slave/test"] 10:32:37 INFO - --app=APP Application being installed. [default: firefox] 10:32:37 INFO - mkdir: /builds/slave/test/build/application 10:32:37 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:32:37 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:32:53 INFO - Reading from file tmpfile_stdout 10:32:53 INFO - Output received: 10:32:53 INFO - /builds/slave/test/build/application/firefox/firefox 10:32:53 INFO - Running post-action listener: _resource_record_post_action 10:32:53 INFO - ##### 10:32:53 INFO - ##### Finished install step (success) 10:32:53 INFO - ##### 10:32:53 INFO - ##### 10:32:53 INFO - ##### Running run-tests step. 10:32:53 INFO - ##### 10:32:53 INFO - Running pre-action listener: _resource_record_pre_action 10:32:53 INFO - Running main action method: run_tests 10:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:32:53 INFO - Python 2.7.3 10:32:53 INFO - Return code: 0 10:32:53 INFO - grabbing minidump binary from tooltool 10:32: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:32:53 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 0x24b71c0>, '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 0x24b80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b8550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:32:53 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:32:53 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:32:53 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:32:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:32:53 INFO - Return code: 0 10:32:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:32:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:32:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:32:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:32:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:32:54 INFO - Return code: 0 10:32:54 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/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:32:54 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/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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:32:54 INFO - Using env: {'DISPLAY': ':0', 10:32:54 INFO - 'HOME': '/home/cltbld', 10:32:54 INFO - 'LANG': 'en_US.UTF-8', 10:32:54 INFO - 'LANGUAGE': 'en_US:en', 10:32:54 INFO - 'LOGNAME': 'cltbld', 10:32:54 INFO - 'MAIL': '/var/mail/cltbld', 10:32:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:32:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:54 INFO - 'MOZ_NO_REMOTE': '1', 10:32:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:54 INFO - 'NO_EM_RESTART': '1', 10:32:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:54 INFO - 'PWD': '/builds/slave/test', 10:32:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:32:54 INFO - 'SHELL': '/bin/bash', 10:32:54 INFO - 'SHLVL': '1', 10:32:54 INFO - 'TERM': 'linux', 10:32:54 INFO - 'TMOUT': '86400', 10:32:54 INFO - 'USER': 'cltbld', 10:32:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418', 10:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:54 INFO - '_': '/tools/buildbot/bin/python'} 10:32:54 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/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:32:54 INFO - mozversion application_buildid: 20160628075250 10:32:54 INFO - mozversion application_changeset: af923f4926e7606c93218467f4de253c9a2bc783 10:32:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:32:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:32:54 INFO - mozversion application_name: Firefox 10:32:54 INFO - mozversion application_remotingname: firefox-dev 10:32:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:32:54 INFO - mozversion application_vendor: Mozilla 10:32:54 INFO - mozversion application_version: 49.0a2 10:32:54 INFO - mozversion platform_buildid: 20160628075250 10:32:54 INFO - mozversion platform_changeset: af923f4926e7606c93218467f4de253c9a2bc783 10:32:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:32:54 INFO - mozversion platform_version: 49.0a2 10:32:54 INFO - using testdate: 1467135174 10:32:54 INFO - actual date: 1467135174 10:32:54 INFO - starting webserver on 'localhost:43718' 10:32:54 INFO - SUITE-START | Running 2 tests 10:32:54 INFO - TEST-START | dromaeo_css 10:32:54 INFO - operating with platform_type : linux_ 10:32:54 INFO - Initialising browser for dromaeo_css test... 10:32:54 INFO - TEST-INFO | started process 15009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFj24R8/profile http://localhost:43718/getInfo.html) 10:32:58 INFO - PROCESS | 15009 | __metrics Screen width/height:1600/1200 10:32:58 INFO - PROCESS | 15009 | colorDepth:24 10:32:58 INFO - PROCESS | 15009 | Browser inner width/height: 1024/697 10:32:58 INFO - PROCESS | 15009 | __metrics 10:32:59 ERROR - PROCESS | 15009 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:32:59 INFO - PROCESS | 15009 | console.error: PushService: 10:32:59 INFO - PROCESS | 15009 | stateChangeProcessEnqueue: Error transitioning state 10:32:59 INFO - PROCESS | 15009 | UnknownError 10:33:00 INFO - TEST-INFO | 15009: exit 0 10:33:00 INFO - Browser initialized. 10:33:00 INFO - Running cycle 1/1 for dromaeo_css test... 10:33:00 INFO - TEST-INFO | started process 15103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFj24R8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:12 INFO - PROCESS | 15103 | RSS: Main: 145793024 10:33:12 INFO - PROCESS | 15103 | 10:34:03 INFO - PROCESS | 15103 | 1467135243051 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:36:11 INFO - PROCESS | 15103 | Cycle 1(1): loaded http://localhost:43718/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43718/tests/dromaeo/cssquery-ext.html) 10:36:12 INFO - PROCESS | 15103 | RSS: Main: 264376320 10:36:12 INFO - PROCESS | 15103 | 10:39:14 INFO - PROCESS | 15103 | Cycle 1(1): loaded http://localhost:43718/tests/dromaeo/cssquery-ext.html (next: http://localhost:43718/tests/dromaeo/cssquery-jquery.html) 10:39:15 INFO - PROCESS | 15103 | RSS: Main: 230535168 10:39:15 INFO - PROCESS | 15103 | 10:42:17 INFO - PROCESS | 15103 | Cycle 1(1): loaded http://localhost:43718/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43718/tests/dromaeo/cssquery-mootools.html) 10:42:17 INFO - PROCESS | 15103 | RSS: Main: 232415232 10:42:17 INFO - PROCESS | 15103 | 10:45:19 INFO - PROCESS | 15103 | Cycle 1(1): loaded http://localhost:43718/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43718/tests/dromaeo/cssquery-prototype.html) 10:45:20 INFO - PROCESS | 15103 | RSS: Main: 218370048 10:45:20 INFO - PROCESS | 15103 | 10:48:22 INFO - PROCESS | 15103 | Cycle 1(1): loaded http://localhost:43718/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43718/tests/dromaeo/cssquery-yui.html) 10:48:23 INFO - PROCESS | 15103 | RSS: Main: 217305088 10:48:23 INFO - PROCESS | 15103 | 10:51:25 INFO - PROCESS | 15103 | Cycle 1(1): loaded http://localhost:43718/tests/dromaeo/cssquery-yui.html (next: http://localhost:43718/tests/dromaeo/cssquery-dojo.html) 10:51:26 INFO - PROCESS | 15103 | RSS: Main: 264060928 10:51:26 INFO - PROCESS | 15103 | 10:51:26 INFO - PROCESS | 15103 | __start_tp_report 10:51:26 INFO - PROCESS | 15103 | _x_x_mozilla_page_load 10:51:26 INFO - PROCESS | 15103 | _x_x_mozilla_page_load_details 10:51:26 INFO - PROCESS | 15103 | |i|pagename|runs| 10:51:26 INFO - PROCESS | 15103 | |0;dojo.html;3393.5079413485046;3418.179636887148;3428.8971330860068;3449.5688038995127;3471.3925063113966;5633.324001119866;5664.291963504562;5689.459501347365;5711.914321285179;5716.056850619653;5646.322441307038;5700.97382471155;5703.3441154267275;5707.086866101425;5713.485786279234;4987.426445958707;5015.272785446108;5078.5175408336145;5135.255387968742;5147.330846989886;5074.13739664258;5081.415637201732;5092.516210959971;5099.617528685345;5177.042247184264;5212.348456442945;5214.817481388152;5215.973920130413;5217.47825217479;5244.711540865251;4993.126202914512;5071.315372424712;5119.56483698886;5141.408737995141;5201.349831271091;5090.465501122403;5154.175331946908;5158.123119069767;5161.7161056141895;5206.323177986837;5632.577556683265;5688.23208866806;5710.200571919934;5721.542276617861;5724.8282551523525;5853.941460585383;5936.46571808535;5980.073088671263;6162.506999440079;6182.907256391158;6096.359882212392;6099.292198184516;6108.633481991094;6108.737922014632;6116.528085182767;5737.340205876336;5746.195532625436;5746.712664366765;5749.626274292157;5756.481916627524;6013.1581578579035;6138.232720909887;6180.536459765535;6222.782202622887;6223.253209614875;6097.451229389376;6097.878042439126;6098.1324718574115;6109;6113.541484388688;6178.227721534809;6181.289151747516;6193.102000209944;6194.721237544321;6205.379462053758;5807.041838096667;5814.331351894586;5910.290765108129;5949.375315591887;6005.849853753691;5971.462568368867;6003.459688627957;6003.7898673546215;6005.459508644243;6015.368386319461;4582.427196600425;4590.242609969385;4590.563896429834;4596.264597664424;4633.559811817872;4002.779847108379;4059.573744756758;4086.0806318578084;4107.527634322091;4126.8761937141935;5761.193432919395;5763.88472230553;5764.308283005982;5780.566457515703;5796.565257605696;5885.293764748258;6073.271207455134;6079.422454866869;6080.2399700037495;6111.677652033329;5777.162311464814;5780.768769249267;5834.416558344216;5835.270591176103;5868.882622347529;5278.524932755993;5292.179712144623;5294.258803767476;5295.338082739658;5296.073187192303;6116.2048933639235;6230.190075290183;6294.244690637152;6417.358264173546;6428.003659432796;6139.338817383189;6152.846178845564;6158.846028849314;6167.321594624677;6168.167297414791;6372.58578192416;6384.425401713868;6389.9041514376395;6396.392342727433;6398.648074355769;5822.534197264124;5931.495822855106;5947.316058653138;5961.493273071664;6041.78853740117;6068.605540639845;6102.664353460602;6103.84740381494;6109.908351374644;6117.480014198843;5879.853003674943;5929.466348028698;5944.762209511744;5945.524358051432;5952.732127054206;5694.772209111589;5876.08920617305;5905;5927.525797936069;6027.156198132353;5892.882142357043;5897.144913987362;5901.645901245939;5906.26171728534;5906.350301466749;5769;6025.276966764016;6041.395860413923;6052.697365131814;6083.391660834058;5633.295838020247;5742.109972954198;5783.392743761844;5786.94213057864;5822.272215973004 10:51:26 INFO - PROCESS | 15103 | |1;ext.html;596.4810614765153;635.440812085365;645.6416688737754;646.6928209100678;661.7088481068332;35136.12159696009;35659.643403565955;35721;35733.99999999997;45407.54592454075;48138.27792583114;48168;48385.51614483854;48511.27233091507;48537.757311213485;9124.543772811367;9261.120193581599;9273.397229180115;9286.674966376178;9297.30270229732;8533.061363250037;9086.409383390092;11051.72370690731;11320.150988675841;11321.377324247163;11066.557337706483;11125.944370278137;11159.497822597961;11194.66416007521;11212.887871121307;8553.74338769838;11048.668539943774;11134.554617815278;11136.832947505794;11154.386508742016;10585.100266477359;10944.069754070913;10944.124470042378;11228.66314010581;11237.83143252852;43972.56027439717;44376.77811610921;44429;44493.777531112464;44605.553944460786;3705.814709264526;3956.090099277182;4108.095247536539;4167.5207351154395;4468.19572476954;34575.4813677795;34651.653483465096;34916;35031.29937401238;36232;4697.906041879178;4708.293755936603;4722.031983443386;4724.314974328703;4761.285807128924;374978;377529;380189;380338;381937;37376.813115934245;39150.41274380887;63444.682776585825;64246.35753642404;64252.35747642464;40942.59057409447;41118.177636447705;41166.38250426246;41201.1759764803;41202.1759564807;16583.087930163714;16642.3343066276;16666.083365414775;16680.666386672197;16683.416080437128;12567.120301578985;13911.721765564633;14218.715625687635;14330;14331.355089021019;9132.863007054899;9273.860892086625;9278.350515463988;9281.257499400032;9366.90633093674;3517.120719820045;3565.144365352297;3571.5892672342493;3598.712103031751;3601.747877648592;1058.3808472043786;1133.4955944604737;1162.2968104296947;1168.5092261250295;1254.680056585583;33024.4894085681;34214.48678269828;34554.82722586371;34787.826060869535;34796.13009674779;1195.2469943935266;1201.4653479201672;1226.6381417481687;1262.6275248801626;1342.8321459817523;17995.550111247325;18027.54931126706;18142.727859082126;18258.726119108225;18270.725939110926;595015;601519;601897;602244;602375;63518.682406588596;65013.67493162599;65257.67371163114;65323.67338163374;65404.672976634814;1359.429039803285;1397.5178563395816;1406.5288128477075;1488.5162322245314;1489.359575382596;26741.19776406711;33126.503102453964;34179;36405.45391819178;36427;58416.123758142814;59032.70483647554;59052;59064.40935590589;59114.40885591089;450726;455807;455822;456127;457518;25708.971641134147;26689.466210675288;27894.442111157256;29800.701992979793;30205.395892082473;45703.542964569926;50040;51164.74417627888;52353.47646523638;53594;43007.354889676055;43306.78346608247;43823.78088109667;43885.66516226009;44971.550284496734;42548.510802121775;43327.78336108299;43355.78322108369;43983.12033759243;44004;43122.568774311854;44022.11955760803;44105.55894441014;44314.556854431044;44319;37287.6271237295;39230.41154382744;39338;39416.80291598524;40022.799886000386;29178.70821291845;29261.561076584294;29509;29687.703122969357;29768.85115574495 10:51:26 INFO - PROCESS | 15103 | |2;jquery.html;433.84381622615854;434.55458155390727;436.95630436956327;441.8983633764234;452.10483243178527;19253.518662033457;20302.796972030294;20937.057832397542;20960.16159353628;21299;18396.81603183971;19314.806851931477;19626.214951401962;19634.70547941782;19661;5829.0964900440395;6040.426159514839;6074.514038876901;6076.817695469143;6077.969610151943;5936.5250779937505;5956.076808094752;5971.641701497924;5973.044312909935;5974.940250597504;5912;5914.585978981473;5929.466348028676;5933.614315069528;5950.226470558821;5835.212246346752;5893.823185304448;5904.586678932476;5939.435753603422;5946.43508866657;5176.663516871391;5178.197379406198;5348.946510534923;5369.40936496985;5370.946290537084;24398.39004024896;24528.632070518957;24713.876430617733;24725.258242252763;24790.25629231126;2671.252049426164;2694.878730457134;2715.1040156748227;2787.7491025807776;3024.500957342036;14311.499097531536;14997.775033374508;15084.321205545777;15262.08427494354;15597;2041.2549419461789;2106.631339515594;2123.0764617391483;2149.8387620928493;2216.2575537195057;74208;76638.23361766366;77433.61283193604;78337;91855.54072229663;9633.229341652652;10171.54228059739;10285.485725713685;10653.733656658645;10786.514606842711;14632.341544630517;14705.191214483306;14744.63138421548;14789.334479948428;14830.33263503145;8342.207490288412;8488.278496327881;8494.447860889022;8575.32781107678;8590.699325523701;8388.28699560532;8404.78988025292;8428.662853485792;8555.443896146731;8560.0583935767;4437.245668236407;4485.259932111165;4488.977555112204;4524.6832721709825;4552.886177845514;2039.8266147377342;2049.313479984222;2053.9281125160846;2075.968860467094;2159.6544552871464;1021.0657248617432;1029.3206483720708;1069.2622090757352;1071.5767271927546;1079.7840431913648;19873.30443434473;20192.59614807725;20381.184752610025;20510;20560.897195513928;1064.2816099133054;1066.4347895615335;1101.2731597145846;1122.7473818390797;1130.1015692524463;10924.726881827859;11502.252353597156;11504.309741415542;11576.594819181288;11637.709057273467;376884;488377;491288;493990;497260;101163.15655418004;102890;103102.48448757858;103152.48423757983;103255.48372258242;1111.5942680921405;1127.6786115957077;1135.863696356426;1140.8459857919074;1151.5221183209042;18506.537336566693;18598.2560697576;18634.906825465787;18648;19001.524961876064;43638.78180609077;45082;45475.31787023263;45783.54216457926;45866.541334587564;61792;62385.376146237955;62589;62704;63296.683516582125;12445.62663120108;12963.675908102374;13122.868771312165;13276.933615332247;13338.799918001432;13147.408366623333;13502.392392342565;13521.391537380645;13674.93162534181;13733.45066197381;12148.514059437524;12312.938435307766;12462.875371246171;12503.87496125027;12827.358632068546;11712.004479618987;11757.470913808727;11827.994620457357;11836.822447663464;12035.277883327028;12111.576094836639;12244.510219591117;12356.505739770308;12497.93751031239;12733.87266127364;12437.253764774143;12583.245005299712;12764.61706148817;12773.169743966613;12859.869492660317;12137.21108127969;12164.817527736914;12344.343251358448;12384.195027323196;12567.49730010826 10:51:26 INFO - PROCESS | 15103 | |3;mootools.html;1337.324651051219;1583.778271042054;1590.1174847959383;1820.3810704360515;1941.844652427805;9255.444673319596;9711.902880971189;9719.70840874774;9976.551055202515;9993.700188994324;9620.326577139604;9791.11879930806;9819.361741486799;9825.410475371482;9836;2087.822535084512;2339.1695947938492;2345.507443436876;2371.762823717632;2445.7187423446267;2470.0243403855466;2470.8270421070533;2472.5549401107883;2482.2677310193444;2483.937901552458;2378.714554253492;2441.7802397784194;2442.9755702443013;2448.3634255093716;2449.363165576945;2092.393205970267;2306.5041016181603;2368.5026144509675;2382.2614989353356;2386.618141097416;2408.301592538162;2427.5630386530415;2428.890699918508;2430.9513809723708;2436.4030812451065;9606.087421694998;9681.08029737181;9686.176674982635;9702.27232957524;9718.222542196678;5313.38896026958;5437.483439073281;5447.210154527571;5454.209139674725;5462.5083742462975;3476;3539.203679172191;3611.4402267648557;3611.94582081269;3629.8548058077645;1146.5184622458587;1151.6851129230224;1182.4206138991833;1202.7173614200656;1281.8461784585816;13944.442222311096;13986.999999999898;14032.579022629337;14042.297885105703;14061.718765624733;4816.8554943351755;4916.090523253138;4937.382827146606;4993.226049962189;5002.249662550574;11527.077833773277;11571.594994175164;11599.188056836108;11601.767964640829;11602.709932251593;5514.448555144453;5522.282103326542;5531.253280807039;5531.474509921551;5533.280673512498;4504.234280172379;5046.873828154252;5215.947840521546;5217.921731174036;5318.867028324245;4331.891702707395;4334.674899382559;4360.106178233455;4387.780610969438;4394.934075988863;1324.2187109605186;1329.222404893129;1348.8786009259213;1372.876441120304;1375.2711063136553;951.1059603972244;991.5637119667323;1004.5027711282816;1012.9898701013043;1016.4460369098858;5946.226990491295;5999.070144127667;6012.458878700938;6018.729157187937;6153;475.60049558371134;476.1833455623622;484.1648156929269;494.06868053719;495.2373345048585;3673.3204357194004;3811.4663947047434;3840.327942610032;3853.075261937115;3912.080661044652;11737.237079589799;12187.329696866758;12204.75590488203;12213.145079844326;12232.81650775239;12031.639050828315;12052.457639406248;12062.276263424223;12069.939650301692;12070.577529786415;8542.402031857835;8620.870686939701;8695.956520217358;8718.47689138641;8752;5875.559333050124;5906.881862362815;5912.083627037816;5980.132880732356;5981.371955944737;10922.453877306261;11099.167562433011;11147.944260278648;11261.26801757916;11275.605353812578;11002.174836887105;11179.72050698739;11524.078073753912;11654.067674586182;11660.242084264495;7760.417968652261;8517.403781735218;8688.218060374596;8824.3381746368;9216.723498295061;9269.629214831331;9509.476978766234;9566.952165239129;9606.951965240129;9615.855762163434;7846.372290216883;8058.234467725557;8422.073571906963;8615.827683446421;8890.688825891062;7803.570803605856;7828.373730101692;7892.723754668559;8004.079530854026;8237;7678.424118191047;7721.729739459092;7745;7746.380289576708;7748.612569371621;5508.44915508446;5508.44915508446;5531.253280807039;5584.525315348241;5762.7694892203845;5304.071787437106;5312.043832110257;5520.972395137998;5530.11518157109;5726.141078838207 10:51:26 INFO - PROCESS | 15103 | |4;prototype.html;351.6729441619294;353.906214853064;363.96724294813464;364.1933118143313;366.84959166741606;5365.356157261134;5527.613067085295;5568.192612071247;5647.887042259153;5677.744501497427;5328.893422131555;5474.178873169027;5496.31296087989;5508.44915508449;5547.972260138694;4327.1345730853955;4328.588784065509;4344.4786625604975;4363.912721745563;4368.29636441788;4110.917781644365;4194.727342722728;4321.395004699345;4346.913061738764;4360.825566977317;4313.2020576193345;4314.007778211013;4320.638998715411;4333.328334108218;4345.130973805236;4290.141971605692;4315.287977483743;4326.372675961984;4340.240457919867;4343.73937563744;3783.9054023649355;3867.7679339239453;3888.3972984187494;3913.2760439318818;3913.62820532049;5281.603879708999;5305.973470132663;5311.5750739941095;5312.7155323211;5357.7765227430955;4974.975125124387;4975.751212439363;4984.950150498485;4990.525900039527;5021.974890125526;5554.91667624986;5714.971425142848;5745.138229265602;5758.856028599276;5825.213596164506;4292.849750258726;4313.590208930146;4316.438862947797;4337.154254920292;4338.3058710606465;5983.611065280743;6017.398260173992;6041.577089603729;6057.636541807506;6111.327753947062;4313.331433627793;4352.847650332224;4372.256716358227;4399.296112621965;4418.293073108352;4448.421705178306;4450.1767173073085;4458.5987261146;4473.261911784519;4486.551344865487;4983.8504844854715;4985.105659849234;5013.623978201649;5034.597232221414;5052.898942021139;5504.504594586507;5764;5776.422357764274;5789.8263052108505;5826.126081087786;1446.6961937992928;1505.224809223251;1524.367387534183;1524.9847501524844;1537.715522628295;993.7167907146429;1006.5822683586376;1022.9590816367411;1028.018242578336;1039.9376037437778;5075.7969681212335;5092.9745351273;5104.846854594368;5106.591472682177;5131.846044618667;5207.505286997729;5223.623251420595;5244.554212891947;5248.343957005374;5271.2868317796865;5000.349954505891;5010.22341537055;5028.64799464034;5197.324347834833;5673.744681489343;3147.653758086609;3154.3533575616943;3157.289609837814;3168.334649723538;3185.3629274145264;6045.909311360333;6143.877122457526;6180.598261113013;6226.688665566703;6252.718627661675;5905.970470147622;6064.968235641021;6071.362506936708;6073.271207455134;6095.238095238095;6149.292831324366;6169.383061693795;6173.444390004921;6181.660008699385;6188.586451284003;5685.886282274414;5945.286565612154;5958.1658567801405;5998.940010599838;6024.668643224665;5902;5920.79277225295;5927.814437112508;5943.4844114752195;5968.641881487125;6014.8195554133445;6226.097215903759;6227.813165605039;6245.250569931455;6259.374062593886;4241.151769646021;4245.57544245573;4245.639120674778;4253.6384407324485;4265.189613973459;5753.877993791338;5837.153612726046;5972.940270597239;5979.342272349951;5989.550783691154;5713.514351280021;5755.3381361144;5767.5674324425;5769.884602308014;5805.390434004537;5661.830145095653;5750.281214848144;5750.856228594152;5778.479936805707;5784.971075144597;5562.777488900399;5721.942780572307;5750.856228594319;5754.187430959234;5760.395158508296;5828.6502809831545;5856.238688970407;5857.7698683276985;5868.471837534642;5877.265341832271;5469.535089517435;5616.887662246814;5642.689652069012;5648.4633959773755;5750.338711048283 10:51:26 INFO - PROCESS | 15103 | |5;yui.html;723.6273319240591;781.4412694923129;810.6068556749976;813.479373201151;823.2056065896409;15559.92220038901;16110.436134735286;16111.355545778184;16409.671806563863;16438.34246630135;15539.300731467083;15623.531294061168;15643.06141631503;15644.608884777886;15662.295196716146;716.451914285572;842.1999100854182;866.7963028688238;876.2726936642604;885.3359980014989;845.5856630251163;848.1603212819326;849.2272032450471;851.6721062390963;852.6291063387415;872.9301655867547;872.9476231426135;873.1748497669705;875.3303722652176;875.3391189651804;749.9250074992511;770.0259172147238;858.8539948208758;881.9867701984475;893.0712059458156;657.8026592022422;658.2726087673148;659.2715049869872;659.3472462262374;659.4526542969325;15533.068015919082;15560.766588501181;15606.843931560652;15612.687746245125;15628.531144065697;13805.102668326626;13998.30008499571;14064.367103480368;14105.2242126683;14184.858151418457;13892.23592702401;13912.58262252134;14086.92956535221;14340.56978290653;14380.209088500129;4567.703099298568;4650.674452788307;4670.439547254351;4704.670673052888;4725.173094708447;77709.61145194294;79470.60264698697;79605;79657;80663.5966820168;12080;12156.149069565223;12192.756144877052;12560.497580096877;12804.10371274002;23078.8846055772;23086.538269234523;23088;23097.307080787603;23101.422464438187;8574.785630359167;8634.481931084156;8759.956200219085;8898.86651700225;8915.28677705782;4515.254982927846;4689.695169814019;4736.502667219961;4791.928121078117;4814.542618451242;3378.1048022274117;3454.170998960282;3458.948115778265;3464.272502774395;3471.340445315382;576.4523702482575;648.970796314167;650.8080116365684;666.4834753066316;677.518961537314;734.5335711822923;741.4883730226127;770.7302444144617;781.2890269854405;781.839722856813;10963.83554246687;10991.19724470271;11109;11343.716407089723;11381;625.4464798653224;709.2588245283691;731.3856360657073;792.1007480951505;831.2061980808313;4984.2025275955675;5073.7716802743225;5174.779809875541;5270.578353731692;5326.733663316819;92524.53737731268;95355.52322238345;102813;115865;120092.39953800174;69308.3069169312;76873;99553.50223248982;100494;100589.49705251573;90022.54988725015;90352;90836.5458172718;90994;92485.5375723117;10321.277510574488;10502.07644294152;10575.15398768112;10685.19861010443;10771.676849694522;50036;50102.49897501124;50730.74634626803;50771;52199.47800521946;69201.65399173173;75902.86145707709;76969.61515192388;77919.61040194989;79245.20754792608;14186.645333866323;14327.57017289483;14339.78490322667;14376.928115359357;14744.705105898036;15888.2055897207;16098.356065757707;16961;17596.208170632097;17672.55818604545;15142.394304227708;15219.239038047832;15343.23283835826;15395.923020384826;16612.667746645242;13716.245606491739;13821.585352439442;14149.787753183504;14563.708725825636;15081.54755357341;14738.926305368404;15488.225588720294;15540.922295388451;15552;16052.598685032968;11991.76016479648;12400.503979840705;12715.908527208545;12880.355982200665;12965.120057591408;12541.74916501683;12828.615141545768;12929.353532323157;13217.40521676546;13291.268980206181 10:51:26 INFO - PROCESS | 15103 | __end_tp_report 10:51:26 INFO - PROCESS | 15103 | __start_cc_report 10:51:26 INFO - PROCESS | 15103 | _x_x_mozilla_cycle_collect,997 10:51:26 INFO - PROCESS | 15103 | __end_cc_report 10:51:26 INFO - PROCESS | 15103 | __startTimestamp1467136286179__endTimestamp 10:51:26 INFO - PROCESS | 15103 | 10:51:26 INFO - PROCESS | 15103 | ------- Summary: start ------- 10:51:26 INFO - PROCESS | 15103 | Number of tests: 6 10:51:26 INFO - PROCESS | 15103 | 10:51:26 INFO - PROCESS | 15103 | [#0] dojo.html Cycles:165 Average:5646.70 Median:5834.42 stddev:639.71 (11.0%) stddev-sans-first:616.77 10:51:26 INFO - PROCESS | 15103 | Values: 3393.5 3418.2 3428.9 3449.6 3471.4 5633.3 5664.3 5689.5 5711.9 5716.1 5646.3 5701.0 5703.3 5707.1 5713.5 4987.4 5015.3 5078.5 5135.3 5147.3 5074.1 5081.4 5092.5 5099.6 5177.0 5212.3 5214.8 5216.0 5217.5 5244.7 4993.1 5071.3 5119.6 5141.4 5201.3 5090.5 5154.2 5158.1 5161.7 5206.3 5632.6 5688.2 5710.2 5721.5 5724.8 5853.9 5936.5 5980.1 6162.5 6182.9 6096.4 6099.3 6108.6 6108.7 6116.5 5737.3 5746.2 5746.7 5749.6 5756.5 6013.2 6138.2 6180.5 6222.8 6223.3 6097.5 6097.9 6098.1 6109.0 6113.5 6178.2 6181.3 6193.1 6194.7 6205.4 5807.0 5814.3 5910.3 5949.4 6005.8 5971.5 6003.5 6003.8 6005.5 6015.4 4582.4 4590.2 4590.6 4596.3 4633.6 4002.8 4059.6 4086.1 4107.5 4126.9 5761.2 5763.9 5764.3 5780.6 5796.6 5885.3 6073.3 6079.4 6080.2 6111.7 5777.2 5780.8 5834.4 5835.3 5868.9 5278.5 5292.2 5294.3 5295.3 5296.1 6116.2 6230.2 6294.2 6417.4 6428.0 6139.3 6152.8 6158.8 6167.3 6168.2 6372.6 6384.4 6389.9 6396.4 6398.6 5822.5 5931.5 5947.3 5961.5 6041.8 6068.6 6102.7 6103.8 6109.9 6117.5 5879.9 5929.5 5944.8 5945.5 5952.7 5694.8 5876.1 5905.0 5927.5 6027.2 5892.9 5897.1 5901.6 5906.3 5906.4 5769.0 6025.3 6041.4 6052.7 6083.4 5633.3 5742.1 5783.4 5786.9 5822.3 10:51:26 INFO - PROCESS | 15103 | 10:51:26 INFO - PROCESS | 15103 | [#1] ext.html Cycles:180 Average:63663.05 Median:39284.21 stddev:129498.01 (329.6%) stddev-sans-first:129774.71 10:51:26 INFO - PROCESS | 15103 | Values: 596.5 635.4 645.6 646.7 661.7 35136.1 35659.6 35721.0 35734.0 45407.5 48138.3 48168.0 48385.5 48511.3 48537.8 9124.5 9261.1 9273.4 9286.7 9297.3 8533.1 9086.4 11051.7 11320.2 11321.4 11066.6 11125.9 11159.5 11194.7 11212.9 8553.7 11048.7 11134.6 11136.8 11154.4 10585.1 10944.1 10944.1 11228.7 11237.8 43972.6 44376.8 44429.0 44493.8 44605.6 3705.8 3956.1 4108.1 4167.5 4468.2 34575.5 34651.7 34916.0 35031.3 36232.0 4697.9 4708.3 4722.0 4724.3 4761.3 374978.0 377529.0 380189.0 380338.0 381937.0 37376.8 39150.4 63444.7 64246.4 64252.4 40942.6 41118.2 41166.4 41201.2 41202.2 16583.1 16642.3 16666.1 16680.7 16683.4 12567.1 13911.7 14218.7 14330.0 14331.4 9132.9 9273.9 9278.4 9281.3 9366.9 3517.1 3565.1 3571.6 3598.7 3601.7 1058.4 1133.5 1162.3 1168.5 1254.7 33024.5 34214.5 34554.8 34787.8 34796.1 1195.2 1201.5 1226.6 1262.6 1342.8 17995.6 18027.5 18142.7 18258.7 18270.7 595015.0 601519.0 601897.0 602244.0 602375.0 63518.7 65013.7 65257.7 65323.7 65404.7 1359.4 1397.5 1406.5 1488.5 1489.4 26741.2 33126.5 34179.0 36405.5 36427.0 58416.1 59032.7 59052.0 59064.4 59114.4 450726.0 455807.0 455822.0 456127.0 457518.0 25709.0 26689.5 27894.4 29800.7 30205.4 45703.5 50040.0 51164.7 52353.5 53594.0 43007.4 43306.8 43823.8 43885.7 44971.6 42548.5 43327.8 43355.8 43983.1 44004.0 43122.6 44022.1 44105.6 44314.6 44319.0 37287.6 39230.4 39338.0 39416.8 40022.8 29178.7 29261.6 29509.0 29687.7 29768.9 10:51:26 INFO - PROCESS | 15103 | 10:51:26 INFO - PROCESS | 15103 | [#2] jquery.html Cycles:180 Average:29561.14 Median:2045.28 stddev:78104.60 (3818.8%) stddev-sans-first:78293.08 10:51:26 INFO - PROCESS | 15103 | Values: 433.8 434.6 437.0 441.9 452.1 19253.5 20302.8 20937.1 20960.2 21299.0 18396.8 19314.8 19626.2 19634.7 19661.0 5829.1 6040.4 6074.5 6076.8 6078.0 5936.5 5956.1 5971.6 5973.0 5974.9 5912.0 5914.6 5929.5 5933.6 5950.2 5835.2 5893.8 5904.6 5939.4 5946.4 5176.7 5178.2 5348.9 5369.4 5370.9 24398.4 24528.6 24713.9 24725.3 24790.3 2671.3 2694.9 2715.1 2787.7 3024.5 14311.5 14997.8 15084.3 15262.1 15597.0 2041.3 2106.6 2123.1 2149.8 2216.3 74208.0 76638.2 77433.6 78337.0 91855.5 9633.2 10171.5 10285.5 10653.7 10786.5 14632.3 14705.2 14744.6 14789.3 14830.3 8342.2 8488.3 8494.4 8575.3 8590.7 8388.3 8404.8 8428.7 8555.4 8560.1 4437.2 4485.3 4489.0 4524.7 4552.9 2039.8 2049.3 2053.9 2076.0 2159.7 1021.1 1029.3 1069.3 1071.6 1079.8 19873.3 20192.6 20381.2 20510.0 20560.9 1064.3 1066.4 1101.3 1122.7 1130.1 10924.7 11502.3 11504.3 11576.6 11637.7 376884.0 488377.0 491288.0 493990.0 497260.0 101163.2 102890.0 103102.5 103152.5 103255.5 1111.6 1127.7 1135.9 1140.8 1151.5 18506.5 18598.3 18634.9 18648.0 19001.5 43638.8 45082.0 45475.3 45783.5 45866.5 61792.0 62385.4 62589.0 62704.0 63296.7 12445.6 12963.7 13122.9 13276.9 13338.8 13147.4 13502.4 13521.4 13674.9 13733.5 12148.5 12312.9 12462.9 12503.9 12827.4 11712.0 11757.5 11828.0 11836.8 12035.3 12111.6 12244.5 12356.5 12497.9 12733.9 12437.3 12583.2 12764.6 12773.2 12859.9 12137.2 12164.8 12344.3 12384.2 12567.5 10:51:26 INFO - PROCESS | 15103 | 10:51:26 INFO - PROCESS | 15103 | [#3] mootools.html Cycles:180 Average:6268.87 Median:2646.52 stddev:3752.94 (141.8%) stddev-sans-first:3745.16 10:51:26 INFO - PROCESS | 15103 | Values: 1337.3 1583.8 1590.1 1820.4 1941.8 9255.4 9711.9 9719.7 9976.6 9993.7 9620.3 9791.1 9819.4 9825.4 9836.0 2087.8 2339.2 2345.5 2371.8 2445.7 2470.0 2470.8 2472.6 2482.3 2483.9 2378.7 2441.8 2443.0 2448.4 2449.4 2092.4 2306.5 2368.5 2382.3 2386.6 2408.3 2427.6 2428.9 2431.0 2436.4 9606.1 9681.1 9686.2 9702.3 9718.2 5313.4 5437.5 5447.2 5454.2 5462.5 3476.0 3539.2 3611.4 3611.9 3629.9 1146.5 1151.7 1182.4 1202.7 1281.8 13944.4 13987.0 14032.6 14042.3 14061.7 4816.9 4916.1 4937.4 4993.2 5002.2 11527.1 11571.6 11599.2 11601.8 11602.7 5514.4 5522.3 5531.3 5531.5 5533.3 4504.2 5046.9 5215.9 5217.9 5318.9 4331.9 4334.7 4360.1 4387.8 4394.9 1324.2 1329.2 1348.9 1372.9 1375.3 951.1 991.6 1004.5 1013.0 1016.4 5946.2 5999.1 6012.5 6018.7 6153.0 475.6 476.2 484.2 494.1 495.2 3673.3 3811.5 3840.3 3853.1 3912.1 11737.2 12187.3 12204.8 12213.1 12232.8 12031.6 12052.5 12062.3 12069.9 12070.6 8542.4 8620.9 8696.0 8718.5 8752.0 5875.6 5906.9 5912.1 5980.1 5981.4 10922.5 11099.2 11147.9 11261.3 11275.6 11002.2 11179.7 11524.1 11654.1 11660.2 7760.4 8517.4 8688.2 8824.3 9216.7 9269.6 9509.5 9567.0 9607.0 9615.9 7846.4 8058.2 8422.1 8615.8 8890.7 7803.6 7828.4 7892.7 8004.1 8237.0 7678.4 7721.7 7745.0 7746.4 7748.6 5508.4 5508.4 5531.3 5584.5 5762.8 5304.1 5312.0 5521.0 5530.1 5726.1 10:51:26 INFO - PROCESS | 15103 | 10:51:26 INFO - PROCESS | 15103 | [#4] prototype.html Cycles:180 Average:4860.95 Median:5312.15 stddev:1405.68 (26.5%) stddev-sans-first:1368.27 10:51:26 INFO - PROCESS | 15103 | Values: 351.7 353.9 364.0 364.2 366.8 5365.4 5527.6 5568.2 5647.9 5677.7 5328.9 5474.2 5496.3 5508.4 5548.0 4327.1 4328.6 4344.5 4363.9 4368.3 4110.9 4194.7 4321.4 4346.9 4360.8 4313.2 4314.0 4320.6 4333.3 4345.1 4290.1 4315.3 4326.4 4340.2 4343.7 3783.9 3867.8 3888.4 3913.3 3913.6 5281.6 5306.0 5311.6 5312.7 5357.8 4975.0 4975.8 4985.0 4990.5 5022.0 5554.9 5715.0 5745.1 5758.9 5825.2 4292.8 4313.6 4316.4 4337.2 4338.3 5983.6 6017.4 6041.6 6057.6 6111.3 4313.3 4352.8 4372.3 4399.3 4418.3 4448.4 4450.2 4458.6 4473.3 4486.6 4983.9 4985.1 5013.6 5034.6 5052.9 5504.5 5764.0 5776.4 5789.8 5826.1 1446.7 1505.2 1524.4 1525.0 1537.7 993.7 1006.6 1023.0 1028.0 1039.9 5075.8 5093.0 5104.8 5106.6 5131.8 5207.5 5223.6 5244.6 5248.3 5271.3 5000.3 5010.2 5028.6 5197.3 5673.7 3147.7 3154.4 3157.3 3168.3 3185.4 6045.9 6143.9 6180.6 6226.7 6252.7 5906.0 6065.0 6071.4 6073.3 6095.2 6149.3 6169.4 6173.4 6181.7 6188.6 5685.9 5945.3 5958.2 5998.9 6024.7 5902.0 5920.8 5927.8 5943.5 5968.6 6014.8 6226.1 6227.8 6245.3 6259.4 4241.2 4245.6 4245.6 4253.6 4265.2 5753.9 5837.2 5972.9 5979.3 5989.6 5713.5 5755.3 5767.6 5769.9 5805.4 5661.8 5750.3 5750.9 5778.5 5785.0 5562.8 5721.9 5750.9 5754.2 5760.4 5828.7 5856.2 5857.8 5868.5 5877.3 5469.5 5616.9 5642.7 5648.5 5750.3 10:51:26 INFO - PROCESS | 15103 | 10:51:26 INFO - PROCESS | 15103 | [#5] yui.html Cycles:180 Average:21114.96 Median:4541.48 stddev:28942.48 (637.3%) stddev-sans-first:28983.17 10:51:26 INFO - PROCESS | 15103 | Values: 723.6 781.4 810.6 813.5 823.2 15559.9 16110.4 16111.4 16409.7 16438.3 15539.3 15623.5 15643.1 15644.6 15662.3 716.5 842.2 866.8 876.3 885.3 845.6 848.2 849.2 851.7 852.6 872.9 872.9 873.2 875.3 875.3 749.9 770.0 858.9 882.0 893.1 657.8 658.3 659.3 659.3 659.5 15533.1 15560.8 15606.8 15612.7 15628.5 13805.1 13998.3 14064.4 14105.2 14184.9 13892.2 13912.6 14086.9 14340.6 14380.2 4567.7 4650.7 4670.4 4704.7 4725.2 77709.6 79470.6 79605.0 79657.0 80663.6 12080.0 12156.1 12192.8 12560.5 12804.1 23078.9 23086.5 23088.0 23097.3 23101.4 8574.8 8634.5 8760.0 8898.9 8915.3 4515.3 4689.7 4736.5 4791.9 4814.5 3378.1 3454.2 3458.9 3464.3 3471.3 576.5 649.0 650.8 666.5 677.5 734.5 741.5 770.7 781.3 781.8 10963.8 10991.2 11109.0 11343.7 11381.0 625.4 709.3 731.4 792.1 831.2 4984.2 5073.8 5174.8 5270.6 5326.7 92524.5 95355.5 102813.0 115865.0 120092.4 69308.3 76873.0 99553.5 100494.0 100589.5 90022.5 90352.0 90836.5 90994.0 92485.5 10321.3 10502.1 10575.2 10685.2 10771.7 50036.0 50102.5 50730.7 50771.0 52199.5 69201.7 75902.9 76969.6 77919.6 79245.2 14186.6 14327.6 14339.8 14376.9 14744.7 15888.2 16098.4 16961.0 17596.2 17672.6 15142.4 15219.2 15343.2 15395.9 16612.7 13716.2 13821.6 14149.8 14563.7 15081.5 14738.9 15488.2 15540.9 15552.0 16052.6 11991.8 12400.5 12715.9 12880.4 12965.1 12541.7 12828.6 12929.4 13217.4 13291.3 10:51:26 INFO - PROCESS | 15103 | -------- Summary: end -------- 10:51:26 INFO - PROCESS | 15103 | 10:51:26 INFO - TEST-INFO | 15103: exit 0 10:51:26 INFO - TEST-OK | dromaeo_css | took 1111935ms 10:51:26 INFO - TEST-START | kraken 10:51:26 INFO - operating with platform_type : linux_ 10:51:26 INFO - Initialising browser for kraken test... 10:51:26 INFO - TEST-INFO | started process 15289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpugf88P/profile http://localhost:43718/getInfo.html) 10:51:30 INFO - PROCESS | 15289 | __metrics Screen width/height:1600/1200 10:51:30 INFO - PROCESS | 15289 | colorDepth:24 10:51:30 INFO - PROCESS | 15289 | Browser inner width/height: 1024/697 10:51:30 INFO - PROCESS | 15289 | __metrics 10:51:31 ERROR - PROCESS | 15289 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:51:31 INFO - PROCESS | 15289 | console.error: PushService: 10:51:31 INFO - PROCESS | 15289 | stateChangeProcessEnqueue: Error transitioning state 10:51:31 INFO - PROCESS | 15289 | UnknownError 10:51:32 INFO - TEST-INFO | 15289: exit 0 10:51:32 INFO - Browser initialized. 10:51:32 INFO - Running cycle 1/1 for kraken test... 10:51:32 INFO - TEST-INFO | started process 15379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpugf88P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:44 INFO - PROCESS | 15379 | RSS: Main: 145539072 10:51:44 INFO - PROCESS | 15379 | 10:51:46 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43718/tests/kraken/driver.html?testName=audio-beat-detection) 10:51:47 INFO - PROCESS | 15379 | RSS: Main: 195043328 10:51:47 INFO - PROCESS | 15379 | 10:51:50 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43718/tests/kraken/driver.html?testName=audio-dft) 10:51:50 INFO - PROCESS | 15379 | RSS: Main: 188657664 10:51:50 INFO - PROCESS | 15379 | 10:51:53 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43718/tests/kraken/driver.html?testName=audio-fft) 10:51:54 INFO - PROCESS | 15379 | RSS: Main: 278929408 10:51:54 INFO - PROCESS | 15379 | 10:51:56 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43718/tests/kraken/driver.html?testName=audio-oscillator) 10:51:56 INFO - PROCESS | 15379 | RSS: Main: 187826176 10:51:56 INFO - PROCESS | 15379 | 10:51:58 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43718/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:51:59 INFO - PROCESS | 15379 | RSS: Main: 188481536 10:51:59 INFO - PROCESS | 15379 | 10:52:02 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43718/tests/kraken/driver.html?testName=imaging-darkroom) 10:52:03 INFO - PROCESS | 15379 | RSS: Main: 222834688 10:52:03 INFO - PROCESS | 15379 | 10:52:06 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43718/tests/kraken/driver.html?testName=imaging-desaturate) 10:52:07 INFO - PROCESS | 15379 | RSS: Main: 223293440 10:52:07 INFO - PROCESS | 15379 | 10:52:09 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43718/tests/kraken/driver.html?testName=json-parse-financial) 10:52:10 INFO - PROCESS | 15379 | RSS: Main: 223051776 10:52:10 INFO - PROCESS | 15379 | 10:52:11 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43718/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:52:12 INFO - PROCESS | 15379 | RSS: Main: 200806400 10:52:12 INFO - PROCESS | 15379 | 10:52:14 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43718/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:52:14 INFO - PROCESS | 15379 | RSS: Main: 202424320 10:52:14 INFO - PROCESS | 15379 | 10:52:16 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43718/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:52:17 INFO - PROCESS | 15379 | RSS: Main: 210026496 10:52:17 INFO - PROCESS | 15379 | 10:52:20 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:52:20 INFO - PROCESS | 15379 | RSS: Main: 214757376 10:52:20 INFO - PROCESS | 15379 | 10:52:23 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:52:23 INFO - PROCESS | 15379 | RSS: Main: 215830528 10:52:23 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:43718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43718/tests/kraken/driver.html?testName=ai-astar) 10:52:25 INFO - PROCESS | 15379 | RSS: Main: 257937408 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | __start_tp_report 10:52:25 INFO - PROCESS | 15379 | _x_x_mozilla_page_load 10:52:25 INFO - PROCESS | 15379 | _x_x_mozilla_page_load_details 10:52:25 INFO - PROCESS | 15379 | |i|pagename|runs| 10:52:25 INFO - PROCESS | 15379 | |0;ai-astar;110;105;111;111;110;110;110;110;110;111 10:52:25 INFO - PROCESS | 15379 | |1;audio-beat-detection;149;132;135;177;130;125;137;149;174;124 10:52:25 INFO - PROCESS | 15379 | |2;audio-dft;161;161;162;161;160;161;161;160;161;161 10:52:25 INFO - PROCESS | 15379 | |3;audio-fft;75;75;75;119;74;75;76;75;106;74 10:52:25 INFO - PROCESS | 15379 | |4;audio-oscillator;85;85;110;86;86;85;111;84;84;131 10:52:25 INFO - PROCESS | 15379 | |5;imaging-gaussian-blur;117;116;117;117;117;118;116;117;117;116 10:52:25 INFO - PROCESS | 15379 | |6;imaging-darkroom;146;146;146;146;146;146;147;147;146;145 10:52:25 INFO - PROCESS | 15379 | |7;imaging-desaturate;94;94;94;95;95;94;95;94;94;95 10:52:25 INFO - PROCESS | 15379 | |8;json-parse-financial;49;49;51;55;51;52;51;50;50;50 10:52:25 INFO - PROCESS | 15379 | |9;json-stringify-tinderbox;60;59;59;60;61;60;60;60;59;61 10:52:25 INFO - PROCESS | 15379 | |10;stanford-crypto-aes;76;81;77;75;77;78;77;78;120;77 10:52:25 INFO - PROCESS | 15379 | |11;stanford-crypto-ccm;118;118;117;125;117;114;125;118;129;128 10:52:25 INFO - PROCESS | 15379 | |12;stanford-crypto-pbkdf2;158;158;156;161;153;154;160;155;156;155 10:52:25 INFO - PROCESS | 15379 | |13;stanford-crypto-sha256-iterative;65;62;62;62;64;61;63;60;61;60 10:52:25 INFO - PROCESS | 15379 | __end_tp_report 10:52:25 INFO - PROCESS | 15379 | __start_cc_report 10:52:25 INFO - PROCESS | 15379 | _x_x_mozilla_cycle_collect,1605 10:52:25 INFO - PROCESS | 15379 | __end_cc_report 10:52:25 INFO - PROCESS | 15379 | __startTimestamp1467136345803__endTimestamp 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | ------- Summary: start ------- 10:52:25 INFO - PROCESS | 15379 | Number of tests: 14 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.75 (1.6%) stddev-sans-first:1.86 10:52:25 INFO - PROCESS | 15379 | Values: 110.0 105.0 111.0 111.0 110.0 110.0 110.0 110.0 110.0 111.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:143.00 stddev:19.04 (13.3%) stddev-sans-first:20.08 10:52:25 INFO - PROCESS | 15379 | Values: 149.0 132.0 135.0 177.0 130.0 125.0 137.0 149.0 174.0 124.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:52:25 INFO - PROCESS | 15379 | Values: 161.0 161.0 162.0 161.0 160.0 161.0 161.0 160.0 161.0 161.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:16.17 (21.6%) stddev-sans-first:16.92 10:52:25 INFO - PROCESS | 15379 | Values: 75.0 75.0 75.0 119.0 74.0 75.0 76.0 75.0 106.0 74.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:85.00 stddev:16.60 (19.5%) stddev-sans-first:17.23 10:52:25 INFO - PROCESS | 15379 | Values: 85.0 85.0 110.0 86.0 86.0 85.0 111.0 84.0 84.0 131.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:52:25 INFO - PROCESS | 15379 | Values: 117.0 116.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 116.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:52:25 INFO - PROCESS | 15379 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 145.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:52:25 INFO - PROCESS | 15379 | Values: 94.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:1.75 (3.4%) stddev-sans-first:1.73 10:52:25 INFO - PROCESS | 15379 | Values: 49.0 49.0 51.0 55.0 51.0 52.0 51.0 50.0 50.0 50.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 10:52:25 INFO - PROCESS | 15379 | Values: 60.0 59.0 59.0 60.0 61.0 60.0 60.0 60.0 59.0 61.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:77.00 stddev:13.58 (17.6%) stddev-sans-first:14.25 10:52:25 INFO - PROCESS | 15379 | Values: 76.0 81.0 77.0 75.0 77.0 78.0 77.0 78.0 120.0 77.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.50 stddev:5.30 (4.4%) stddev-sans-first:5.52 10:52:25 INFO - PROCESS | 15379 | Values: 118.0 118.0 117.0 125.0 117.0 114.0 125.0 118.0 129.0 128.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:157.00 stddev:2.59 (1.7%) stddev-sans-first:2.70 10:52:25 INFO - PROCESS | 15379 | Values: 158.0 158.0 156.0 161.0 153.0 154.0 160.0 155.0 156.0 155.0 10:52:25 INFO - PROCESS | 15379 | 10:52:25 INFO - PROCESS | 15379 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.63 (2.6%) stddev-sans-first:1.32 10:52:25 INFO - PROCESS | 15379 | Values: 65.0 62.0 62.0 62.0 64.0 61.0 63.0 60.0 61.0 60.0 10:52:25 INFO - PROCESS | 15379 | -------- Summary: end -------- 10:52:25 INFO - PROCESS | 15379 | 10:52:26 INFO - TEST-INFO | 15379: exit 0 10:52:26 INFO - TEST-OK | kraken | took 59890ms 10:52:26 INFO - SUITE-END | took 1171s 10:52:26 INFO - Completed test suite (00:19:31) 10:52:26 INFO - javascript benchmark 10:52:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3393.5079413485046, 3418.179636887148, 3428.8971330860068, 3449.5688038995127, 3471.3925063113966, 5633.324001119866, 5664.291963504562, 5689.459501347365, 5711.914321285179, 5716.056850619653, 5646.322441307038, 5700.97382471155, 5703.3441154267275, 5707.086866101425, 5713.485786279234, 4987.426445958707, 5015.272785446108, 5078.5175408336145, 5135.255387968742, 5147.330846989886, 5074.13739664258, 5081.415637201732, 5092.516210959971, 5099.617528685345, 5177.042247184264, 5212.348456442945, 5214.817481388152, 5215.973920130413, 5217.47825217479, 5244.711540865251, 4993.126202914512, 5071.315372424712, 5119.56483698886, 5141.408737995141, 5201.349831271091, 5090.465501122403, 5154.175331946908, 5158.123119069767, 5161.7161056141895, 5206.323177986837, 5632.577556683265, 5688.23208866806, 5710.200571919934, 5721.542276617861, 5724.8282551523525, 5853.941460585383, 5936.46571808535, 5980.073088671263, 6162.506999440079, 6182.907256391158, 6096.359882212392, 6099.292198184516, 6108.633481991094, 6108.737922014632, 6116.528085182767, 5737.340205876336, 5746.195532625436, 5746.712664366765, 5749.626274292157, 5756.481916627524, 6013.1581578579035, 6138.232720909887, 6180.536459765535, 6222.782202622887, 6223.253209614875, 6097.451229389376, 6097.878042439126, 6098.1324718574115, 6109.0, 6113.541484388688, 6178.227721534809, 6181.289151747516, 6193.102000209944, 6194.721237544321, 6205.379462053758, 5807.041838096667, 5814.331351894586, 5910.290765108129, 5949.375315591887, 6005.849853753691, 5971.462568368867, 6003.459688627957, 6003.7898673546215, 6005.459508644243, 6015.368386319461, 4582.427196600425, 4590.242609969385, 4590.563896429834, 4596.264597664424, 4633.559811817872, 4002.779847108379, 4059.573744756758, 4086.0806318578084, 4107.527634322091, 4126.8761937141935, 5761.193432919395, 5763.88472230553, 5764.308283005982, 5780.566457515703, 5796.565257605696, 5885.293764748258, 6073.271207455134, 6079.422454866869, 6080.2399700037495, 6111.677652033329, 5777.162311464814, 5780.768769249267, 5834.416558344216, 5835.270591176103, 5868.882622347529, 5278.524932755993, 5292.179712144623, 5294.258803767476, 5295.338082739658, 5296.073187192303, 6116.2048933639235, 6230.190075290183, 6294.244690637152, 6417.358264173546, 6428.003659432796, 6139.338817383189, 6152.846178845564, 6158.846028849314, 6167.321594624677, 6168.167297414791, 6372.58578192416, 6384.425401713868, 6389.9041514376395, 6396.392342727433, 6398.648074355769, 5822.534197264124, 5931.495822855106, 5947.316058653138, 5961.493273071664, 6041.78853740117, 6068.605540639845, 6102.664353460602, 6103.84740381494, 6109.908351374644, 6117.480014198843, 5879.853003674943, 5929.466348028698, 5944.762209511744, 5945.524358051432, 5952.732127054206, 5694.772209111589, 5876.08920617305, 5905.0, 5927.525797936069, 6027.156198132353, 5892.882142357043, 5897.144913987362, 5901.645901245939, 5906.26171728534, 5906.350301466749, 5769.0, 6025.276966764016, 6041.395860413923, 6052.697365131814, 6083.391660834058, 5633.295838020247, 5742.109972954198, 5783.392743761844, 5786.94213057864, 5822.272215973004], "value": 5604.468960667425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.4810614765153, 635.440812085365, 645.6416688737754, 646.6928209100678, 661.7088481068332, 35136.12159696009, 35659.643403565955, 35721.0, 35733.99999999997, 45407.54592454075, 48138.27792583114, 48168.0, 48385.51614483854, 48511.27233091507, 48537.757311213485, 9124.543772811367, 9261.120193581599, 9273.397229180115, 9286.674966376178, 9297.30270229732, 8533.061363250037, 9086.409383390092, 11051.72370690731, 11320.150988675841, 11321.377324247163, 11066.557337706483, 11125.944370278137, 11159.497822597961, 11194.66416007521, 11212.887871121307, 8553.74338769838, 11048.668539943774, 11134.554617815278, 11136.832947505794, 11154.386508742016, 10585.100266477359, 10944.069754070913, 10944.124470042378, 11228.66314010581, 11237.83143252852, 43972.56027439717, 44376.77811610921, 44429.0, 44493.777531112464, 44605.553944460786, 3705.814709264526, 3956.090099277182, 4108.095247536539, 4167.5207351154395, 4468.19572476954, 34575.4813677795, 34651.653483465096, 34916.0, 35031.29937401238, 36232.0, 4697.906041879178, 4708.293755936603, 4722.031983443386, 4724.314974328703, 4761.285807128924, 374978.0, 377529.0, 380189.0, 380338.0, 381937.0, 37376.813115934245, 39150.41274380887, 63444.682776585825, 64246.35753642404, 64252.35747642464, 40942.59057409447, 41118.177636447705, 41166.38250426246, 41201.1759764803, 41202.1759564807, 16583.087930163714, 16642.3343066276, 16666.083365414775, 16680.666386672197, 16683.416080437128, 12567.120301578985, 13911.721765564633, 14218.715625687635, 14330.0, 14331.355089021019, 9132.863007054899, 9273.860892086625, 9278.350515463988, 9281.257499400032, 9366.90633093674, 3517.120719820045, 3565.144365352297, 3571.5892672342493, 3598.712103031751, 3601.747877648592, 1058.3808472043786, 1133.4955944604737, 1162.2968104296947, 1168.5092261250295, 1254.680056585583, 33024.4894085681, 34214.48678269828, 34554.82722586371, 34787.826060869535, 34796.13009674779, 1195.2469943935266, 1201.4653479201672, 1226.6381417481687, 1262.6275248801626, 1342.8321459817523, 17995.550111247325, 18027.54931126706, 18142.727859082126, 18258.726119108225, 18270.725939110926, 595015.0, 601519.0, 601897.0, 602244.0, 602375.0, 63518.682406588596, 65013.67493162599, 65257.67371163114, 65323.67338163374, 65404.672976634814, 1359.429039803285, 1397.5178563395816, 1406.5288128477075, 1488.5162322245314, 1489.359575382596, 26741.19776406711, 33126.503102453964, 34179.0, 36405.45391819178, 36427.0, 58416.123758142814, 59032.70483647554, 59052.0, 59064.40935590589, 59114.40885591089, 450726.0, 455807.0, 455822.0, 456127.0, 457518.0, 25708.971641134147, 26689.466210675288, 27894.442111157256, 29800.701992979793, 30205.395892082473, 45703.542964569926, 50040.0, 51164.74417627888, 52353.47646523638, 53594.0, 43007.354889676055, 43306.78346608247, 43823.78088109667, 43885.66516226009, 44971.550284496734, 42548.510802121775, 43327.78336108299, 43355.78322108369, 43983.12033759243, 44004.0, 43122.568774311854, 44022.11955760803, 44105.55894441014, 44314.556854431044, 44319.0, 37287.6271237295, 39230.41154382744, 39338.0, 39416.80291598524, 40022.799886000386, 29178.70821291845, 29261.561076584294, 29509.0, 29687.703122969357, 29768.85115574495], "value": 20501.741483383426, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.84381622615854, 434.55458155390727, 436.95630436956327, 441.8983633764234, 452.10483243178527, 19253.518662033457, 20302.796972030294, 20937.057832397542, 20960.16159353628, 21299.0, 18396.81603183971, 19314.806851931477, 19626.214951401962, 19634.70547941782, 19661.0, 5829.0964900440395, 6040.426159514839, 6074.514038876901, 6076.817695469143, 6077.969610151943, 5936.5250779937505, 5956.076808094752, 5971.641701497924, 5973.044312909935, 5974.940250597504, 5912.0, 5914.585978981473, 5929.466348028676, 5933.614315069528, 5950.226470558821, 5835.212246346752, 5893.823185304448, 5904.586678932476, 5939.435753603422, 5946.43508866657, 5176.663516871391, 5178.197379406198, 5348.946510534923, 5369.40936496985, 5370.946290537084, 24398.39004024896, 24528.632070518957, 24713.876430617733, 24725.258242252763, 24790.25629231126, 2671.252049426164, 2694.878730457134, 2715.1040156748227, 2787.7491025807776, 3024.500957342036, 14311.499097531536, 14997.775033374508, 15084.321205545777, 15262.08427494354, 15597.0, 2041.2549419461789, 2106.631339515594, 2123.0764617391483, 2149.8387620928493, 2216.2575537195057, 74208.0, 76638.23361766366, 77433.61283193604, 78337.0, 91855.54072229663, 9633.229341652652, 10171.54228059739, 10285.485725713685, 10653.733656658645, 10786.514606842711, 14632.341544630517, 14705.191214483306, 14744.63138421548, 14789.334479948428, 14830.33263503145, 8342.207490288412, 8488.278496327881, 8494.447860889022, 8575.32781107678, 8590.699325523701, 8388.28699560532, 8404.78988025292, 8428.662853485792, 8555.443896146731, 8560.0583935767, 4437.245668236407, 4485.259932111165, 4488.977555112204, 4524.6832721709825, 4552.886177845514, 2039.8266147377342, 2049.313479984222, 2053.9281125160846, 2075.968860467094, 2159.6544552871464, 1021.0657248617432, 1029.3206483720708, 1069.2622090757352, 1071.5767271927546, 1079.7840431913648, 19873.30443434473, 20192.59614807725, 20381.184752610025, 20510.0, 20560.897195513928, 1064.2816099133054, 1066.4347895615335, 1101.2731597145846, 1122.7473818390797, 1130.1015692524463, 10924.726881827859, 11502.252353597156, 11504.309741415542, 11576.594819181288, 11637.709057273467, 376884.0, 488377.0, 491288.0, 493990.0, 497260.0, 101163.15655418004, 102890.0, 103102.48448757858, 103152.48423757983, 103255.48372258242, 1111.5942680921405, 1127.6786115957077, 1135.863696356426, 1140.8459857919074, 1151.5221183209042, 18506.537336566693, 18598.2560697576, 18634.906825465787, 18648.0, 19001.524961876064, 43638.78180609077, 45082.0, 45475.31787023263, 45783.54216457926, 45866.541334587564, 61792.0, 62385.376146237955, 62589.0, 62704.0, 63296.683516582125, 12445.62663120108, 12963.675908102374, 13122.868771312165, 13276.933615332247, 13338.799918001432, 13147.408366623333, 13502.392392342565, 13521.391537380645, 13674.93162534181, 13733.45066197381, 12148.514059437524, 12312.938435307766, 12462.875371246171, 12503.87496125027, 12827.358632068546, 11712.004479618987, 11757.470913808727, 11827.994620457357, 11836.822447663464, 12035.277883327028, 12111.576094836639, 12244.510219591117, 12356.505739770308, 12497.93751031239, 12733.87266127364, 12437.253764774143, 12583.245005299712, 12764.61706148817, 12773.169743966613, 12859.869492660317, 12137.21108127969, 12164.817527736914, 12344.343251358448, 12384.195027323196, 12567.49730010826], "value": 9941.225107227741, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.324651051219, 1583.778271042054, 1590.1174847959383, 1820.3810704360515, 1941.844652427805, 9255.444673319596, 9711.902880971189, 9719.70840874774, 9976.551055202515, 9993.700188994324, 9620.326577139604, 9791.11879930806, 9819.361741486799, 9825.410475371482, 9836.0, 2087.822535084512, 2339.1695947938492, 2345.507443436876, 2371.762823717632, 2445.7187423446267, 2470.0243403855466, 2470.8270421070533, 2472.5549401107883, 2482.2677310193444, 2483.937901552458, 2378.714554253492, 2441.7802397784194, 2442.9755702443013, 2448.3634255093716, 2449.363165576945, 2092.393205970267, 2306.5041016181603, 2368.5026144509675, 2382.2614989353356, 2386.618141097416, 2408.301592538162, 2427.5630386530415, 2428.890699918508, 2430.9513809723708, 2436.4030812451065, 9606.087421694998, 9681.08029737181, 9686.176674982635, 9702.27232957524, 9718.222542196678, 5313.38896026958, 5437.483439073281, 5447.210154527571, 5454.209139674725, 5462.5083742462975, 3476.0, 3539.203679172191, 3611.4402267648557, 3611.94582081269, 3629.8548058077645, 1146.5184622458587, 1151.6851129230224, 1182.4206138991833, 1202.7173614200656, 1281.8461784585816, 13944.442222311096, 13986.999999999898, 14032.579022629337, 14042.297885105703, 14061.718765624733, 4816.8554943351755, 4916.090523253138, 4937.382827146606, 4993.226049962189, 5002.249662550574, 11527.077833773277, 11571.594994175164, 11599.188056836108, 11601.767964640829, 11602.709932251593, 5514.448555144453, 5522.282103326542, 5531.253280807039, 5531.474509921551, 5533.280673512498, 4504.234280172379, 5046.873828154252, 5215.947840521546, 5217.921731174036, 5318.867028324245, 4331.891702707395, 4334.674899382559, 4360.106178233455, 4387.780610969438, 4394.934075988863, 1324.2187109605186, 1329.222404893129, 1348.8786009259213, 1372.876441120304, 1375.2711063136553, 951.1059603972244, 991.5637119667323, 1004.5027711282816, 1012.9898701013043, 1016.4460369098858, 5946.226990491295, 5999.070144127667, 6012.458878700938, 6018.729157187937, 6153.0, 475.60049558371134, 476.1833455623622, 484.1648156929269, 494.06868053719, 495.2373345048585, 3673.3204357194004, 3811.4663947047434, 3840.327942610032, 3853.075261937115, 3912.080661044652, 11737.237079589799, 12187.329696866758, 12204.75590488203, 12213.145079844326, 12232.81650775239, 12031.639050828315, 12052.457639406248, 12062.276263424223, 12069.939650301692, 12070.577529786415, 8542.402031857835, 8620.870686939701, 8695.956520217358, 8718.47689138641, 8752.0, 5875.559333050124, 5906.881862362815, 5912.083627037816, 5980.132880732356, 5981.371955944737, 10922.453877306261, 11099.167562433011, 11147.944260278648, 11261.26801757916, 11275.605353812578, 11002.174836887105, 11179.72050698739, 11524.078073753912, 11654.067674586182, 11660.242084264495, 7760.417968652261, 8517.403781735218, 8688.218060374596, 8824.3381746368, 9216.723498295061, 9269.629214831331, 9509.476978766234, 9566.952165239129, 9606.951965240129, 9615.855762163434, 7846.372290216883, 8058.234467725557, 8422.073571906963, 8615.827683446421, 8890.688825891062, 7803.570803605856, 7828.373730101692, 7892.723754668559, 8004.079530854026, 8237.0, 7678.424118191047, 7721.729739459092, 7745.0, 7746.380289576708, 7748.612569371621, 5508.44915508446, 5508.44915508446, 5531.253280807039, 5584.525315348241, 5762.7694892203845, 5304.071787437106, 5312.043832110257, 5520.972395137998, 5530.11518157109, 5726.141078838207], "value": 4852.910082928622, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.6729441619294, 353.906214853064, 363.96724294813464, 364.1933118143313, 366.84959166741606, 5365.356157261134, 5527.613067085295, 5568.192612071247, 5647.887042259153, 5677.744501497427, 5328.893422131555, 5474.178873169027, 5496.31296087989, 5508.44915508449, 5547.972260138694, 4327.1345730853955, 4328.588784065509, 4344.4786625604975, 4363.912721745563, 4368.29636441788, 4110.917781644365, 4194.727342722728, 4321.395004699345, 4346.913061738764, 4360.825566977317, 4313.2020576193345, 4314.007778211013, 4320.638998715411, 4333.328334108218, 4345.130973805236, 4290.141971605692, 4315.287977483743, 4326.372675961984, 4340.240457919867, 4343.73937563744, 3783.9054023649355, 3867.7679339239453, 3888.3972984187494, 3913.2760439318818, 3913.62820532049, 5281.603879708999, 5305.973470132663, 5311.5750739941095, 5312.7155323211, 5357.7765227430955, 4974.975125124387, 4975.751212439363, 4984.950150498485, 4990.525900039527, 5021.974890125526, 5554.91667624986, 5714.971425142848, 5745.138229265602, 5758.856028599276, 5825.213596164506, 4292.849750258726, 4313.590208930146, 4316.438862947797, 4337.154254920292, 4338.3058710606465, 5983.611065280743, 6017.398260173992, 6041.577089603729, 6057.636541807506, 6111.327753947062, 4313.331433627793, 4352.847650332224, 4372.256716358227, 4399.296112621965, 4418.293073108352, 4448.421705178306, 4450.1767173073085, 4458.5987261146, 4473.261911784519, 4486.551344865487, 4983.8504844854715, 4985.105659849234, 5013.623978201649, 5034.597232221414, 5052.898942021139, 5504.504594586507, 5764.0, 5776.422357764274, 5789.8263052108505, 5826.126081087786, 1446.6961937992928, 1505.224809223251, 1524.367387534183, 1524.9847501524844, 1537.715522628295, 993.7167907146429, 1006.5822683586376, 1022.9590816367411, 1028.018242578336, 1039.9376037437778, 5075.7969681212335, 5092.9745351273, 5104.846854594368, 5106.591472682177, 5131.846044618667, 5207.505286997729, 5223.623251420595, 5244.554212891947, 5248.343957005374, 5271.2868317796865, 5000.349954505891, 5010.22341537055, 5028.64799464034, 5197.324347834833, 5673.744681489343, 3147.653758086609, 3154.3533575616943, 3157.289609837814, 3168.334649723538, 3185.3629274145264, 6045.909311360333, 6143.877122457526, 6180.598261113013, 6226.688665566703, 6252.718627661675, 5905.970470147622, 6064.968235641021, 6071.362506936708, 6073.271207455134, 6095.238095238095, 6149.292831324366, 6169.383061693795, 6173.444390004921, 6181.660008699385, 6188.586451284003, 5685.886282274414, 5945.286565612154, 5958.1658567801405, 5998.940010599838, 6024.668643224665, 5902.0, 5920.79277225295, 5927.814437112508, 5943.4844114752195, 5968.641881487125, 6014.8195554133445, 6226.097215903759, 6227.813165605039, 6245.250569931455, 6259.374062593886, 4241.151769646021, 4245.57544245573, 4245.639120674778, 4253.6384407324485, 4265.189613973459, 5753.877993791338, 5837.153612726046, 5972.940270597239, 5979.342272349951, 5989.550783691154, 5713.514351280021, 5755.3381361144, 5767.5674324425, 5769.884602308014, 5805.390434004537, 5661.830145095653, 5750.281214848144, 5750.856228594152, 5778.479936805707, 5784.971075144597, 5562.777488900399, 5721.942780572307, 5750.856228594319, 5754.187430959234, 5760.395158508296, 5828.6502809831545, 5856.238688970407, 5857.7698683276985, 5868.471837534642, 5877.265341832271, 5469.535089517435, 5616.887662246814, 5642.689652069012, 5648.4633959773755, 5750.338711048283], "value": 4420.427704640525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.6273319240591, 781.4412694923129, 810.6068556749976, 813.479373201151, 823.2056065896409, 15559.92220038901, 16110.436134735286, 16111.355545778184, 16409.671806563863, 16438.34246630135, 15539.300731467083, 15623.531294061168, 15643.06141631503, 15644.608884777886, 15662.295196716146, 716.451914285572, 842.1999100854182, 866.7963028688238, 876.2726936642604, 885.3359980014989, 845.5856630251163, 848.1603212819326, 849.2272032450471, 851.6721062390963, 852.6291063387415, 872.9301655867547, 872.9476231426135, 873.1748497669705, 875.3303722652176, 875.3391189651804, 749.9250074992511, 770.0259172147238, 858.8539948208758, 881.9867701984475, 893.0712059458156, 657.8026592022422, 658.2726087673148, 659.2715049869872, 659.3472462262374, 659.4526542969325, 15533.068015919082, 15560.766588501181, 15606.843931560652, 15612.687746245125, 15628.531144065697, 13805.102668326626, 13998.30008499571, 14064.367103480368, 14105.2242126683, 14184.858151418457, 13892.23592702401, 13912.58262252134, 14086.92956535221, 14340.56978290653, 14380.209088500129, 4567.703099298568, 4650.674452788307, 4670.439547254351, 4704.670673052888, 4725.173094708447, 77709.61145194294, 79470.60264698697, 79605.0, 79657.0, 80663.5966820168, 12080.0, 12156.149069565223, 12192.756144877052, 12560.497580096877, 12804.10371274002, 23078.8846055772, 23086.538269234523, 23088.0, 23097.307080787603, 23101.422464438187, 8574.785630359167, 8634.481931084156, 8759.956200219085, 8898.86651700225, 8915.28677705782, 4515.254982927846, 4689.695169814019, 4736.502667219961, 4791.928121078117, 4814.542618451242, 3378.1048022274117, 3454.170998960282, 3458.948115778265, 3464.272502774395, 3471.340445315382, 576.4523702482575, 648.970796314167, 650.8080116365684, 666.4834753066316, 677.518961537314, 734.5335711822923, 741.4883730226127, 770.7302444144617, 781.2890269854405, 781.839722856813, 10963.83554246687, 10991.19724470271, 11109.0, 11343.716407089723, 11381.0, 625.4464798653224, 709.2588245283691, 731.3856360657073, 792.1007480951505, 831.2061980808313, 4984.2025275955675, 5073.7716802743225, 5174.779809875541, 5270.578353731692, 5326.733663316819, 92524.53737731268, 95355.52322238345, 102813.0, 115865.0, 120092.39953800174, 69308.3069169312, 76873.0, 99553.50223248982, 100494.0, 100589.49705251573, 90022.54988725015, 90352.0, 90836.5458172718, 90994.0, 92485.5375723117, 10321.277510574488, 10502.07644294152, 10575.15398768112, 10685.19861010443, 10771.676849694522, 50036.0, 50102.49897501124, 50730.74634626803, 50771.0, 52199.47800521946, 69201.65399173173, 75902.86145707709, 76969.61515192388, 77919.61040194989, 79245.20754792608, 14186.645333866323, 14327.57017289483, 14339.78490322667, 14376.928115359357, 14744.705105898036, 15888.2055897207, 16098.356065757707, 16961.0, 17596.208170632097, 17672.55818604545, 15142.394304227708, 15219.239038047832, 15343.23283835826, 15395.923020384826, 16612.667746645242, 13716.245606491739, 13821.585352439442, 14149.787753183504, 14563.708725825636, 15081.54755357341, 14738.926305368404, 15488.225588720294, 15540.922295388451, 15552.0, 16052.598685032968, 11991.76016479648, 12400.503979840705, 12715.908527208545, 12880.355982200665, 12965.120057591408, 12541.74916501683, 12828.615141545768, 12929.353532323157, 13217.40521676546, 13291.268980206181], "value": 7992.224779208524, "unit": "score"}], "name": "dromaeo_css", "value": 7620.620028948483, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 135.0, 177.0, 130.0, 125.0, 137.0, 149.0, 174.0, 124.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 119.0, 74.0, 75.0, 76.0, 75.0, 106.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 110.0, 86.0, 86.0, 85.0, 111.0, 84.0, 84.0, 131.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 51.0, 55.0, 51.0, 52.0, 51.0, 50.0, 50.0, 50.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 60.0, 61.0, 60.0, 60.0, 60.0, 59.0, 61.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 77.0, 75.0, 77.0, 78.0, 77.0, 78.0, 120.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 125.0, 117.0, 114.0, 125.0, 118.0, 129.0, 128.0], "value": 120.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 156.0, 161.0, 153.0, 154.0, 160.0, 155.0, 156.0, 155.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 62.0, 64.0, 61.0, 63.0, 60.0, 61.0, 60.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1480.1, "alertThreshold": 2.0}]} 10:52:27 INFO - Return code: 0 10:52:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:52:27 ERROR - # TBPL SUCCESS # 10:52:27 INFO - Running post-action listener: _resource_record_post_action 10:52:27 INFO - ##### 10:52:27 INFO - ##### Finished run-tests step (success) 10:52:27 INFO - ##### 10:52:27 INFO - Running post-run listener: _resource_record_post_run 10:52:27 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507850752; Read time: 12; Write time: 397956 10:52:27 INFO - TinderboxPrint: CPU usage
13.1% 10:52:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:52:27 INFO - TinderboxPrint: I/O write bytes / time
507,850,752 / 397,956 10:52:27 INFO - TinderboxPrint: CPU idle
8,248.9 (86.9%) 10:52:27 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 10:52:27 INFO - TinderboxPrint: Swap in / out
0 / 0 10:52:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 217178112; Read time: 0; Write time: 216592 10:52:27 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254693376; Read time: 12; Write time: 172372 10:52:27 INFO - Running post-run listener: _upload_blobber_files 10:52:27 INFO - Blob upload gear active. 10:52:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:52:27 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:52:27 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:52:27 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:52:28 INFO - (blobuploader) - INFO - Open directory for files ... 10:52:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:52:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:52:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:32 INFO - (blobuploader) - INFO - Done attempting. 10:52:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:52:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:52:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:33 INFO - (blobuploader) - INFO - Done attempting. 10:52:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:52:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:52:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:33 INFO - (blobuploader) - INFO - Done attempting. 10:52:33 INFO - (blobuploader) - INFO - Iteration through files over. 10:52:33 INFO - Return code: 0 10:52:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:52:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:52:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf29a5195b4fd369d15dc256ae92be0740123c482094898548b551ede78538dc9f6dc6d885f6b7d29d043fc364f6a9e5c684458e3a94c8b39ddb7e87d38f7b9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/233d384ebab62814fedcebf3a600414649b5a0b6cd05a077045047e97ba04c66b7fb3ad12a6332ee4c2a1e32fcacc1320b6f2bb7837670f6f5a8f54a6cca7add", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc85bb2af526a351c2bff3c4e9655ca8c8eae39183bef6c4719f86fab4df2df2a55f94b07631f1a137ac64ad7d66ff418a4da15f75cf288454c13e797f52559a"} 10:52:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:52:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:52:33 INFO - Contents: 10:52:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf29a5195b4fd369d15dc256ae92be0740123c482094898548b551ede78538dc9f6dc6d885f6b7d29d043fc364f6a9e5c684458e3a94c8b39ddb7e87d38f7b9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/233d384ebab62814fedcebf3a600414649b5a0b6cd05a077045047e97ba04c66b7fb3ad12a6332ee4c2a1e32fcacc1320b6f2bb7837670f6f5a8f54a6cca7add", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc85bb2af526a351c2bff3c4e9655ca8c8eae39183bef6c4719f86fab4df2df2a55f94b07631f1a137ac64ad7d66ff418a4da15f75cf288454c13e797f52559a"} 10:52:33 INFO - Running post-run listener: copy_logs_to_upload_dir 10:52:33 INFO - Copying logs to upload dir... 10:52:33 INFO - mkdir: /builds/slave/test/build/upload/logs 10:52:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.924889 ========= master_lag: 0.82 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-28 10:52:34.278273) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:52:34.281647) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418 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/cf29a5195b4fd369d15dc256ae92be0740123c482094898548b551ede78538dc9f6dc6d885f6b7d29d043fc364f6a9e5c684458e3a94c8b39ddb7e87d38f7b9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/233d384ebab62814fedcebf3a600414649b5a0b6cd05a077045047e97ba04c66b7fb3ad12a6332ee4c2a1e32fcacc1320b6f2bb7837670f6f5a8f54a6cca7add", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc85bb2af526a351c2bff3c4e9655ca8c8eae39183bef6c4719f86fab4df2df2a55f94b07631f1a137ac64ad7d66ff418a4da15f75cf288454c13e797f52559a"} build_url:https://queue.taskcluster.net/v1/task/fafIa-TZRraqkgNUYhdqRQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/fafIa-TZRraqkgNUYhdqRQ/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/cf29a5195b4fd369d15dc256ae92be0740123c482094898548b551ede78538dc9f6dc6d885f6b7d29d043fc364f6a9e5c684458e3a94c8b39ddb7e87d38f7b9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/233d384ebab62814fedcebf3a600414649b5a0b6cd05a077045047e97ba04c66b7fb3ad12a6332ee4c2a1e32fcacc1320b6f2bb7837670f6f5a8f54a6cca7add", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc85bb2af526a351c2bff3c4e9655ca8c8eae39183bef6c4719f86fab4df2df2a55f94b07631f1a137ac64ad7d66ff418a4da15f75cf288454c13e797f52559a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:52:34.314728) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:52:34.315129) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467135117.972919-1979982418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.41 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:52:34.725856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:52:34.726182) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:52:34.726598) ========= ========= Total master_lag: 1.32 =========