builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1470075854.68 results: success (0) buildid: 20160801070053 builduid: eaf10adbc6074edb9e3b1e3d32dab73b revision: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.679593) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.680019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.680297) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.780782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.781051) ========= 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=337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 11:24:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.5M=0s 2016-08-01 11:24:15 (88.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093033 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.893732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.897044) ========= 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=337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017386 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.946264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 11:24:14.946612) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 --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-beta --rev bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 --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=337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 11:24:15,667 truncating revision to first 12 chars 2016-08-01 11:24:15,667 Setting DEBUG logging. 2016-08-01 11:24:15,667 attempt 1/10 2016-08-01 11:24:15,667 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bad9d4f5bf7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 11:24:16,597 unpacking tar archive at: mozilla-beta-bad9d4f5bf7e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.247486 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 11:24:16.210532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:16.210832) ========= script_repo_revision: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:16.211240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:16.211517) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:16.218983) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-01 11:24:16.219248) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:17 INFO - MultiFileLogger online at 20160801 11:24:17 in /builds/slave/test 11:24:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:24:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:17 INFO - {'append_to_log': False, 11:24:17 INFO - 'base_work_dir': '/builds/slave/test', 11:24:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:24:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:17 INFO - 'branch': 'Mozilla-Beta', 11:24:17 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:17 INFO - 'config_files': ('talos/linux_config.py',), 11:24:17 INFO - 'default_actions': ('clobber', 11:24:17 INFO - 'read-buildbot-config', 11:24:17 INFO - 'download-and-extract', 11:24:17 INFO - 'populate-webroot', 11:24:17 INFO - 'create-virtualenv', 11:24:17 INFO - 'install', 11:24:17 INFO - 'run-tests'), 11:24:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:17 INFO - 'download_minidump_stackwalk': True, 11:24:17 INFO - 'download_symbols': 'ondemand', 11:24:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:17 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:17 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:17 INFO - 'installer_path': 'installer.exe', 11:24:17 INFO - 'log_level': 'info', 11:24:17 INFO - 'log_name': 'talos', 11:24:17 INFO - 'log_to_console': True, 11:24:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:17 INFO - 'opt_config_files': (), 11:24:17 INFO - 'pip_index': False, 11:24:17 INFO - 'sps_profile': False, 11:24:17 INFO - 'sps_profile_interval': 0, 11:24:17 INFO - 'suite': 'dromaeojs-e10s', 11:24:17 INFO - 'system_bits': '32', 11:24:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:17 INFO - 'title': 'talos-linux64-ix-060', 11:24:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:17 INFO - 'use_talos_json': True, 11:24:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:17 INFO - 'work_dir': 'build'} 11:24:17 INFO - ##### 11:24:17 INFO - ##### Running clobber step. 11:24:17 INFO - ##### 11:24:17 INFO - Running pre-action listener: _resource_record_pre_action 11:24:17 INFO - Running main action method: clobber 11:24:17 INFO - rmtree: /builds/slave/test/build 11:24:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:17 INFO - Running post-action listener: _resource_record_post_action 11:24:17 INFO - ##### 11:24:17 INFO - ##### Finished clobber step (success) 11:24:17 INFO - ##### 11:24:17 INFO - ##### 11:24:17 INFO - ##### Running read-buildbot-config step. 11:24:17 INFO - ##### 11:24:17 INFO - Running pre-action listener: _resource_record_pre_action 11:24:17 INFO - Running main action method: read_buildbot_config 11:24:17 INFO - Using buildbot properties: 11:24:17 INFO - { 11:24:17 INFO - "project": "", 11:24:17 INFO - "product": "firefox", 11:24:17 INFO - "script_repo_revision": "production", 11:24:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:24:17 INFO - "repository": "", 11:24:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 11:24:17 INFO - "buildid": "20160801070053", 11:24:17 INFO - "pgo_build": "True", 11:24:17 INFO - "basedir": "/builds/slave/test", 11:24:17 INFO - "buildnumber": 62, 11:24:17 INFO - "slavename": "talos-linux64-ix-060", 11:24:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:24:17 INFO - "platform": "ubuntu64_hw", 11:24:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:24:17 INFO - "branch": "mozilla-beta", 11:24:17 INFO - "repo_path": "releases/mozilla-beta", 11:24:17 INFO - "revision": "bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2", 11:24:17 INFO - "stage_platform": "linux64-pgo", 11:24:17 INFO - "builduid": "eaf10adbc6074edb9e3b1e3d32dab73b", 11:24:17 INFO - "slavebuilddir": "test" 11:24:17 INFO - } 11:24:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 11:24:17 INFO - Running post-action listener: _resource_record_post_action 11:24:17 INFO - ##### 11:24:17 INFO - ##### Finished read-buildbot-config step (success) 11:24:17 INFO - ##### 11:24:17 INFO - ##### 11:24:17 INFO - ##### Running download-and-extract step. 11:24:17 INFO - ##### 11:24:17 INFO - Running pre-action listener: _resource_record_pre_action 11:24:17 INFO - Running main action method: download_and_extract 11:24:17 INFO - mkdir: /builds/slave/test/build/tests 11:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:17 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:24:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:24:26 INFO - Downloaded 1327 bytes. 11:24:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:26 INFO - Using the following test package requirements: 11:24:26 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:26 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:26 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:24:26 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:26 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 11:24:26 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:26 INFO - u'jsshell-linux-x86_64.zip'], 11:24:26 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:26 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:24:26 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:26 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:26 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 11:24:26 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:26 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 11:24:26 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:26 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:24:26 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:26 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:24:26 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:26 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:29 INFO - Downloaded 21968684 bytes. 11:24:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:24:30 INFO - Return code: 0 11:24:30 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:24: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')]} 11:24:30 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:32 INFO - Downloaded 21968684 bytes. 11:24:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:24:34 INFO - Return code: 0 11:24: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')]} 11:24:34 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:24:35 INFO - Downloaded 10833369 bytes. 11:24:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:24:35 INFO - Return code: 0 11:24:35 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')]} 11:24:35 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:24:36 INFO - Downloaded 55264299 bytes. 11:24:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:36 INFO - mkdir: /builds/slave/test/properties 11:24:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:36 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:36 INFO - Contents: 11:24:36 INFO - build_url:https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:37 INFO - Running post-action listener: _resource_record_post_action 11:24:37 INFO - Running post-action listener: set_extra_try_arguments 11:24:37 INFO - ##### 11:24:37 INFO - ##### Finished download-and-extract step (success) 11:24:37 INFO - ##### 11:24:37 INFO - ##### 11:24:37 INFO - ##### Running populate-webroot step. 11:24:37 INFO - ##### 11:24:37 INFO - Running pre-action listener: _resource_record_pre_action 11:24:37 INFO - Running main action method: populate_webroot 11:24:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:37 INFO - '--tppagecycles', 11:24:37 INFO - '7'], 11:24:37 INFO - 'tests': ['tsvgm']}}, 11:24:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:37 INFO - 'talos_options': ['--disable-e10s'], 11:24:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:37 INFO - 'talos_options': ['--disable-e10s'], 11:24:37 INFO - 'tests': ['damp', 'tps']}, 11:24:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:37 INFO - 'tests': ['damp', 'tps']}, 11:24:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:37 INFO - 'tests': ['dromaeo_dom']}, 11:24:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:37 INFO - 'tests': ['a11yr', 11:24:37 INFO - 'ts_paint', 11:24:37 INFO - 'tpaint', 11:24:37 INFO - 'sessionrestore', 11:24:37 INFO - 'sessionrestore_no_auto_restore', 11:24:37 INFO - 'tabpaint']}, 11:24:37 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:37 INFO - 'ts_paint', 11:24:37 INFO - 'tpaint', 11:24:37 INFO - 'sessionrestore', 11:24:37 INFO - 'sessionrestore_no_auto_restore', 11:24:37 INFO - 'tabpaint']}, 11:24:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:37 INFO - 'ts_paint', 11:24:37 INFO - 'tpaint', 11:24:37 INFO - 'sessionrestore', 11:24:37 INFO - 'sessionrestore_no_auto_restore', 11:24:37 INFO - 'tabpaint']}, 11:24:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:37 INFO - 'ts_paint', 11:24:37 INFO - 'tpaint', 11:24:37 INFO - 'sessionrestore', 11:24:37 INFO - 'sessionrestore_no_auto_restore', 11:24:37 INFO - 'tabpaint']}, 11:24:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:37 INFO - 'tests': ['a11yr', 11:24:37 INFO - 'ts_paint', 11:24:37 INFO - 'tpaint', 11:24:37 INFO - 'sessionrestore', 11:24:37 INFO - 'sessionrestore_no_auto_restore', 11:24:37 INFO - 'tabpaint']}, 11:24:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:37 INFO - 'tests': ['a11yr', 11:24:37 INFO - 'ts_paint', 11:24:37 INFO - 'tpaint', 11:24:37 INFO - 'sessionrestore', 11:24:37 INFO - 'sessionrestore_no_auto_restore', 11:24:37 INFO - 'tabpaint']}, 11:24:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:37 INFO - 'tests': ['tsvgx', 11:24:37 INFO - 'tsvgr_opacity', 11:24:37 INFO - 'tart', 11:24:37 INFO - 'tscrollx', 11:24:37 INFO - 'cart']}, 11:24:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:37 INFO - 'tsvgr_opacity', 11:24:37 INFO - 'tart', 11:24:37 INFO - 'tscrollx', 11:24:37 INFO - 'cart']}, 11:24:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:37 INFO - 'talos_options': ['--disable-e10s'], 11:24:37 INFO - 'tests': ['tp5o']}, 11:24:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:37 INFO - 'tests': ['tp5o']}, 11:24:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:37 INFO - 'talos_options': ['--disable-e10s', 11:24:37 INFO - '--xperf_path', 11:24:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:37 INFO - 'tests': ['tp5n']}, 11:24:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:37 INFO - 'talos_options': ['--xperf_path', 11:24:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:37 INFO - 'tests': ['tp5n']}}, 11:24:37 INFO - 'talos.zip': {'path': '', 11:24:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:37 INFO - Running post-action listener: _resource_record_post_action 11:24:37 INFO - ##### 11:24:37 INFO - ##### Finished populate-webroot step (success) 11:24:37 INFO - ##### 11:24:37 INFO - ##### 11:24:37 INFO - ##### Running create-virtualenv step. 11:24:37 INFO - ##### 11:24:37 INFO - Running pre-action listener: _resource_record_pre_action 11:24:37 INFO - Running main action method: create_virtualenv 11:24:37 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:37 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 11:24:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:37 INFO - Using real prefix '/usr' 11:24:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:38 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:40 INFO - Installing pip.................done. 11:24:40 INFO - Return code: 0 11:24:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:40 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')]} 11:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:40 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')]} 11:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:40 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 0x7fde4efe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17262e0>, '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 0x1692140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16925d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', '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 11:24:40 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 11:24:40 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 11:24:40 INFO - Using env: {'DISPLAY': ':0', 11:24:40 INFO - 'HOME': '/home/cltbld', 11:24:40 INFO - 'LANG': 'en_US.UTF-8', 11:24:40 INFO - 'LANGUAGE': 'en_US:en', 11:24:40 INFO - 'LOGNAME': 'cltbld', 11:24:40 INFO - 'MAIL': '/var/mail/cltbld', 11:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:40 INFO - 'MOZ_NO_REMOTE': '1', 11:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:40 INFO - 'NO_EM_RESTART': '1', 11:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:40 INFO - 'PWD': '/builds/slave/test', 11:24:40 INFO - 'SHELL': '/bin/bash', 11:24:40 INFO - 'SHLVL': '1', 11:24:40 INFO - 'TERM': 'linux', 11:24:40 INFO - 'TMOUT': '86400', 11:24:40 INFO - 'USER': 'cltbld', 11:24:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', 11:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:40 INFO - '_': '/tools/buildbot/bin/python'} 11:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:40 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 11:24:40 INFO - Cleaning up... 11:24:40 INFO - Return code: 0 11:24:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:40 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')]} 11:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:40 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')]} 11:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:40 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 0x7fde4efe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17262e0>, '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 0x1692140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16925d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', '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 11:24:40 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 11:24:40 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 11:24:40 INFO - Using env: {'DISPLAY': ':0', 11:24:40 INFO - 'HOME': '/home/cltbld', 11:24:40 INFO - 'LANG': 'en_US.UTF-8', 11:24:40 INFO - 'LANGUAGE': 'en_US:en', 11:24:40 INFO - 'LOGNAME': 'cltbld', 11:24:40 INFO - 'MAIL': '/var/mail/cltbld', 11:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:40 INFO - 'MOZ_NO_REMOTE': '1', 11:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:40 INFO - 'NO_EM_RESTART': '1', 11:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:40 INFO - 'PWD': '/builds/slave/test', 11:24:40 INFO - 'SHELL': '/bin/bash', 11:24:40 INFO - 'SHLVL': '1', 11:24:40 INFO - 'TERM': 'linux', 11:24:40 INFO - 'TMOUT': '86400', 11:24:40 INFO - 'USER': 'cltbld', 11:24:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', 11:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:40 INFO - '_': '/tools/buildbot/bin/python'} 11:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:40 INFO - Downloading/unpacking psutil>=3.1.1 11:24:40 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 11:24:40 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 11:24:40 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 11:24:40 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 11:24:40 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 11:24:40 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 11:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:42 INFO - Installing collected packages: psutil 11:24:42 INFO - Running setup.py install for psutil 11:24:42 INFO - building 'psutil._psutil_linux' extension 11:24:42 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 11:24:42 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 11:24:42 INFO - building 'psutil._psutil_posix' extension 11:24:42 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 11:24:43 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 11:24:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:43 INFO - Successfully installed psutil 11:24:43 INFO - Cleaning up... 11:24:43 INFO - Return code: 0 11:24:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:43 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 0x7fde4efe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17262e0>, '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 0x1692140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16925d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', '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 11:24:43 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 11:24:43 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 11:24:43 INFO - Using env: {'DISPLAY': ':0', 11:24:43 INFO - 'HOME': '/home/cltbld', 11:24:43 INFO - 'LANG': 'en_US.UTF-8', 11:24:43 INFO - 'LANGUAGE': 'en_US:en', 11:24:43 INFO - 'LOGNAME': 'cltbld', 11:24:43 INFO - 'MAIL': '/var/mail/cltbld', 11:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:43 INFO - 'MOZ_NO_REMOTE': '1', 11:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:43 INFO - 'NO_EM_RESTART': '1', 11:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:43 INFO - 'PWD': '/builds/slave/test', 11:24:43 INFO - 'SHELL': '/bin/bash', 11:24:43 INFO - 'SHLVL': '1', 11:24:43 INFO - 'TERM': 'linux', 11:24:43 INFO - 'TMOUT': '86400', 11:24:43 INFO - 'USER': 'cltbld', 11:24:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', 11:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:43 INFO - '_': '/tools/buildbot/bin/python'} 11:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24:43 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 11:24:43 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 11:24:43 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 11:24:43 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 11:24:43 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 11:24:43 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 11:24:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:45 INFO - Installing collected packages: mozsystemmonitor 11:24:45 INFO - Running setup.py install for mozsystemmonitor 11:24:45 INFO - Successfully installed mozsystemmonitor 11:24:45 INFO - Cleaning up... 11:24:45 INFO - Return code: 0 11:24:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24:45 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')]} 11:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:45 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')]} 11:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:45 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 0x7fde4efe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17262e0>, '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 0x1692140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16925d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', '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 11:24:45 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 11:24:45 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 11:24:45 INFO - Using env: {'DISPLAY': ':0', 11:24:45 INFO - 'HOME': '/home/cltbld', 11:24:45 INFO - 'LANG': 'en_US.UTF-8', 11:24:45 INFO - 'LANGUAGE': 'en_US:en', 11:24:45 INFO - 'LOGNAME': 'cltbld', 11:24:45 INFO - 'MAIL': '/var/mail/cltbld', 11:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:45 INFO - 'MOZ_NO_REMOTE': '1', 11:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:45 INFO - 'NO_EM_RESTART': '1', 11:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:45 INFO - 'PWD': '/builds/slave/test', 11:24:45 INFO - 'SHELL': '/bin/bash', 11:24:45 INFO - 'SHLVL': '1', 11:24:45 INFO - 'TERM': 'linux', 11:24:45 INFO - 'TMOUT': '86400', 11:24:45 INFO - 'USER': 'cltbld', 11:24:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', 11:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:45 INFO - '_': '/tools/buildbot/bin/python'} 11:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:45 INFO - Downloading/unpacking jsonschema==2.5.1 11:24:45 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 11:24:45 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 11:24:45 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 11:24:45 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 11:24:45 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 11:24:45 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 11:24:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:47 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 11:24:47 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 11:24:47 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 11:24:47 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 11:24:47 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 11:24:47 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 11:24:47 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:47 INFO - warning: no files found matching '*.txt' 11:24:47 INFO - no previously-included directories found matching 'build' 11:24:47 INFO - no previously-included directories found matching 'dist' 11:24:47 INFO - no previously-included directories found matching '.git*' 11:24:47 INFO - Installing collected packages: jsonschema, functools32 11:24:47 INFO - Running setup.py install for functools32 11:24:47 INFO - warning: no files found matching '*.txt' 11:24:47 INFO - no previously-included directories found matching 'build' 11:24:47 INFO - no previously-included directories found matching 'dist' 11:24:47 INFO - no previously-included directories found matching '.git*' 11:24:47 INFO - Successfully installed jsonschema functools32 11:24:47 INFO - Cleaning up... 11:24:48 INFO - Return code: 0 11:24:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:48 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 0x7fde4efe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17262e0>, '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 0x1692140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16925d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', '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 11:24:48 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 11:24:48 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 11:24:48 INFO - Using env: {'DISPLAY': ':0', 11:24:48 INFO - 'HOME': '/home/cltbld', 11:24:48 INFO - 'LANG': 'en_US.UTF-8', 11:24:48 INFO - 'LANGUAGE': 'en_US:en', 11:24:48 INFO - 'LOGNAME': 'cltbld', 11:24:48 INFO - 'MAIL': '/var/mail/cltbld', 11:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:48 INFO - 'MOZ_NO_REMOTE': '1', 11:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:48 INFO - 'NO_EM_RESTART': '1', 11:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:48 INFO - 'PWD': '/builds/slave/test', 11:24:48 INFO - 'SHELL': '/bin/bash', 11:24:48 INFO - 'SHLVL': '1', 11:24:48 INFO - 'TERM': 'linux', 11:24:48 INFO - 'TMOUT': '86400', 11:24:48 INFO - 'USER': 'cltbld', 11:24:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', 11:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:48 INFO - '_': '/tools/buildbot/bin/python'} 11:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:48 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:48 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 11:24:48 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 11:24:48 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 11:24:48 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 11:24:48 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 11:24:48 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 11:24:50 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 INFO - Downloading docopt-0.6.1.tar.gz 11:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:50 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:50 INFO - Running setup.py install for blobuploader 11:24:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:51 INFO - Running setup.py install for requests 11:24:51 INFO - Running setup.py install for docopt 11:24:51 INFO - Successfully installed blobuploader requests docopt 11:24:51 INFO - Cleaning up... 11:24:51 INFO - Return code: 0 11:24:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:51 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')]} 11:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:51 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')]} 11:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:51 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 0x7fde4efe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17262e0>, '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 0x1692140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16925d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', '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 11:24:51 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 11:24:51 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 11:24:51 INFO - Using env: {'DISPLAY': ':0', 11:24:51 INFO - 'HOME': '/home/cltbld', 11:24:51 INFO - 'LANG': 'en_US.UTF-8', 11:24:51 INFO - 'LANGUAGE': 'en_US:en', 11:24:51 INFO - 'LOGNAME': 'cltbld', 11:24:51 INFO - 'MAIL': '/var/mail/cltbld', 11:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:51 INFO - 'MOZ_NO_REMOTE': '1', 11:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:51 INFO - 'NO_EM_RESTART': '1', 11:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:51 INFO - 'PWD': '/builds/slave/test', 11:24:51 INFO - 'SHELL': '/bin/bash', 11:24:51 INFO - 'SHLVL': '1', 11:24:51 INFO - 'TERM': 'linux', 11:24:51 INFO - 'TMOUT': '86400', 11:24:51 INFO - 'USER': 'cltbld', 11:24:51 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', 11:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:51 INFO - '_': '/tools/buildbot/bin/python'} 11:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:51 INFO - Running setup.py (path:/tmp/pip-tyudJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:51 INFO - Running setup.py (path:/tmp/pip-HHO2O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:51 INFO - Running setup.py (path:/tmp/pip-aE_KPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:51 INFO - Running setup.py (path:/tmp/pip-0iyIVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:52 INFO - Running setup.py (path:/tmp/pip-S6dvY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:52 INFO - Running setup.py (path:/tmp/pip-ZWQb68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:52 INFO - Running setup.py (path:/tmp/pip-rNJr3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:52 INFO - Running setup.py (path:/tmp/pip-rqSPCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:52 INFO - Running setup.py (path:/tmp/pip-i_jeyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:52 INFO - Running setup.py (path:/tmp/pip-MpTVP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:52 INFO - Running setup.py (path:/tmp/pip-Rn5IAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:52 INFO - Running setup.py (path:/tmp/pip-orxcu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:52 INFO - Running setup.py (path:/tmp/pip-GZbOmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:52 INFO - Running setup.py (path:/tmp/pip-i9eug7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:52 INFO - Running setup.py (path:/tmp/pip-Zp44G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:52 INFO - Running setup.py (path:/tmp/pip-geZS8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:52 INFO - Running setup.py (path:/tmp/pip-EEOpiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:52 INFO - Running setup.py install for manifestparser 11:24:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:53 INFO - Running setup.py install for mozcrash 11:24:53 INFO - Running setup.py install for mozdebug 11:24:53 INFO - Running setup.py install for mozdevice 11:24:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:53 INFO - Running setup.py install for mozfile 11:24:53 INFO - Running setup.py install for mozhttpd 11:24:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:53 INFO - Running setup.py install for mozinfo 11:24:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:53 INFO - Running setup.py install for mozInstall 11:24:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:53 INFO - Running setup.py install for mozleak 11:24:53 INFO - Running setup.py install for mozlog 11:24:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:53 INFO - Running setup.py install for moznetwork 11:24:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:54 INFO - Running setup.py install for mozprocess 11:24:54 INFO - Running setup.py install for mozprofile 11:24:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:54 INFO - Running setup.py install for mozrunner 11:24:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:54 INFO - Running setup.py install for mozscreenshot 11:24:54 INFO - Running setup.py install for moztest 11:24:54 INFO - Running setup.py install for mozversion 11:24:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:54 INFO - Cleaning up... 11:24:54 INFO - Return code: 0 11:24:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:54 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 0x7fde4efe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17262e0>, '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 0x1692140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16925d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', '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 11:24:54 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 11:24:54 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 11:24:54 INFO - Using env: {'DISPLAY': ':0', 11:24:54 INFO - 'HOME': '/home/cltbld', 11:24:54 INFO - 'LANG': 'en_US.UTF-8', 11:24:54 INFO - 'LANGUAGE': 'en_US:en', 11:24:54 INFO - 'LOGNAME': 'cltbld', 11:24:54 INFO - 'MAIL': '/var/mail/cltbld', 11:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:54 INFO - 'MOZ_NO_REMOTE': '1', 11:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:54 INFO - 'NO_EM_RESTART': '1', 11:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:54 INFO - 'PWD': '/builds/slave/test', 11:24:54 INFO - 'SHELL': '/bin/bash', 11:24:54 INFO - 'SHLVL': '1', 11:24:54 INFO - 'TERM': 'linux', 11:24:54 INFO - 'TMOUT': '86400', 11:24:54 INFO - 'USER': 'cltbld', 11:24:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', 11:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:54 INFO - '_': '/tools/buildbot/bin/python'} 11:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:54 INFO - Running setup.py (path:/tmp/pip-LbBefy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:55 INFO - Running setup.py (path:/tmp/pip-jcXp68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:55 INFO - Running setup.py (path:/tmp/pip-iDp2QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:55 INFO - Running setup.py (path:/tmp/pip-XQD5fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:55 INFO - Running setup.py (path:/tmp/pip-bwfK7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:55 INFO - Running setup.py (path:/tmp/pip-a8HxqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:55 INFO - Running setup.py (path:/tmp/pip-Dtuq0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:55 INFO - Running setup.py (path:/tmp/pip-lp98tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:55 INFO - Running setup.py (path:/tmp/pip-A4vd5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:55 INFO - Running setup.py (path:/tmp/pip-sKjlfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:55 INFO - Running setup.py (path:/tmp/pip-uEdHzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:55 INFO - Running setup.py (path:/tmp/pip-Ekgv5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:55 INFO - Running setup.py (path:/tmp/pip-p9Ltsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:55 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:55 INFO - Running setup.py (path:/tmp/pip-gqIN9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:55 INFO - Running setup.py (path:/tmp/pip-_Tz3z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:56 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)) 11:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:56 INFO - Running setup.py (path:/tmp/pip-nE7KlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:56 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)) 11:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:56 INFO - Running setup.py (path:/tmp/pip-tjR20W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:56 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)) 11:24:56 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)) 11:24:56 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)) 11:24:56 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)) 11:24:56 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)) 11:24:56 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)) 11:24:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 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 11:24:58 INFO - Downloading blessings-1.6.tar.gz 11:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:58 INFO - Installing collected packages: blessings 11:24:58 INFO - Running setup.py install for blessings 11:24:58 INFO - Successfully installed blessings 11:24:58 INFO - Cleaning up... 11:24:58 INFO - Return code: 0 11:24:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:58 INFO - Reading from file tmpfile_stdout 11:24:58 INFO - Current package versions: 11:24:58 INFO - argparse == 1.2.1 11:24:58 INFO - blessings == 1.6 11:24:58 INFO - blobuploader == 1.2.4 11:24:58 INFO - docopt == 0.6.1 11:24:58 INFO - functools32 == 3.2.3-2 11:24:58 INFO - jsonschema == 2.5.1 11:24:58 INFO - manifestparser == 1.1 11:24:58 INFO - mozInstall == 1.12 11:24:58 INFO - mozcrash == 0.17 11:24:58 INFO - mozdebug == 0.1 11:24:58 INFO - mozdevice == 0.48 11:24:58 INFO - mozfile == 1.2 11:24:58 INFO - mozhttpd == 0.7 11:24:58 INFO - mozinfo == 0.9 11:24:58 INFO - mozleak == 0.1 11:24:58 INFO - mozlog == 3.2 11:24:58 INFO - moznetwork == 0.27 11:24:58 INFO - mozprocess == 0.23 11:24:58 INFO - mozprofile == 0.28 11:24:58 INFO - mozrunner == 6.12 11:24:58 INFO - mozscreenshot == 0.1 11:24:58 INFO - mozsystemmonitor == 0.3 11:24:58 INFO - moztest == 0.7 11:24:58 INFO - mozversion == 1.4 11:24:58 INFO - psutil == 3.1.1 11:24:58 INFO - requests == 1.2.3 11:24:58 INFO - wsgiref == 0.1.2 11:24:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:58 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')]} 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:58 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')]} 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:58 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 0x7fde4efe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17262e0>, '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 0x1692140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16925d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', '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 11:24:58 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 11:24:58 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 11:24:58 INFO - Using env: {'DISPLAY': ':0', 11:24:58 INFO - 'HOME': '/home/cltbld', 11:24:58 INFO - 'LANG': 'en_US.UTF-8', 11:24:58 INFO - 'LANGUAGE': 'en_US:en', 11:24:58 INFO - 'LOGNAME': 'cltbld', 11:24:58 INFO - 'MAIL': '/var/mail/cltbld', 11:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:58 INFO - 'MOZ_NO_REMOTE': '1', 11:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:58 INFO - 'NO_EM_RESTART': '1', 11:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:58 INFO - 'PWD': '/builds/slave/test', 11:24:58 INFO - 'SHELL': '/bin/bash', 11:24:58 INFO - 'SHLVL': '1', 11:24:58 INFO - 'TERM': 'linux', 11:24:58 INFO - 'TMOUT': '86400', 11:24:58 INFO - 'USER': 'cltbld', 11:24:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', 11:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:58 INFO - '_': '/tools/buildbot/bin/python'} 11:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 INFO - Cleaning up... 11:24:58 INFO - Return code: 0 11:24:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:58 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')]} 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:58 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')]} 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:58 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 0x7fde4efe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17262e0>, '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 0x1692140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16925d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', '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 11:24:58 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 11:24:58 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 11:24:58 INFO - Using env: {'DISPLAY': ':0', 11:24:58 INFO - 'HOME': '/home/cltbld', 11:24:58 INFO - 'LANG': 'en_US.UTF-8', 11:24:58 INFO - 'LANGUAGE': 'en_US:en', 11:24:58 INFO - 'LOGNAME': 'cltbld', 11:24:58 INFO - 'MAIL': '/var/mail/cltbld', 11:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:58 INFO - 'MOZ_NO_REMOTE': '1', 11:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:58 INFO - 'NO_EM_RESTART': '1', 11:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:58 INFO - 'PWD': '/builds/slave/test', 11:24:58 INFO - 'SHELL': '/bin/bash', 11:24:58 INFO - 'SHLVL': '1', 11:24:58 INFO - 'TERM': 'linux', 11:24:58 INFO - 'TMOUT': '86400', 11:24:58 INFO - 'USER': 'cltbld', 11:24:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', 11:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:58 INFO - '_': '/tools/buildbot/bin/python'} 11:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:58 INFO - Cleaning up... 11:24:58 INFO - Return code: 0 11:24:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:24:58 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')]} 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:58 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')]} 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:58 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 0x7fde4efe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17262e0>, '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 0x1692140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16925d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', '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 11:24:58 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 11:24:58 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 11:24:58 INFO - Using env: {'DISPLAY': ':0', 11:24:58 INFO - 'HOME': '/home/cltbld', 11:24:58 INFO - 'LANG': 'en_US.UTF-8', 11:24:58 INFO - 'LANGUAGE': 'en_US:en', 11:24:58 INFO - 'LOGNAME': 'cltbld', 11:24:58 INFO - 'MAIL': '/var/mail/cltbld', 11:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:58 INFO - 'MOZ_NO_REMOTE': '1', 11:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:58 INFO - 'NO_EM_RESTART': '1', 11:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:58 INFO - 'PWD': '/builds/slave/test', 11:24:58 INFO - 'SHELL': '/bin/bash', 11:24:58 INFO - 'SHLVL': '1', 11:24:58 INFO - 'TERM': 'linux', 11:24:58 INFO - 'TMOUT': '86400', 11:24:58 INFO - 'USER': 'cltbld', 11:24:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', 11:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:58 INFO - '_': '/tools/buildbot/bin/python'} 11:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:59 INFO - Downloading/unpacking flake8 11:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:25:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:25:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:25:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:01 INFO - no previously-included directories found matching 'docs/_build' 11:25:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:25:01 INFO - Running setup.py install for pep8 11:25:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:01 INFO - no previously-included directories found matching 'docs/_build' 11:25:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:25:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:25:01 INFO - Cleaning up... 11:25:02 INFO - Return code: 0 11:25:02 INFO - Running post-action listener: _resource_record_post_action 11:25:02 INFO - Running post-action listener: _start_resource_monitoring 11:25:02 INFO - Starting resource monitoring. 11:25:02 INFO - ##### 11:25:02 INFO - ##### Finished create-virtualenv step (success) 11:25:02 INFO - ##### 11:25:02 INFO - ##### 11:25:02 INFO - ##### Running install step. 11:25:02 INFO - ##### 11:25:02 INFO - Running pre-action listener: _resource_record_pre_action 11:25:02 INFO - Running main action method: install 11:25:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:02 INFO - Reading from file tmpfile_stdout 11:25:02 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:02 INFO - Reading from file tmpfile_stdout 11:25:02 INFO - Output received: 11:25:02 INFO - Usage: mozinstall [options] installer 11:25:02 INFO - Options: 11:25:02 INFO - -h, --help show this help message and exit 11:25:02 INFO - -d DEST, --destination=DEST 11:25:02 INFO - Directory to install application into. [default: 11:25:02 INFO - "/builds/slave/test"] 11:25:02 INFO - --app=APP Application being installed. [default: firefox] 11:25:02 INFO - mkdir: /builds/slave/test/build/application 11:25:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:25:15 INFO - Reading from file tmpfile_stdout 11:25:15 INFO - Output received: 11:25:15 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:15 INFO - Running post-action listener: _resource_record_post_action 11:25:15 INFO - ##### 11:25:15 INFO - ##### Finished install step (success) 11:25:15 INFO - ##### 11:25:15 INFO - ##### 11:25:15 INFO - ##### Running run-tests step. 11:25:15 INFO - ##### 11:25:15 INFO - Running pre-action listener: _resource_record_pre_action 11:25:15 INFO - Running main action method: run_tests 11:25:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:15 INFO - Python 2.7.3 11:25:15 INFO - Return code: 0 11:25:15 INFO - grabbing minidump binary from tooltool 11:25: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')]} 11:25:15 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 0x17262e0>, '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 0x1692140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16925d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:15 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 11:25:15 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 11:25:15 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 11:25:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:15 INFO - Return code: 0 11:25:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:25:16 INFO - Return code: 0 11:25:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:25:16 INFO - Using env: {'DISPLAY': ':0', 11:25:16 INFO - 'HOME': '/home/cltbld', 11:25:16 INFO - 'LANG': 'en_US.UTF-8', 11:25:16 INFO - 'LANGUAGE': 'en_US:en', 11:25:16 INFO - 'LOGNAME': 'cltbld', 11:25:16 INFO - 'MAIL': '/var/mail/cltbld', 11:25:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:16 INFO - 'MOZ_NO_REMOTE': '1', 11:25:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:16 INFO - 'NO_EM_RESTART': '1', 11:25:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:16 INFO - 'PWD': '/builds/slave/test', 11:25:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:16 INFO - 'SHELL': '/bin/bash', 11:25:16 INFO - 'SHLVL': '1', 11:25:16 INFO - 'TERM': 'linux', 11:25:16 INFO - 'TMOUT': '86400', 11:25:16 INFO - 'USER': 'cltbld', 11:25:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669', 11:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:16 INFO - '_': '/tools/buildbot/bin/python'} 11:25:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:25:16 INFO - mozversion application_buildid: 20160801070053 11:25:16 INFO - mozversion application_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:16 INFO - mozversion application_display_name: Firefox 11:25:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:16 INFO - mozversion application_name: Firefox 11:25:16 INFO - mozversion application_remotingname: firefox 11:25:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:16 INFO - mozversion application_vendor: Mozilla 11:25:16 INFO - mozversion application_version: 49.0 11:25:16 INFO - mozversion platform_buildid: 20160801070053 11:25:16 INFO - mozversion platform_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:16 INFO - mozversion platform_version: 49.0 11:25:16 INFO - using testdate: 1470075916 11:25:16 INFO - actual date: 1470075916 11:25:16 INFO - starting webserver on 'localhost:57895' 11:25:16 INFO - SUITE-START | Running 2 tests 11:25:16 INFO - TEST-START | dromaeo_css 11:25:16 INFO - operating with platform_type : linux_ 11:25:16 INFO - Initialising browser for dromaeo_css test... 11:25:16 INFO - TEST-INFO | started process 22562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5eohZ8/profile http://localhost:57895/getInfo.html) 11:25:21 INFO - PROCESS | 22562 | __metrics Screen width/height:1600/1200 11:25:21 INFO - PROCESS | 22562 | colorDepth:24 11:25:21 INFO - PROCESS | 22562 | Browser inner width/height: 1024/697 11:25:21 INFO - PROCESS | 22562 | __metrics 11:25:21 ERROR - PROCESS | 22562 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:25:22 INFO - TEST-INFO | 22562: exit 0 11:25:22 INFO - Browser initialized. 11:25:22 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:22 INFO - TEST-INFO | started process 22691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5eohZ8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:34 INFO - PROCESS | 22691 | RSS: Main: 153399296 11:25:34 INFO - PROCESS | 22691 | 11:26:23 INFO - PROCESS | 22691 | 1470075983963 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] 11:28:32 INFO - PROCESS | 22691 | Cycle 1(1): loaded http://localhost:57895/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57895/tests/dromaeo/cssquery-ext.html) 11:28:33 INFO - PROCESS | 22691 | RSS: Main: 157085696 11:28:33 INFO - PROCESS | 22691 | 11:31:35 INFO - PROCESS | 22691 | Cycle 1(1): loaded http://localhost:57895/tests/dromaeo/cssquery-ext.html (next: http://localhost:57895/tests/dromaeo/cssquery-jquery.html) 11:31:35 INFO - PROCESS | 22691 | RSS: Main: 155385856 11:31:35 INFO - PROCESS | 22691 | 11:34:37 INFO - PROCESS | 22691 | Cycle 1(1): loaded http://localhost:57895/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57895/tests/dromaeo/cssquery-mootools.html) 11:34:38 INFO - PROCESS | 22691 | RSS: Main: 154689536 11:34:38 INFO - PROCESS | 22691 | 11:37:39 INFO - PROCESS | 22691 | Cycle 1(1): loaded http://localhost:57895/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57895/tests/dromaeo/cssquery-prototype.html) 11:37:40 INFO - PROCESS | 22691 | RSS: Main: 156418048 11:37:40 INFO - PROCESS | 22691 | 11:40:42 INFO - PROCESS | 22691 | Cycle 1(1): loaded http://localhost:57895/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57895/tests/dromaeo/cssquery-yui.html) 11:40:43 INFO - PROCESS | 22691 | RSS: Main: 154611712 11:40:43 INFO - PROCESS | 22691 | 11:43:45 INFO - PROCESS | 22691 | Cycle 1(1): loaded http://localhost:57895/tests/dromaeo/cssquery-yui.html (next: http://localhost:57895/tests/dromaeo/cssquery-dojo.html) 11:43:45 INFO - PROCESS | 22691 | RSS: Main: 158388224 11:43:45 INFO - PROCESS | 22691 | 11:43:45 INFO - PROCESS | 22691 | __start_tp_report 11:43:45 INFO - PROCESS | 22691 | _x_x_mozilla_page_load 11:43:45 INFO - PROCESS | 22691 | _x_x_mozilla_page_load_details 11:43:45 INFO - PROCESS | 22691 | |i|pagename|runs| 11:43:45 INFO - PROCESS | 22691 | |0;dojo.html;3417.572803399575;3432.2449061206526;3438.5873695156583;3439.174598096457;3461.2039230976875;5717.485426311631;5733.65598064116;5743.913841292374;5784.56615753818;5790.10253410722;5736.8852622947625;5771.797987070443;5772.076467765159;5792.68140252286;5800.709964501769;5189.169732842755;5256.868578285555;5292.179712144604;5309.946900531003;5390.380106287768;5243.895122097556;5287.312649355578;5328.387235467912;5338.439463856278;5359.678419294835;5225.477452254782;5243.528082472577;5277.287566178575;5301.1783173608155;5340.305760251162;5245.134552798802;5320.680759154463;5333.626646134772;5334.306540149794;5334.626576139691;5129.615278854101;5188.5849132069725;5239.973800131013;5306.6550674206055;5307.893842123174;5670.404607516192;5749.798757043483;5767.740451679684;5776.277965254343;5785.797497087582;6348.523860710419;6350.809475715736;6353.162872084292;6364.809055728336;6373.171487706569;6110.08348747687;6184.041473571604;6430.260520040209;6436.292007879129;6437.806865794034;5829.795957141479;5919.1713160157615;5921.230240068763;5932.970335148297;5974.6713930733795;6422.100905873182;6445.4199122079235;6474.773382931669;6475;6489.772857949949;6044.909326360108;6111.561351782736;6136.20229370179;6230.283517395467;6243.406876346739;6327.841803954938;6331.715072821734;6332;6340.904886426707;6365.8726825464155;6229.875402492015;6288.842778930563;6293;6315.747370105236;6320.178376810985;6096.329403765582;6219.440250377397;6264;6271.122042913996;6275.6862156891975;4781.928271075936;4785.688930219525;4791.592714619227;4794.065157294364;4803.087413391444;4274.294741367702;4287.57124287575;4289.2922667760095;4290.420793192941;4312.956870431255;5867.853303667443;6018.247719035121;6036.879262414815;6073.362296958844;6139.539534534839;6217.658028808459;6228.781992630236;6267.091271765568;6275.466585340206;6387.520935929824;6035.155078289043;6077.4226448487325;6083.057126145454;6084.30030546484;6084.5436592255755;5264.473552644705;5357.43746906577;5382.273393091961;5392.379876314274;5428.45715428454;6459.935400645933;6493.155889734398;6557.082008518812;6567.244766851778;6598.73605055802;6197.628142311295;6396.680165991682;6402.519811014099;6402.935970640234;6405.487560995202;6385.042243663488;6432.6462044588;6467.159269294962;6555.4427873629365;6556.868862622816;6236.158118653923;6247.219097612799;6248.750049997949;6250.843728906631;6261.248650161828;6162.044883043135;6285.402886725754;6323.20959880015;6329.936700632935;6332.398422149889;6130.398136741914;6231.096491008869;6265.4361107500545;6268.686565671789;6272.6236425814595;6199.5040396767245;6237.7193026314835;6248.281447633581;6254.437100660963;6254.437100660963;5998.25021872266;6004.309504407049;6029.51763858899;6154.384561543989;6157;6192.473639740672;6219;6229.5327850410495;6234.594751341148;6253.093301471352;6057.545684073624;6061.909071363845;6075.969620151871;6081.5742897996715;6105.145279660762 11:43:45 INFO - PROCESS | 22691 | |1;ext.html;579.9565032622554;630.3601844128209;652.5921299188009;656.2092678322622;677.1129819935882;35103.122421939435;38994;47590.28614570784;48303.758481207544;48672;50543.74728126363;50581;50700.74649626756;50962.49037509624;51083.48916510834;9132.589033493492;9272.536373181347;9286.349955503118;9294.535273236312;9311.441313521176;9084.636614535411;9167.44995300284;9177.219936305388;9195.908040919572;9198.4480931144;9150.40522366044;9189.218916392081;9192.816143677122;9233.49215793131;9264.30517711171;9147.17675409213;9159.633614655406;9239.584218710173;9243;9245.491497967609;9098.135677110664;9155.038720934273;9161.175494205487;9168.495732734697;9176.587053582605;45795.54204457946;45844;46079.76960115212;46126;46213.768931155464;3914.5693973662874;3924.038610540436;4199.68502362324;4210.978945105255;4571.291449825282;31161.376772464424;31992;32248.677513225037;37137;37304.44043339352;4768.2847572864;4818.734969576672;4822.180229361017;4876.341693871317;5044.646874718771;263055;266686.9999999981;267157;267425;268921;39160.80419597884;40114.19771604551;40196.39705404421;67043.32956670469;67491;42208.7337379873;42476.78761606172;42493.362599561035;42630.36054459186;42636.3604545932;17704.645907081787;17767;17853.7321940171;17870.106494675216;18003.18985645623;14592.562223133324;14696.412143514353;14698.485553005594;14760.704785904221;14896.776548351783;9362.438253704799;9453.243740500744;9500.287478439144;9506.33455658111;9543.665971690958;3508.4212104553053;3557.488067571272;3595.802230877327;3658.5243918290453;3666.4683620874825;1131.0555686002115;1135.9943200283947;1158.8377627132209;1201.0571701214506;1203.0676225924803;34139.82930085383;34252.65747342545;34420.31159376798;34512.13719656978;34929.65070349315;1178.157617303632;1190.2858285029085;1202.971459402216;1251.7809383357876;1255.2844878419214;17630.2066407012;17660.470185894443;17678.646427071388;17749.378771742926;17773.555661108574;601546;889078;895688;899277;965575;62973.68513157497;63747.36252637414;63776.68111659412;63815.68092159509;63967;1486.6357742353193;1498.0487390507105;1503.4812989518816;1516.113073851787;1523.5353217268619;31986;32787;33250.33499329951;33289.500657489676;33798.986030419124;55823.441765581825;55897.72051139718;56351.43648563462;56401.43598563962;56605.71697141488;410985;413211;413217;413778;415992;28732.13803585896;29028.854855725585;29514.409711805216;30889.69110308868;30959.69040309568;51289.743551282;51664.22503662373;51721.224181638056;52076.21885671642;52550.47449525456;42608;42624.360634591125;42902.78548607237;43130.35304470373;44485.33272000987;41739.37390939078;42163.7891810539;42291;42708;43752.56247437485;42651;43519.564804351554;43759.781201095066;44137.33793993029;44148.11703765971;36560;37435.2512949734;37805.43291850569;38551.42172867465;38653.226935461695;28929.56605650875;29436.411271774872;29535.85232073826;29546;29787.55318670265 11:43:45 INFO - PROCESS | 22691 | |2;jquery.html;409.7951024487756;415.8918681142902;416.4690020224213;418.69435312222095;434.20540411047784;19995.60008799825;20091.497712557175;20555.177792888306;20685.276015339467;20997;20000.599988000267;20257.898710506463;20674.793252067513;21216.257430989917;21317.893410532924;5736.598438109324;5900.704964751767;5943.405659434044;5947.970260148715;5963.61236519627;4331.523532411432;5855;5913.763449462038;6303.212098487689;6312.33720459352;6185.381461853824;6343.238811342645;6343.904841427382;6353.237611486628;6660.733570657168;6612.041254018189;6612.735490580371;6651.501137414713;6655.434288085518;6671.166104236971;5078.4159821620615;5386.2997810284805;5394.298741163623;5431.511163995259;5920.141579470953;14349.497767578188;14538.781918271234;20605.587888242302;24317.27048188557;24528.87735561311;2303.9884800576056;2323.7211534615953;2551.0561092395747;2671.2787547362104;2793.9243391294294;10342.689719308433;10622.62820801276;14702.809206794587;15003.24983750819;15120.168390738505;1924.8460123190112;2033.674612062063;2056.105594066571;2066.359428577146;2127.1491403438595;84666;86004.56997714972;86942;88626.55686721524;89384.55307723484;11427.714307142389;11565.132615053904;12027.21823081497;12102.757944841054;12448;16791.748123778154;16898.239579218964;16916.407925722542;16928.49214523566;17006;8649.610767515476;8747.343949203836;8977.371583989057;8978.147076027766;8999.505027223435;8613.870791938127;8638.26574741154;8705.6517739291;8720.738377848675;8915.197632213132;5002.849914502571;5040.79836806531;5056.317397151411;5095.974520127375;5175.404828444777;2019.5163343232805;2035.816776490123;2073.626747185491;2091.163534586178;2099.2757498662936;1005.2259759984917;1109.8335249712607;1120.2046546951756;1140.1434597901264;1177.0995188680665;19639.214431422868;19693.60612787765;19758.604827903648;20614.27850025272;20623.071961761758;1054.235679132638;1066.1524088349781;1081.5944020992129;1106.0819519798547;1109.750306181119;11168.162387820783;11375.260608060615;11481.827772583418;11585.015273701829;11664.475098620582;531941;532265;534270;549911;553298;99692.50153749184;101925;102761;103191.48404257931;103457.48271258596;1088.3796236145322;1105.5135740274254;1148.5176225985106;1150.5685367986837;1156.4853640130061;16530.66938661196;18676.25294988185;18684;18762.343317983807;19056.80943190606;39501.40747888727;41417.79291103525;46065;46376.768116159205;47339.52660473351;50380;60966.390336097844;61277.38722612717;61493.69253153705;61655.38344616497;8878.289736820909;9053.864192037256;9131.77170570741;9161.816763664556;9369.203617692572;13605.523806666719;13637.86362136366;13855.307234638027;13890.791638125638;14064.78902816479;11935.940320298343;11970.521179152736;12182.147249692436;12293.200941938745;12340.876591234331;12082.879171208528;12243.020558355132;12287.75424491523;12403.813942791046;12569.560065397667;12395;12580.182288151242;12615.243085414904;12668.809967850306;12838.29389383593;9028.729138125867;9079.228265597234;9218.124278193562;9460.952695236756;9525.333226674344;12186.390680465764;12186.57346992851;12300.938495307466;12334.259944403364;12346.876531234573 11:43:45 INFO - PROCESS | 22691 | |3;mootools.html;1633.1181162172427;1642.0640235066014;1858.8327050565447;1940.1092372365163;1954.472292481031;9573.377730447515;9793.804123917518;10160.390376577392;10234.488275586218;10236.795264094722;9751.31740778144;9851.605935762562;9874.25943054272;9880.505974701255;9887.851682224773;2471.3821544613847;2508.6613307203565;2513.0576033987254;2514.2959971208;2517.7356377580363;2411.2163546847255;2501.6372625969225;2504.6243063540433;2508.2475257422793;2515.76100270474;2417.5527527407485;2422.527607116613;2475.195561442529;2481.1192026830486;2481.2680259323542;2440.792532634728;2454.325060608347;2460.434100156956;2463.482668639597;2482.2305085423486;2407.4222186675247;2428.91498797543;2439.42673471734;2455.312512496504;2462.815288853343;9567.904320956772;9643.035696430372;9643.421394716339;9654.90345096547;9655.855162172573;5769.1923130761725;5949.8810023799715;5977.970110149421;5980.551458640576;5983.551233657493;3507.91230219244;3597.406427939387;3670.504481894937;3677.264547090566;3705.2959937611768;1122.2817396866012;1123.3035517978906;1140.726225705833;1144.4907016377715;1146.5814977533223;13866;13893.374798134108;13971.09187902783;13991.510297139654;14003.439862405492;4931.7040977541465;4946.629002824802;5088.956763863399;5097.311862898536;5098.770555325019;10892.564297428173;10901.672949811518;10974.012338889539;10978.505967231495;10989.6153634624;5695.117256825116;5748.02283611787;5794.478496935296;5838.386969368155;5843.590948633555;4787.138315103245;5229.163333866563;5356.223347614574;5364.409914909357;5378.865528361822;4133.6693064554765;4172.916541669149;4177.8537751178565;4177.937330940038;4212.241796476664;1143.89704926557;1208.6736581123223;1209.3469526455792;1219.0613227814533;1225.0567063361161;989.3717489394287;1104.5195340027115;1119.412308538024;1119.6641007697658;1124.8537690100234;6800.795976120626;6878.518503704692;6895.620740859301;6955.65221738911;7074.22183559808;459.9540045995441;480.69475882814663;483.56720734942735;490.9558139767438;497.7834641930772;4444.177827101997;4447.555244475591;4477.686561940698;4503.874031492127;4514.210013247669;12126.818097728541;12679.93660031694;12709.110362274738;12713.364331783374;12730.55443059507;12394.442250098768;12518.8933104053;12651.557195498113;12681.682957926125;12695;9271.95364023189;9275.860862087075;9286.767830804283;9288.117628825386;9313.53432328381;6559.508036897157;6633.568818026813;6729.764458243938;6790.1851777785005;6829.760958366632;11382.487788049722;11390.974812266935;11617.709557261136;11697.415129243334;11799.292042477478;11611.361375124112;11752.88247117552;11792.823107653221;11797.52809887595;11857.347845868215;7124.536905101152;8041.87937180931;8153.510789352657;8316.875246871423;8394.0766515682;9712.077352651488;9719.222462203148;9723.9027609723;9751.073648003428;9789.9021009789;8470.788230294293;8664.436811607226;8761.780955476164;8787.121287871161;8858.73423797287;8033.8393232136195;8040;8210.727798356646;8223.671053157806;8312.127226641116;7679.846403072019;7874.645640946057;7880.960595196987;7887.171846955987;7896.249856263646;5922.851928701817;5972.343042265435;6013.87972240544;6089.786857459968;6171.84570385726;5824.417558244142;5825.621334613236;5856.092305692625;5889.764409423575;6029.57792954489 11:43:45 INFO - PROCESS | 22691 | |4;prototype.html;337.41626985315406;348.5590727729422;351.2132822477651;352.7530728490058;353.16476532999457;5681.687507187103;5701.629394089381;5968.164456976021;6032.607880487771;6051.818445446638;5764.682942438175;5780.161876527901;5793.986052440827;5804.303483581976;5816.534677225823;4523.778579783457;4539.137563862872;4539.886502837422;4558.111168322179;4565.840195593139;4424.690271680984;4485.686001979862;4497.955020449803;4505.662075344346;4566.13243483737;4419.0499042705815;4428.335749637564;4445.799939002753;4453.6659750518675;4453.799579018936;4479.283314669638;4519;4522.841700540465;4528.977355113237;4547.613452856478;3869.8452061917487;3973.6821054315587;3995.800209989489;4030.838766449368;4038.3134867072376;5519.917201241985;5550.139728342114;5565.6104072714925;5568.693721845338;5580.107182850725;5074.238864170367;5144;5172.8965420691375;5181.792728290864;5182.533571978503;5927.911081333784;6051.757929682807;6086.878262434727;6103.29812071613;6113.572049956505;4370.497392799837;4401.141777353418;4409.140217657558;4410.125696578941;4410.360497727812;6147.754089836446;6320.399562041599;6367.395097465734;6374;6407.935920640781;4486.394336764561;4518.254488009442;4527;4532.5694059064335;4542.250528662799;4563.224251877189;4579.267317229294;4599.724016559017;4600.97699511507;4601.308234682681;5097.286379906816;5169.689818610896;5218.817341393033;5235.712035838065;5241.510282615727;5899.911501327483;6045.312359460725;6128.908066379008;6135.233095863017;6141.785037523755;1505.2473763118442;1520.711064897666;1521.3230112599788;1523.9560900783;1524.3140586736013;957.3968399908014;974.586849068853;982.1553464020936;988.9357191782511;993.6919554937992;5256.211568264791;5290.9735451322495;5313.335833020872;5323.057084164252;5344.465553444625;5519.337679478408;5534.363548191929;5608.607397482218;5662.037453632893;5699.658020518699;4765.785539650655;5137.8896882493855;5217.556507696812;5288.206768984683;5288.2596436498925;2966.777491688132;2998.2804127009363;3002.9249268768017;3003.684613115635;3013.909582712522;5678.375378708339;5687.857803554944;5729.742161602738;5757.337906140848;5789.565782566325;5975.492083172892;6500.374906273431;6507.186601674791;6512.804615861532;6526.869462610721;6520.902186467207;6537.28089910119;6548.738050477928;6550;6576.8355791105605;6150.292716337678;6365.172527571386;6377.649229292433;6383.234011918599;6398.168238129014;6279.026750853625;6309.779157729641;6315.210598675166;6325.304216536269;6340.365963403623;6342.746290148342;6523.706433210612;6550.377714117151;6591.242007169045;6591.703373348307;4416.33754936762;4456.5766252205985;4463.174312752021;4463.709858859163;4476.440444944382;6168.013117901114;6378.712957916812;6409.647469389229;6417;6439.422341526356;6191.25704915413;6208.565400421927;6212.161358216764;6216.564840461125;6266.843328916813;6136.7852125175405;6240.687965601793;6243.562950593415;6250.1874756281395;6291.465225455888;6081.179040829431;6087.573869829246;6132.202813634199;6133;6137.96931015342;6223.284322302812;6253.78111766086;6255.437010669061;6298.330942300203;6322.304546499973;5853.64878107315;6058.878822423615;6059.394060593905;6082.239720034996;6134.877302454015 11:43:45 INFO - PROCESS | 22691 | |5;yui.html;806.8587997100506;822.4941660878561;835.9498430094195;900.7973206028645;929.6978481993353;15513.146776927279;16831.242594083265;17138.742918856195;17155.914220428895;17166.914165429185;15961;16211.99999999997;16243.918780406111;16270;16273.267702953366;866.6533386645345;893;893.13366034946;894.7852515396323;898.9011208767031;883.1080608585343;886.5965985476593;888.0409158109227;888.9777755556098;889.3507739350279;929.1266209762836;932.7341707613332;936.0732874454309;937.7983733497297;938.3431597881477;926.1849572376333;927.6706769097009;928.5914197752967;928.633189889993;928.9628414863397;682.0928165539821;682.4335801284972;682.8156397772623;684.5174152222721;686.1800148822159;14449.927750361287;14549.34527946245;14553.490627827976;14586.124832509977;14588.489402870848;12264.938675306566;12600.936995315056;13006.544770932973;13099.410526526233;13343.599692009255;11921.821172682417;12048.819267710991;12049.216800907912;12116.636500904988;12380.690482738004;3826.1773718650625;3886.067343837487;3984.183242435294;4000.8599699010397;4017.1563971566006;63898;66472.667636662;66847;77265.61367193185;79275.20724792793;12830.55093071738;12894.226346419246;12982.35088245584;12990.155639883566;13001.674958125934;21457;22221.666674999888;23230.65154022691;23315.067397304258;23331.95006224724;7845.529268243924;8280.544570048705;8281.29608983243;9323.766905827273;9440.716778496657;4577.22187228172;4684.508126646721;4821.228603423436;4832.371791667061;4905.583025442877;3893.2602805467436;3987.6610488108254;3994.201159768058;3998.8200530975596;4000.599940005976;638.1958731997717;698.5215127637584;701.2426579294452;702.3222590200481;702.9964850175717;668.6489592963733;700.5656492974389;701.4283359062348;705.1995984557564;707.4163814852767;9926.652567160114;10038.598456061822;10101.64644237463;10135.442550659785;10258.28192026566;661.5832025823796;680.2517231045908;694.7464175575878;712.4051417066704;715.7029832619509;4662.953370466252;4667.603253723471;4675.366183748575;4684.74233917131;4715.221510959884;67745.05861149637;69238.65380673166;69435.30564694389;108193;122662.48018839174;71534;72857.6357118211;96974;101436.47845282327;103287;92001.53999229961;92321.53839230762;92509.29962801412;93112.53443732738;93353.53323233205;7419.517731347445;7497.400207983457;7594;9123.77190570241;9192.54037298119;39162;51611;51979.48020519746;53745;54015;71496.14015439533;72553.6372318135;73233.16917077116;75052.62473687597;78016;11811.940940295244;12015.339156346485;12422.689432764253;12466.56367027186;12550;14049.578512644637;14131.293435327987;14341.067830590979;14449.711005779614;14598.854011459749;13160;13395.196288222738;13474.730505389642;13683.589492315246;13915;12476.937615311865;12833.743325133632;12974;13129.671758205739;13194;12685.4291556882;12707.174033687781;12799.616011519669;13066.412011459317;13154.868451315364;10462.476876156314;10772.353658780497;10818.242723009314;10948.233623646269;11003.119750420108;11342.262752921033;11405.600803971822;11492.655220343404;11524.308541487537;11575.421228938689 11:43:45 INFO - PROCESS | 22691 | __end_tp_report 11:43:45 INFO - PROCESS | 22691 | __start_cc_report 11:43:45 INFO - PROCESS | 22691 | _x_x_mozilla_cycle_collect,335 11:43:45 INFO - PROCESS | 22691 | __end_cc_report 11:43:45 INFO - PROCESS | 22691 | __startTimestamp1470077025820__endTimestamp 11:43:45 INFO - PROCESS | 22691 | 11:43:45 INFO - PROCESS | 22691 | ------- Summary: start ------- 11:43:45 INFO - PROCESS | 22691 | Number of tests: 6 11:43:45 INFO - PROCESS | 22691 | 11:43:45 INFO - PROCESS | 22691 | [#0] dojo.html Cycles:165 Average:5841.86 Median:6096.33 stddev:679.02 (11.1%) stddev-sans-first:653.92 11:43:45 INFO - PROCESS | 22691 | Values: 3417.6 3432.2 3438.6 3439.2 3461.2 5717.5 5733.7 5743.9 5784.6 5790.1 5736.9 5771.8 5772.1 5792.7 5800.7 5189.2 5256.9 5292.2 5309.9 5390.4 5243.9 5287.3 5328.4 5338.4 5359.7 5225.5 5243.5 5277.3 5301.2 5340.3 5245.1 5320.7 5333.6 5334.3 5334.6 5129.6 5188.6 5240.0 5306.7 5307.9 5670.4 5749.8 5767.7 5776.3 5785.8 6348.5 6350.8 6353.2 6364.8 6373.2 6110.1 6184.0 6430.3 6436.3 6437.8 5829.8 5919.2 5921.2 5933.0 5974.7 6422.1 6445.4 6474.8 6475.0 6489.8 6044.9 6111.6 6136.2 6230.3 6243.4 6327.8 6331.7 6332.0 6340.9 6365.9 6229.9 6288.8 6293.0 6315.7 6320.2 6096.3 6219.4 6264.0 6271.1 6275.7 4781.9 4785.7 4791.6 4794.1 4803.1 4274.3 4287.6 4289.3 4290.4 4313.0 5867.9 6018.2 6036.9 6073.4 6139.5 6217.7 6228.8 6267.1 6275.5 6387.5 6035.2 6077.4 6083.1 6084.3 6084.5 5264.5 5357.4 5382.3 5392.4 5428.5 6459.9 6493.2 6557.1 6567.2 6598.7 6197.6 6396.7 6402.5 6402.9 6405.5 6385.0 6432.6 6467.2 6555.4 6556.9 6236.2 6247.2 6248.8 6250.8 6261.2 6162.0 6285.4 6323.2 6329.9 6332.4 6130.4 6231.1 6265.4 6268.7 6272.6 6199.5 6237.7 6248.3 6254.4 6254.4 5998.3 6004.3 6029.5 6154.4 6157.0 6192.5 6219.0 6229.5 6234.6 6253.1 6057.5 6061.9 6076.0 6081.6 6105.1 11:43:45 INFO - PROCESS | 22691 | 11:43:45 INFO - PROCESS | 22691 | [#1] ext.html Cycles:180 Average:66293.96 Median:42616.18 stddev:154781.83 (363.2%) stddev-sans-first:155137.39 11:43:45 INFO - PROCESS | 22691 | Values: 580.0 630.4 652.6 656.2 677.1 35103.1 38994.0 47590.3 48303.8 48672.0 50543.7 50581.0 50700.7 50962.5 51083.5 9132.6 9272.5 9286.3 9294.5 9311.4 9084.6 9167.4 9177.2 9195.9 9198.4 9150.4 9189.2 9192.8 9233.5 9264.3 9147.2 9159.6 9239.6 9243.0 9245.5 9098.1 9155.0 9161.2 9168.5 9176.6 45795.5 45844.0 46079.8 46126.0 46213.8 3914.6 3924.0 4199.7 4211.0 4571.3 31161.4 31992.0 32248.7 37137.0 37304.4 4768.3 4818.7 4822.2 4876.3 5044.6 263055.0 266687.0 267157.0 267425.0 268921.0 39160.8 40114.2 40196.4 67043.3 67491.0 42208.7 42476.8 42493.4 42630.4 42636.4 17704.6 17767.0 17853.7 17870.1 18003.2 14592.6 14696.4 14698.5 14760.7 14896.8 9362.4 9453.2 9500.3 9506.3 9543.7 3508.4 3557.5 3595.8 3658.5 3666.5 1131.1 1136.0 1158.8 1201.1 1203.1 34139.8 34252.7 34420.3 34512.1 34929.7 1178.2 1190.3 1203.0 1251.8 1255.3 17630.2 17660.5 17678.6 17749.4 17773.6 601546.0 889078.0 895688.0 899277.0 965575.0 62973.7 63747.4 63776.7 63815.7 63967.0 1486.6 1498.0 1503.5 1516.1 1523.5 31986.0 32787.0 33250.3 33289.5 33799.0 55823.4 55897.7 56351.4 56401.4 56605.7 410985.0 413211.0 413217.0 413778.0 415992.0 28732.1 29028.9 29514.4 30889.7 30959.7 51289.7 51664.2 51721.2 52076.2 52550.5 42608.0 42624.4 42902.8 43130.4 44485.3 41739.4 42163.8 42291.0 42708.0 43752.6 42651.0 43519.6 43759.8 44137.3 44148.1 36560.0 37435.3 37805.4 38551.4 38653.2 28929.6 29436.4 29535.9 29546.0 29787.6 11:43:45 INFO - PROCESS | 22691 | 11:43:45 INFO - PROCESS | 22691 | [#2] jquery.html Cycles:180 Average:31397.74 Median:2082.40 stddev:89092.51 (4278.4%) stddev-sans-first:89312.05 11:43:45 INFO - PROCESS | 22691 | Values: 409.8 415.9 416.5 418.7 434.2 19995.6 20091.5 20555.2 20685.3 20997.0 20000.6 20257.9 20674.8 21216.3 21317.9 5736.6 5900.7 5943.4 5948.0 5963.6 4331.5 5855.0 5913.8 6303.2 6312.3 6185.4 6343.2 6343.9 6353.2 6660.7 6612.0 6612.7 6651.5 6655.4 6671.2 5078.4 5386.3 5394.3 5431.5 5920.1 14349.5 14538.8 20605.6 24317.3 24528.9 2304.0 2323.7 2551.1 2671.3 2793.9 10342.7 10622.6 14702.8 15003.2 15120.2 1924.8 2033.7 2056.1 2066.4 2127.1 84666.0 86004.6 86942.0 88626.6 89384.6 11427.7 11565.1 12027.2 12102.8 12448.0 16791.7 16898.2 16916.4 16928.5 17006.0 8649.6 8747.3 8977.4 8978.1 8999.5 8613.9 8638.3 8705.7 8720.7 8915.2 5002.8 5040.8 5056.3 5096.0 5175.4 2019.5 2035.8 2073.6 2091.2 2099.3 1005.2 1109.8 1120.2 1140.1 1177.1 19639.2 19693.6 19758.6 20614.3 20623.1 1054.2 1066.2 1081.6 1106.1 1109.8 11168.2 11375.3 11481.8 11585.0 11664.5 531941.0 532265.0 534270.0 549911.0 553298.0 99692.5 101925.0 102761.0 103191.5 103457.5 1088.4 1105.5 1148.5 1150.6 1156.5 16530.7 18676.3 18684.0 18762.3 19056.8 39501.4 41417.8 46065.0 46376.8 47339.5 50380.0 60966.4 61277.4 61493.7 61655.4 8878.3 9053.9 9131.8 9161.8 9369.2 13605.5 13637.9 13855.3 13890.8 14064.8 11935.9 11970.5 12182.1 12293.2 12340.9 12082.9 12243.0 12287.8 12403.8 12569.6 12395.0 12580.2 12615.2 12668.8 12838.3 9028.7 9079.2 9218.1 9461.0 9525.3 12186.4 12186.6 12300.9 12334.3 12346.9 11:43:45 INFO - PROCESS | 22691 | 11:43:45 INFO - PROCESS | 22691 | [#3] mootools.html Cycles:180 Average:6458.69 Median:4509.04 stddev:3794.14 (84.1%) stddev-sans-first:3787.46 11:43:45 INFO - PROCESS | 22691 | Values: 1633.1 1642.1 1858.8 1940.1 1954.5 9573.4 9793.8 10160.4 10234.5 10236.8 9751.3 9851.6 9874.3 9880.5 9887.9 2471.4 2508.7 2513.1 2514.3 2517.7 2411.2 2501.6 2504.6 2508.2 2515.8 2417.6 2422.5 2475.2 2481.1 2481.3 2440.8 2454.3 2460.4 2463.5 2482.2 2407.4 2428.9 2439.4 2455.3 2462.8 9567.9 9643.0 9643.4 9654.9 9655.9 5769.2 5949.9 5978.0 5980.6 5983.6 3507.9 3597.4 3670.5 3677.3 3705.3 1122.3 1123.3 1140.7 1144.5 1146.6 13866.0 13893.4 13971.1 13991.5 14003.4 4931.7 4946.6 5089.0 5097.3 5098.8 10892.6 10901.7 10974.0 10978.5 10989.6 5695.1 5748.0 5794.5 5838.4 5843.6 4787.1 5229.2 5356.2 5364.4 5378.9 4133.7 4172.9 4177.9 4177.9 4212.2 1143.9 1208.7 1209.3 1219.1 1225.1 989.4 1104.5 1119.4 1119.7 1124.9 6800.8 6878.5 6895.6 6955.7 7074.2 460.0 480.7 483.6 491.0 497.8 4444.2 4447.6 4477.7 4503.9 4514.2 12126.8 12679.9 12709.1 12713.4 12730.6 12394.4 12518.9 12651.6 12681.7 12695.0 9272.0 9275.9 9286.8 9288.1 9313.5 6559.5 6633.6 6729.8 6790.2 6829.8 11382.5 11391.0 11617.7 11697.4 11799.3 11611.4 11752.9 11792.8 11797.5 11857.3 7124.5 8041.9 8153.5 8316.9 8394.1 9712.1 9719.2 9723.9 9751.1 9789.9 8470.8 8664.4 8761.8 8787.1 8858.7 8033.8 8040.0 8210.7 8223.7 8312.1 7679.8 7874.6 7881.0 7887.2 7896.2 5922.9 5972.3 6013.9 6089.8 6171.8 5824.4 5825.6 5856.1 5889.8 6029.6 11:43:45 INFO - PROCESS | 22691 | 11:43:45 INFO - PROCESS | 22691 | [#4] prototype.html Cycles:180 Average:5082.18 Median:5684.77 stddev:1520.48 (26.7%) stddev-sans-first:1482.45 11:43:45 INFO - PROCESS | 22691 | Values: 337.4 348.6 351.2 352.8 353.2 5681.7 5701.6 5968.2 6032.6 6051.8 5764.7 5780.2 5794.0 5804.3 5816.5 4523.8 4539.1 4539.9 4558.1 4565.8 4424.7 4485.7 4498.0 4505.7 4566.1 4419.0 4428.3 4445.8 4453.7 4453.8 4479.3 4519.0 4522.8 4529.0 4547.6 3869.8 3973.7 3995.8 4030.8 4038.3 5519.9 5550.1 5565.6 5568.7 5580.1 5074.2 5144.0 5172.9 5181.8 5182.5 5927.9 6051.8 6086.9 6103.3 6113.6 4370.5 4401.1 4409.1 4410.1 4410.4 6147.8 6320.4 6367.4 6374.0 6407.9 4486.4 4518.3 4527.0 4532.6 4542.3 4563.2 4579.3 4599.7 4601.0 4601.3 5097.3 5169.7 5218.8 5235.7 5241.5 5899.9 6045.3 6128.9 6135.2 6141.8 1505.2 1520.7 1521.3 1524.0 1524.3 957.4 974.6 982.2 988.9 993.7 5256.2 5291.0 5313.3 5323.1 5344.5 5519.3 5534.4 5608.6 5662.0 5699.7 4765.8 5137.9 5217.6 5288.2 5288.3 2966.8 2998.3 3002.9 3003.7 3013.9 5678.4 5687.9 5729.7 5757.3 5789.6 5975.5 6500.4 6507.2 6512.8 6526.9 6520.9 6537.3 6548.7 6550.0 6576.8 6150.3 6365.2 6377.6 6383.2 6398.2 6279.0 6309.8 6315.2 6325.3 6340.4 6342.7 6523.7 6550.4 6591.2 6591.7 4416.3 4456.6 4463.2 4463.7 4476.4 6168.0 6378.7 6409.6 6417.0 6439.4 6191.3 6208.6 6212.2 6216.6 6266.8 6136.8 6240.7 6243.6 6250.2 6291.5 6081.2 6087.6 6132.2 6133.0 6138.0 6223.3 6253.8 6255.4 6298.3 6322.3 5853.6 6058.9 6059.4 6082.2 6134.9 11:43:45 INFO - PROCESS | 22691 | 11:43:45 INFO - PROCESS | 22691 | [#5] yui.html Cycles:180 Average:19779.31 Median:4665.28 stddev:27526.01 (590.0%) stddev-sans-first:27566.36 11:43:45 INFO - PROCESS | 22691 | Values: 806.9 822.5 835.9 900.8 929.7 15513.1 16831.2 17138.7 17155.9 17166.9 15961.0 16212.0 16243.9 16270.0 16273.3 866.7 893.0 893.1 894.8 898.9 883.1 886.6 888.0 889.0 889.4 929.1 932.7 936.1 937.8 938.3 926.2 927.7 928.6 928.6 929.0 682.1 682.4 682.8 684.5 686.2 14449.9 14549.3 14553.5 14586.1 14588.5 12264.9 12600.9 13006.5 13099.4 13343.6 11921.8 12048.8 12049.2 12116.6 12380.7 3826.2 3886.1 3984.2 4000.9 4017.2 63898.0 66472.7 66847.0 77265.6 79275.2 12830.6 12894.2 12982.4 12990.2 13001.7 21457.0 22221.7 23230.7 23315.1 23332.0 7845.5 8280.5 8281.3 9323.8 9440.7 4577.2 4684.5 4821.2 4832.4 4905.6 3893.3 3987.7 3994.2 3998.8 4000.6 638.2 698.5 701.2 702.3 703.0 668.6 700.6 701.4 705.2 707.4 9926.7 10038.6 10101.6 10135.4 10258.3 661.6 680.3 694.7 712.4 715.7 4663.0 4667.6 4675.4 4684.7 4715.2 67745.1 69238.7 69435.3 108193.0 122662.5 71534.0 72857.6 96974.0 101436.5 103287.0 92001.5 92321.5 92509.3 93112.5 93353.5 7419.5 7497.4 7594.0 9123.8 9192.5 39162.0 51611.0 51979.5 53745.0 54015.0 71496.1 72553.6 73233.2 75052.6 78016.0 11811.9 12015.3 12422.7 12466.6 12550.0 14049.6 14131.3 14341.1 14449.7 14598.9 13160.0 13395.2 13474.7 13683.6 13915.0 12476.9 12833.7 12974.0 13129.7 13194.0 12685.4 12707.2 12799.6 13066.4 13154.9 10462.5 10772.4 10818.2 10948.2 11003.1 11342.3 11405.6 11492.7 11524.3 11575.4 11:43:45 INFO - PROCESS | 22691 | -------- Summary: end -------- 11:43:45 INFO - PROCESS | 22691 | 11:43:46 INFO - TEST-INFO | 22691: exit 0 11:43:46 INFO - TEST-OK | dromaeo_css | took 1109704ms 11:43:46 INFO - TEST-START | kraken 11:43:46 INFO - operating with platform_type : linux_ 11:43:46 INFO - Initialising browser for kraken test... 11:43:46 INFO - TEST-INFO | started process 22934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd5xvuY/profile http://localhost:57895/getInfo.html) 11:43:50 INFO - PROCESS | 22934 | __metrics Screen width/height:1600/1200 11:43:50 INFO - PROCESS | 22934 | colorDepth:24 11:43:50 INFO - PROCESS | 22934 | Browser inner width/height: 1024/697 11:43:50 INFO - PROCESS | 22934 | __metrics 11:43:51 ERROR - PROCESS | 22934 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:43:52 INFO - TEST-INFO | 22934: exit 0 11:43:52 INFO - Browser initialized. 11:43:52 INFO - Running cycle 1/1 for kraken test... 11:43:52 INFO - TEST-INFO | started process 23062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd5xvuY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:03 INFO - PROCESS | 23062 | RSS: Main: 152788992 11:44:03 INFO - PROCESS | 23062 | 11:44:06 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57895/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:07 INFO - PROCESS | 23062 | RSS: Main: 157827072 11:44:07 INFO - PROCESS | 23062 | 11:44:09 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57895/tests/kraken/driver.html?testName=audio-dft) 11:44:10 INFO - PROCESS | 23062 | RSS: Main: 156729344 11:44:10 INFO - PROCESS | 23062 | 11:44:13 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57895/tests/kraken/driver.html?testName=audio-fft) 11:44:13 INFO - PROCESS | 23062 | RSS: Main: 157679616 11:44:13 INFO - PROCESS | 23062 | 11:44:15 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57895/tests/kraken/driver.html?testName=audio-oscillator) 11:44:16 INFO - PROCESS | 23062 | RSS: Main: 158023680 11:44:16 INFO - PROCESS | 23062 | 11:44:18 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57895/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:19 INFO - PROCESS | 23062 | RSS: Main: 157814784 11:44:19 INFO - PROCESS | 23062 | 11:44:22 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57895/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:22 INFO - PROCESS | 23062 | RSS: Main: 156643328 11:44:22 INFO - PROCESS | 23062 | 11:44:26 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57895/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:27 INFO - PROCESS | 23062 | RSS: Main: 157630464 11:44:27 INFO - PROCESS | 23062 | 11:44:29 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57895/tests/kraken/driver.html?testName=json-parse-financial) 11:44:30 INFO - PROCESS | 23062 | RSS: Main: 158195712 11:44:30 INFO - PROCESS | 23062 | 11:44:31 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57895/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:32 INFO - PROCESS | 23062 | RSS: Main: 157700096 11:44:32 INFO - PROCESS | 23062 | 11:44:34 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57895/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:34 INFO - PROCESS | 23062 | RSS: Main: 157270016 11:44:34 INFO - PROCESS | 23062 | 11:44:36 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57895/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:37 INFO - PROCESS | 23062 | RSS: Main: 157454336 11:44:37 INFO - PROCESS | 23062 | 11:44:40 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:40 INFO - PROCESS | 23062 | RSS: Main: 158724096 11:44:40 INFO - PROCESS | 23062 | 11:44:43 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:44 INFO - PROCESS | 23062 | RSS: Main: 158441472 11:44:44 INFO - PROCESS | 23062 | 11:44:45 INFO - PROCESS | 23062 | Cycle 1(1): loaded http://localhost:57895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57895/tests/kraken/driver.html?testName=ai-astar) 11:44:46 INFO - PROCESS | 23062 | RSS: Main: 158629888 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | __start_tp_report 11:44:46 INFO - PROCESS | 23062 | _x_x_mozilla_page_load 11:44:46 INFO - PROCESS | 23062 | _x_x_mozilla_page_load_details 11:44:46 INFO - PROCESS | 23062 | |i|pagename|runs| 11:44:46 INFO - PROCESS | 23062 | |0;ai-astar;113;104;111;110;110;112;109;109;111;112 11:44:46 INFO - PROCESS | 23062 | |1;audio-beat-detection;152;124;155;183;124;150;151;127;174;127 11:44:46 INFO - PROCESS | 23062 | |2;audio-dft;161;162;161;163;163;164;162;162;163;163 11:44:46 INFO - PROCESS | 23062 | |3;audio-fft;76;75;75;180;76;77;74;76;166;77 11:44:46 INFO - PROCESS | 23062 | |4;audio-oscillator;84;84;147;85;85;84;143;90;85;140 11:44:46 INFO - PROCESS | 23062 | |5;imaging-gaussian-blur;117;118;120;117;118;117;117;117;118;118 11:44:46 INFO - PROCESS | 23062 | |6;imaging-darkroom;147;147;147;146;148;147;147;148;146;147 11:44:46 INFO - PROCESS | 23062 | |7;imaging-desaturate;96;95;97;96;95;95;96;96;94;95 11:44:46 INFO - PROCESS | 23062 | |8;json-parse-financial;55;52;54;56;54;55;58;56;53;55 11:44:46 INFO - PROCESS | 23062 | |9;json-stringify-tinderbox;59;61;61;65;60;59;60;60;60;60 11:44:46 INFO - PROCESS | 23062 | |10;stanford-crypto-aes;79;77;78;78;78;80;83;77;107;83 11:44:46 INFO - PROCESS | 23062 | |11;stanford-crypto-ccm;129;131;128;120;119;125;120;132;127;123 11:44:46 INFO - PROCESS | 23062 | |12;stanford-crypto-pbkdf2;157;153;161;154;159;160;163;156;160;165 11:44:46 INFO - PROCESS | 23062 | |13;stanford-crypto-sha256-iterative;63;64;63;62;63;67;61;62;61;62 11:44:46 INFO - PROCESS | 23062 | __end_tp_report 11:44:46 INFO - PROCESS | 23062 | __start_cc_report 11:44:46 INFO - PROCESS | 23062 | _x_x_mozilla_cycle_collect,875 11:44:46 INFO - PROCESS | 23062 | __end_cc_report 11:44:46 INFO - PROCESS | 23062 | __startTimestamp1470077086020__endTimestamp 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | ------- Summary: start ------- 11:44:46 INFO - PROCESS | 23062 | Number of tests: 14 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.51 (2.3%) stddev-sans-first:2.44 11:44:46 INFO - PROCESS | 23062 | Values: 113.0 104.0 111.0 110.0 110.0 112.0 109.0 109.0 111.0 112.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:151.50 stddev:21.07 (13.9%) stddev-sans-first:22.26 11:44:46 INFO - PROCESS | 23062 | Values: 152.0 124.0 155.0 183.0 124.0 150.0 151.0 127.0 174.0 127.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 11:44:46 INFO - PROCESS | 23062 | Values: 161.0 162.0 161.0 163.0 163.0 164.0 162.0 162.0 163.0 163.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:41.15 (54.1%) stddev-sans-first:43.05 11:44:46 INFO - PROCESS | 23062 | Values: 76.0 75.0 75.0 180.0 76.0 77.0 74.0 76.0 166.0 77.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:84.50 stddev:28.14 (33.3%) stddev-sans-first:29.02 11:44:46 INFO - PROCESS | 23062 | Values: 84.0 84.0 147.0 85.0 85.0 84.0 143.0 90.0 85.0 140.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 11:44:46 INFO - PROCESS | 23062 | Values: 117.0 118.0 120.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:44:46 INFO - PROCESS | 23062 | Values: 147.0 147.0 147.0 146.0 148.0 147.0 147.0 148.0 146.0 147.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 11:44:46 INFO - PROCESS | 23062 | Values: 96.0 95.0 97.0 96.0 95.0 95.0 96.0 96.0 94.0 95.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.69 (3.1%) stddev-sans-first:1.79 11:44:46 INFO - PROCESS | 23062 | Values: 55.0 52.0 54.0 56.0 54.0 55.0 58.0 56.0 53.0 55.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.00 stddev:1.72 (2.9%) stddev-sans-first:1.73 11:44:46 INFO - PROCESS | 23062 | Values: 59.0 61.0 61.0 65.0 60.0 59.0 60.0 60.0 60.0 60.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:78.50 stddev:9.06 (11.5%) stddev-sans-first:9.54 11:44:46 INFO - PROCESS | 23062 | Values: 79.0 77.0 78.0 78.0 78.0 80.0 83.0 77.0 107.0 83.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:127.50 stddev:4.74 (3.7%) stddev-sans-first:4.85 11:44:46 INFO - PROCESS | 23062 | Values: 129.0 131.0 128.0 120.0 119.0 125.0 120.0 132.0 127.0 123.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:160.00 stddev:3.82 (2.4%) stddev-sans-first:4.00 11:44:46 INFO - PROCESS | 23062 | Values: 157.0 153.0 161.0 154.0 159.0 160.0 163.0 156.0 160.0 165.0 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - PROCESS | 23062 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.75 (2.8%) stddev-sans-first:1.86 11:44:46 INFO - PROCESS | 23062 | Values: 63.0 64.0 63.0 62.0 63.0 67.0 61.0 62.0 61.0 62.0 11:44:46 INFO - PROCESS | 23062 | -------- Summary: end -------- 11:44:46 INFO - PROCESS | 23062 | 11:44:46 INFO - TEST-INFO | 23062: exit 0 11:44:46 INFO - TEST-OK | kraken | took 60565ms 11:44:46 INFO - SUITE-END | took 1170s 11:44:47 INFO - Completed test suite (00:19:30) 11:44:47 INFO - javascript benchmark 11:44:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7665.342126554949, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3417.572803399575, 3432.2449061206526, 3438.5873695156583, 3439.174598096457, 3461.2039230976875, 5717.485426311631, 5733.65598064116, 5743.913841292374, 5784.56615753818, 5790.10253410722, 5736.8852622947625, 5771.797987070443, 5772.076467765159, 5792.68140252286, 5800.709964501769, 5189.169732842755, 5256.868578285555, 5292.179712144604, 5309.946900531003, 5390.380106287768, 5243.895122097556, 5287.312649355578, 5328.387235467912, 5338.439463856278, 5359.678419294835, 5225.477452254782, 5243.528082472577, 5277.287566178575, 5301.1783173608155, 5340.305760251162, 5245.134552798802, 5320.680759154463, 5333.626646134772, 5334.306540149794, 5334.626576139691, 5129.615278854101, 5188.5849132069725, 5239.973800131013, 5306.6550674206055, 5307.893842123174, 5670.404607516192, 5749.798757043483, 5767.740451679684, 5776.277965254343, 5785.797497087582, 6348.523860710419, 6350.809475715736, 6353.162872084292, 6364.809055728336, 6373.171487706569, 6110.08348747687, 6184.041473571604, 6430.260520040209, 6436.292007879129, 6437.806865794034, 5829.795957141479, 5919.1713160157615, 5921.230240068763, 5932.970335148297, 5974.6713930733795, 6422.100905873182, 6445.4199122079235, 6474.773382931669, 6475.0, 6489.772857949949, 6044.909326360108, 6111.561351782736, 6136.20229370179, 6230.283517395467, 6243.406876346739, 6327.841803954938, 6331.715072821734, 6332.0, 6340.904886426707, 6365.8726825464155, 6229.875402492015, 6288.842778930563, 6293.0, 6315.747370105236, 6320.178376810985, 6096.329403765582, 6219.440250377397, 6264.0, 6271.122042913996, 6275.6862156891975, 4781.928271075936, 4785.688930219525, 4791.592714619227, 4794.065157294364, 4803.087413391444, 4274.294741367702, 4287.57124287575, 4289.2922667760095, 4290.420793192941, 4312.956870431255, 5867.853303667443, 6018.247719035121, 6036.879262414815, 6073.362296958844, 6139.539534534839, 6217.658028808459, 6228.781992630236, 6267.091271765568, 6275.466585340206, 6387.520935929824, 6035.155078289043, 6077.4226448487325, 6083.057126145454, 6084.30030546484, 6084.5436592255755, 5264.473552644705, 5357.43746906577, 5382.273393091961, 5392.379876314274, 5428.45715428454, 6459.935400645933, 6493.155889734398, 6557.082008518812, 6567.244766851778, 6598.73605055802, 6197.628142311295, 6396.680165991682, 6402.519811014099, 6402.935970640234, 6405.487560995202, 6385.042243663488, 6432.6462044588, 6467.159269294962, 6555.4427873629365, 6556.868862622816, 6236.158118653923, 6247.219097612799, 6248.750049997949, 6250.843728906631, 6261.248650161828, 6162.044883043135, 6285.402886725754, 6323.20959880015, 6329.936700632935, 6332.398422149889, 6130.398136741914, 6231.096491008869, 6265.4361107500545, 6268.686565671789, 6272.6236425814595, 6199.5040396767245, 6237.7193026314835, 6248.281447633581, 6254.437100660963, 6254.437100660963, 5998.25021872266, 6004.309504407049, 6029.51763858899, 6154.384561543989, 6157.0, 6192.473639740672, 6219.0, 6229.5327850410495, 6234.594751341148, 6253.093301471352, 6057.545684073624, 6061.909071363845, 6075.969620151871, 6081.5742897996715, 6105.145279660762], "value": 5795.502493509899, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.9565032622554, 630.3601844128209, 652.5921299188009, 656.2092678322622, 677.1129819935882, 35103.122421939435, 38994.0, 47590.28614570784, 48303.758481207544, 48672.0, 50543.74728126363, 50581.0, 50700.74649626756, 50962.49037509624, 51083.48916510834, 9132.589033493492, 9272.536373181347, 9286.349955503118, 9294.535273236312, 9311.441313521176, 9084.636614535411, 9167.44995300284, 9177.219936305388, 9195.908040919572, 9198.4480931144, 9150.40522366044, 9189.218916392081, 9192.816143677122, 9233.49215793131, 9264.30517711171, 9147.17675409213, 9159.633614655406, 9239.584218710173, 9243.0, 9245.491497967609, 9098.135677110664, 9155.038720934273, 9161.175494205487, 9168.495732734697, 9176.587053582605, 45795.54204457946, 45844.0, 46079.76960115212, 46126.0, 46213.768931155464, 3914.5693973662874, 3924.038610540436, 4199.68502362324, 4210.978945105255, 4571.291449825282, 31161.376772464424, 31992.0, 32248.677513225037, 37137.0, 37304.44043339352, 4768.2847572864, 4818.734969576672, 4822.180229361017, 4876.341693871317, 5044.646874718771, 263055.0, 266686.9999999981, 267157.0, 267425.0, 268921.0, 39160.80419597884, 40114.19771604551, 40196.39705404421, 67043.32956670469, 67491.0, 42208.7337379873, 42476.78761606172, 42493.362599561035, 42630.36054459186, 42636.3604545932, 17704.645907081787, 17767.0, 17853.7321940171, 17870.106494675216, 18003.18985645623, 14592.562223133324, 14696.412143514353, 14698.485553005594, 14760.704785904221, 14896.776548351783, 9362.438253704799, 9453.243740500744, 9500.287478439144, 9506.33455658111, 9543.665971690958, 3508.4212104553053, 3557.488067571272, 3595.802230877327, 3658.5243918290453, 3666.4683620874825, 1131.0555686002115, 1135.9943200283947, 1158.8377627132209, 1201.0571701214506, 1203.0676225924803, 34139.82930085383, 34252.65747342545, 34420.31159376798, 34512.13719656978, 34929.65070349315, 1178.157617303632, 1190.2858285029085, 1202.971459402216, 1251.7809383357876, 1255.2844878419214, 17630.2066407012, 17660.470185894443, 17678.646427071388, 17749.378771742926, 17773.555661108574, 601546.0, 889078.0, 895688.0, 899277.0, 965575.0, 62973.68513157497, 63747.36252637414, 63776.68111659412, 63815.68092159509, 63967.0, 1486.6357742353193, 1498.0487390507105, 1503.4812989518816, 1516.113073851787, 1523.5353217268619, 31986.0, 32787.0, 33250.33499329951, 33289.500657489676, 33798.986030419124, 55823.441765581825, 55897.72051139718, 56351.43648563462, 56401.43598563962, 56605.71697141488, 410985.0, 413211.0, 413217.0, 413778.0, 415992.0, 28732.13803585896, 29028.854855725585, 29514.409711805216, 30889.69110308868, 30959.69040309568, 51289.743551282, 51664.22503662373, 51721.224181638056, 52076.21885671642, 52550.47449525456, 42608.0, 42624.360634591125, 42902.78548607237, 43130.35304470373, 44485.33272000987, 41739.37390939078, 42163.7891810539, 42291.0, 42708.0, 43752.56247437485, 42651.0, 43519.564804351554, 43759.781201095066, 44137.33793993029, 44148.11703765971, 36560.0, 37435.2512949734, 37805.43291850569, 38551.42172867465, 38653.226935461695, 28929.56605650875, 29436.411271774872, 29535.85232073826, 29546.0, 29787.55318670265], "value": 20283.915148601893, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.7951024487756, 415.8918681142902, 416.4690020224213, 418.69435312222095, 434.20540411047784, 19995.60008799825, 20091.497712557175, 20555.177792888306, 20685.276015339467, 20997.0, 20000.599988000267, 20257.898710506463, 20674.793252067513, 21216.257430989917, 21317.893410532924, 5736.598438109324, 5900.704964751767, 5943.405659434044, 5947.970260148715, 5963.61236519627, 4331.523532411432, 5855.0, 5913.763449462038, 6303.212098487689, 6312.33720459352, 6185.381461853824, 6343.238811342645, 6343.904841427382, 6353.237611486628, 6660.733570657168, 6612.041254018189, 6612.735490580371, 6651.501137414713, 6655.434288085518, 6671.166104236971, 5078.4159821620615, 5386.2997810284805, 5394.298741163623, 5431.511163995259, 5920.141579470953, 14349.497767578188, 14538.781918271234, 20605.587888242302, 24317.27048188557, 24528.87735561311, 2303.9884800576056, 2323.7211534615953, 2551.0561092395747, 2671.2787547362104, 2793.9243391294294, 10342.689719308433, 10622.62820801276, 14702.809206794587, 15003.24983750819, 15120.168390738505, 1924.8460123190112, 2033.674612062063, 2056.105594066571, 2066.359428577146, 2127.1491403438595, 84666.0, 86004.56997714972, 86942.0, 88626.55686721524, 89384.55307723484, 11427.714307142389, 11565.132615053904, 12027.21823081497, 12102.757944841054, 12448.0, 16791.748123778154, 16898.239579218964, 16916.407925722542, 16928.49214523566, 17006.0, 8649.610767515476, 8747.343949203836, 8977.371583989057, 8978.147076027766, 8999.505027223435, 8613.870791938127, 8638.26574741154, 8705.6517739291, 8720.738377848675, 8915.197632213132, 5002.849914502571, 5040.79836806531, 5056.317397151411, 5095.974520127375, 5175.404828444777, 2019.5163343232805, 2035.816776490123, 2073.626747185491, 2091.163534586178, 2099.2757498662936, 1005.2259759984917, 1109.8335249712607, 1120.2046546951756, 1140.1434597901264, 1177.0995188680665, 19639.214431422868, 19693.60612787765, 19758.604827903648, 20614.27850025272, 20623.071961761758, 1054.235679132638, 1066.1524088349781, 1081.5944020992129, 1106.0819519798547, 1109.750306181119, 11168.162387820783, 11375.260608060615, 11481.827772583418, 11585.015273701829, 11664.475098620582, 531941.0, 532265.0, 534270.0, 549911.0, 553298.0, 99692.50153749184, 101925.0, 102761.0, 103191.48404257931, 103457.48271258596, 1088.3796236145322, 1105.5135740274254, 1148.5176225985106, 1150.5685367986837, 1156.4853640130061, 16530.66938661196, 18676.25294988185, 18684.0, 18762.343317983807, 19056.80943190606, 39501.40747888727, 41417.79291103525, 46065.0, 46376.768116159205, 47339.52660473351, 50380.0, 60966.390336097844, 61277.38722612717, 61493.69253153705, 61655.38344616497, 8878.289736820909, 9053.864192037256, 9131.77170570741, 9161.816763664556, 9369.203617692572, 13605.523806666719, 13637.86362136366, 13855.307234638027, 13890.791638125638, 14064.78902816479, 11935.940320298343, 11970.521179152736, 12182.147249692436, 12293.200941938745, 12340.876591234331, 12082.879171208528, 12243.020558355132, 12287.75424491523, 12403.813942791046, 12569.560065397667, 12395.0, 12580.182288151242, 12615.243085414904, 12668.809967850306, 12838.29389383593, 9028.729138125867, 9079.228265597234, 9218.124278193562, 9460.952695236756, 9525.333226674344, 12186.390680465764, 12186.57346992851, 12300.938495307466, 12334.259944403364, 12346.876531234573], "value": 9854.890164936474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1633.1181162172427, 1642.0640235066014, 1858.8327050565447, 1940.1092372365163, 1954.472292481031, 9573.377730447515, 9793.804123917518, 10160.390376577392, 10234.488275586218, 10236.795264094722, 9751.31740778144, 9851.605935762562, 9874.25943054272, 9880.505974701255, 9887.851682224773, 2471.3821544613847, 2508.6613307203565, 2513.0576033987254, 2514.2959971208, 2517.7356377580363, 2411.2163546847255, 2501.6372625969225, 2504.6243063540433, 2508.2475257422793, 2515.76100270474, 2417.5527527407485, 2422.527607116613, 2475.195561442529, 2481.1192026830486, 2481.2680259323542, 2440.792532634728, 2454.325060608347, 2460.434100156956, 2463.482668639597, 2482.2305085423486, 2407.4222186675247, 2428.91498797543, 2439.42673471734, 2455.312512496504, 2462.815288853343, 9567.904320956772, 9643.035696430372, 9643.421394716339, 9654.90345096547, 9655.855162172573, 5769.1923130761725, 5949.8810023799715, 5977.970110149421, 5980.551458640576, 5983.551233657493, 3507.91230219244, 3597.406427939387, 3670.504481894937, 3677.264547090566, 3705.2959937611768, 1122.2817396866012, 1123.3035517978906, 1140.726225705833, 1144.4907016377715, 1146.5814977533223, 13866.0, 13893.374798134108, 13971.09187902783, 13991.510297139654, 14003.439862405492, 4931.7040977541465, 4946.629002824802, 5088.956763863399, 5097.311862898536, 5098.770555325019, 10892.564297428173, 10901.672949811518, 10974.012338889539, 10978.505967231495, 10989.6153634624, 5695.117256825116, 5748.02283611787, 5794.478496935296, 5838.386969368155, 5843.590948633555, 4787.138315103245, 5229.163333866563, 5356.223347614574, 5364.409914909357, 5378.865528361822, 4133.6693064554765, 4172.916541669149, 4177.8537751178565, 4177.937330940038, 4212.241796476664, 1143.89704926557, 1208.6736581123223, 1209.3469526455792, 1219.0613227814533, 1225.0567063361161, 989.3717489394287, 1104.5195340027115, 1119.412308538024, 1119.6641007697658, 1124.8537690100234, 6800.795976120626, 6878.518503704692, 6895.620740859301, 6955.65221738911, 7074.22183559808, 459.9540045995441, 480.69475882814663, 483.56720734942735, 490.9558139767438, 497.7834641930772, 4444.177827101997, 4447.555244475591, 4477.686561940698, 4503.874031492127, 4514.210013247669, 12126.818097728541, 12679.93660031694, 12709.110362274738, 12713.364331783374, 12730.55443059507, 12394.442250098768, 12518.8933104053, 12651.557195498113, 12681.682957926125, 12695.0, 9271.95364023189, 9275.860862087075, 9286.767830804283, 9288.117628825386, 9313.53432328381, 6559.508036897157, 6633.568818026813, 6729.764458243938, 6790.1851777785005, 6829.760958366632, 11382.487788049722, 11390.974812266935, 11617.709557261136, 11697.415129243334, 11799.292042477478, 11611.361375124112, 11752.88247117552, 11792.823107653221, 11797.52809887595, 11857.347845868215, 7124.536905101152, 8041.87937180931, 8153.510789352657, 8316.875246871423, 8394.0766515682, 9712.077352651488, 9719.222462203148, 9723.9027609723, 9751.073648003428, 9789.9021009789, 8470.788230294293, 8664.436811607226, 8761.780955476164, 8787.121287871161, 8858.73423797287, 8033.8393232136195, 8040.0, 8210.727798356646, 8223.671053157806, 8312.127226641116, 7679.846403072019, 7874.645640946057, 7880.960595196987, 7887.171846955987, 7896.249856263646, 5922.851928701817, 5972.343042265435, 6013.87972240544, 6089.786857459968, 6171.84570385726, 5824.417558244142, 5825.621334613236, 5856.092305692625, 5889.764409423575, 6029.57792954489], "value": 5006.452016444985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.41626985315406, 348.5590727729422, 351.2132822477651, 352.7530728490058, 353.16476532999457, 5681.687507187103, 5701.629394089381, 5968.164456976021, 6032.607880487771, 6051.818445446638, 5764.682942438175, 5780.161876527901, 5793.986052440827, 5804.303483581976, 5816.534677225823, 4523.778579783457, 4539.137563862872, 4539.886502837422, 4558.111168322179, 4565.840195593139, 4424.690271680984, 4485.686001979862, 4497.955020449803, 4505.662075344346, 4566.13243483737, 4419.0499042705815, 4428.335749637564, 4445.799939002753, 4453.6659750518675, 4453.799579018936, 4479.283314669638, 4519.0, 4522.841700540465, 4528.977355113237, 4547.613452856478, 3869.8452061917487, 3973.6821054315587, 3995.800209989489, 4030.838766449368, 4038.3134867072376, 5519.917201241985, 5550.139728342114, 5565.6104072714925, 5568.693721845338, 5580.107182850725, 5074.238864170367, 5144.0, 5172.8965420691375, 5181.792728290864, 5182.533571978503, 5927.911081333784, 6051.757929682807, 6086.878262434727, 6103.29812071613, 6113.572049956505, 4370.497392799837, 4401.141777353418, 4409.140217657558, 4410.125696578941, 4410.360497727812, 6147.754089836446, 6320.399562041599, 6367.395097465734, 6374.0, 6407.935920640781, 4486.394336764561, 4518.254488009442, 4527.0, 4532.5694059064335, 4542.250528662799, 4563.224251877189, 4579.267317229294, 4599.724016559017, 4600.97699511507, 4601.308234682681, 5097.286379906816, 5169.689818610896, 5218.817341393033, 5235.712035838065, 5241.510282615727, 5899.911501327483, 6045.312359460725, 6128.908066379008, 6135.233095863017, 6141.785037523755, 1505.2473763118442, 1520.711064897666, 1521.3230112599788, 1523.9560900783, 1524.3140586736013, 957.3968399908014, 974.586849068853, 982.1553464020936, 988.9357191782511, 993.6919554937992, 5256.211568264791, 5290.9735451322495, 5313.335833020872, 5323.057084164252, 5344.465553444625, 5519.337679478408, 5534.363548191929, 5608.607397482218, 5662.037453632893, 5699.658020518699, 4765.785539650655, 5137.8896882493855, 5217.556507696812, 5288.206768984683, 5288.2596436498925, 2966.777491688132, 2998.2804127009363, 3002.9249268768017, 3003.684613115635, 3013.909582712522, 5678.375378708339, 5687.857803554944, 5729.742161602738, 5757.337906140848, 5789.565782566325, 5975.492083172892, 6500.374906273431, 6507.186601674791, 6512.804615861532, 6526.869462610721, 6520.902186467207, 6537.28089910119, 6548.738050477928, 6550.0, 6576.8355791105605, 6150.292716337678, 6365.172527571386, 6377.649229292433, 6383.234011918599, 6398.168238129014, 6279.026750853625, 6309.779157729641, 6315.210598675166, 6325.304216536269, 6340.365963403623, 6342.746290148342, 6523.706433210612, 6550.377714117151, 6591.242007169045, 6591.703373348307, 4416.33754936762, 4456.5766252205985, 4463.174312752021, 4463.709858859163, 4476.440444944382, 6168.013117901114, 6378.712957916812, 6409.647469389229, 6417.0, 6439.422341526356, 6191.25704915413, 6208.565400421927, 6212.161358216764, 6216.564840461125, 6266.843328916813, 6136.7852125175405, 6240.687965601793, 6243.562950593415, 6250.1874756281395, 6291.465225455888, 6081.179040829431, 6087.573869829246, 6132.202813634199, 6133.0, 6137.96931015342, 6223.284322302812, 6253.78111766086, 6255.437010669061, 6298.330942300203, 6322.304546499973, 5853.64878107315, 6058.878822423615, 6059.394060593905, 6082.239720034996, 6134.877302454015], "value": 4589.635635852788, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.8587997100506, 822.4941660878561, 835.9498430094195, 900.7973206028645, 929.6978481993353, 15513.146776927279, 16831.242594083265, 17138.742918856195, 17155.914220428895, 17166.914165429185, 15961.0, 16211.99999999997, 16243.918780406111, 16270.0, 16273.267702953366, 866.6533386645345, 893.0, 893.13366034946, 894.7852515396323, 898.9011208767031, 883.1080608585343, 886.5965985476593, 888.0409158109227, 888.9777755556098, 889.3507739350279, 929.1266209762836, 932.7341707613332, 936.0732874454309, 937.7983733497297, 938.3431597881477, 926.1849572376333, 927.6706769097009, 928.5914197752967, 928.633189889993, 928.9628414863397, 682.0928165539821, 682.4335801284972, 682.8156397772623, 684.5174152222721, 686.1800148822159, 14449.927750361287, 14549.34527946245, 14553.490627827976, 14586.124832509977, 14588.489402870848, 12264.938675306566, 12600.936995315056, 13006.544770932973, 13099.410526526233, 13343.599692009255, 11921.821172682417, 12048.819267710991, 12049.216800907912, 12116.636500904988, 12380.690482738004, 3826.1773718650625, 3886.067343837487, 3984.183242435294, 4000.8599699010397, 4017.1563971566006, 63898.0, 66472.667636662, 66847.0, 77265.61367193185, 79275.20724792793, 12830.55093071738, 12894.226346419246, 12982.35088245584, 12990.155639883566, 13001.674958125934, 21457.0, 22221.666674999888, 23230.65154022691, 23315.067397304258, 23331.95006224724, 7845.529268243924, 8280.544570048705, 8281.29608983243, 9323.766905827273, 9440.716778496657, 4577.22187228172, 4684.508126646721, 4821.228603423436, 4832.371791667061, 4905.583025442877, 3893.2602805467436, 3987.6610488108254, 3994.201159768058, 3998.8200530975596, 4000.599940005976, 638.1958731997717, 698.5215127637584, 701.2426579294452, 702.3222590200481, 702.9964850175717, 668.6489592963733, 700.5656492974389, 701.4283359062348, 705.1995984557564, 707.4163814852767, 9926.652567160114, 10038.598456061822, 10101.64644237463, 10135.442550659785, 10258.28192026566, 661.5832025823796, 680.2517231045908, 694.7464175575878, 712.4051417066704, 715.7029832619509, 4662.953370466252, 4667.603253723471, 4675.366183748575, 4684.74233917131, 4715.221510959884, 67745.05861149637, 69238.65380673166, 69435.30564694389, 108193.0, 122662.48018839174, 71534.0, 72857.6357118211, 96974.0, 101436.47845282327, 103287.0, 92001.53999229961, 92321.53839230762, 92509.29962801412, 93112.53443732738, 93353.53323233205, 7419.517731347445, 7497.400207983457, 7594.0, 9123.77190570241, 9192.54037298119, 39162.0, 51611.0, 51979.48020519746, 53745.0, 54015.0, 71496.14015439533, 72553.6372318135, 73233.16917077116, 75052.62473687597, 78016.0, 11811.940940295244, 12015.339156346485, 12422.689432764253, 12466.56367027186, 12550.0, 14049.578512644637, 14131.293435327987, 14341.067830590979, 14449.711005779614, 14598.854011459749, 13160.0, 13395.196288222738, 13474.730505389642, 13683.589492315246, 13915.0, 12476.937615311865, 12833.743325133632, 12974.0, 13129.671758205739, 13194.0, 12685.4291556882, 12707.174033687781, 12799.616011519669, 13066.412011459317, 13154.868451315364, 10462.476876156314, 10772.353658780497, 10818.242723009314, 10948.233623646269, 11003.119750420108, 11342.262752921033, 11405.600803971822, 11492.655220343404, 11524.308541487537, 11575.421228938689], "value": 7619.868755601787, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 111.0, 110.0, 110.0, 112.0, 109.0, 109.0, 111.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 155.0, 183.0, 124.0, 150.0, 151.0, 127.0, 174.0, 127.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 163.0, 163.0, 164.0, 162.0, 162.0, 163.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 180.0, 76.0, 77.0, 74.0, 76.0, 166.0, 77.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 147.0, 85.0, 85.0, 84.0, 143.0, 90.0, 85.0, 140.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 120.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 148.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 94.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 54.0, 56.0, 54.0, 55.0, 58.0, 56.0, 53.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 65.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 78.0, 78.0, 80.0, 83.0, 77.0, 107.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 128.0, 120.0, 119.0, 125.0, 120.0, 132.0, 127.0, 123.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 161.0, 154.0, 159.0, 160.0, 163.0, 156.0, 160.0, 165.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 62.0, 63.0, 67.0, 61.0, 62.0, 61.0, 62.0], "value": 62.8, "unit": "score"}]}]} 11:44:47 INFO - Return code: 0 11:44:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:47 ERROR - # TBPL SUCCESS # 11:44:47 INFO - Running post-action listener: _resource_record_post_action 11:44:47 INFO - ##### 11:44:47 INFO - ##### Finished run-tests step (success) 11:44:47 INFO - ##### 11:44:47 INFO - Running post-run listener: _resource_record_post_run 11:44:47 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 20480; Write bytes: 458219520; Read time: 284; Write time: 268528 11:44:47 INFO - TinderboxPrint: CPU usage
13.3% 11:44:47 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 284 11:44:47 INFO - TinderboxPrint: I/O write bytes / time
458,219,520 / 268,528 11:44:47 INFO - TinderboxPrint: CPU idle
8,195.1 (86.7%) 11:44:47 INFO - TinderboxPrint: CPU user
1,209.4 (12.8%) 11:44:47 INFO - TinderboxPrint: Swap in / out
0 / 0 11:44:47 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 4096; Write bytes: 234975232; Read time: 180; Write time: 185296 11:44:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 222932992; Read time: 104; Write time: 83216 11:44:47 INFO - Running post-run listener: _upload_blobber_files 11:44:47 INFO - Blob upload gear active. 11:44:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:47 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 11:44:47 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:47 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:48 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:44:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:44:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:49 INFO - (blobuploader) - INFO - Done attempting. 11:44:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:00 INFO - (blobuploader) - INFO - Done attempting. 11:45:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:45:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:01 INFO - (blobuploader) - INFO - Done attempting. 11:45:01 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:01 INFO - Return code: 0 11:45:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eca7a8adb240ef18505eb7c7641bc9d571328bac91d595ae55a751fa929fa4ac4437cdb1a08f864b831e3ddb38ddce53e88f1ddd0522ea8fc600e66d9a4f3973", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c3f69cd4a7c51c962197a9568f472eacca69c19f9339cb7dce31717688629320a036eef4cc9d185055503141d71fffbe52aaae1515824dd26f57ecac44db12b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fcfe5d19cb9ce808a98030564017ec04b71584b52c510a8bb3bd106c1c94ed603117bbec12e7cd89cedc8824efab55a208ee818eaa8d2efda65ea6b1dc7ac53"} 11:45:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:01 INFO - Contents: 11:45:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eca7a8adb240ef18505eb7c7641bc9d571328bac91d595ae55a751fa929fa4ac4437cdb1a08f864b831e3ddb38ddce53e88f1ddd0522ea8fc600e66d9a4f3973", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c3f69cd4a7c51c962197a9568f472eacca69c19f9339cb7dce31717688629320a036eef4cc9d185055503141d71fffbe52aaae1515824dd26f57ecac44db12b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fcfe5d19cb9ce808a98030564017ec04b71584b52c510a8bb3bd106c1c94ed603117bbec12e7cd89cedc8824efab55a208ee818eaa8d2efda65ea6b1dc7ac53"} 11:45:01 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:01 INFO - Copying logs to upload dir... 11:45:01 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.173046 ========= master_lag: 2.93 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-01 11:45:03.324610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:03.328332) ========= 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=337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eca7a8adb240ef18505eb7c7641bc9d571328bac91d595ae55a751fa929fa4ac4437cdb1a08f864b831e3ddb38ddce53e88f1ddd0522ea8fc600e66d9a4f3973", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c3f69cd4a7c51c962197a9568f472eacca69c19f9339cb7dce31717688629320a036eef4cc9d185055503141d71fffbe52aaae1515824dd26f57ecac44db12b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fcfe5d19cb9ce808a98030564017ec04b71584b52c510a8bb3bd106c1c94ed603117bbec12e7cd89cedc8824efab55a208ee818eaa8d2efda65ea6b1dc7ac53"} build_url:https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eca7a8adb240ef18505eb7c7641bc9d571328bac91d595ae55a751fa929fa4ac4437cdb1a08f864b831e3ddb38ddce53e88f1ddd0522ea8fc600e66d9a4f3973", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c3f69cd4a7c51c962197a9568f472eacca69c19f9339cb7dce31717688629320a036eef4cc9d185055503141d71fffbe52aaae1515824dd26f57ecac44db12b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fcfe5d19cb9ce808a98030564017ec04b71584b52c510a8bb3bd106c1c94ed603117bbec12e7cd89cedc8824efab55a208ee818eaa8d2efda65ea6b1dc7ac53"}' ========= master_lag: 0.51 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:03.845655) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:03.850028) ========= 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=337fe3f4b1febe37b85fccc40000019e-1470075352.88740-1848744669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.40 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:04.258299) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:45:04.258613) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:45:04.258875) ========= ========= Total master_lag: 3.91 =========