builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1470075887.41 results: success (0) buildid: 20160801070053 builduid: eaf10adbc6074edb9e3b1e3d32dab73b revision: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:47.412584) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:47.413054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:47.413599) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:47.909152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:47.909473) ========= 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=fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 11:24:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 69.9M=0s 2016-08-01 11:24:48 (69.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139067 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:48.114178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:48.114518) ========= 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=fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018442 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:48.176584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 11:24:48.176975) ========= 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=fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 11:24:48,275 truncating revision to first 12 chars 2016-08-01 11:24:48,275 Setting DEBUG logging. 2016-08-01 11:24:48,275 attempt 1/10 2016-08-01 11:24:48,275 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:48,900 unpacking tar archive at: mozilla-beta-bad9d4f5bf7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.978675 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 11:24:49.204074) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:49.204391) ========= script_repo_revision: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:49.204817) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:49.205117) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:49.217352) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-01 11:24:49.217756) ========= /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=fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:49 INFO - MultiFileLogger online at 20160801 11:24:49 in /builds/slave/test 11:24:49 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:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:49 INFO - {'append_to_log': False, 11:24:49 INFO - 'base_work_dir': '/builds/slave/test', 11:24:49 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:24:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:49 INFO - 'branch': 'Mozilla-Beta', 11:24:49 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:49 INFO - 'config_files': ('talos/linux_config.py',), 11:24:49 INFO - 'default_actions': ('clobber', 11:24:49 INFO - 'read-buildbot-config', 11:24:49 INFO - 'download-and-extract', 11:24:49 INFO - 'populate-webroot', 11:24:49 INFO - 'create-virtualenv', 11:24:49 INFO - 'install', 11:24:49 INFO - 'run-tests'), 11:24:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:49 INFO - 'download_minidump_stackwalk': True, 11:24:49 INFO - 'download_symbols': 'ondemand', 11:24:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:49 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:49 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:49 INFO - 'installer_path': 'installer.exe', 11:24:49 INFO - 'log_level': 'info', 11:24:49 INFO - 'log_name': 'talos', 11:24:49 INFO - 'log_to_console': True, 11:24:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:49 INFO - 'opt_config_files': (), 11:24:49 INFO - 'pip_index': False, 11:24:49 INFO - 'sps_profile': False, 11:24:49 INFO - 'sps_profile_interval': 0, 11:24:49 INFO - 'suite': 'dromaeojs-e10s', 11:24:49 INFO - 'system_bits': '32', 11:24:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:49 INFO - 'title': 'talos-linux64-ix-048', 11:24:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:49 INFO - 'use_talos_json': True, 11:24:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:49 INFO - 'work_dir': 'build'} 11:24:49 INFO - ##### 11:24:49 INFO - ##### Running clobber step. 11:24:49 INFO - ##### 11:24:49 INFO - Running pre-action listener: _resource_record_pre_action 11:24:49 INFO - Running main action method: clobber 11:24:49 INFO - rmtree: /builds/slave/test/build 11:24:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:49 INFO - Running post-action listener: _resource_record_post_action 11:24:49 INFO - ##### 11:24:49 INFO - ##### Finished clobber step (success) 11:24:49 INFO - ##### 11:24:49 INFO - ##### 11:24:49 INFO - ##### Running read-buildbot-config step. 11:24:49 INFO - ##### 11:24:49 INFO - Running pre-action listener: _resource_record_pre_action 11:24:49 INFO - Running main action method: read_buildbot_config 11:24:49 INFO - Using buildbot properties: 11:24:49 INFO - { 11:24:49 INFO - "project": "", 11:24:49 INFO - "product": "firefox", 11:24:49 INFO - "script_repo_revision": "production", 11:24:49 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:24:49 INFO - "repository": "", 11:24:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 11:24:49 INFO - "buildid": "20160801070053", 11:24:49 INFO - "pgo_build": "True", 11:24:49 INFO - "basedir": "/builds/slave/test", 11:24:49 INFO - "buildnumber": 109, 11:24:49 INFO - "slavename": "talos-linux64-ix-048", 11:24:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:24:49 INFO - "platform": "ubuntu64_hw", 11:24:49 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:24:49 INFO - "branch": "mozilla-beta", 11:24:49 INFO - "repo_path": "releases/mozilla-beta", 11:24:49 INFO - "revision": "bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2", 11:24:49 INFO - "stage_platform": "linux64-pgo", 11:24:49 INFO - "builduid": "eaf10adbc6074edb9e3b1e3d32dab73b", 11:24:49 INFO - "slavebuilddir": "test" 11:24:49 INFO - } 11:24:49 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:49 INFO - Running post-action listener: _resource_record_post_action 11:24:49 INFO - ##### 11:24:49 INFO - ##### Finished read-buildbot-config step (success) 11:24:49 INFO - ##### 11:24:49 INFO - ##### 11:24:49 INFO - ##### Running download-and-extract step. 11:24:49 INFO - ##### 11:24:49 INFO - Running pre-action listener: _resource_record_pre_action 11:24:49 INFO - Running main action method: download_and_extract 11:24:49 INFO - mkdir: /builds/slave/test/build/tests 11:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:49 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:49 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:49 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:49 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:49 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:55 INFO - Downloaded 1327 bytes. 11:24:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:55 INFO - Using the following test package requirements: 11:24:55 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:55 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:55 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:24:55 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:55 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 11:24:55 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:55 INFO - u'jsshell-linux-x86_64.zip'], 11:24:55 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:55 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:24:55 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:55 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:55 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 11:24:55 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:55 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 11:24:55 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:55 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:24:55 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:55 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:24:55 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:55 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:55 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:55 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:55 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:55 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:58 INFO - Downloaded 21968684 bytes. 11:24:58 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:58 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:59 INFO - Return code: 0 11:24:59 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:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:59 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:59 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:59 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:59 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:59 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:25:01 INFO - Downloaded 21968684 bytes. 11:25:01 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:25:01 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:25:02 INFO - Return code: 0 11:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:02 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:25:02 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:25:02 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:25:02 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:25:02 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:25:05 INFO - Downloaded 10833369 bytes. 11:25:05 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:25:05 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:25:05 INFO - Return code: 0 11:25:05 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:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:07 INFO - Downloaded 55264299 bytes. 11:25:07 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:25:07 INFO - mkdir: /builds/slave/test/properties 11:25:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:25:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:25:07 INFO - Contents: 11:25:07 INFO - build_url:https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:25:07 INFO - Running post-action listener: _resource_record_post_action 11:25:07 INFO - Running post-action listener: set_extra_try_arguments 11:25:07 INFO - ##### 11:25:07 INFO - ##### Finished download-and-extract step (success) 11:25:07 INFO - ##### 11:25:07 INFO - ##### 11:25:07 INFO - ##### Running populate-webroot step. 11:25:07 INFO - ##### 11:25:07 INFO - Running pre-action listener: _resource_record_pre_action 11:25:07 INFO - Running main action method: populate_webroot 11:25:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:25:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:25:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:25:07 INFO - '--tppagecycles', 11:25:07 INFO - '7'], 11:25:07 INFO - 'tests': ['tsvgm']}}, 11:25:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:25:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:25:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:25:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:25:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:25:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:25:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:07 INFO - 'talos_options': ['--disable-e10s'], 11:25:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:07 INFO - 'talos_options': ['--disable-e10s'], 11:25:07 INFO - 'tests': ['damp', 'tps']}, 11:25:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:07 INFO - 'tests': ['damp', 'tps']}, 11:25:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:25:07 INFO - 'tests': ['dromaeo_dom']}, 11:25:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:25:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:25:07 INFO - 'tests': ['a11yr', 11:25:07 INFO - 'ts_paint', 11:25:07 INFO - 'tpaint', 11:25:07 INFO - 'sessionrestore', 11:25:07 INFO - 'sessionrestore_no_auto_restore', 11:25:07 INFO - 'tabpaint']}, 11:25:07 INFO - 'other-e10s': {'tests': ['a11yr', 11:25:07 INFO - 'ts_paint', 11:25:07 INFO - 'tpaint', 11:25:07 INFO - 'sessionrestore', 11:25:07 INFO - 'sessionrestore_no_auto_restore', 11:25:07 INFO - 'tabpaint']}, 11:25:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:25:07 INFO - 'ts_paint', 11:25:07 INFO - 'tpaint', 11:25:07 INFO - 'sessionrestore', 11:25:07 INFO - 'sessionrestore_no_auto_restore', 11:25:07 INFO - 'tabpaint']}, 11:25:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:25:07 INFO - 'ts_paint', 11:25:07 INFO - 'tpaint', 11:25:07 INFO - 'sessionrestore', 11:25:07 INFO - 'sessionrestore_no_auto_restore', 11:25:07 INFO - 'tabpaint']}, 11:25:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:25:07 INFO - 'tests': ['a11yr', 11:25:07 INFO - 'ts_paint', 11:25:07 INFO - 'tpaint', 11:25:07 INFO - 'sessionrestore', 11:25:07 INFO - 'sessionrestore_no_auto_restore', 11:25:07 INFO - 'tabpaint']}, 11:25:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:25:07 INFO - 'tests': ['a11yr', 11:25:07 INFO - 'ts_paint', 11:25:07 INFO - 'tpaint', 11:25:07 INFO - 'sessionrestore', 11:25:07 INFO - 'sessionrestore_no_auto_restore', 11:25:07 INFO - 'tabpaint']}, 11:25:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:25:07 INFO - 'tests': ['tsvgx', 11:25:07 INFO - 'tsvgr_opacity', 11:25:07 INFO - 'tart', 11:25:07 INFO - 'tscrollx', 11:25:07 INFO - 'cart']}, 11:25:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:25:07 INFO - 'tsvgr_opacity', 11:25:07 INFO - 'tart', 11:25:07 INFO - 'tscrollx', 11:25:07 INFO - 'cart']}, 11:25:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:07 INFO - 'talos_options': ['--disable-e10s'], 11:25:07 INFO - 'tests': ['tp5o']}, 11:25:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:07 INFO - 'tests': ['tp5o']}, 11:25:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:07 INFO - 'talos_options': ['--disable-e10s', 11:25:07 INFO - '--xperf_path', 11:25:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:07 INFO - 'tests': ['tp5n']}, 11:25:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:07 INFO - 'talos_options': ['--xperf_path', 11:25:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:07 INFO - 'tests': ['tp5n']}}, 11:25:07 INFO - 'talos.zip': {'path': '', 11:25:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:25:07 INFO - Running post-action listener: _resource_record_post_action 11:25:07 INFO - ##### 11:25:07 INFO - ##### Finished populate-webroot step (success) 11:25:07 INFO - ##### 11:25:07 INFO - ##### 11:25:07 INFO - ##### Running create-virtualenv step. 11:25:07 INFO - ##### 11:25:07 INFO - Running pre-action listener: _resource_record_pre_action 11:25:07 INFO - Running main action method: create_virtualenv 11:25:07 INFO - Creating virtualenv /builds/slave/test/build/venv 11:25:07 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:25:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:25:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:25:07 INFO - Using real prefix '/usr' 11:25:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:25:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:25:10 INFO - Installing pip.................done. 11:25:10 INFO - Return code: 0 11:25:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:10 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 0x7fd867696f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1840350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cf1c0>, '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 0x18d00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0550>, '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': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', '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:25:10 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:25:10 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:25:10 INFO - Using env: {'DISPLAY': ':0', 11:25:10 INFO - 'HOME': '/home/cltbld', 11:25:10 INFO - 'LANG': 'en_US.UTF-8', 11:25:10 INFO - 'LANGUAGE': 'en_US:en', 11:25:10 INFO - 'LOGNAME': 'cltbld', 11:25:10 INFO - 'MAIL': '/var/mail/cltbld', 11:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:10 INFO - 'MOZ_NO_REMOTE': '1', 11:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:10 INFO - 'NO_EM_RESTART': '1', 11:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:10 INFO - 'PWD': '/builds/slave/test', 11:25:10 INFO - 'SHELL': '/bin/bash', 11:25:10 INFO - 'SHLVL': '1', 11:25:10 INFO - 'TERM': 'linux', 11:25:10 INFO - 'TMOUT': '86400', 11:25:10 INFO - 'USER': 'cltbld', 11:25:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', 11:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:10 INFO - '_': '/tools/buildbot/bin/python'} 11:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:11 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:25:11 INFO - Cleaning up... 11:25:11 INFO - Return code: 0 11:25:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:25:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:11 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 0x7fd867696f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1840350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cf1c0>, '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 0x18d00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0550>, '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': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', '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:25:11 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:25:11 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:25:11 INFO - Using env: {'DISPLAY': ':0', 11:25:11 INFO - 'HOME': '/home/cltbld', 11:25:11 INFO - 'LANG': 'en_US.UTF-8', 11:25:11 INFO - 'LANGUAGE': 'en_US:en', 11:25:11 INFO - 'LOGNAME': 'cltbld', 11:25:11 INFO - 'MAIL': '/var/mail/cltbld', 11:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:11 INFO - 'MOZ_NO_REMOTE': '1', 11:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:11 INFO - 'NO_EM_RESTART': '1', 11:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:11 INFO - 'PWD': '/builds/slave/test', 11:25:11 INFO - 'SHELL': '/bin/bash', 11:25:11 INFO - 'SHLVL': '1', 11:25:11 INFO - 'TERM': 'linux', 11:25:11 INFO - 'TMOUT': '86400', 11:25:11 INFO - 'USER': 'cltbld', 11:25:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', 11:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:11 INFO - '_': '/tools/buildbot/bin/python'} 11:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:11 INFO - Downloading/unpacking psutil>=3.1.1 11:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:13 INFO - Installing collected packages: psutil 11:25:13 INFO - Running setup.py install for psutil 11:25:13 INFO - building 'psutil._psutil_linux' extension 11:25:13 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:25:15 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:25:15 INFO - building 'psutil._psutil_posix' extension 11:25:15 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:25:15 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:25:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:15 INFO - Successfully installed psutil 11:25:15 INFO - Cleaning up... 11:25:15 INFO - Return code: 0 11:25:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd867696f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1840350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cf1c0>, '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 0x18d00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0550>, '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': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', '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:25:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:25:15 INFO - Using env: {'DISPLAY': ':0', 11:25:15 INFO - 'HOME': '/home/cltbld', 11:25:15 INFO - 'LANG': 'en_US.UTF-8', 11:25:15 INFO - 'LANGUAGE': 'en_US:en', 11:25:15 INFO - 'LOGNAME': 'cltbld', 11:25:15 INFO - 'MAIL': '/var/mail/cltbld', 11:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:15 INFO - 'MOZ_NO_REMOTE': '1', 11:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:15 INFO - 'NO_EM_RESTART': '1', 11:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:15 INFO - 'PWD': '/builds/slave/test', 11:25:15 INFO - 'SHELL': '/bin/bash', 11:25:15 INFO - 'SHLVL': '1', 11:25:15 INFO - 'TERM': 'linux', 11:25:15 INFO - 'TMOUT': '86400', 11:25:15 INFO - 'USER': 'cltbld', 11:25:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', 11:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:15 INFO - '_': '/tools/buildbot/bin/python'} 11:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:17 INFO - Installing collected packages: mozsystemmonitor 11:25:17 INFO - Running setup.py install for mozsystemmonitor 11:25:17 INFO - Successfully installed mozsystemmonitor 11:25:17 INFO - Cleaning up... 11:25:17 INFO - Return code: 0 11:25:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25: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:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd867696f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1840350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cf1c0>, '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 0x18d00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0550>, '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': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', '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:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:25:17 INFO - Using env: {'DISPLAY': ':0', 11:25:17 INFO - 'HOME': '/home/cltbld', 11:25:17 INFO - 'LANG': 'en_US.UTF-8', 11:25:17 INFO - 'LANGUAGE': 'en_US:en', 11:25:17 INFO - 'LOGNAME': 'cltbld', 11:25:17 INFO - 'MAIL': '/var/mail/cltbld', 11:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:17 INFO - 'MOZ_NO_REMOTE': '1', 11:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:17 INFO - 'NO_EM_RESTART': '1', 11:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:17 INFO - 'PWD': '/builds/slave/test', 11:25:17 INFO - 'SHELL': '/bin/bash', 11:25:17 INFO - 'SHLVL': '1', 11:25:17 INFO - 'TERM': 'linux', 11:25:17 INFO - 'TMOUT': '86400', 11:25:17 INFO - 'USER': 'cltbld', 11:25:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', 11:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:17 INFO - '_': '/tools/buildbot/bin/python'} 11:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:18 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25:19 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:19 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:19 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:19 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:19 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:19 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:20 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:20 INFO - warning: no files found matching '*.txt' 11:25:20 INFO - no previously-included directories found matching 'build' 11:25:20 INFO - no previously-included directories found matching 'dist' 11:25:20 INFO - no previously-included directories found matching '.git*' 11:25:20 INFO - Installing collected packages: jsonschema, functools32 11:25:20 INFO - Running setup.py install for functools32 11:25:20 INFO - warning: no files found matching '*.txt' 11:25:20 INFO - no previously-included directories found matching 'build' 11:25:20 INFO - no previously-included directories found matching 'dist' 11:25:20 INFO - no previously-included directories found matching '.git*' 11:25:20 INFO - Successfully installed jsonschema functools32 11:25:20 INFO - Cleaning up... 11:25:20 INFO - Return code: 0 11:25:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd867696f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1840350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cf1c0>, '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 0x18d00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0550>, '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': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', '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:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:25:20 INFO - Using env: {'DISPLAY': ':0', 11:25:20 INFO - 'HOME': '/home/cltbld', 11:25:20 INFO - 'LANG': 'en_US.UTF-8', 11:25:20 INFO - 'LANGUAGE': 'en_US:en', 11:25:20 INFO - 'LOGNAME': 'cltbld', 11:25:20 INFO - 'MAIL': '/var/mail/cltbld', 11:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:20 INFO - 'MOZ_NO_REMOTE': '1', 11:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:20 INFO - 'NO_EM_RESTART': '1', 11:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:20 INFO - 'PWD': '/builds/slave/test', 11:25:20 INFO - 'SHELL': '/bin/bash', 11:25:20 INFO - 'SHLVL': '1', 11:25:20 INFO - 'TERM': 'linux', 11:25:20 INFO - 'TMOUT': '86400', 11:25:20 INFO - 'USER': 'cltbld', 11:25:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', 11:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:20 INFO - '_': '/tools/buildbot/bin/python'} 11:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:20 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:22 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:23 INFO - Downloading docopt-0.6.1.tar.gz 11:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:23 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:23 INFO - Running setup.py install for blobuploader 11:25:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:23 INFO - Running setup.py install for requests 11:25:23 INFO - Running setup.py install for docopt 11:25:23 INFO - Successfully installed blobuploader requests docopt 11:25:23 INFO - Cleaning up... 11:25:23 INFO - Return code: 0 11:25:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:23 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 0x7fd867696f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1840350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cf1c0>, '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 0x18d00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0550>, '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': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', '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:25:23 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:25:23 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:25:23 INFO - Using env: {'DISPLAY': ':0', 11:25:23 INFO - 'HOME': '/home/cltbld', 11:25:23 INFO - 'LANG': 'en_US.UTF-8', 11:25:23 INFO - 'LANGUAGE': 'en_US:en', 11:25:23 INFO - 'LOGNAME': 'cltbld', 11:25:23 INFO - 'MAIL': '/var/mail/cltbld', 11:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:23 INFO - 'MOZ_NO_REMOTE': '1', 11:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:23 INFO - 'NO_EM_RESTART': '1', 11:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:23 INFO - 'PWD': '/builds/slave/test', 11:25:23 INFO - 'SHELL': '/bin/bash', 11:25:23 INFO - 'SHLVL': '1', 11:25:23 INFO - 'TERM': 'linux', 11:25:23 INFO - 'TMOUT': '86400', 11:25:23 INFO - 'USER': 'cltbld', 11:25:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', 11:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:23 INFO - '_': '/tools/buildbot/bin/python'} 11:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:24 INFO - Running setup.py (path:/tmp/pip-6q2gQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:24 INFO - Running setup.py (path:/tmp/pip-q2Mpgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:24 INFO - Running setup.py (path:/tmp/pip-hqZ00e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:24 INFO - Running setup.py (path:/tmp/pip-VI0Gvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:24 INFO - Running setup.py (path:/tmp/pip-BA1CNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:24 INFO - Running setup.py (path:/tmp/pip-Qdshwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:24 INFO - Running setup.py (path:/tmp/pip-X2ZLKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:24 INFO - Running setup.py (path:/tmp/pip-OYc7e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:24 INFO - Running setup.py (path:/tmp/pip-7vIsmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:24 INFO - Running setup.py (path:/tmp/pip-Qq01la-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:24 INFO - Running setup.py (path:/tmp/pip-FRNx2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:24 INFO - Running setup.py (path:/tmp/pip-Di6MeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:25 INFO - Running setup.py (path:/tmp/pip-bHtj4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:25 INFO - Running setup.py (path:/tmp/pip-7bm_OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:25 INFO - Running setup.py (path:/tmp/pip-0tfgnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:25 INFO - Running setup.py (path:/tmp/pip-MelbeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:25 INFO - Running setup.py (path:/tmp/pip-ybLCnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:25 INFO - Running setup.py install for manifestparser 11:25:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:25 INFO - Running setup.py install for mozcrash 11:25:25 INFO - Running setup.py install for mozdebug 11:25:25 INFO - Running setup.py install for mozdevice 11:25:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:25:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:25 INFO - Running setup.py install for mozfile 11:25:25 INFO - Running setup.py install for mozhttpd 11:25:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:25 INFO - Running setup.py install for mozinfo 11:25:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:26 INFO - Running setup.py install for mozInstall 11:25:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:26 INFO - Running setup.py install for mozleak 11:25:26 INFO - Running setup.py install for mozlog 11:25:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:26 INFO - Running setup.py install for moznetwork 11:25:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:26 INFO - Running setup.py install for mozprocess 11:25:26 INFO - Running setup.py install for mozprofile 11:25:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:26 INFO - Running setup.py install for mozrunner 11:25:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:26 INFO - Running setup.py install for mozscreenshot 11:25:26 INFO - Running setup.py install for moztest 11:25:27 INFO - Running setup.py install for mozversion 11:25:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:27 INFO - Cleaning up... 11:25:27 INFO - Return code: 0 11:25:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:27 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 0x7fd867696f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1840350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cf1c0>, '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 0x18d00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0550>, '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': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', '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:25:27 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:25:27 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:25:27 INFO - Using env: {'DISPLAY': ':0', 11:25:27 INFO - 'HOME': '/home/cltbld', 11:25:27 INFO - 'LANG': 'en_US.UTF-8', 11:25:27 INFO - 'LANGUAGE': 'en_US:en', 11:25:27 INFO - 'LOGNAME': 'cltbld', 11:25:27 INFO - 'MAIL': '/var/mail/cltbld', 11:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:27 INFO - 'MOZ_NO_REMOTE': '1', 11:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:27 INFO - 'NO_EM_RESTART': '1', 11:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:27 INFO - 'PWD': '/builds/slave/test', 11:25:27 INFO - 'SHELL': '/bin/bash', 11:25:27 INFO - 'SHLVL': '1', 11:25:27 INFO - 'TERM': 'linux', 11:25:27 INFO - 'TMOUT': '86400', 11:25:27 INFO - 'USER': 'cltbld', 11:25:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', 11:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:27 INFO - '_': '/tools/buildbot/bin/python'} 11:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:27 INFO - Running setup.py (path:/tmp/pip-LMhMf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:27 INFO - Running setup.py (path:/tmp/pip-i_tw4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:27 INFO - Running setup.py (path:/tmp/pip-ydH9I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:27 INFO - Running setup.py (path:/tmp/pip-HCtJuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:27 INFO - Running setup.py (path:/tmp/pip-_5vzg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:27 INFO - Running setup.py (path:/tmp/pip-e4hZGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:27 INFO - Running setup.py (path:/tmp/pip-XXU5T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:27 INFO - Running setup.py (path:/tmp/pip-DXoLUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:27 INFO - Running setup.py (path:/tmp/pip-4RlEac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:28 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:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:28 INFO - Running setup.py (path:/tmp/pip-39aZOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:28 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:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:28 INFO - Running setup.py (path:/tmp/pip-Px9wca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:28 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:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:28 INFO - Running setup.py (path:/tmp/pip-rSjShJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:28 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:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:28 INFO - Running setup.py (path:/tmp/pip-GMw8CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:28 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:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:28 INFO - Running setup.py (path:/tmp/pip-K7ykp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:28 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:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:28 INFO - Running setup.py (path:/tmp/pip-EBksPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:28 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:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:28 INFO - Running setup.py (path:/tmp/pip-_EXtXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:28 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:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:28 INFO - Running setup.py (path:/tmp/pip-NJxoPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:28 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:25:28 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:25:28 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:25:28 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:25:28 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:25:28 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:25:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:28 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:28 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:28 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:28 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:28 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:28 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:30 INFO - Downloading blessings-1.6.tar.gz 11:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:30 INFO - Installing collected packages: blessings 11:25:30 INFO - Running setup.py install for blessings 11:25:30 INFO - Successfully installed blessings 11:25:30 INFO - Cleaning up... 11:25:30 INFO - Return code: 0 11:25:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:30 INFO - Reading from file tmpfile_stdout 11:25:30 INFO - Current package versions: 11:25:30 INFO - argparse == 1.2.1 11:25:30 INFO - blessings == 1.6 11:25:30 INFO - blobuploader == 1.2.4 11:25:30 INFO - docopt == 0.6.1 11:25:30 INFO - functools32 == 3.2.3-2 11:25:30 INFO - jsonschema == 2.5.1 11:25:30 INFO - manifestparser == 1.1 11:25:30 INFO - mozInstall == 1.12 11:25:30 INFO - mozcrash == 0.17 11:25:30 INFO - mozdebug == 0.1 11:25:30 INFO - mozdevice == 0.48 11:25:30 INFO - mozfile == 1.2 11:25:30 INFO - mozhttpd == 0.7 11:25:30 INFO - mozinfo == 0.9 11:25:30 INFO - mozleak == 0.1 11:25:30 INFO - mozlog == 3.2 11:25:30 INFO - moznetwork == 0.27 11:25:30 INFO - mozprocess == 0.23 11:25:30 INFO - mozprofile == 0.28 11:25:30 INFO - mozrunner == 6.12 11:25:30 INFO - mozscreenshot == 0.1 11:25:30 INFO - mozsystemmonitor == 0.3 11:25:30 INFO - moztest == 0.7 11:25:30 INFO - mozversion == 1.4 11:25:30 INFO - psutil == 3.1.1 11:25:30 INFO - requests == 1.2.3 11:25:30 INFO - wsgiref == 0.1.2 11:25:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:30 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 0x7fd867696f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1840350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cf1c0>, '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 0x18d00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0550>, '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': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', '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:25:30 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:25:30 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:25:30 INFO - Using env: {'DISPLAY': ':0', 11:25:30 INFO - 'HOME': '/home/cltbld', 11:25:30 INFO - 'LANG': 'en_US.UTF-8', 11:25:30 INFO - 'LANGUAGE': 'en_US:en', 11:25:30 INFO - 'LOGNAME': 'cltbld', 11:25:30 INFO - 'MAIL': '/var/mail/cltbld', 11:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:30 INFO - 'MOZ_NO_REMOTE': '1', 11:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:30 INFO - 'NO_EM_RESTART': '1', 11:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:30 INFO - 'PWD': '/builds/slave/test', 11:25:30 INFO - 'SHELL': '/bin/bash', 11:25:30 INFO - 'SHLVL': '1', 11:25:30 INFO - 'TERM': 'linux', 11:25:30 INFO - 'TMOUT': '86400', 11:25:30 INFO - 'USER': 'cltbld', 11:25:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', 11:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:30 INFO - '_': '/tools/buildbot/bin/python'} 11:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:31 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:25:31 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:25:31 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:25:31 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:25:31 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:25:31 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:25:31 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:25:31 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:25:31 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:25:31 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:25:31 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:25:31 INFO - Cleaning up... 11:25:31 INFO - Return code: 0 11:25:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:31 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 0x7fd867696f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1840350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cf1c0>, '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 0x18d00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0550>, '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': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', '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:25:31 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:25:31 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:25:31 INFO - Using env: {'DISPLAY': ':0', 11:25:31 INFO - 'HOME': '/home/cltbld', 11:25:31 INFO - 'LANG': 'en_US.UTF-8', 11:25:31 INFO - 'LANGUAGE': 'en_US:en', 11:25:31 INFO - 'LOGNAME': 'cltbld', 11:25:31 INFO - 'MAIL': '/var/mail/cltbld', 11:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:31 INFO - 'MOZ_NO_REMOTE': '1', 11:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:31 INFO - 'NO_EM_RESTART': '1', 11:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:31 INFO - 'PWD': '/builds/slave/test', 11:25:31 INFO - 'SHELL': '/bin/bash', 11:25:31 INFO - 'SHLVL': '1', 11:25:31 INFO - 'TERM': 'linux', 11:25:31 INFO - 'TMOUT': '86400', 11:25:31 INFO - 'USER': 'cltbld', 11:25:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', 11:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:31 INFO - '_': '/tools/buildbot/bin/python'} 11:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:31 INFO - Cleaning up... 11:25:31 INFO - Return code: 0 11:25:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:25:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:31 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 0x7fd867696f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1840350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cf1c0>, '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 0x18d00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0550>, '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': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', '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:25:31 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:25:31 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:25:31 INFO - Using env: {'DISPLAY': ':0', 11:25:31 INFO - 'HOME': '/home/cltbld', 11:25:31 INFO - 'LANG': 'en_US.UTF-8', 11:25:31 INFO - 'LANGUAGE': 'en_US:en', 11:25:31 INFO - 'LOGNAME': 'cltbld', 11:25:31 INFO - 'MAIL': '/var/mail/cltbld', 11:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:31 INFO - 'MOZ_NO_REMOTE': '1', 11:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:31 INFO - 'NO_EM_RESTART': '1', 11:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:31 INFO - 'PWD': '/builds/slave/test', 11:25:31 INFO - 'SHELL': '/bin/bash', 11:25:31 INFO - 'SHLVL': '1', 11:25:31 INFO - 'TERM': 'linux', 11:25:31 INFO - 'TMOUT': '86400', 11:25:31 INFO - 'USER': 'cltbld', 11:25:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', 11:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:31 INFO - '_': '/tools/buildbot/bin/python'} 11:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:31 INFO - Downloading/unpacking flake8 11:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:25:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:25:33 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:33 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:33 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:33 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:33 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:33 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:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:25:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:25:33 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:33 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:33 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:33 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:33 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:33 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:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:25:33 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:33 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:33 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:33 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:33 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:33 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:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:25:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:34 INFO - no previously-included directories found matching 'docs/_build' 11:25:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:25:34 INFO - Running setup.py install for pep8 11:25:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:34 INFO - no previously-included directories found matching 'docs/_build' 11:25:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:25:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:25:34 INFO - Cleaning up... 11:25:34 INFO - Return code: 0 11:25:34 INFO - Running post-action listener: _resource_record_post_action 11:25:34 INFO - Running post-action listener: _start_resource_monitoring 11:25:34 INFO - Starting resource monitoring. 11:25:34 INFO - ##### 11:25:34 INFO - ##### Finished create-virtualenv step (success) 11:25:34 INFO - ##### 11:25:34 INFO - ##### 11:25:34 INFO - ##### Running install step. 11:25:34 INFO - ##### 11:25:34 INFO - Running pre-action listener: _resource_record_pre_action 11:25:34 INFO - Running main action method: install 11:25:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:34 INFO - Reading from file tmpfile_stdout 11:25:34 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:34 INFO - Reading from file tmpfile_stdout 11:25:34 INFO - Output received: 11:25:34 INFO - Usage: mozinstall [options] installer 11:25:34 INFO - Options: 11:25:34 INFO - -h, --help show this help message and exit 11:25:34 INFO - -d DEST, --destination=DEST 11:25:34 INFO - Directory to install application into. [default: 11:25:34 INFO - "/builds/slave/test"] 11:25:34 INFO - --app=APP Application being installed. [default: firefox] 11:25:34 INFO - mkdir: /builds/slave/test/build/application 11:25:34 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:34 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:47 INFO - Reading from file tmpfile_stdout 11:25:47 INFO - Output received: 11:25:47 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:47 INFO - Running post-action listener: _resource_record_post_action 11:25:47 INFO - ##### 11:25:47 INFO - ##### Finished install step (success) 11:25:47 INFO - ##### 11:25:47 INFO - ##### 11:25:47 INFO - ##### Running run-tests step. 11:25:47 INFO - ##### 11:25:47 INFO - Running pre-action listener: _resource_record_pre_action 11:25:47 INFO - Running main action method: run_tests 11:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:47 INFO - Python 2.7.3 11:25:47 INFO - Return code: 0 11:25:47 INFO - grabbing minidump binary from tooltool 11:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:47 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 0x18cf1c0>, '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 0x18d00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d0550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:47 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:47 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:47 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:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:48 INFO - Return code: 0 11:25:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:25:48 INFO - Return code: 0 11:25:48 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-048', '--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:48 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-048 --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:48 INFO - Using env: {'DISPLAY': ':0', 11:25:48 INFO - 'HOME': '/home/cltbld', 11:25:48 INFO - 'LANG': 'en_US.UTF-8', 11:25:48 INFO - 'LANGUAGE': 'en_US:en', 11:25:48 INFO - 'LOGNAME': 'cltbld', 11:25:48 INFO - 'MAIL': '/var/mail/cltbld', 11:25:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:48 INFO - 'MOZ_NO_REMOTE': '1', 11:25:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:48 INFO - 'NO_EM_RESTART': '1', 11:25:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:48 INFO - 'PWD': '/builds/slave/test', 11:25:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:48 INFO - 'SHELL': '/bin/bash', 11:25:48 INFO - 'SHLVL': '1', 11:25:48 INFO - 'TERM': 'linux', 11:25:48 INFO - 'TMOUT': '86400', 11:25:48 INFO - 'USER': 'cltbld', 11:25:48 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597', 11:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:48 INFO - '_': '/tools/buildbot/bin/python'} 11:25:48 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-048', '--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:49 INFO - mozversion application_buildid: 20160801070053 11:25:49 INFO - mozversion application_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:49 INFO - mozversion application_display_name: Firefox 11:25:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:49 INFO - mozversion application_name: Firefox 11:25:49 INFO - mozversion application_remotingname: firefox 11:25:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:49 INFO - mozversion application_vendor: Mozilla 11:25:49 INFO - mozversion application_version: 49.0 11:25:49 INFO - mozversion platform_buildid: 20160801070053 11:25:49 INFO - mozversion platform_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:49 INFO - mozversion platform_version: 49.0 11:25:49 INFO - using testdate: 1470075949 11:25:49 INFO - actual date: 1470075949 11:25:49 INFO - starting webserver on 'localhost:42065' 11:25:49 INFO - SUITE-START | Running 2 tests 11:25:49 INFO - TEST-START | dromaeo_css 11:25:49 INFO - operating with platform_type : linux_ 11:25:49 INFO - Initialising browser for dromaeo_css test... 11:25:49 INFO - TEST-INFO | started process 3330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9vlNXo/profile http://localhost:42065/getInfo.html) 11:25:56 INFO - PROCESS | 3330 | __metrics Screen width/height:1600/1200 11:25:56 INFO - PROCESS | 3330 | colorDepth:24 11:25:56 INFO - PROCESS | 3330 | Browser inner width/height: 1024/697 11:25:56 INFO - PROCESS | 3330 | __metrics 11:25:56 ERROR - PROCESS | 3330 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:25:57 INFO - TEST-INFO | 3330: exit 0 11:25:57 INFO - Browser initialized. 11:25:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:57 INFO - TEST-INFO | started process 3463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9vlNXo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:09 INFO - PROCESS | 3463 | RSS: Main: 152907776 11:26:09 INFO - PROCESS | 3463 | 11:26:59 INFO - PROCESS | 3463 | 1470076019135 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:29:07 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:42065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42065/tests/dromaeo/cssquery-ext.html) 11:29:08 INFO - PROCESS | 3463 | RSS: Main: 158019584 11:29:08 INFO - PROCESS | 3463 | 11:32:10 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:42065/tests/dromaeo/cssquery-ext.html (next: http://localhost:42065/tests/dromaeo/cssquery-jquery.html) 11:32:10 INFO - PROCESS | 3463 | RSS: Main: 154636288 11:32:10 INFO - PROCESS | 3463 | 11:35:12 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:42065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42065/tests/dromaeo/cssquery-mootools.html) 11:35:13 INFO - PROCESS | 3463 | RSS: Main: 153763840 11:35:13 INFO - PROCESS | 3463 | 11:38:14 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:42065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42065/tests/dromaeo/cssquery-prototype.html) 11:38:15 INFO - PROCESS | 3463 | RSS: Main: 155475968 11:38:15 INFO - PROCESS | 3463 | 11:41:17 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:42065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42065/tests/dromaeo/cssquery-yui.html) 11:41:18 INFO - PROCESS | 3463 | RSS: Main: 154718208 11:41:18 INFO - PROCESS | 3463 | 11:44:20 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:42065/tests/dromaeo/cssquery-yui.html (next: http://localhost:42065/tests/dromaeo/cssquery-dojo.html) 11:44:20 INFO - PROCESS | 3463 | RSS: Main: 158973952 11:44:20 INFO - PROCESS | 3463 | 11:44:20 INFO - PROCESS | 3463 | __start_tp_report 11:44:20 INFO - PROCESS | 3463 | _x_x_mozilla_page_load 11:44:20 INFO - PROCESS | 3463 | _x_x_mozilla_page_load_details 11:44:20 INFO - PROCESS | 3463 | |i|pagename|runs| 11:44:20 INFO - PROCESS | 3463 | |0;dojo.html;3448.431008883536;3459.8443070061844;3466.3933811582965;3471.44456886898;3484.268303656232;5726.3700992890745;5758.884822303551;5794.623349482281;5805.042168042268;5816.563757718167;5720.656760594367;5738.42615738426;5750.108733146369;5792.6814025228705;5796.507296879759;5169.741512924348;5194.065068287707;5231.633785635007;5268.157094864822;5301.045811753883;5151.536361727443;5191.299174611436;5217.3217481727515;5226.242194881759;5231.084560201968;5222.086134926391;5232.843014709565;5296.576273898079;5301.549368303698;5326.733663316838;4997.975010124963;5224.164133738622;5236.450172731847;5304.9655317213155;5309.7610607522565;5071.2139618359215;5100.515451032146;5129.435762066169;5149.742512874342;5172.793088276464;5665.263515742969;5679.403662615448;5689.089745640677;5690.203371527948;5696.060150075233;6222.657753823538;6246.469050130744;6249.593776404565;6266.530010249204;6275.905861412082;6120.69094295093;6125.693715314261;6149.538784591129;6186.628802271878;6228.813135605939;5810.070388737824;5816.389279125716;5816.709164541756;5847.678377689225;5866.853328666774;6176.567640265228;6368.076628888785;6384.553081284265;6386.521010924199;6390.137331460193;6054.485368743706;6058.394160583906;6078.149059131725;6140.17107690456;6176.969115154396;6260.906086408708;6285.811425657238;6298.275698294755;6302.4958003359625;6303.716332764945;6009.819705408845;6144.446999770043;6253.749850005949;6257.843553911098;6277.435030847246;6136.274005700925;6244.1570387997945;6267.655278959701;6268.247810262797;6271.937280627227;4730.385049943486;4738.763061846894;4745.1695953208055;4752.310914917318;4764.213904705754;4161.979190104091;4166.729162604421;4185.518665353462;4215.641670457984;4232.111256636079;5791.942080579141;5936.7328470218945;5987.221661184105;6041;6047.667378294236;6334.873302533923;6375.521835862236;6376.872462550723;6382.266039405527;6383;5881.323647780475;5900.1149827526215;5941.31674857397;6069.969650151721;6084.330723620398;5285.127953887565;5290.28581141541;5304.496072873071;5329.81345652908;5386.649867758583;6400.967995159995;6426.907425737636;6436.324185960407;6448.193975753031;6526.053722210348;6069.484093852072;6162.506999440124;6313.652749098844;6332.366763323631;6334.588251763805;6384.585001974857;6508.284088750139;6521.152250207443;6530.738770449128;6532.41208291256;6187.659678717714;6197.783077592263;6199.876002479835;6203.2245969253845;6206.813795586139;6073.635581865102;6135.875804921915;6167.321594624677;6248.906266406098;6303.936960630518;6071.058985857199;6111.908321375094;6112.510999120149;6119.296280927572;6121.3878612140215;6033.577649564664;6093.634381937098;6123.601965872204;6129.693515324305;6130.601510901777;5818.0981947798155;5825.679587622722;5834.445727655866;5863.20846685692;6035.094735789667;5955.136505206808;5996;6009.849753756191;6028.306744724413;6034.974054410848;5889.676067816311;5890.2342695449315;5893.970530147321;5901;5901.350851406428 11:44:20 INFO - PROCESS | 3463 | |1;ext.html;623.9188905442292;634.923804151962;647.1231481342777;674.6559254780062;685.7291369908885;46272.53727462724;47745;47861.28208076882;47895.281570776424;51560;49821;50409.74795126019;50536.24195637059;50699;50794.74602626991;9078.818423631523;9320.067993200659;9327.113924177193;9337.253019758436;9343.813123737522;9121.635134594608;9129.908700912973;9174.449533028006;9178.724638260863;9205.033471485498;9197.494137822418;9221.031791661879;9221.40060896043;9233.538323083852;9291.210247129002;9141.72574822753;9173.678921237724;9185.17333439987;9185.49479778612;9226.354155209105;9126.68056618022;9166.358354915159;9182.908170918272;9236.907630923739;9243.584038718274;45084.54915450869;45259.77370113161;45335.31997020047;45365.546344536466;45503.862403439845;3821.503204583414;4352.978235108804;4566.680332376735;4571.062932098912;4696.037312350994;34044.319113617836;34599.4810077849;34782;34936.82531587351;35095.6490435095;4760.928586071212;4774.665773395864;4786.832460863888;4828.88348909035;4848.248521479177;367601;371883;371973;372729.1363543192;373693;67358;67771.66114169496;67790;67883.3211667887;67925.32074679289;41007.38488922668;41950;42062;44166.89582760393;44180;19377.61244775125;19426.611467770566;19832.90083549573;19869.503262418268;19880.304189353305;14356.856431435552;14400.207988560729;14445.349959251858;14496.565103046925;14581.270936453135;21529.461763456038;21726.23958161457;21730.78269217319;21791.67312490314;21886.343409697736;7632.923670763333;7639.579823109671;7799.571023593643;7829.960850195826;7894.328982036591;1092.5356723392526;1152.1474109159162;1178.9469473873526;1188.976220475603;1251.9311437871004;34048.1487962798;34333.656663433045;34422.65577344244;34545.65454345424;35154.64845351514;1074.0762943868267;1150.9597164099384;1153.1985270237271;1163.4938801621322;1197.437204513877;17985.370512032016;18068.36760713395;18109.54726131831;18267.543311417056;18364.540886477946;591899;879003;885341;895870;901156;62872.68563657152;64153;64205.357946419936;64444;64478.677606612604;1492.2613306413177;1493.6116609681344;1498.752705803552;1508.58513908676;1512.4101600375861;32618.34763304673;33189.83405082959;33434.66565334413;33654.66345336515;34214.657853421144;54834;55296.44703552913;55360.72319638376;55470.44529554653;55521.44478555163;315785;317121;318064;318781;319992;31009.224769380042;31096.378072438878;31660.5250921241;31688.20779480439;31808.840955795073;50064.49935500598;50681.49318506915;50846;51689.224661630855;51714;42237.78881105575;43101.7844910786;43562.782186088865;43605.34591981059;44297.77851110724;42816.357754633085;43382;43646.56353436425;43856;44228.11543769171;42521.1495770089;42821.357679635454;43180.78409608058;43353.56646433495;43746.56253437425;36617.90146295616;37037.62962370342;37496.43755343727;37548.62451375451;38108;29252.414951700423;29498.705012949595;29568;29650.110496685134;29804 11:44:20 INFO - PROCESS | 3463 | |2;jquery.html;424.2024993013135;428.14584903118276;430.02384586987534;430.8427423990241;443.00987293399265;19030.714539281904;20094.799052009475;20871.269505567307;20963.37109886702;21017.47456313593;19432.417027489162;19771.70342444861;20064.799352006474;20582.794172058275;20697.586048279027;5822.767089316422;6043.637381757087;6081.1790408294755;6085.300190478085;6089.6955152242435;5839.270091238595;6023.156758053876;6037.849053773647;6041.758329666808;6052.182955301022;5948.702564871761;5952.851178720523;5989.251343582052;6013.518918486532;6025.879482410349;5767.279090113736;5919.852003699899;5935.258092738408;5950.553708471882;5976.3724808895095;5279.894402111936;5294.179402192666;5300.655457395295;5326.707031113326;5339.439358867341;24025.879870600536;24491.26526204199;24659.136930207536;24685.50628987428;25090.623640645405;2469.2345372934446;2530.9240722778345;2579.84520928743;2585.961210581824;2608.4000679843743;15510.922445387701;15518.922405388013;15588.688226235412;15635.296411661502;15844.52466426009;2022.9291974780813;2114.2917122763893;2168.533765240465;2169.5227050048966;2178.814800741939;78845.60577197134;80104.59947700224;80553.19446805515;81043.5947820263;81840.18159818384;11102.888971110347;11276.605318813967;11451.828222576669;11653.708657283467;11794.646160615195;15963.920180399024;16005.279762410719;16067.634251088555;16120.355185792438;16184.67630647404;8685;9012.594433250519;9113.681021164228;9237.12247336502;9260.490673012915;9040.095990400907;9048.819023619491;9105.089491050841;9108.316876234308;9139.543022848831;7068.964655176691;7137.10786151731;7201.17186523546;7225.880959136587;7266.309700578437;1956.383739122172;1976.7958726020383;1994.3717728915344;2039.6736522156384;2049.846261530391;1038.9064984151462;1089.6458650938478;1118.2507719827736;1164.1443538998828;1167.200467679642;20135.194592216147;20238.494037649176;20475.180992760124;20492.282770102975;20528.794712052986;1090.0679918669582;1110.0619976120165;1128.492178519653;1151.614209239914;1178.9056875449944;11448.713782155513;11917.986971107379;11996.220245684002;12023.759524809455;12128.332941688292;544472;548390;551187;561701;565541;53464;70092.649536752;80108.59945700351;81196.59401703071;81326.18673813304;1080;1090.9454527273604;1109.7891400633853;1110.6001839337832;1118.278710231896;17699.38052168168;18165.455036348932;18230.72653910219;18254;18345.357912473;38051.61948380481;38502.42246366251;38715.80642096772;39429.408558872216;39825.80087099546;51866.74066629643;53337;53960.19059714029;53996.46003540071;54073;8650.43772154808;8761.03628600866;8900.06549312313;8923.375363724477;9071.546422678708;12822.743545128858;13542.458301667823;13861.376238069513;13992.292717810227;14086.22525761093;11813.586524471602;12197.75604487923;12392;12427.067969902113;12433.502659893864;12256.632301030982;12292.877071229173;12300.753984920431;12323.322217278135;12532.937335313265;11146.721331966766;11347.773044539228;12008.939955300168;12020;12486.250824950532;8773.912260877309;9077.727668169966;9179.082091790768;9185.586648600962;9351.111644393772;9283;11390.145739069769;12196.878031219574;12276.202046866925;12470.501179953064 11:44:20 INFO - PROCESS | 3463 | |3;mootools.html;1611.363511412992;1647.9588010299742;1866.2286504540764;1940.6506828770816;1980.5345743750224;8606.827863442728;9162.496062716547;9455.290853186012;9999.10008099271;10050.095491405782;9245.12171343723;9404.435733855973;9603.519824008807;9614.423134611929;9623.133917947383;2471.0609968212098;2510.6736124303816;2527.6208568714655;2536.1123606737588;2541.47899680566;2455.594826853576;2494.725580186178;2516.1570873757223;2519.6220566914926;2520.5463016656995;2100.9474763130966;2109.4199095248778;2115.4182599785104;2116.714243577113;2117.53414248865;2456.152627343564;2468.2471846086937;2471.147454128323;2472.5673007223663;2505.1607711416696;2430.7447717989535;2433.8904749286326;2434.342727463575;2444.816638752083;2447.5349683560066;9552.044795520462;9600.135987761136;9618.807623847484;9626.711198664052;9628.855567166498;5666.206731057655;5858.912116318259;5862.530997520188;5876.823695289148;5891.499222566087;3640.7815531068222;3641.2535430237003;3677.6322367763278;3698.408254679265;3737.439384092381;1131.8132508136148;1132.0434233073122;1133.0991861470152;1135.5855112883821;1143.4625725908809;13824.101433406797;14007.579772606736;14026.649333766636;14037.01740878139;14141.222232777192;5122.820701275437;5153.3558305211845;5200.93380856931;5251.632385733038;5263.26314315996;11847.822282665767;11885.465154068088;11910.404479775976;11915.76168476643;11937.104717146076;5882.058870580772;5972.402759723993;5985.281766187998;5989.580729348903;5996.880062398727;4772.236442169236;5260.71066091361;5401.513863752281;5440.646357986719;5444.074507333763;4416.624586910084;4444.377787109807;4450.2434586120435;4456.22016147173;4463.527036078086;1389.2289779172454;1407.5425486716858;1421.1899217445957;1431.9284035798169;1436.561848636155;950.2445555783169;1073.9570417183381;1085.4464223246043;1090.432974853088;1095.6274866545414;6580.078788969548;6607.075009498674;6735.562188457735;6768.83077923046;6784.3554862288;491.95080491951234;493.1247036510223;493.7777999900059;499.9300097986285;501.99498005019484;4577.29051996941;4584.17484852723;4584.541545845389;4608.101420223024;4610.2623580227;11612.6516204514;11828.763424731456;11831.46758395857;11889.464974076187;11932.582359617372;11717.414129293502;11751.118666100077;11786.528538858349;12104.15270931044;12132.75734485323;9081.500517471603;9223.76940576491;9238.815223695488;9250.352475326798;9318.627254909728;6674.332566743286;6740.595564266159;6800.557963732342;6959.89560156588;7074.646267686698;11366.488508017324;11431.085513159094;11582.222310860414;11753.47109380097;11789.76420471603;11610.129240306842;11693.298402095901;11875.76248475043;11947.641570752892;11949.940250298692;7789.688412463438;8269.95865020671;8531.616077276662;8714.607842646968;8892.510911899908;9388.81222375535;9425.340226184102;9426.481543515172;9448.149666530046;9522.666706665234;8186.386021048326;8374.288185504056;8396.496210227406;8407.45351552147;8603.569821508774;8070.798230044061;8099.514029158269;8149.755507334789;8165.836053445961;8267.793305167419;7468.3278504934815;7737.806554836174;7742.109657389472;7776;7786.844263114819;5494.780208791603;5731.254936858182;5739.2252045973255;5848.561357898089;5904.557158213065;5955.91066134017;5966.582339236212;5999.970000149971;6006.789762358297;6021.006533922029 11:44:20 INFO - PROCESS | 3463 | |4;prototype.html;330.15645026956145;333.38989648942425;333.73134626625574;351.839912839658;356.76988342519076;5825;5832.32928213255;5834.387389324118;5851.7074146292725;5858.7949421770245;5766.1639062335935;5785.27684039495;5788.768449262035;5790.507806836414;5791.884162316751;4251.787410629471;4359.455068116486;4456.108778244348;4475.149721552911;4494.730316181023;4468.262736648449;4474.9776251118865;4475.462944446671;4477.417935668359;4497.685162038659;4468.017036252019;4503.234450143484;4519.254323036695;4527.343535187396;4529.954700453003;4321.913561728764;4391.077873646538;4417.094495628388;4440.933385999197;4443.533428989942;3909.7654140751647;3922.0783115967724;3936.6063393660693;3949.5063117110362;3978.8607398740905;5561.610687251894;5576.33084029919;5586.608937374385;5601.159826026088;5616.213730077792;5096.923546146811;5157.200633901752;5170.172772356443;5177.430482646906;5218.6868787872845;6006.339302676702;6019.578629495937;6029.246344206974;6052.394760523956;6064.423879731418;4445.377647129404;4469.955300446986;4480.260756975095;4487.326900964881;4488.573585509372;5992.543057346467;6299.842503937392;6332.936670633327;6351.904721429182;6354.491640668735;4408.272635015251;4451.955480445219;4459.175052615212;4461.174682683714;4464.6428285737065;4321.503027151855;4493.370928070073;4503.144402563503;4522.25382811839;4524.0094358482165;5125.948740512622;5141.126008578551;5160.535551800356;5178;5199.818006369835;6129.069343156892;6151.231096112986;6156.569040167235;6178.66017369049;6189.381061893865;1463.1440607244667;1521.8249901261274;1545.3663997760864;1545.63677535779;1557.2603013568464;971.5336638413601;1015.8780946286345;1051.0330495943597;1054.583439541377;1058.6718117383482;5883.382244864313;5950.285965684146;5965.463108320272;5975.207437768652;5993.940060599338;6148.354422785633;6305.369463053658;6310;6326.240851097806;6361.809145725636;5816.970915145397;5911.320198177179;5920.437558431942;5985.892609867188;6004.877463718842;3346.3641908037393;3358.5633867597544;3387.2040070583394;3388.5933687957604;3390.983045084759;6262.749490020348;6497.545171837926;6501.772437964649;6520.18497687789;6538.476921846241;6281;6307.905381419282;6321.841953951188;6335.841603959938;6366.172397588284;6274.403931626488;6438.6136831790245;6456.225252969673;6479.222493300834;6597.208334999831;6358.459530939922;6360;6382.393672601095;6382.808515744535;6393.680315984275;6086.817395478142;6266.717997690023;6288.182536270256;6294.464970477561;6350.1109844622715;6622.1722284714415;6637.203535575762;6656.30108838565;6666.033425153422;6692.899606506004;4471.463424389094;4488.102379524043;4501.819927203006;4502.212112880298;4510.819567217274;6097.207363042776;6377;6380.202474690664;6389.456896163692;6408.967955160194;6214.751409943552;6228.750849966132;6258.968705156445;6265.8746825062335;6300.369963003663;6069.423404776539;6122.6938653068055;6170.969145154246;6230.906536402048;6269.592476489013;5877.588568800143;6095;6131.172291740736;6154.476869466145;6204.875902481835;6217.751289948352;6257.874842503215;6260.968695156495;6278.434940855345;6285.465735412358;5888.499477544457;6091.5126789857595;6093;6106.480949119375;6133.570650054453 11:44:20 INFO - PROCESS | 3463 | |5;yui.html;826.8222332198576;843.4391129898618;855.9657613695452;859.2953777902122;923.0031565908819;15703.450379236729;16293.348266069373;16322;16416.09711465869;16422.178891055446;15137.545873623809;15264.771028434583;15288.541343759678;15343.386264549432;15357.001794883352;715.68867542619;842.9072801991776;868.431177578687;868.535333596526;878.7012415778634;874.0254616103031;877.7015814623027;887.7248053103526;888.4802390601506;889.9866502002475;927.777333439973;932.0958670090001;933.3466573398648;935.5182081228173;935.8689783430325;926.1664501948233;931.1433481197281;931.329442801182;932.1470854168427;932.9207017403563;677.1062197898775;679.7145199016425;680.7549282258383;682.9658517074126;683.1290105115967;15826.841731582652;15908.681826363523;15909;15988.360465581363;16044.117573533451;14151.363188656433;14284.857151428561;14415.207163605997;14903.70192596142;15127.848721512753;13823;13927.094738841943;14069.296535173302;14232.85767142336;14413.13521188732;4813.181759100961;4833.746750244848;4903;4978.850634480971;4998.975005124988;80959.19040809576;81035.18964810335;81519.18480815175;82278.17721822824;82323.17676823215;12159.756804863853;12356.320402377956;12368.81446778299;12481.126321157431;12559.372031398576;21962.341129766133;21997.780022199895;22008.339749807532;22107.11571537153;22129.225477108223;8790.560471976376;8904.065073167225;8914.153155450222;8945.23965462943;9133.315001374924;4900.289458028566;4917.434495033045;4966.503349665077;5007.974960125176;5041.59667226621;3606.098475381155;3702.1485058436174;3703.5926048134684;3704.6295370463276;3707.1102935295876;614.4623454477332;679.9524033317621;680.0717021265937;680.5848432456198;686.8214264291221;646.3019938466445;671.9025741267586;698.0820221408933;705.9294070592899;721.6932803558467;9561.426314421156;9752.21982241419;9755.512224388753;9811.31320807551;10064.899351006543;657.3820608627874;712.2379054411833;753.2016062973266;758.9734359297398;759.6353750199935;4333.696641235083;4616.553226789807;4629.587975667387;4684.648651351163;4724.291356296514;106708.46645766721;111581.44209278902;114049;114727.42636286766;116088.41955790335;96113.51943240239;99719;99761;99973.50013249887;100649.49675251577;83354.16645833464;83643;83671.16328836755;84157;84489.57755211185;8871.512066836385;9183.586738596645;9283.814323713623;9428.905710943078;9475.526223688927;53434;53492.197617034995;54496.72751636217;54933.17600236079;55194.17208741952;49944.75027624984;72950.63524682343;73201;73404.63297683478;74328;10600.628977985734;10672.519736612026;11088.33469991803;11125.388103654377;11343.319400835977;12414.131010829517;12693.4287957044;12704.74590508203;12749.553765618159;13026.674333141747;11809.881901180877;11952.820707689218;12028.699282518008;12054.819177712166;12075.939620301842;11929.403529823649;11989.22070065443;12066.698332541757;12355.505779768708;12650.05124615639;11968.880311196777;12007.639770806889;12095.516179352728;12153.210041347284;12205.389730513261;9865.605375784888;10035.49822508857;10136.290459667753;10293.43386113771;10462.529186186792;10180.694579162637;10467.842982355118;10492.737681557717;10583.682489525327;10626.681199564026 11:44:20 INFO - PROCESS | 3463 | __end_tp_report 11:44:20 INFO - PROCESS | 3463 | __start_cc_report 11:44:20 INFO - PROCESS | 3463 | _x_x_mozilla_cycle_collect,324 11:44:20 INFO - PROCESS | 3463 | __end_cc_report 11:44:20 INFO - PROCESS | 3463 | __startTimestamp1470077060741__endTimestamp 11:44:20 INFO - PROCESS | 3463 | 11:44:20 INFO - PROCESS | 3463 | ------- Summary: start ------- 11:44:20 INFO - PROCESS | 3463 | Number of tests: 6 11:44:20 INFO - PROCESS | 3463 | 11:44:20 INFO - PROCESS | 3463 | [#0] dojo.html Cycles:165 Average:5765.68 Median:6009.82 stddev:665.64 (11.1%) stddev-sans-first:642.38 11:44:20 INFO - PROCESS | 3463 | Values: 3448.4 3459.8 3466.4 3471.4 3484.3 5726.4 5758.9 5794.6 5805.0 5816.6 5720.7 5738.4 5750.1 5792.7 5796.5 5169.7 5194.1 5231.6 5268.2 5301.0 5151.5 5191.3 5217.3 5226.2 5231.1 5222.1 5232.8 5296.6 5301.5 5326.7 4998.0 5224.2 5236.5 5305.0 5309.8 5071.2 5100.5 5129.4 5149.7 5172.8 5665.3 5679.4 5689.1 5690.2 5696.1 6222.7 6246.5 6249.6 6266.5 6275.9 6120.7 6125.7 6149.5 6186.6 6228.8 5810.1 5816.4 5816.7 5847.7 5866.9 6176.6 6368.1 6384.6 6386.5 6390.1 6054.5 6058.4 6078.1 6140.2 6177.0 6260.9 6285.8 6298.3 6302.5 6303.7 6009.8 6144.4 6253.7 6257.8 6277.4 6136.3 6244.2 6267.7 6268.2 6271.9 4730.4 4738.8 4745.2 4752.3 4764.2 4162.0 4166.7 4185.5 4215.6 4232.1 5791.9 5936.7 5987.2 6041.0 6047.7 6334.9 6375.5 6376.9 6382.3 6383.0 5881.3 5900.1 5941.3 6070.0 6084.3 5285.1 5290.3 5304.5 5329.8 5386.6 6401.0 6426.9 6436.3 6448.2 6526.1 6069.5 6162.5 6313.7 6332.4 6334.6 6384.6 6508.3 6521.2 6530.7 6532.4 6187.7 6197.8 6199.9 6203.2 6206.8 6073.6 6135.9 6167.3 6248.9 6303.9 6071.1 6111.9 6112.5 6119.3 6121.4 6033.6 6093.6 6123.6 6129.7 6130.6 5818.1 5825.7 5834.4 5863.2 6035.1 5955.1 5996.0 6009.8 6028.3 6035.0 5889.7 5890.2 5894.0 5901.0 5901.4 11:44:20 INFO - PROCESS | 3463 | 11:44:20 INFO - PROCESS | 3463 | [#1] ext.html Cycles:180 Average:67153.32 Median:43696.56 stddev:151211.42 (346.0%) stddev-sans-first:151553.10 11:44:20 INFO - PROCESS | 3463 | Values: 623.9 634.9 647.1 674.7 685.7 46272.5 47745.0 47861.3 47895.3 51560.0 49821.0 50409.7 50536.2 50699.0 50794.7 9078.8 9320.1 9327.1 9337.3 9343.8 9121.6 9129.9 9174.4 9178.7 9205.0 9197.5 9221.0 9221.4 9233.5 9291.2 9141.7 9173.7 9185.2 9185.5 9226.4 9126.7 9166.4 9182.9 9236.9 9243.6 45084.5 45259.8 45335.3 45365.5 45503.9 3821.5 4353.0 4566.7 4571.1 4696.0 34044.3 34599.5 34782.0 34936.8 35095.6 4760.9 4774.7 4786.8 4828.9 4848.2 367601.0 371883.0 371973.0 372729.1 373693.0 67358.0 67771.7 67790.0 67883.3 67925.3 41007.4 41950.0 42062.0 44166.9 44180.0 19377.6 19426.6 19832.9 19869.5 19880.3 14356.9 14400.2 14445.3 14496.6 14581.3 21529.5 21726.2 21730.8 21791.7 21886.3 7632.9 7639.6 7799.6 7830.0 7894.3 1092.5 1152.1 1178.9 1189.0 1251.9 34048.1 34333.7 34422.7 34545.7 35154.6 1074.1 1151.0 1153.2 1163.5 1197.4 17985.4 18068.4 18109.5 18267.5 18364.5 591899.0 879003.0 885341.0 895870.0 901156.0 62872.7 64153.0 64205.4 64444.0 64478.7 1492.3 1493.6 1498.8 1508.6 1512.4 32618.3 33189.8 33434.7 33654.7 34214.7 54834.0 55296.4 55360.7 55470.4 55521.4 315785.0 317121.0 318064.0 318781.0 319992.0 31009.2 31096.4 31660.5 31688.2 31808.8 50064.5 50681.5 50846.0 51689.2 51714.0 42237.8 43101.8 43562.8 43605.3 44297.8 42816.4 43382.0 43646.6 43856.0 44228.1 42521.1 42821.4 43180.8 43353.6 43746.6 36617.9 37037.6 37496.4 37548.6 38108.0 29252.4 29498.7 29568.0 29650.1 29804.0 11:44:20 INFO - PROCESS | 3463 | 11:44:20 INFO - PROCESS | 3463 | [#2] jquery.html Cycles:180 Average:30654.53 Median:24575.20 stddev:90628.17 (368.8%) stddev-sans-first:90853.98 11:44:20 INFO - PROCESS | 3463 | Values: 424.2 428.1 430.0 430.8 443.0 19030.7 20094.8 20871.3 20963.4 21017.5 19432.4 19771.7 20064.8 20582.8 20697.6 5822.8 6043.6 6081.2 6085.3 6089.7 5839.3 6023.2 6037.8 6041.8 6052.2 5948.7 5952.9 5989.3 6013.5 6025.9 5767.3 5919.9 5935.3 5950.6 5976.4 5279.9 5294.2 5300.7 5326.7 5339.4 24025.9 24491.3 24659.1 24685.5 25090.6 2469.2 2530.9 2579.8 2586.0 2608.4 15510.9 15518.9 15588.7 15635.3 15844.5 2022.9 2114.3 2168.5 2169.5 2178.8 78845.6 80104.6 80553.2 81043.6 81840.2 11102.9 11276.6 11451.8 11653.7 11794.6 15963.9 16005.3 16067.6 16120.4 16184.7 8685.0 9012.6 9113.7 9237.1 9260.5 9040.1 9048.8 9105.1 9108.3 9139.5 7069.0 7137.1 7201.2 7225.9 7266.3 1956.4 1976.8 1994.4 2039.7 2049.8 1038.9 1089.6 1118.3 1164.1 1167.2 20135.2 20238.5 20475.2 20492.3 20528.8 1090.1 1110.1 1128.5 1151.6 1178.9 11448.7 11918.0 11996.2 12023.8 12128.3 544472.0 548390.0 551187.0 561701.0 565541.0 53464.0 70092.6 80108.6 81196.6 81326.2 1080.0 1090.9 1109.8 1110.6 1118.3 17699.4 18165.5 18230.7 18254.0 18345.4 38051.6 38502.4 38715.8 39429.4 39825.8 51866.7 53337.0 53960.2 53996.5 54073.0 8650.4 8761.0 8900.1 8923.4 9071.5 12822.7 13542.5 13861.4 13992.3 14086.2 11813.6 12197.8 12392.0 12427.1 12433.5 12256.6 12292.9 12300.8 12323.3 12532.9 11146.7 11347.8 12008.9 12020.0 12486.3 8773.9 9077.7 9179.1 9185.6 9351.1 9283.0 11390.1 12196.9 12276.2 12470.5 11:44:20 INFO - PROCESS | 3463 | 11:44:20 INFO - PROCESS | 3463 | [#3] mootools.html Cycles:180 Average:6420.83 Median:2632.09 stddev:3734.85 (141.9%) stddev-sans-first:3727.84 11:44:20 INFO - PROCESS | 3463 | Values: 1611.4 1648.0 1866.2 1940.7 1980.5 8606.8 9162.5 9455.3 9999.1 10050.1 9245.1 9404.4 9603.5 9614.4 9623.1 2471.1 2510.7 2527.6 2536.1 2541.5 2455.6 2494.7 2516.2 2519.6 2520.5 2100.9 2109.4 2115.4 2116.7 2117.5 2456.2 2468.2 2471.1 2472.6 2505.2 2430.7 2433.9 2434.3 2444.8 2447.5 9552.0 9600.1 9618.8 9626.7 9628.9 5666.2 5858.9 5862.5 5876.8 5891.5 3640.8 3641.3 3677.6 3698.4 3737.4 1131.8 1132.0 1133.1 1135.6 1143.5 13824.1 14007.6 14026.6 14037.0 14141.2 5122.8 5153.4 5200.9 5251.6 5263.3 11847.8 11885.5 11910.4 11915.8 11937.1 5882.1 5972.4 5985.3 5989.6 5996.9 4772.2 5260.7 5401.5 5440.6 5444.1 4416.6 4444.4 4450.2 4456.2 4463.5 1389.2 1407.5 1421.2 1431.9 1436.6 950.2 1074.0 1085.4 1090.4 1095.6 6580.1 6607.1 6735.6 6768.8 6784.4 492.0 493.1 493.8 499.9 502.0 4577.3 4584.2 4584.5 4608.1 4610.3 11612.7 11828.8 11831.5 11889.5 11932.6 11717.4 11751.1 11786.5 12104.2 12132.8 9081.5 9223.8 9238.8 9250.4 9318.6 6674.3 6740.6 6800.6 6959.9 7074.6 11366.5 11431.1 11582.2 11753.5 11789.8 11610.1 11693.3 11875.8 11947.6 11949.9 7789.7 8270.0 8531.6 8714.6 8892.5 9388.8 9425.3 9426.5 9448.1 9522.7 8186.4 8374.3 8396.5 8407.5 8603.6 8070.8 8099.5 8149.8 8165.8 8267.8 7468.3 7737.8 7742.1 7776.0 7786.8 5494.8 5731.3 5739.2 5848.6 5904.6 5955.9 5966.6 6000.0 6006.8 6021.0 11:44:20 INFO - PROCESS | 3463 | 11:44:20 INFO - PROCESS | 3463 | [#4] prototype.html Cycles:180 Average:5160.27 Median:5880.49 stddev:1539.43 (26.2%) stddev-sans-first:1500.45 11:44:20 INFO - PROCESS | 3463 | Values: 330.2 333.4 333.7 351.8 356.8 5825.0 5832.3 5834.4 5851.7 5858.8 5766.2 5785.3 5788.8 5790.5 5791.9 4251.8 4359.5 4456.1 4475.1 4494.7 4468.3 4475.0 4475.5 4477.4 4497.7 4468.0 4503.2 4519.3 4527.3 4530.0 4321.9 4391.1 4417.1 4440.9 4443.5 3909.8 3922.1 3936.6 3949.5 3978.9 5561.6 5576.3 5586.6 5601.2 5616.2 5096.9 5157.2 5170.2 5177.4 5218.7 6006.3 6019.6 6029.2 6052.4 6064.4 4445.4 4470.0 4480.3 4487.3 4488.6 5992.5 6299.8 6332.9 6351.9 6354.5 4408.3 4452.0 4459.2 4461.2 4464.6 4321.5 4493.4 4503.1 4522.3 4524.0 5125.9 5141.1 5160.5 5178.0 5199.8 6129.1 6151.2 6156.6 6178.7 6189.4 1463.1 1521.8 1545.4 1545.6 1557.3 971.5 1015.9 1051.0 1054.6 1058.7 5883.4 5950.3 5965.5 5975.2 5993.9 6148.4 6305.4 6310.0 6326.2 6361.8 5817.0 5911.3 5920.4 5985.9 6004.9 3346.4 3358.6 3387.2 3388.6 3391.0 6262.7 6497.5 6501.8 6520.2 6538.5 6281.0 6307.9 6321.8 6335.8 6366.2 6274.4 6438.6 6456.2 6479.2 6597.2 6358.5 6360.0 6382.4 6382.8 6393.7 6086.8 6266.7 6288.2 6294.5 6350.1 6622.2 6637.2 6656.3 6666.0 6692.9 4471.5 4488.1 4501.8 4502.2 4510.8 6097.2 6377.0 6380.2 6389.5 6409.0 6214.8 6228.8 6259.0 6265.9 6300.4 6069.4 6122.7 6171.0 6230.9 6269.6 5877.6 6095.0 6131.2 6154.5 6204.9 6217.8 6257.9 6261.0 6278.4 6285.5 5888.5 6091.5 6093.0 6106.5 6133.6 11:44:20 INFO - PROCESS | 3463 | 11:44:20 INFO - PROCESS | 3463 | [#5] yui.html Cycles:180 Average:20691.62 Median:4941.97 stddev:29749.60 (602.0%) stddev-sans-first:29795.67 11:44:20 INFO - PROCESS | 3463 | Values: 826.8 843.4 856.0 859.3 923.0 15703.5 16293.3 16322.0 16416.1 16422.2 15137.5 15264.8 15288.5 15343.4 15357.0 715.7 842.9 868.4 868.5 878.7 874.0 877.7 887.7 888.5 890.0 927.8 932.1 933.3 935.5 935.9 926.2 931.1 931.3 932.1 932.9 677.1 679.7 680.8 683.0 683.1 15826.8 15908.7 15909.0 15988.4 16044.1 14151.4 14284.9 14415.2 14903.7 15127.8 13823.0 13927.1 14069.3 14232.9 14413.1 4813.2 4833.7 4903.0 4978.9 4999.0 80959.2 81035.2 81519.2 82278.2 82323.2 12159.8 12356.3 12368.8 12481.1 12559.4 21962.3 21997.8 22008.3 22107.1 22129.2 8790.6 8904.1 8914.2 8945.2 9133.3 4900.3 4917.4 4966.5 5008.0 5041.6 3606.1 3702.1 3703.6 3704.6 3707.1 614.5 680.0 680.1 680.6 686.8 646.3 671.9 698.1 705.9 721.7 9561.4 9752.2 9755.5 9811.3 10064.9 657.4 712.2 753.2 759.0 759.6 4333.7 4616.6 4629.6 4684.6 4724.3 106708.5 111581.4 114049.0 114727.4 116088.4 96113.5 99719.0 99761.0 99973.5 100649.5 83354.2 83643.0 83671.2 84157.0 84489.6 8871.5 9183.6 9283.8 9428.9 9475.5 53434.0 53492.2 54496.7 54933.2 55194.2 49944.8 72950.6 73201.0 73404.6 74328.0 10600.6 10672.5 11088.3 11125.4 11343.3 12414.1 12693.4 12704.7 12749.6 13026.7 11809.9 11952.8 12028.7 12054.8 12075.9 11929.4 11989.2 12066.7 12355.5 12650.1 11968.9 12007.6 12095.5 12153.2 12205.4 9865.6 10035.5 10136.3 10293.4 10462.5 10180.7 10467.8 10492.7 10583.7 10626.7 11:44:20 INFO - PROCESS | 3463 | -------- Summary: end -------- 11:44:20 INFO - PROCESS | 3463 | 11:44:21 INFO - TEST-INFO | 3463: exit 0 11:44:21 INFO - TEST-OK | dromaeo_css | took 1111716ms 11:44:21 INFO - TEST-START | kraken 11:44:21 INFO - operating with platform_type : linux_ 11:44:21 INFO - Initialising browser for kraken test... 11:44:21 INFO - TEST-INFO | started process 3709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjX4CXq/profile http://localhost:42065/getInfo.html) 11:44:26 INFO - PROCESS | 3709 | __metrics Screen width/height:1600/1200 11:44:26 INFO - PROCESS | 3709 | colorDepth:24 11:44:26 INFO - PROCESS | 3709 | Browser inner width/height: 1024/697 11:44:26 INFO - PROCESS | 3709 | __metrics 11:44:26 ERROR - PROCESS | 3709 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:44:27 INFO - TEST-INFO | 3709: exit 0 11:44:27 INFO - Browser initialized. 11:44:27 INFO - Running cycle 1/1 for kraken test... 11:44:27 INFO - TEST-INFO | started process 3840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjX4CXq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:39 INFO - PROCESS | 3840 | RSS: Main: 153055232 11:44:39 INFO - PROCESS | 3840 | 11:44:41 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42065/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:42 INFO - PROCESS | 3840 | RSS: Main: 157683712 11:44:42 INFO - PROCESS | 3840 | 11:44:45 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42065/tests/kraken/driver.html?testName=audio-dft) 11:44:45 INFO - PROCESS | 3840 | RSS: Main: 157110272 11:44:45 INFO - PROCESS | 3840 | 11:44:48 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42065/tests/kraken/driver.html?testName=audio-fft) 11:44:49 INFO - PROCESS | 3840 | RSS: Main: 157659136 11:44:49 INFO - PROCESS | 3840 | 11:44:51 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42065/tests/kraken/driver.html?testName=audio-oscillator) 11:44:51 INFO - PROCESS | 3840 | RSS: Main: 157548544 11:44:51 INFO - PROCESS | 3840 | 11:44:54 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:54 INFO - PROCESS | 3840 | RSS: Main: 158097408 11:44:54 INFO - PROCESS | 3840 | 11:44:57 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42065/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:58 INFO - PROCESS | 3840 | RSS: Main: 157343744 11:44:58 INFO - PROCESS | 3840 | 11:45:01 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42065/tests/kraken/driver.html?testName=imaging-desaturate) 11:45:02 INFO - PROCESS | 3840 | RSS: Main: 157736960 11:45:02 INFO - PROCESS | 3840 | 11:45:05 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42065/tests/kraken/driver.html?testName=json-parse-financial) 11:45:06 INFO - PROCESS | 3840 | RSS: Main: 158826496 11:45:06 INFO - PROCESS | 3840 | 11:45:07 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:45:07 INFO - PROCESS | 3840 | RSS: Main: 158175232 11:45:07 INFO - PROCESS | 3840 | 11:45:09 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42065/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:10 INFO - PROCESS | 3840 | RSS: Main: 157851648 11:45:10 INFO - PROCESS | 3840 | 11:45:12 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:13 INFO - PROCESS | 3840 | RSS: Main: 158167040 11:45:13 INFO - PROCESS | 3840 | 11:45:15 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:16 INFO - PROCESS | 3840 | RSS: Main: 158519296 11:45:16 INFO - PROCESS | 3840 | 11:45:18 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:19 INFO - PROCESS | 3840 | RSS: Main: 158453760 11:45:19 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:42065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42065/tests/kraken/driver.html?testName=ai-astar) 11:45:21 INFO - PROCESS | 3840 | RSS: Main: 158785536 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | __start_tp_report 11:45:21 INFO - PROCESS | 3840 | _x_x_mozilla_page_load 11:45:21 INFO - PROCESS | 3840 | _x_x_mozilla_page_load_details 11:45:21 INFO - PROCESS | 3840 | |i|pagename|runs| 11:45:21 INFO - PROCESS | 3840 | |0;ai-astar;113;105;111;110;109;110;110;111;109;110 11:45:21 INFO - PROCESS | 3840 | |1;audio-beat-detection;152;132;157;187;130;157;149;126;174;125 11:45:21 INFO - PROCESS | 3840 | |2;audio-dft;162;161;161;163;161;162;162;164;161;162 11:45:21 INFO - PROCESS | 3840 | |3;audio-fft;74;75;76;175;76;75;75;75;168;76 11:45:21 INFO - PROCESS | 3840 | |4;audio-oscillator;87;85;148;85;84;85;138;85;85;150 11:45:21 INFO - PROCESS | 3840 | |5;imaging-gaussian-blur;118;117;118;118;117;117;117;117;118;117 11:45:21 INFO - PROCESS | 3840 | |6;imaging-darkroom;147;147;147;147;147;148;147;146;147;147 11:45:21 INFO - PROCESS | 3840 | |7;imaging-desaturate;96;95;96;96;95;95;95;96;95;95 11:45:21 INFO - PROCESS | 3840 | |8;json-parse-financial;55;54;54;55;56;56;55;55;53;54 11:45:21 INFO - PROCESS | 3840 | |9;json-stringify-tinderbox;59;60;59;61;61;60;59;62;60;60 11:45:21 INFO - PROCESS | 3840 | |10;stanford-crypto-aes;76;76;79;77;77;77;77;82;108;78 11:45:21 INFO - PROCESS | 3840 | |11;stanford-crypto-ccm;121;137;122;128;118;122;126;127;125;146 11:45:21 INFO - PROCESS | 3840 | |12;stanford-crypto-pbkdf2;155;153;155;156;153;154;154;155;153;155 11:45:21 INFO - PROCESS | 3840 | |13;stanford-crypto-sha256-iterative;61;61;61;63;61;60;61;64;61;60 11:45:21 INFO - PROCESS | 3840 | __end_tp_report 11:45:21 INFO - PROCESS | 3840 | __start_cc_report 11:45:21 INFO - PROCESS | 3840 | _x_x_mozilla_cycle_collect,869 11:45:21 INFO - PROCESS | 3840 | __end_cc_report 11:45:21 INFO - PROCESS | 3840 | __startTimestamp1470077121278__endTimestamp 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | ------- Summary: start ------- 11:45:21 INFO - PROCESS | 3840 | Number of tests: 14 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:2.04 (1.9%) stddev-sans-first:1.81 11:45:21 INFO - PROCESS | 3840 | Values: 113.0 105.0 111.0 110.0 109.0 110.0 110.0 111.0 109.0 110.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:154.50 stddev:20.98 (13.6%) stddev-sans-first:22.22 11:45:21 INFO - PROCESS | 3840 | Values: 152.0 132.0 157.0 187.0 130.0 157.0 149.0 126.0 174.0 125.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 11:45:21 INFO - PROCESS | 3840 | Values: 162.0 161.0 161.0 163.0 161.0 162.0 162.0 164.0 161.0 162.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.00 stddev:40.62 (54.2%) stddev-sans-first:42.40 11:45:21 INFO - PROCESS | 3840 | Values: 74.0 75.0 76.0 175.0 76.0 75.0 75.0 75.0 168.0 76.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.00 stddev:29.24 (34.4%) stddev-sans-first:30.42 11:45:21 INFO - PROCESS | 3840 | Values: 87.0 85.0 148.0 85.0 84.0 85.0 138.0 85.0 85.0 150.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:45:21 INFO - PROCESS | 3840 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 11:45:21 INFO - PROCESS | 3840 | Values: 147.0 147.0 147.0 147.0 147.0 148.0 147.0 146.0 147.0 147.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:45:21 INFO - PROCESS | 3840 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:1.00 11:45:21 INFO - PROCESS | 3840 | Values: 55.0 54.0 54.0 55.0 56.0 56.0 55.0 55.0 53.0 54.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.99 (1.7%) stddev-sans-first:0.97 11:45:21 INFO - PROCESS | 3840 | Values: 59.0 60.0 59.0 61.0 61.0 60.0 59.0 62.0 60.0 60.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:77.00 stddev:9.75 (12.7%) stddev-sans-first:10.20 11:45:21 INFO - PROCESS | 3840 | Values: 76.0 76.0 79.0 77.0 77.0 77.0 77.0 82.0 108.0 78.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:126.50 stddev:8.39 (6.6%) stddev-sans-first:8.59 11:45:21 INFO - PROCESS | 3840 | Values: 121.0 137.0 122.0 128.0 118.0 122.0 126.0 127.0 125.0 146.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:155.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 11:45:21 INFO - PROCESS | 3840 | Values: 155.0 153.0 155.0 156.0 153.0 154.0 154.0 155.0 153.0 155.0 11:45:21 INFO - PROCESS | 3840 | 11:45:21 INFO - PROCESS | 3840 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.00 stddev:1.25 (2.1%) stddev-sans-first:1.32 11:45:21 INFO - PROCESS | 3840 | Values: 61.0 61.0 61.0 63.0 61.0 60.0 61.0 64.0 61.0 60.0 11:45:21 INFO - PROCESS | 3840 | -------- Summary: end -------- 11:45:21 INFO - PROCESS | 3840 | 11:45:22 INFO - TEST-INFO | 3840: exit 0 11:45:22 INFO - TEST-OK | kraken | took 60859ms 11:45:22 INFO - SUITE-END | took 1172s 11:45:22 INFO - Completed test suite (00:19:32) 11:45:22 INFO - javascript benchmark 11:45:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7749.5746180203805, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3448.431008883536, 3459.8443070061844, 3466.3933811582965, 3471.44456886898, 3484.268303656232, 5726.3700992890745, 5758.884822303551, 5794.623349482281, 5805.042168042268, 5816.563757718167, 5720.656760594367, 5738.42615738426, 5750.108733146369, 5792.6814025228705, 5796.507296879759, 5169.741512924348, 5194.065068287707, 5231.633785635007, 5268.157094864822, 5301.045811753883, 5151.536361727443, 5191.299174611436, 5217.3217481727515, 5226.242194881759, 5231.084560201968, 5222.086134926391, 5232.843014709565, 5296.576273898079, 5301.549368303698, 5326.733663316838, 4997.975010124963, 5224.164133738622, 5236.450172731847, 5304.9655317213155, 5309.7610607522565, 5071.2139618359215, 5100.515451032146, 5129.435762066169, 5149.742512874342, 5172.793088276464, 5665.263515742969, 5679.403662615448, 5689.089745640677, 5690.203371527948, 5696.060150075233, 6222.657753823538, 6246.469050130744, 6249.593776404565, 6266.530010249204, 6275.905861412082, 6120.69094295093, 6125.693715314261, 6149.538784591129, 6186.628802271878, 6228.813135605939, 5810.070388737824, 5816.389279125716, 5816.709164541756, 5847.678377689225, 5866.853328666774, 6176.567640265228, 6368.076628888785, 6384.553081284265, 6386.521010924199, 6390.137331460193, 6054.485368743706, 6058.394160583906, 6078.149059131725, 6140.17107690456, 6176.969115154396, 6260.906086408708, 6285.811425657238, 6298.275698294755, 6302.4958003359625, 6303.716332764945, 6009.819705408845, 6144.446999770043, 6253.749850005949, 6257.843553911098, 6277.435030847246, 6136.274005700925, 6244.1570387997945, 6267.655278959701, 6268.247810262797, 6271.937280627227, 4730.385049943486, 4738.763061846894, 4745.1695953208055, 4752.310914917318, 4764.213904705754, 4161.979190104091, 4166.729162604421, 4185.518665353462, 4215.641670457984, 4232.111256636079, 5791.942080579141, 5936.7328470218945, 5987.221661184105, 6041.0, 6047.667378294236, 6334.873302533923, 6375.521835862236, 6376.872462550723, 6382.266039405527, 6383.0, 5881.323647780475, 5900.1149827526215, 5941.31674857397, 6069.969650151721, 6084.330723620398, 5285.127953887565, 5290.28581141541, 5304.496072873071, 5329.81345652908, 5386.649867758583, 6400.967995159995, 6426.907425737636, 6436.324185960407, 6448.193975753031, 6526.053722210348, 6069.484093852072, 6162.506999440124, 6313.652749098844, 6332.366763323631, 6334.588251763805, 6384.585001974857, 6508.284088750139, 6521.152250207443, 6530.738770449128, 6532.41208291256, 6187.659678717714, 6197.783077592263, 6199.876002479835, 6203.2245969253845, 6206.813795586139, 6073.635581865102, 6135.875804921915, 6167.321594624677, 6248.906266406098, 6303.936960630518, 6071.058985857199, 6111.908321375094, 6112.510999120149, 6119.296280927572, 6121.3878612140215, 6033.577649564664, 6093.634381937098, 6123.601965872204, 6129.693515324305, 6130.601510901777, 5818.0981947798155, 5825.679587622722, 5834.445727655866, 5863.20846685692, 6035.094735789667, 5955.136505206808, 5996.0, 6009.849753756191, 6028.306744724413, 6034.974054410848, 5889.676067816311, 5890.2342695449315, 5893.970530147321, 5901.0, 5901.350851406428], "value": 5720.989377871711, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.9188905442292, 634.923804151962, 647.1231481342777, 674.6559254780062, 685.7291369908885, 46272.53727462724, 47745.0, 47861.28208076882, 47895.281570776424, 51560.0, 49821.0, 50409.74795126019, 50536.24195637059, 50699.0, 50794.74602626991, 9078.818423631523, 9320.067993200659, 9327.113924177193, 9337.253019758436, 9343.813123737522, 9121.635134594608, 9129.908700912973, 9174.449533028006, 9178.724638260863, 9205.033471485498, 9197.494137822418, 9221.031791661879, 9221.40060896043, 9233.538323083852, 9291.210247129002, 9141.72574822753, 9173.678921237724, 9185.17333439987, 9185.49479778612, 9226.354155209105, 9126.68056618022, 9166.358354915159, 9182.908170918272, 9236.907630923739, 9243.584038718274, 45084.54915450869, 45259.77370113161, 45335.31997020047, 45365.546344536466, 45503.862403439845, 3821.503204583414, 4352.978235108804, 4566.680332376735, 4571.062932098912, 4696.037312350994, 34044.319113617836, 34599.4810077849, 34782.0, 34936.82531587351, 35095.6490435095, 4760.928586071212, 4774.665773395864, 4786.832460863888, 4828.88348909035, 4848.248521479177, 367601.0, 371883.0, 371973.0, 372729.1363543192, 373693.0, 67358.0, 67771.66114169496, 67790.0, 67883.3211667887, 67925.32074679289, 41007.38488922668, 41950.0, 42062.0, 44166.89582760393, 44180.0, 19377.61244775125, 19426.611467770566, 19832.90083549573, 19869.503262418268, 19880.304189353305, 14356.856431435552, 14400.207988560729, 14445.349959251858, 14496.565103046925, 14581.270936453135, 21529.461763456038, 21726.23958161457, 21730.78269217319, 21791.67312490314, 21886.343409697736, 7632.923670763333, 7639.579823109671, 7799.571023593643, 7829.960850195826, 7894.328982036591, 1092.5356723392526, 1152.1474109159162, 1178.9469473873526, 1188.976220475603, 1251.9311437871004, 34048.1487962798, 34333.656663433045, 34422.65577344244, 34545.65454345424, 35154.64845351514, 1074.0762943868267, 1150.9597164099384, 1153.1985270237271, 1163.4938801621322, 1197.437204513877, 17985.370512032016, 18068.36760713395, 18109.54726131831, 18267.543311417056, 18364.540886477946, 591899.0, 879003.0, 885341.0, 895870.0, 901156.0, 62872.68563657152, 64153.0, 64205.357946419936, 64444.0, 64478.677606612604, 1492.2613306413177, 1493.6116609681344, 1498.752705803552, 1508.58513908676, 1512.4101600375861, 32618.34763304673, 33189.83405082959, 33434.66565334413, 33654.66345336515, 34214.657853421144, 54834.0, 55296.44703552913, 55360.72319638376, 55470.44529554653, 55521.44478555163, 315785.0, 317121.0, 318064.0, 318781.0, 319992.0, 31009.224769380042, 31096.378072438878, 31660.5250921241, 31688.20779480439, 31808.840955795073, 50064.49935500598, 50681.49318506915, 50846.0, 51689.224661630855, 51714.0, 42237.78881105575, 43101.7844910786, 43562.782186088865, 43605.34591981059, 44297.77851110724, 42816.357754633085, 43382.0, 43646.56353436425, 43856.0, 44228.11543769171, 42521.1495770089, 42821.357679635454, 43180.78409608058, 43353.56646433495, 43746.56253437425, 36617.90146295616, 37037.62962370342, 37496.43755343727, 37548.62451375451, 38108.0, 29252.414951700423, 29498.705012949595, 29568.0, 29650.110496685134, 29804.0], "value": 21564.70572901802, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.2024993013135, 428.14584903118276, 430.02384586987534, 430.8427423990241, 443.00987293399265, 19030.714539281904, 20094.799052009475, 20871.269505567307, 20963.37109886702, 21017.47456313593, 19432.417027489162, 19771.70342444861, 20064.799352006474, 20582.794172058275, 20697.586048279027, 5822.767089316422, 6043.637381757087, 6081.1790408294755, 6085.300190478085, 6089.6955152242435, 5839.270091238595, 6023.156758053876, 6037.849053773647, 6041.758329666808, 6052.182955301022, 5948.702564871761, 5952.851178720523, 5989.251343582052, 6013.518918486532, 6025.879482410349, 5767.279090113736, 5919.852003699899, 5935.258092738408, 5950.553708471882, 5976.3724808895095, 5279.894402111936, 5294.179402192666, 5300.655457395295, 5326.707031113326, 5339.439358867341, 24025.879870600536, 24491.26526204199, 24659.136930207536, 24685.50628987428, 25090.623640645405, 2469.2345372934446, 2530.9240722778345, 2579.84520928743, 2585.961210581824, 2608.4000679843743, 15510.922445387701, 15518.922405388013, 15588.688226235412, 15635.296411661502, 15844.52466426009, 2022.9291974780813, 2114.2917122763893, 2168.533765240465, 2169.5227050048966, 2178.814800741939, 78845.60577197134, 80104.59947700224, 80553.19446805515, 81043.5947820263, 81840.18159818384, 11102.888971110347, 11276.605318813967, 11451.828222576669, 11653.708657283467, 11794.646160615195, 15963.920180399024, 16005.279762410719, 16067.634251088555, 16120.355185792438, 16184.67630647404, 8685.0, 9012.594433250519, 9113.681021164228, 9237.12247336502, 9260.490673012915, 9040.095990400907, 9048.819023619491, 9105.089491050841, 9108.316876234308, 9139.543022848831, 7068.964655176691, 7137.10786151731, 7201.17186523546, 7225.880959136587, 7266.309700578437, 1956.383739122172, 1976.7958726020383, 1994.3717728915344, 2039.6736522156384, 2049.846261530391, 1038.9064984151462, 1089.6458650938478, 1118.2507719827736, 1164.1443538998828, 1167.200467679642, 20135.194592216147, 20238.494037649176, 20475.180992760124, 20492.282770102975, 20528.794712052986, 1090.0679918669582, 1110.0619976120165, 1128.492178519653, 1151.614209239914, 1178.9056875449944, 11448.713782155513, 11917.986971107379, 11996.220245684002, 12023.759524809455, 12128.332941688292, 544472.0, 548390.0, 551187.0, 561701.0, 565541.0, 53464.0, 70092.649536752, 80108.59945700351, 81196.59401703071, 81326.18673813304, 1080.0, 1090.9454527273604, 1109.7891400633853, 1110.6001839337832, 1118.278710231896, 17699.38052168168, 18165.455036348932, 18230.72653910219, 18254.0, 18345.357912473, 38051.61948380481, 38502.42246366251, 38715.80642096772, 39429.408558872216, 39825.80087099546, 51866.74066629643, 53337.0, 53960.19059714029, 53996.46003540071, 54073.0, 8650.43772154808, 8761.03628600866, 8900.06549312313, 8923.375363724477, 9071.546422678708, 12822.743545128858, 13542.458301667823, 13861.376238069513, 13992.292717810227, 14086.22525761093, 11813.586524471602, 12197.75604487923, 12392.0, 12427.067969902113, 12433.502659893864, 12256.632301030982, 12292.877071229173, 12300.753984920431, 12323.322217278135, 12532.937335313265, 11146.721331966766, 11347.773044539228, 12008.939955300168, 12020.0, 12486.250824950532, 8773.912260877309, 9077.727668169966, 9179.082091790768, 9185.586648600962, 9351.111644393772, 9283.0, 11390.145739069769, 12196.878031219574, 12276.202046866925, 12470.501179953064], "value": 9819.451724460896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1611.363511412992, 1647.9588010299742, 1866.2286504540764, 1940.6506828770816, 1980.5345743750224, 8606.827863442728, 9162.496062716547, 9455.290853186012, 9999.10008099271, 10050.095491405782, 9245.12171343723, 9404.435733855973, 9603.519824008807, 9614.423134611929, 9623.133917947383, 2471.0609968212098, 2510.6736124303816, 2527.6208568714655, 2536.1123606737588, 2541.47899680566, 2455.594826853576, 2494.725580186178, 2516.1570873757223, 2519.6220566914926, 2520.5463016656995, 2100.9474763130966, 2109.4199095248778, 2115.4182599785104, 2116.714243577113, 2117.53414248865, 2456.152627343564, 2468.2471846086937, 2471.147454128323, 2472.5673007223663, 2505.1607711416696, 2430.7447717989535, 2433.8904749286326, 2434.342727463575, 2444.816638752083, 2447.5349683560066, 9552.044795520462, 9600.135987761136, 9618.807623847484, 9626.711198664052, 9628.855567166498, 5666.206731057655, 5858.912116318259, 5862.530997520188, 5876.823695289148, 5891.499222566087, 3640.7815531068222, 3641.2535430237003, 3677.6322367763278, 3698.408254679265, 3737.439384092381, 1131.8132508136148, 1132.0434233073122, 1133.0991861470152, 1135.5855112883821, 1143.4625725908809, 13824.101433406797, 14007.579772606736, 14026.649333766636, 14037.01740878139, 14141.222232777192, 5122.820701275437, 5153.3558305211845, 5200.93380856931, 5251.632385733038, 5263.26314315996, 11847.822282665767, 11885.465154068088, 11910.404479775976, 11915.76168476643, 11937.104717146076, 5882.058870580772, 5972.402759723993, 5985.281766187998, 5989.580729348903, 5996.880062398727, 4772.236442169236, 5260.71066091361, 5401.513863752281, 5440.646357986719, 5444.074507333763, 4416.624586910084, 4444.377787109807, 4450.2434586120435, 4456.22016147173, 4463.527036078086, 1389.2289779172454, 1407.5425486716858, 1421.1899217445957, 1431.9284035798169, 1436.561848636155, 950.2445555783169, 1073.9570417183381, 1085.4464223246043, 1090.432974853088, 1095.6274866545414, 6580.078788969548, 6607.075009498674, 6735.562188457735, 6768.83077923046, 6784.3554862288, 491.95080491951234, 493.1247036510223, 493.7777999900059, 499.9300097986285, 501.99498005019484, 4577.29051996941, 4584.17484852723, 4584.541545845389, 4608.101420223024, 4610.2623580227, 11612.6516204514, 11828.763424731456, 11831.46758395857, 11889.464974076187, 11932.582359617372, 11717.414129293502, 11751.118666100077, 11786.528538858349, 12104.15270931044, 12132.75734485323, 9081.500517471603, 9223.76940576491, 9238.815223695488, 9250.352475326798, 9318.627254909728, 6674.332566743286, 6740.595564266159, 6800.557963732342, 6959.89560156588, 7074.646267686698, 11366.488508017324, 11431.085513159094, 11582.222310860414, 11753.47109380097, 11789.76420471603, 11610.129240306842, 11693.298402095901, 11875.76248475043, 11947.641570752892, 11949.940250298692, 7789.688412463438, 8269.95865020671, 8531.616077276662, 8714.607842646968, 8892.510911899908, 9388.81222375535, 9425.340226184102, 9426.481543515172, 9448.149666530046, 9522.666706665234, 8186.386021048326, 8374.288185504056, 8396.496210227406, 8407.45351552147, 8603.569821508774, 8070.798230044061, 8099.514029158269, 8149.755507334789, 8165.836053445961, 8267.793305167419, 7468.3278504934815, 7737.806554836174, 7742.109657389472, 7776.0, 7786.844263114819, 5494.780208791603, 5731.254936858182, 5739.2252045973255, 5848.561357898089, 5904.557158213065, 5955.91066134017, 5966.582339236212, 5999.970000149971, 6006.789762358297, 6021.006533922029], "value": 5003.265980801207, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.15645026956145, 333.38989648942425, 333.73134626625574, 351.839912839658, 356.76988342519076, 5825.0, 5832.32928213255, 5834.387389324118, 5851.7074146292725, 5858.7949421770245, 5766.1639062335935, 5785.27684039495, 5788.768449262035, 5790.507806836414, 5791.884162316751, 4251.787410629471, 4359.455068116486, 4456.108778244348, 4475.149721552911, 4494.730316181023, 4468.262736648449, 4474.9776251118865, 4475.462944446671, 4477.417935668359, 4497.685162038659, 4468.017036252019, 4503.234450143484, 4519.254323036695, 4527.343535187396, 4529.954700453003, 4321.913561728764, 4391.077873646538, 4417.094495628388, 4440.933385999197, 4443.533428989942, 3909.7654140751647, 3922.0783115967724, 3936.6063393660693, 3949.5063117110362, 3978.8607398740905, 5561.610687251894, 5576.33084029919, 5586.608937374385, 5601.159826026088, 5616.213730077792, 5096.923546146811, 5157.200633901752, 5170.172772356443, 5177.430482646906, 5218.6868787872845, 6006.339302676702, 6019.578629495937, 6029.246344206974, 6052.394760523956, 6064.423879731418, 4445.377647129404, 4469.955300446986, 4480.260756975095, 4487.326900964881, 4488.573585509372, 5992.543057346467, 6299.842503937392, 6332.936670633327, 6351.904721429182, 6354.491640668735, 4408.272635015251, 4451.955480445219, 4459.175052615212, 4461.174682683714, 4464.6428285737065, 4321.503027151855, 4493.370928070073, 4503.144402563503, 4522.25382811839, 4524.0094358482165, 5125.948740512622, 5141.126008578551, 5160.535551800356, 5178.0, 5199.818006369835, 6129.069343156892, 6151.231096112986, 6156.569040167235, 6178.66017369049, 6189.381061893865, 1463.1440607244667, 1521.8249901261274, 1545.3663997760864, 1545.63677535779, 1557.2603013568464, 971.5336638413601, 1015.8780946286345, 1051.0330495943597, 1054.583439541377, 1058.6718117383482, 5883.382244864313, 5950.285965684146, 5965.463108320272, 5975.207437768652, 5993.940060599338, 6148.354422785633, 6305.369463053658, 6310.0, 6326.240851097806, 6361.809145725636, 5816.970915145397, 5911.320198177179, 5920.437558431942, 5985.892609867188, 6004.877463718842, 3346.3641908037393, 3358.5633867597544, 3387.2040070583394, 3388.5933687957604, 3390.983045084759, 6262.749490020348, 6497.545171837926, 6501.772437964649, 6520.18497687789, 6538.476921846241, 6281.0, 6307.905381419282, 6321.841953951188, 6335.841603959938, 6366.172397588284, 6274.403931626488, 6438.6136831790245, 6456.225252969673, 6479.222493300834, 6597.208334999831, 6358.459530939922, 6360.0, 6382.393672601095, 6382.808515744535, 6393.680315984275, 6086.817395478142, 6266.717997690023, 6288.182536270256, 6294.464970477561, 6350.1109844622715, 6622.1722284714415, 6637.203535575762, 6656.30108838565, 6666.033425153422, 6692.899606506004, 4471.463424389094, 4488.102379524043, 4501.819927203006, 4502.212112880298, 4510.819567217274, 6097.207363042776, 6377.0, 6380.202474690664, 6389.456896163692, 6408.967955160194, 6214.751409943552, 6228.750849966132, 6258.968705156445, 6265.8746825062335, 6300.369963003663, 6069.423404776539, 6122.6938653068055, 6170.969145154246, 6230.906536402048, 6269.592476489013, 5877.588568800143, 6095.0, 6131.172291740736, 6154.476869466145, 6204.875902481835, 6217.751289948352, 6257.874842503215, 6260.968695156495, 6278.434940855345, 6285.465735412358, 5888.499477544457, 6091.5126789857595, 6093.0, 6106.480949119375, 6133.570650054453], "value": 4660.198074014235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.8222332198576, 843.4391129898618, 855.9657613695452, 859.2953777902122, 923.0031565908819, 15703.450379236729, 16293.348266069373, 16322.0, 16416.09711465869, 16422.178891055446, 15137.545873623809, 15264.771028434583, 15288.541343759678, 15343.386264549432, 15357.001794883352, 715.68867542619, 842.9072801991776, 868.431177578687, 868.535333596526, 878.7012415778634, 874.0254616103031, 877.7015814623027, 887.7248053103526, 888.4802390601506, 889.9866502002475, 927.777333439973, 932.0958670090001, 933.3466573398648, 935.5182081228173, 935.8689783430325, 926.1664501948233, 931.1433481197281, 931.329442801182, 932.1470854168427, 932.9207017403563, 677.1062197898775, 679.7145199016425, 680.7549282258383, 682.9658517074126, 683.1290105115967, 15826.841731582652, 15908.681826363523, 15909.0, 15988.360465581363, 16044.117573533451, 14151.363188656433, 14284.857151428561, 14415.207163605997, 14903.70192596142, 15127.848721512753, 13823.0, 13927.094738841943, 14069.296535173302, 14232.85767142336, 14413.13521188732, 4813.181759100961, 4833.746750244848, 4903.0, 4978.850634480971, 4998.975005124988, 80959.19040809576, 81035.18964810335, 81519.18480815175, 82278.17721822824, 82323.17676823215, 12159.756804863853, 12356.320402377956, 12368.81446778299, 12481.126321157431, 12559.372031398576, 21962.341129766133, 21997.780022199895, 22008.339749807532, 22107.11571537153, 22129.225477108223, 8790.560471976376, 8904.065073167225, 8914.153155450222, 8945.23965462943, 9133.315001374924, 4900.289458028566, 4917.434495033045, 4966.503349665077, 5007.974960125176, 5041.59667226621, 3606.098475381155, 3702.1485058436174, 3703.5926048134684, 3704.6295370463276, 3707.1102935295876, 614.4623454477332, 679.9524033317621, 680.0717021265937, 680.5848432456198, 686.8214264291221, 646.3019938466445, 671.9025741267586, 698.0820221408933, 705.9294070592899, 721.6932803558467, 9561.426314421156, 9752.21982241419, 9755.512224388753, 9811.31320807551, 10064.899351006543, 657.3820608627874, 712.2379054411833, 753.2016062973266, 758.9734359297398, 759.6353750199935, 4333.696641235083, 4616.553226789807, 4629.587975667387, 4684.648651351163, 4724.291356296514, 106708.46645766721, 111581.44209278902, 114049.0, 114727.42636286766, 116088.41955790335, 96113.51943240239, 99719.0, 99761.0, 99973.50013249887, 100649.49675251577, 83354.16645833464, 83643.0, 83671.16328836755, 84157.0, 84489.57755211185, 8871.512066836385, 9183.586738596645, 9283.814323713623, 9428.905710943078, 9475.526223688927, 53434.0, 53492.197617034995, 54496.72751636217, 54933.17600236079, 55194.17208741952, 49944.75027624984, 72950.63524682343, 73201.0, 73404.63297683478, 74328.0, 10600.628977985734, 10672.519736612026, 11088.33469991803, 11125.388103654377, 11343.319400835977, 12414.131010829517, 12693.4287957044, 12704.74590508203, 12749.553765618159, 13026.674333141747, 11809.881901180877, 11952.820707689218, 12028.699282518008, 12054.819177712166, 12075.939620301842, 11929.403529823649, 11989.22070065443, 12066.698332541757, 12355.505779768708, 12650.05124615639, 11968.880311196777, 12007.639770806889, 12095.516179352728, 12153.210041347284, 12205.389730513261, 9865.605375784888, 10035.49822508857, 10136.290459667753, 10293.43386113771, 10462.529186186792, 10180.694579162637, 10467.842982355118, 10492.737681557717, 10583.682489525327, 10626.681199564026], "value": 7667.727048861704, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 111.0, 110.0, 109.0, 110.0, 110.0, 111.0, 109.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 132.0, 157.0, 187.0, 130.0, 157.0, 149.0, 126.0, 174.0, 125.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 163.0, 161.0, 162.0, 162.0, 164.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 175.0, 76.0, 75.0, 75.0, 75.0, 168.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 148.0, 85.0, 84.0, 85.0, 138.0, 85.0, 85.0, 150.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 55.0, 56.0, 56.0, 55.0, 55.0, 53.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 61.0, 61.0, 60.0, 59.0, 62.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 77.0, 77.0, 77.0, 77.0, 82.0, 108.0, 78.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 137.0, 122.0, 128.0, 118.0, 122.0, 126.0, 127.0, 125.0, 146.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 153.0, 155.0, 156.0, 153.0, 154.0, 154.0, 155.0, 153.0, 155.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 63.0, 61.0, 60.0, 61.0, 64.0, 61.0, 60.0], "value": 61.3, "unit": "score"}]}]} 11:45:22 INFO - Return code: 0 11:45:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:22 ERROR - # TBPL SUCCESS # 11:45:22 INFO - Running post-action listener: _resource_record_post_action 11:45:22 INFO - ##### 11:45:22 INFO - ##### Finished run-tests step (success) 11:45:22 INFO - ##### 11:45:22 INFO - Running post-run listener: _resource_record_post_run 11:45:22 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 7663616; Write bytes: 351420416; Read time: 1664; Write time: 360348 11:45:22 INFO - TinderboxPrint: CPU usage
13.3% 11:45:22 INFO - TinderboxPrint: I/O read bytes / time
7,663,616 / 1,664 11:45:22 INFO - TinderboxPrint: I/O write bytes / time
351,420,416 / 360,348 11:45:22 INFO - TinderboxPrint: CPU idle
8,212.0 (86.7%) 11:45:22 INFO - TinderboxPrint: CPU user
1,204.4 (12.7%) 11:45:22 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:22 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 6406144; Read time: 0; Write time: 672 11:45:22 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 5902336; Write bytes: 345014272; Read time: 1628; Write time: 359676 11:45:23 INFO - Running post-run listener: _upload_blobber_files 11:45:23 INFO - Blob upload gear active. 11:45:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:23 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:45:23 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:45:23 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:45:23 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:45:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:24 INFO - (blobuploader) - INFO - Done attempting. 11:45:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:45:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:45:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:25 INFO - (blobuploader) - INFO - Done attempting. 11:45:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:28 INFO - (blobuploader) - INFO - Done attempting. 11:45:28 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:28 INFO - Return code: 0 11:45:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/19fe102f18ee671939b79bedfaab632c1ef958070f0511a5231e63a8209fc00c47d2e8f715ed917a6b00531348355c721c0e741744c53850691ea11deed99f76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23796d8bb5ab93dd3718f37c6c07a36675b29b112a9d3965a942213d77af0f7b5e6bd5c0da6a0194690a504281c9cff594905001f13038899c9aac0fa35df5dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe581b106d3e545152ab60d0175e4b5df04991828331dbfd9de345359254c26aea0d5affde8bc00e3593abe61e7ccb1e5b824d9d58749cea41f8cb629de7a36f"} 11:45:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:28 INFO - Contents: 11:45:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/19fe102f18ee671939b79bedfaab632c1ef958070f0511a5231e63a8209fc00c47d2e8f715ed917a6b00531348355c721c0e741744c53850691ea11deed99f76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23796d8bb5ab93dd3718f37c6c07a36675b29b112a9d3965a942213d77af0f7b5e6bd5c0da6a0194690a504281c9cff594905001f13038899c9aac0fa35df5dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe581b106d3e545152ab60d0175e4b5df04991828331dbfd9de345359254c26aea0d5affde8bc00e3593abe61e7ccb1e5b824d9d58749cea41f8cb629de7a36f"} 11:45:28 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:28 INFO - Copying logs to upload dir... 11:45:28 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.291431 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-01 11:45:28.514776) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:28.518671) ========= 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=fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597 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/19fe102f18ee671939b79bedfaab632c1ef958070f0511a5231e63a8209fc00c47d2e8f715ed917a6b00531348355c721c0e741744c53850691ea11deed99f76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23796d8bb5ab93dd3718f37c6c07a36675b29b112a9d3965a942213d77af0f7b5e6bd5c0da6a0194690a504281c9cff594905001f13038899c9aac0fa35df5dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe581b106d3e545152ab60d0175e4b5df04991828331dbfd9de345359254c26aea0d5affde8bc00e3593abe61e7ccb1e5b824d9d58749cea41f8cb629de7a36f"} 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.011326 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/19fe102f18ee671939b79bedfaab632c1ef958070f0511a5231e63a8209fc00c47d2e8f715ed917a6b00531348355c721c0e741744c53850691ea11deed99f76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23796d8bb5ab93dd3718f37c6c07a36675b29b112a9d3965a942213d77af0f7b5e6bd5c0da6a0194690a504281c9cff594905001f13038899c9aac0fa35df5dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe581b106d3e545152ab60d0175e4b5df04991828331dbfd9de345359254c26aea0d5affde8bc00e3593abe61e7ccb1e5b824d9d58749cea41f8cb629de7a36f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:28.543958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:28.544298) ========= 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=fa44defc139c4ba8574fe040000001db-1470075410.735150-1856413597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:28.628611) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:45:28.628959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:45:28.629275) ========= ========= Total master_lag: 0.26 =========