builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1467525962.74 results: success (0) buildid: 20160701065031 builduid: c767f5fb4f57427c8722dbadfbf73505 revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.741193) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.741732) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.742070) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.878931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.879226) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 23:06:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-07-02 23:06:03 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157169 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.063122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.063435) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018368 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.117325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:06:03.117716) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e6976a28642d4d159071e14fd3251d76b9c46fa --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 5e6976a28642d4d159071e14fd3251d76b9c46fa --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=9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 23:06:03,390 truncating revision to first 12 chars 2016-07-02 23:06:03,390 Setting DEBUG logging. 2016-07-02 23:06:03,390 attempt 1/10 2016-07-02 23:06:03,390 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5e6976a28642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 23:06:04,182 unpacking tar archive at: mozilla-beta-5e6976a28642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.265903 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:06:04.398240) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.398611) ========= script_repo_revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.399063) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.399381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.412311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-02 23:06:04.412634) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:06:04 INFO - MultiFileLogger online at 20160702 23:06:04 in /builds/slave/test 23:06:04 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 23:06:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:06:04 INFO - {'append_to_log': False, 23:06:04 INFO - 'base_work_dir': '/builds/slave/test', 23:06:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:06:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:06:04 INFO - 'branch': 'Mozilla-Beta', 23:06:04 INFO - 'buildbot_json_path': 'buildprops.json', 23:06:04 INFO - 'config_files': ('talos/linux_config.py',), 23:06:04 INFO - 'default_actions': ('clobber', 23:06:04 INFO - 'read-buildbot-config', 23:06:04 INFO - 'download-and-extract', 23:06:04 INFO - 'populate-webroot', 23:06:04 INFO - 'create-virtualenv', 23:06:04 INFO - 'install', 23:06:04 INFO - 'run-tests'), 23:06:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:06:04 INFO - 'download_minidump_stackwalk': True, 23:06:04 INFO - 'download_symbols': 'ondemand', 23:06:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:06:04 INFO - 'tooltool.py': '/tools/tooltool.py', 23:06:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:06:04 INFO - '/tools/misc-python/virtualenv.py')}, 23:06:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:06:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:06:04 INFO - 'installer_path': 'installer.exe', 23:06:04 INFO - 'log_level': 'info', 23:06:04 INFO - 'log_name': 'talos', 23:06:04 INFO - 'log_to_console': True, 23:06:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:06:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:06:04 INFO - 'opt_config_files': (), 23:06:04 INFO - 'pip_index': False, 23:06:04 INFO - 'sps_profile': False, 23:06:04 INFO - 'sps_profile_interval': 0, 23:06:04 INFO - 'suite': 'dromaeojs-e10s', 23:06:04 INFO - 'system_bits': '32', 23:06:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:06:04 INFO - 'title': 'talos-linux64-ix-013', 23:06:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:06:04 INFO - 'use_talos_json': True, 23:06:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:06:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:06:04 INFO - 'work_dir': 'build'} 23:06:04 INFO - ##### 23:06:04 INFO - ##### Running clobber step. 23:06:04 INFO - ##### 23:06:04 INFO - Running pre-action listener: _resource_record_pre_action 23:06:04 INFO - Running main action method: clobber 23:06:04 INFO - rmtree: /builds/slave/test/build 23:06:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:06:05 INFO - Running post-action listener: _resource_record_post_action 23:06:05 INFO - ##### 23:06:05 INFO - ##### Running read-buildbot-config step. 23:06:05 INFO - ##### 23:06:05 INFO - Running pre-action listener: _resource_record_pre_action 23:06:05 INFO - Running main action method: read_buildbot_config 23:06:05 INFO - Using buildbot properties: 23:06:05 INFO - { 23:06:05 INFO - "project": "", 23:06:05 INFO - "product": "firefox", 23:06:05 INFO - "script_repo_revision": "production", 23:06:05 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 23:06:05 INFO - "repository": "", 23:06:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 23:06:05 INFO - "buildid": "20160701065031", 23:06:05 INFO - "pgo_build": "True", 23:06:05 INFO - "basedir": "/builds/slave/test", 23:06:05 INFO - "buildnumber": 81, 23:06:05 INFO - "slavename": "talos-linux64-ix-013", 23:06:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:06:05 INFO - "platform": "ubuntu64_hw", 23:06:05 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:06:05 INFO - "branch": "mozilla-beta", 23:06:05 INFO - "repo_path": "releases/mozilla-beta", 23:06:05 INFO - "revision": "5e6976a28642d4d159071e14fd3251d76b9c46fa", 23:06:05 INFO - "stage_platform": "linux64-pgo", 23:06:05 INFO - "builduid": "c767f5fb4f57427c8722dbadfbf73505", 23:06:05 INFO - "slavebuilddir": "test" 23:06:05 INFO - } 23:06:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 23:06:05 INFO - Running post-action listener: _resource_record_post_action 23:06:05 INFO - ##### 23:06:05 INFO - ##### Running download-and-extract step. 23:06:05 INFO - ##### 23:06:05 INFO - Running pre-action listener: _resource_record_pre_action 23:06:05 INFO - Running main action method: download_and_extract 23:06:05 INFO - mkdir: /builds/slave/test/build/tests 23:06: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')]} 23:06:05 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:06:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:06:14 INFO - Downloaded 1327 bytes. 23:06:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:14 INFO - Using the following test package requirements: 23:06:14 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:06:14 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:14 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:06:14 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:14 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 23:06:14 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:14 INFO - u'jsshell-linux-x86_64.zip'], 23:06:14 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:14 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:06:14 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:06:14 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:14 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 23:06:14 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:14 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 23:06:14 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:14 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:06:14 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:14 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:06:14 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:06:14 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')]} 23:06:14 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:06:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:06:15 INFO - Downloaded 24236612 bytes. 23:06:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:06:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:06:16 INFO - Return code: 0 23:06:16 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:16 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:06:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:06:28 INFO - Downloaded 24236612 bytes. 23:06:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:06:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:06:29 INFO - Return code: 0 23:06:29 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')]} 23:06:29 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:06:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:06:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:06:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:06:31 INFO - Downloaded 10840145 bytes. 23:06:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:06:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:06:31 INFO - Return code: 0 23:06: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')]} 23:06:31 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:06:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:06:33 INFO - Downloaded 56023399 bytes. 23:06:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:33 INFO - mkdir: /builds/slave/test/properties 23:06:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:06:33 INFO - Writing to file /builds/slave/test/properties/build_url 23:06:33 INFO - Contents: 23:06:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:33 INFO - Running post-action listener: _resource_record_post_action 23:06:33 INFO - Running post-action listener: set_extra_try_arguments 23:06:33 INFO - ##### 23:06:33 INFO - ##### Running populate-webroot step. 23:06:33 INFO - ##### 23:06:33 INFO - Running pre-action listener: _resource_record_pre_action 23:06:33 INFO - Running main action method: populate_webroot 23:06:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:06:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:06:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:06:33 INFO - '--tppagecycles', 23:06:33 INFO - '7'], 23:06:33 INFO - 'tests': ['tsvgm']}}, 23:06:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:06:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:06:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:06:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:06:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:06:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:06:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:33 INFO - 'talos_options': ['--disable-e10s'], 23:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:33 INFO - 'talos_options': ['--disable-e10s'], 23:06:33 INFO - 'tests': ['damp', 'tps']}, 23:06:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:33 INFO - 'tests': ['damp', 'tps']}, 23:06:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:06:33 INFO - 'tests': ['dromaeo_dom']}, 23:06:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:06:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:06:33 INFO - 'tests': ['a11yr', 23:06:33 INFO - 'ts_paint', 23:06:33 INFO - 'tpaint', 23:06:33 INFO - 'sessionrestore', 23:06:33 INFO - 'sessionrestore_no_auto_restore', 23:06:33 INFO - 'tabpaint']}, 23:06:33 INFO - 'other-e10s': {'tests': ['a11yr', 23:06:33 INFO - 'ts_paint', 23:06:33 INFO - 'tpaint', 23:06:33 INFO - 'sessionrestore', 23:06:33 INFO - 'sessionrestore_no_auto_restore', 23:06:33 INFO - 'tabpaint']}, 23:06:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:06:33 INFO - 'ts_paint', 23:06:33 INFO - 'tpaint', 23:06:33 INFO - 'sessionrestore', 23:06:33 INFO - 'sessionrestore_no_auto_restore', 23:06:33 INFO - 'tabpaint']}, 23:06:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:06:33 INFO - 'ts_paint', 23:06:33 INFO - 'tpaint', 23:06:33 INFO - 'sessionrestore', 23:06:33 INFO - 'sessionrestore_no_auto_restore', 23:06:33 INFO - 'tabpaint']}, 23:06:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:06:33 INFO - 'tests': ['a11yr', 23:06:33 INFO - 'ts_paint', 23:06:33 INFO - 'tpaint', 23:06:33 INFO - 'sessionrestore', 23:06:33 INFO - 'sessionrestore_no_auto_restore', 23:06:33 INFO - 'tabpaint']}, 23:06:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:06:33 INFO - 'tests': ['a11yr', 23:06:33 INFO - 'ts_paint', 23:06:33 INFO - 'tpaint', 23:06:33 INFO - 'sessionrestore', 23:06:33 INFO - 'sessionrestore_no_auto_restore', 23:06:33 INFO - 'tabpaint']}, 23:06:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:06:33 INFO - 'tests': ['tsvgx', 23:06:33 INFO - 'tsvgr_opacity', 23:06:33 INFO - 'tart', 23:06:33 INFO - 'tscrollx', 23:06:33 INFO - 'cart']}, 23:06:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:06:33 INFO - 'tsvgr_opacity', 23:06:33 INFO - 'tart', 23:06:33 INFO - 'tscrollx', 23:06:33 INFO - 'cart']}, 23:06:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:33 INFO - 'talos_options': ['--disable-e10s'], 23:06:33 INFO - 'tests': ['tp5o']}, 23:06:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:33 INFO - 'tests': ['tp5o']}, 23:06:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:33 INFO - 'talos_options': ['--disable-e10s', 23:06:33 INFO - '--xperf_path', 23:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:33 INFO - 'tests': ['tp5n']}, 23:06:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:33 INFO - 'talos_options': ['--xperf_path', 23:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:33 INFO - 'tests': ['tp5n']}}, 23:06:33 INFO - 'talos.zip': {'path': '', 23:06:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:06:33 INFO - Running post-action listener: _resource_record_post_action 23:06:33 INFO - ##### 23:06:33 INFO - ##### Running create-virtualenv step. 23:06:33 INFO - ##### 23:06:33 INFO - Running pre-action listener: _resource_record_pre_action 23:06:33 INFO - Running main action method: create_virtualenv 23:06:33 INFO - Creating virtualenv /builds/slave/test/build/venv 23:06:33 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 23:06:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:06:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:06:33 INFO - Using real prefix '/usr' 23:06:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:06:34 INFO - Installing distribute.............................................................................................................................................................................................done. 23:06:36 INFO - Installing pip.................done. 23:06:36 INFO - Return code: 0 23:06:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:06:36 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')]} 23:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:36 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')]} 23:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:36 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 0x7fde72784f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066410>, '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 0x2067310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20677a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', '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 23:06:36 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 23:06:36 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 23:06:36 INFO - Using env: {'DISPLAY': ':0', 23:06:36 INFO - 'HOME': '/home/cltbld', 23:06:36 INFO - 'LANG': 'en_US.UTF-8', 23:06:36 INFO - 'LANGUAGE': 'en_US:en', 23:06:36 INFO - 'LOGNAME': 'cltbld', 23:06:36 INFO - 'MAIL': '/var/mail/cltbld', 23:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:36 INFO - 'MOZ_NO_REMOTE': '1', 23:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:36 INFO - 'NO_EM_RESTART': '1', 23:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:36 INFO - 'PWD': '/builds/slave/test', 23:06:36 INFO - 'SHELL': '/bin/bash', 23:06:36 INFO - 'SHLVL': '1', 23:06:36 INFO - 'TERM': 'linux', 23:06:36 INFO - 'TMOUT': '86400', 23:06:36 INFO - 'USER': 'cltbld', 23:06:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', 23:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:36 INFO - '_': '/tools/buildbot/bin/python'} 23:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:36 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 23:06:36 INFO - Cleaning up... 23:06:36 INFO - Return code: 0 23:06:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:06:36 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')]} 23:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:36 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')]} 23:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:36 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde72784f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066410>, '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 0x2067310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20677a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', '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 23:06:36 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>=0.7.1'] in /builds/slave/test/build 23:06:36 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>=0.7.1 23:06:36 INFO - Using env: {'DISPLAY': ':0', 23:06:36 INFO - 'HOME': '/home/cltbld', 23:06:36 INFO - 'LANG': 'en_US.UTF-8', 23:06:36 INFO - 'LANGUAGE': 'en_US:en', 23:06:36 INFO - 'LOGNAME': 'cltbld', 23:06:36 INFO - 'MAIL': '/var/mail/cltbld', 23:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:36 INFO - 'MOZ_NO_REMOTE': '1', 23:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:36 INFO - 'NO_EM_RESTART': '1', 23:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:36 INFO - 'PWD': '/builds/slave/test', 23:06:36 INFO - 'SHELL': '/bin/bash', 23:06:36 INFO - 'SHLVL': '1', 23:06:36 INFO - 'TERM': 'linux', 23:06:36 INFO - 'TMOUT': '86400', 23:06:36 INFO - 'USER': 'cltbld', 23:06:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', 23:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:36 INFO - '_': '/tools/buildbot/bin/python'} 23:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:36 INFO - Downloading/unpacking psutil>=0.7.1 23:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:38 INFO - Installing collected packages: psutil 23:06:38 INFO - Running setup.py install for psutil 23:06:38 INFO - building 'psutil._psutil_linux' extension 23:06:38 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 23:06:39 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 23:06:39 INFO - building 'psutil._psutil_posix' extension 23:06:39 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 23:06:39 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 23:06:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:39 INFO - Successfully installed psutil 23:06:39 INFO - Cleaning up... 23:06:39 INFO - Return code: 0 23:06:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:39 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde72784f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066410>, '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 0x2067310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20677a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', '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 23:06:39 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.0.0'] in /builds/slave/test/build 23:06:39 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.0.0 23:06:39 INFO - Using env: {'DISPLAY': ':0', 23:06:39 INFO - 'HOME': '/home/cltbld', 23:06:39 INFO - 'LANG': 'en_US.UTF-8', 23:06:39 INFO - 'LANGUAGE': 'en_US:en', 23:06:39 INFO - 'LOGNAME': 'cltbld', 23:06:39 INFO - 'MAIL': '/var/mail/cltbld', 23:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:39 INFO - 'MOZ_NO_REMOTE': '1', 23:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:39 INFO - 'NO_EM_RESTART': '1', 23:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:39 INFO - 'PWD': '/builds/slave/test', 23:06:39 INFO - 'SHELL': '/bin/bash', 23:06:39 INFO - 'SHLVL': '1', 23:06:39 INFO - 'TERM': 'linux', 23:06:39 INFO - 'TMOUT': '86400', 23:06:39 INFO - 'USER': 'cltbld', 23:06:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', 23:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:39 INFO - '_': '/tools/buildbot/bin/python'} 23:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:06:39 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 23:06:39 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 23:06:39 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 23:06:39 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 23:06:39 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 23:06:39 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 23:06:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:06:41 INFO - Installing collected packages: mozsystemmonitor 23:06:41 INFO - Running setup.py install for mozsystemmonitor 23:06:41 INFO - Successfully installed mozsystemmonitor 23:06:41 INFO - Cleaning up... 23:06:41 INFO - Return code: 0 23:06:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:06:41 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')]} 23:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:41 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')]} 23:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:41 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 0x7fde72784f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066410>, '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 0x2067310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20677a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', '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 23:06:41 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 23:06:41 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 23:06:41 INFO - Using env: {'DISPLAY': ':0', 23:06:41 INFO - 'HOME': '/home/cltbld', 23:06:41 INFO - 'LANG': 'en_US.UTF-8', 23:06:41 INFO - 'LANGUAGE': 'en_US:en', 23:06:41 INFO - 'LOGNAME': 'cltbld', 23:06:41 INFO - 'MAIL': '/var/mail/cltbld', 23:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:41 INFO - 'MOZ_NO_REMOTE': '1', 23:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:41 INFO - 'NO_EM_RESTART': '1', 23:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:41 INFO - 'PWD': '/builds/slave/test', 23:06:41 INFO - 'SHELL': '/bin/bash', 23:06:41 INFO - 'SHLVL': '1', 23:06:41 INFO - 'TERM': 'linux', 23:06:41 INFO - 'TMOUT': '86400', 23:06:41 INFO - 'USER': 'cltbld', 23:06:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', 23:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:41 INFO - '_': '/tools/buildbot/bin/python'} 23:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:41 INFO - Downloading/unpacking blobuploader==1.2.4 23:06:41 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 23:06:41 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 23:06:41 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 23:06:41 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 23:06:41 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 23:06:41 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 23:06:43 INFO - Downloading blobuploader-1.2.4.tar.gz 23:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:06:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:06:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:06:44 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 23:06:44 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 23:06:44 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 23:06:44 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 23:06:44 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 23:06:44 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 23:06:44 INFO - Downloading docopt-0.6.1.tar.gz 23:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:06:44 INFO - Installing collected packages: blobuploader, requests, docopt 23:06:44 INFO - Running setup.py install for blobuploader 23:06:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:06:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:06:44 INFO - Running setup.py install for requests 23:06:45 INFO - Running setup.py install for docopt 23:06:45 INFO - Successfully installed blobuploader requests docopt 23:06:45 INFO - Cleaning up... 23:06:45 INFO - Return code: 0 23:06:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:45 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 0x7fde72784f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066410>, '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 0x2067310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20677a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', '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 23:06:45 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 23:06:45 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 23:06:45 INFO - Using env: {'DISPLAY': ':0', 23:06:45 INFO - 'HOME': '/home/cltbld', 23:06:45 INFO - 'LANG': 'en_US.UTF-8', 23:06:45 INFO - 'LANGUAGE': 'en_US:en', 23:06:45 INFO - 'LOGNAME': 'cltbld', 23:06:45 INFO - 'MAIL': '/var/mail/cltbld', 23:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:45 INFO - 'MOZ_NO_REMOTE': '1', 23:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:45 INFO - 'NO_EM_RESTART': '1', 23:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:45 INFO - 'PWD': '/builds/slave/test', 23:06:45 INFO - 'SHELL': '/bin/bash', 23:06:45 INFO - 'SHLVL': '1', 23:06:45 INFO - 'TERM': 'linux', 23:06:45 INFO - 'TMOUT': '86400', 23:06:45 INFO - 'USER': 'cltbld', 23:06:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', 23:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:45 INFO - '_': '/tools/buildbot/bin/python'} 23:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:45 INFO - Running setup.py (path:/tmp/pip-8KUfCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:45 INFO - Running setup.py (path:/tmp/pip-H1J1sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:45 INFO - Running setup.py (path:/tmp/pip-CCkvNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:45 INFO - Running setup.py (path:/tmp/pip-z4GKiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:45 INFO - Running setup.py (path:/tmp/pip-HdpPz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:45 INFO - Running setup.py (path:/tmp/pip-XEePOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:45 INFO - Running setup.py (path:/tmp/pip-xQadq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:45 INFO - Running setup.py (path:/tmp/pip-iZ0eMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:45 INFO - Running setup.py (path:/tmp/pip-7JtqHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:46 INFO - Running setup.py (path:/tmp/pip-qOrBSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:46 INFO - Running setup.py (path:/tmp/pip-kVKFaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:46 INFO - Running setup.py (path:/tmp/pip-G3jygB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:46 INFO - Running setup.py (path:/tmp/pip-rurRb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:46 INFO - Running setup.py (path:/tmp/pip-s0qSDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:46 INFO - Running setup.py (path:/tmp/pip-AQfMGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:46 INFO - Running setup.py (path:/tmp/pip-MFwgOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:46 INFO - Running setup.py (path:/tmp/pip-XIX3jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:06:46 INFO - Running setup.py install for manifestparser 23:06:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:06:46 INFO - Running setup.py install for mozcrash 23:06:46 INFO - Running setup.py install for mozdebug 23:06:46 INFO - Running setup.py install for mozdevice 23:06:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Running setup.py install for mozfile 23:06:47 INFO - Running setup.py install for mozhttpd 23:06:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Running setup.py install for mozinfo 23:06:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Running setup.py install for mozInstall 23:06:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Running setup.py install for mozleak 23:06:47 INFO - Running setup.py install for mozlog 23:06:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Running setup.py install for moznetwork 23:06:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Running setup.py install for mozprocess 23:06:47 INFO - Running setup.py install for mozprofile 23:06:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:06:47 INFO - Running setup.py install for mozrunner 23:06:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:06:48 INFO - Running setup.py install for mozscreenshot 23:06:48 INFO - Running setup.py install for moztest 23:06:48 INFO - Running setup.py install for mozversion 23:06:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:06:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:06:48 INFO - Cleaning up... 23:06:48 INFO - Return code: 0 23:06:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:48 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 0x7fde72784f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066410>, '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 0x2067310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20677a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', '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 23:06:48 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 23:06:48 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 23:06:48 INFO - Using env: {'DISPLAY': ':0', 23:06:48 INFO - 'HOME': '/home/cltbld', 23:06:48 INFO - 'LANG': 'en_US.UTF-8', 23:06:48 INFO - 'LANGUAGE': 'en_US:en', 23:06:48 INFO - 'LOGNAME': 'cltbld', 23:06:48 INFO - 'MAIL': '/var/mail/cltbld', 23:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:48 INFO - 'MOZ_NO_REMOTE': '1', 23:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:48 INFO - 'NO_EM_RESTART': '1', 23:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:48 INFO - 'PWD': '/builds/slave/test', 23:06:48 INFO - 'SHELL': '/bin/bash', 23:06:48 INFO - 'SHLVL': '1', 23:06:48 INFO - 'TERM': 'linux', 23:06:48 INFO - 'TMOUT': '86400', 23:06:48 INFO - 'USER': 'cltbld', 23:06:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', 23:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:48 INFO - '_': '/tools/buildbot/bin/python'} 23:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:48 INFO - Running setup.py (path:/tmp/pip-pavmYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:48 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)) 23:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:48 INFO - Running setup.py (path:/tmp/pip-cL6UgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:48 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)) 23:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:48 INFO - Running setup.py (path:/tmp/pip-5HMES9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:48 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)) 23:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:48 INFO - Running setup.py (path:/tmp/pip-ug6Pkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:48 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)) 23:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:48 INFO - Running setup.py (path:/tmp/pip-t1wVDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:48 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)) 23:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:48 INFO - Running setup.py (path:/tmp/pip-7T_bq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:49 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)) 23:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:49 INFO - Running setup.py (path:/tmp/pip-Dmu3qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:49 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)) 23:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:49 INFO - Running setup.py (path:/tmp/pip-ggUzi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:49 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)) 23:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:49 INFO - Running setup.py (path:/tmp/pip-gAw6bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:49 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)) 23:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:49 INFO - Running setup.py (path:/tmp/pip-MGtpmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 23:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:49 INFO - Running setup.py (path:/tmp/pip-wflF14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:49 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)) 23:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:49 INFO - Running setup.py (path:/tmp/pip-OpbbnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:49 INFO - Running setup.py (path:/tmp/pip-35xmJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:49 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)) 23:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:49 INFO - Running setup.py (path:/tmp/pip-v0uHAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:49 INFO - Running setup.py (path:/tmp/pip-aT23HK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:49 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)) 23:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:49 INFO - Running setup.py (path:/tmp/pip-bUH7o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:49 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)) 23:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:49 INFO - Running setup.py (path:/tmp/pip-7DCSnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:49 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)) 23:06:49 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)) 23:06:49 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)) 23:06:49 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)) 23:06:49 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)) 23:06:49 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)) 23:06:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:49 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 23:06:49 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 23:06:49 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 23:06:49 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 23:06:49 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 23:06:49 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 23:06:51 INFO - Downloading blessings-1.6.tar.gz 23:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:06:51 INFO - Installing collected packages: blessings 23:06:51 INFO - Running setup.py install for blessings 23:06:51 INFO - Successfully installed blessings 23:06:51 INFO - Cleaning up... 23:06:51 INFO - Return code: 0 23:06:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:06:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:52 INFO - Reading from file tmpfile_stdout 23:06:52 INFO - Current package versions: 23:06:52 INFO - argparse == 1.2.1 23:06:52 INFO - blessings == 1.6 23:06:52 INFO - blobuploader == 1.2.4 23:06:52 INFO - docopt == 0.6.1 23:06:52 INFO - manifestparser == 1.1 23:06:52 INFO - mozInstall == 1.12 23:06:52 INFO - mozcrash == 0.17 23:06:52 INFO - mozdebug == 0.1 23:06:52 INFO - mozdevice == 0.48 23:06:52 INFO - mozfile == 1.2 23:06:52 INFO - mozhttpd == 0.7 23:06:52 INFO - mozinfo == 0.9 23:06:52 INFO - mozleak == 0.1 23:06:52 INFO - mozlog == 3.1 23:06:52 INFO - moznetwork == 0.27 23:06:52 INFO - mozprocess == 0.22 23:06:52 INFO - mozprofile == 0.28 23:06:52 INFO - mozrunner == 6.11 23:06:52 INFO - mozscreenshot == 0.1 23:06:52 INFO - mozsystemmonitor == 0.0 23:06:52 INFO - moztest == 0.7 23:06:52 INFO - mozversion == 1.4 23:06:52 INFO - psutil == 3.1.1 23:06:52 INFO - requests == 1.2.3 23:06:52 INFO - wsgiref == 0.1.2 23:06:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:52 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')]} 23:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:52 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')]} 23:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:52 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 0x7fde72784f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066410>, '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 0x2067310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20677a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', '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 23:06:52 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 23:06:52 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 23:06:52 INFO - Using env: {'DISPLAY': ':0', 23:06:52 INFO - 'HOME': '/home/cltbld', 23:06:52 INFO - 'LANG': 'en_US.UTF-8', 23:06:52 INFO - 'LANGUAGE': 'en_US:en', 23:06:52 INFO - 'LOGNAME': 'cltbld', 23:06:52 INFO - 'MAIL': '/var/mail/cltbld', 23:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:52 INFO - 'MOZ_NO_REMOTE': '1', 23:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:52 INFO - 'NO_EM_RESTART': '1', 23:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:52 INFO - 'PWD': '/builds/slave/test', 23:06:52 INFO - 'SHELL': '/bin/bash', 23:06:52 INFO - 'SHLVL': '1', 23:06:52 INFO - 'TERM': 'linux', 23:06:52 INFO - 'TMOUT': '86400', 23:06:52 INFO - 'USER': 'cltbld', 23:06:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', 23:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:52 INFO - '_': '/tools/buildbot/bin/python'} 23:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:52 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)) 23:06:52 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)) 23:06:52 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)) 23:06:52 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)) 23:06:52 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)) 23:06:52 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)) 23:06:52 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)) 23:06:52 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)) 23:06:52 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)) 23:06:52 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)) 23:06:52 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)) 23:06:52 INFO - Cleaning up... 23:06:52 INFO - Return code: 0 23:06:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:06:52 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')]} 23:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:52 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')]} 23:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:52 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 0x7fde72784f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066410>, '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 0x2067310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20677a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', '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 23:06:52 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 23:06:52 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 23:06:52 INFO - Using env: {'DISPLAY': ':0', 23:06:52 INFO - 'HOME': '/home/cltbld', 23:06:52 INFO - 'LANG': 'en_US.UTF-8', 23:06:52 INFO - 'LANGUAGE': 'en_US:en', 23:06:52 INFO - 'LOGNAME': 'cltbld', 23:06:52 INFO - 'MAIL': '/var/mail/cltbld', 23:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:52 INFO - 'MOZ_NO_REMOTE': '1', 23:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:52 INFO - 'NO_EM_RESTART': '1', 23:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:52 INFO - 'PWD': '/builds/slave/test', 23:06:52 INFO - 'SHELL': '/bin/bash', 23:06:52 INFO - 'SHLVL': '1', 23:06:52 INFO - 'TERM': 'linux', 23:06:52 INFO - 'TMOUT': '86400', 23:06:52 INFO - 'USER': 'cltbld', 23:06:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', 23:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:52 INFO - '_': '/tools/buildbot/bin/python'} 23:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:52 INFO - Downloading/unpacking jsonschema 23:06:52 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 23:06:52 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 23:06:52 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 23:06:52 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 23:06:52 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 23:06:52 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 23:06:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:06:54 INFO - Downloading/unpacking functools32 (from jsonschema) 23:06:54 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 23:06:54 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 23:06:54 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 23:06:54 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 23:06:54 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 23:06:54 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 23:06:54 INFO - Downloading functools32-3.2.3-2.tar.gz 23:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:06:54 INFO - warning: no files found matching '*.txt' 23:06:54 INFO - no previously-included directories found matching 'build' 23:06:54 INFO - no previously-included directories found matching 'dist' 23:06:54 INFO - no previously-included directories found matching '.git*' 23:06:54 INFO - Installing collected packages: jsonschema, functools32 23:06:54 INFO - Running setup.py install for functools32 23:06:54 INFO - warning: no files found matching '*.txt' 23:06:54 INFO - no previously-included directories found matching 'build' 23:06:54 INFO - no previously-included directories found matching 'dist' 23:06:54 INFO - no previously-included directories found matching '.git*' 23:06:54 INFO - Successfully installed jsonschema functools32 23:06:54 INFO - Cleaning up... 23:06:55 INFO - Return code: 0 23:06:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:06: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')]} 23:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06: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')]} 23:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:55 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 0x7fde72784f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066410>, '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 0x2067310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20677a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', '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 23:06:55 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 23:06:55 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 23:06:55 INFO - Using env: {'DISPLAY': ':0', 23:06:55 INFO - 'HOME': '/home/cltbld', 23:06:55 INFO - 'LANG': 'en_US.UTF-8', 23:06:55 INFO - 'LANGUAGE': 'en_US:en', 23:06:55 INFO - 'LOGNAME': 'cltbld', 23:06:55 INFO - 'MAIL': '/var/mail/cltbld', 23:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:55 INFO - 'MOZ_NO_REMOTE': '1', 23:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:55 INFO - 'NO_EM_RESTART': '1', 23:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:55 INFO - 'PWD': '/builds/slave/test', 23:06:55 INFO - 'SHELL': '/bin/bash', 23:06:55 INFO - 'SHLVL': '1', 23:06:55 INFO - 'TERM': 'linux', 23:06:55 INFO - 'TMOUT': '86400', 23:06:55 INFO - 'USER': 'cltbld', 23:06:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', 23:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:55 INFO - '_': '/tools/buildbot/bin/python'} 23:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:55 INFO - Downloading/unpacking flake8 23:06:55 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 23:06:55 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 23:06:55 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 23:06:55 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 23:06:55 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 23:06:55 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 23:06:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:06:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:06:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 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 23:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:57 INFO - no previously-included directories found matching 'docs/_build' 23:06:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:06:57 INFO - Running setup.py install for pep8 23:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:57 INFO - no previously-included directories found matching 'docs/_build' 23:06:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:06:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:06:58 INFO - Cleaning up... 23:06:58 INFO - Return code: 0 23:06:58 INFO - Running post-action listener: _resource_record_post_action 23:06:58 INFO - Running post-action listener: _start_resource_monitoring 23:06:58 INFO - Starting resource monitoring. 23:06:58 INFO - ##### 23:06:58 INFO - ##### Running install step. 23:06:58 INFO - ##### 23:06:58 INFO - Running pre-action listener: _resource_record_pre_action 23:06:58 INFO - Running main action method: install 23:06:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:58 INFO - Reading from file tmpfile_stdout 23:06:58 INFO - Detecting whether we're running mozinstall >=1.0... 23:06:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:06:58 INFO - Reading from file tmpfile_stdout 23:06:58 INFO - Output received: 23:06:58 INFO - Usage: mozinstall [options] installer 23:06:58 INFO - Options: 23:06:58 INFO - -h, --help show this help message and exit 23:06:58 INFO - -d DEST, --destination=DEST 23:06:58 INFO - Directory to install application into. [default: 23:06:58 INFO - "/builds/slave/test"] 23:06:58 INFO - --app=APP Application being installed. [default: firefox] 23:06:58 INFO - mkdir: /builds/slave/test/build/application 23:06:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:07:11 INFO - Reading from file tmpfile_stdout 23:07:11 INFO - Output received: 23:07:11 INFO - /builds/slave/test/build/application/firefox/firefox 23:07:11 INFO - Running post-action listener: _resource_record_post_action 23:07:11 INFO - ##### 23:07:11 INFO - ##### Running run-tests step. 23:07:11 INFO - ##### 23:07:11 INFO - Running pre-action listener: _resource_record_pre_action 23:07:11 INFO - Running main action method: run_tests 23:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:07:11 INFO - Python 2.7.3 23:07:11 INFO - Return code: 0 23:07:11 INFO - grabbing minidump binary from tooltool 23:07: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')]} 23:07:11 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066410>, '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 0x2067310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20677a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:07:11 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 23:07:11 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 23:07:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:07:11 INFO - Return code: 0 23:07:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:07:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:07:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:07:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:07:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:07:12 INFO - Return code: 0 23:07:12 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/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 23:07:12 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/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 23:07:12 INFO - Using env: {'DISPLAY': ':0', 23:07:12 INFO - 'HOME': '/home/cltbld', 23:07:12 INFO - 'LANG': 'en_US.UTF-8', 23:07:12 INFO - 'LANGUAGE': 'en_US:en', 23:07:12 INFO - 'LOGNAME': 'cltbld', 23:07:12 INFO - 'MAIL': '/var/mail/cltbld', 23:07:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:07:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:12 INFO - 'MOZ_NO_REMOTE': '1', 23:07:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:12 INFO - 'NO_EM_RESTART': '1', 23:07:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:12 INFO - 'PWD': '/builds/slave/test', 23:07:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:07:12 INFO - 'SHELL': '/bin/bash', 23:07:12 INFO - 'SHLVL': '1', 23:07:12 INFO - 'TERM': 'linux', 23:07:12 INFO - 'TMOUT': '86400', 23:07:12 INFO - 'USER': 'cltbld', 23:07:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885', 23:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:12 INFO - '_': '/tools/buildbot/bin/python'} 23:07:12 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/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 23:07:12 INFO - mozversion application_buildid: 20160701065031 23:07:12 INFO - mozversion application_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:07:12 INFO - mozversion application_display_name: Firefox 23:07:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:07:12 INFO - mozversion application_name: Firefox 23:07:12 INFO - mozversion application_remotingname: firefox 23:07:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:07:12 INFO - mozversion application_vendor: Mozilla 23:07:12 INFO - mozversion application_version: 48.0 23:07:12 INFO - mozversion platform_buildid: 20160701065031 23:07:12 INFO - mozversion platform_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:07:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:07:12 INFO - mozversion platform_version: 48.0 23:07:12 INFO - using testdate: 1467526032 23:07:12 INFO - actual date: 1467526032 23:07:12 INFO - starting webserver on 'localhost:35205' 23:07:12 INFO - SUITE-START | Running 2 tests 23:07:12 INFO - TEST-START | dromaeo_css 23:07:12 INFO - operating with platform_type : linux_ 23:07:12 INFO - Initialising browser for dromaeo_css test... 23:07:12 INFO - TEST-INFO | started process 27641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLdBqP8/profile http://localhost:35205/getInfo.html) 23:07:16 INFO - PROCESS | 27641 | 23:07:16 INFO - PROCESS | 27641 | (process:27719): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:07:17 INFO - PROCESS | 27641 | __metrics Screen width/height:1600/1200 23:07:17 INFO - PROCESS | 27641 | colorDepth:24 23:07:17 INFO - PROCESS | 27641 | Browser inner width/height: 1024/697 23:07:17 INFO - PROCESS | 27641 | __metrics 23:07:18 ERROR - PROCESS | 27641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:07:18 INFO - TEST-INFO | 27641: exit 0 23:07:18 INFO - Browser initialized. 23:07:18 INFO - Running cycle 1/1 for dromaeo_css test... 23:07:19 INFO - TEST-INFO | started process 27769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLdBqP8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:20 INFO - PROCESS | 27769 | 23:07:20 INFO - PROCESS | 27769 | (process:27836): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:07:30 INFO - PROCESS | 27769 | RSS: Main: 150376448 23:07:30 INFO - PROCESS | 27769 | 23:08:20 INFO - PROCESS | 27769 | 1467526100339 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] 23:10:27 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:35205/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35205/tests/dromaeo/cssquery-ext.html) 23:10:28 INFO - PROCESS | 27769 | RSS: Main: 155148288 23:10:28 INFO - PROCESS | 27769 | 23:13:30 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:35205/tests/dromaeo/cssquery-ext.html (next: http://localhost:35205/tests/dromaeo/cssquery-jquery.html) 23:13:31 INFO - PROCESS | 27769 | RSS: Main: 152797184 23:13:31 INFO - PROCESS | 27769 | 23:16:33 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:35205/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35205/tests/dromaeo/cssquery-mootools.html) 23:16:33 INFO - PROCESS | 27769 | RSS: Main: 153116672 23:16:33 INFO - PROCESS | 27769 | 23:19:35 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:35205/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35205/tests/dromaeo/cssquery-prototype.html) 23:19:35 INFO - PROCESS | 27769 | RSS: Main: 153587712 23:19:35 INFO - PROCESS | 27769 | 23:22:38 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:35205/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35205/tests/dromaeo/cssquery-yui.html) 23:22:38 INFO - PROCESS | 27769 | RSS: Main: 152543232 23:22:38 INFO - PROCESS | 27769 | 23:25:40 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:35205/tests/dromaeo/cssquery-yui.html (next: http://localhost:35205/tests/dromaeo/cssquery-dojo.html) 23:25:41 INFO - PROCESS | 27769 | RSS: Main: 156557312 23:25:41 INFO - PROCESS | 27769 | 23:25:41 INFO - PROCESS | 27769 | __start_tp_report 23:25:41 INFO - PROCESS | 27769 | _x_x_mozilla_page_load 23:25:41 INFO - PROCESS | 27769 | _x_x_mozilla_page_load_details 23:25:41 INFO - PROCESS | 27769 | |i|pagename|runs| 23:25:41 INFO - PROCESS | 27769 | |0;dojo.html;3357.479590663447;3430.536877521534;3443.9655603443957;3449.724022078234;3483.0769845990817;5602.46776556227;5609.775608975641;5623.381428042922;5636.1264004079385;5640.266765320513;5597.6641401515935;5609.607327487078;5621.4659607337235;5625.212470254168;5630.268065151525;5039.848804535861;5071.568916642072;5125.103106956286;5178.093833579127;5182.870428239286;5089.185730283156;5128.640995130342;5158.2004789257535;5267.86830329241;5272.578193744491;5116.667416617926;5141.82003629873;5154.098032844256;5155.690658560479;5206.947930520684;5118.283440318359;5122.718250496221;5132.948670513321;5147.48525147486;5163.432022477525;4944.975275123601;4966.304717339575;5012.924806127911;5016.072026675077;5082.720450375228;5435;5453.672779633195;5462.535684466825;5465.180222966586;5521.5306698930235;5900.468957793819;5926.288845338544;5930.110483427477;5939.168516407706;5966.820995370146;5917.911231331534;5920.851978700523;5994.97002514989;6000.669963152025;6114;5660.094384898438;5668.97165514174;5669.971650141723;5672.858178545528;5699.145128230757;6148.385161483905;6157.96921015392;6167.259928808572;6167.475764559973;6180.8763824723255;5770.480656740913;5827.854303642443;5917.082852157922;5939.2575928009;5945.256842894638;6016.819495415057;6044.335123136451;6046.244219472566;6047.909281360783;6064.151018857364;5970.402959703995;6004;6008.399160084044;6012.188354572077;6025.186599809057;5944.7324870380935;5947.434993675594;6014.72933717975;6024.126501657235;6028.849278768066;4544.977275113603;4562.520935301812;4565.406497155349;4584.862454126382;4612.0545288215835;4046.635802777764;4109.301418758818;4119.052617897841;4123.60825721556;4141.213169497786;5686.317641882918;5732.0255556555485;5813.854653633693;5864.296284445893;5896.233489646404;6050.757969681252;6114.021756518936;6115.611137939864;6118.832384214075;6120.050983828535;5729.197912292282;5834.183214349994;5840.153177789197;5851.414858514115;5851.6781577012825;5125.487451254845;5174.611904107207;5230.424653288135;5247.081760691864;5249.291345668286;6255.12428260044;6293.3391993840905;6296.905546416808;6298.685065746786;6324.43080122782;6013.248343957005;6032.788852390233;6038.5772995889865;6042.758289668364;6047.274327080779;6239.469645080219;6317.5893566918;6342.682865856781;6353.872922541431;6362.936370636235;5919.6152250103605;5925.081612350093;5925.4370834770625;5933.917062626473;5960.76156953717;5904.940950590439;5945.970270148621;5996.940030599812;6008.8798224036145;6037.9735444973585;5927.4665280125;5965.9105113422465;5972.163897054329;5973.074173503114;6005.129256257731;5869.7945571904775;5956.047032474957;5966.910496342472;5971.044632858895;5975.312839023568;5730.799422020376;5776.42235776419;5880.14737863016;5891.05743081105;5910.261217347832;5826.504747096545;5921.940780592139;5930.7924222652;5950.285965684146;5971.193888824953;5815.244018277766;5821.738021789114;5822.272215973004;5824.912626310694;5830.300363956352 23:25:41 INFO - PROCESS | 27769 | |1;ext.html;648.7923864363405;677.3937326093146;692.3042342445841;721.5237942957646;735.5586648011194;38415.80792096039;38876.416853747214;38901;38996.41505377422;39184;40015.199696006064;40794.18411631773;40801.183976320455;40861.59138408615;40982.795086024526;8698.086700896394;8971.461712297283;8996.460212387277;9010.504422256774;9031.23234525066;8764.21122099011;8833.646654133827;8888.822223555526;9155.587998540082;9187.081291870827;9124.589393477276;9150.86273705895;9173.08269173084;9177.128172823604;9222.21611163052;9115.908840911572;9181.540922953825;9214.44713317203;9222.631094756201;9239.907600924005;9023.458592484472;9096.8635470468;9149.679761208392;9160.129787670161;9167.862482062774;42796.78601607003;42993.35509967353;43382;43382.349264761055;43400.3489947651;3846.653801157909;3861.2856621525107;3916.902077448058;4105.117399759066;4249.383839343278;33051.3389732204;33393;33525.32949341024;33627.663723362944;34404.31191376159;4366.366876802846;4428.269335559628;4443.666724995638;4463.196624607569;4475.373447717322;310702.4464877684;314378;316199;316669;317087;39923.80038099791;60598.091028634604;61243.38756612377;61594;61780.38219617836;38780;39002;39073.609263907565;39136.21727565433;39245.80377098153;16826.158692065346;16940.152992350333;17028.57428564271;17065.06142162168;17123.22945467457;14321.856781432261;14467.565973020826;14487.058341207789;14501.129932204101;14535.27323633814;9414.482203478738;9494.905050949541;9528;9556.187724043533;9583.616655333848;3623.7644553103964;3674.8713795017047;3695.926081478355;3723.2367364690717;3730.6642402183934;1103.6137351926761;1123.455124264731;1142.8514293142005;1155.5031336525208;1181.704573856536;34361.31277374489;36170.27659446796;37091.814540927124;37237.81381093077;37460.25079498395;1233.6422437493027;1235.882591153839;1245.9377031148406;1248.831407759959;1268.245393990574;16671.583210419594;16691.332346705996;16723.665526689398;16762.497125086265;17113;481217;521553;537835;540233;545955;58090;58508.122378164364;58888.70555647194;59070;59105;1497.8876584256225;1528.8165420149653;1536.8155821301516;1540.283768047863;1567.2163918040978;31136.844315778275;31835.36329273448;31988.840055799574;32056.198595035312;32118.35763284768;54460;55236.44763552313;55357.44642553684;55430.72284638551;55567.166492501834;360330;361097;366027;366718;366741;31541.52687709732;31920;31986.360272793947;31987.680123198472;32002.839985800852;49992.25011624756;51026.74486627692;51548;51564.74217628888;52506.73746631242;42272;42811.35782963196;42907.141857163304;42984;44041.339379909965;41218;41287.380689289086;41443;42525.78737106295;42948.78525607352;42917.14165716606;43854.34218486789;43870;43980.56019439764;44552.55447445484;35843;36329.63670363263;36401.11387487749;36553.45169822402;36909.81545092365;28737;29519.55720664149;30174;30523.38953220879;30757.23106922345 23:25:41 INFO - PROCESS | 27769 | |2;jquery.html;424.687854426996;428.38312829525483;434.27042568484933;437.24793355428653;439.2532694419487;18389;19191.103225774466;19240.71138932917;21019.47451313718;21756;20703.689444658343;21082.57834843302;21183.470413239676;21209.681854772152;21214.257500987467;5490.835274941758;5731.598788084836;5740.024195886709;5752.712364381775;5763.337216220126;5677.886442271152;5754.913676294859;5757.942420575782;5990.9400905990815;6454.0641606966965;6491.383318584751;6511.902321465182;6521.771737989171;6522.1195138656385;6538.901916471256;5888.882222355572;5942.138389933435;5970.253718285215;6401.263854656704;6471.708773105198;5761.452661997104;5782.132680098019;5792.218050563162;5793.594448388614;5814.854628634275;13495.460181592725;13690.178589284575;13941.721165576733;13948.442062317496;13971.79042314366;2513.195777351248;2522.205505265835;2526.141112021903;2593.572060609997;2881.639795025622;9882.061204185591;10925.453727313603;11444;11572.6528204154;15042.32309546073;1983.1868933737098;2040.7755146933825;2050.2106688924873;2054.096197673019;2094.1100032486283;78790;79384;81743.59128204381;82661;82722;10744.623938162127;11156.944215278872;11274.774504509864;11292;11381.430928453545;15734;15791.289391977389;15796;15808;15832.525024249291;8528.317734581342;8747.606357713918;8876.112388761201;8883.42257753244;9069.863952040725;8787.604557794915;8854.656456644689;8872.689455869142;8879.200871921428;8937.106289371011;4826.396700412449;4836.347093142451;4850.466448690641;4872.512748725099;4983.50164983506;1897.4212865076283;1964.6365422396902;1975.140813746025;1982.603479304145;1998.920043198285;1009.7273736091214;1077.9083777878811;1090.4711215060688;1105.2705214558353;1129.1869853705318;18995.43013709591;19412.902935485232;19473.415797526097;19930.90034549818;20138.798612013987;1067.524951396621;1090.4166271045112;1100.2793170473353;1126.5831642292405;1132.4111462039693;10884;11111.111111111091;11139.275947063577;11147.777044459066;11195.720106997227;474600;511441;518423.94521011336;521917;526825;78953;87197.56401217953;89201;90419.54790226139;91060.54469727608;1111.0889070961734;1152.9192956493132;1165.9941700291613;1167.7430965187816;1174.2484809721784;17388.74064302068;17643.470695879143;17808.821911781233;18031.729524057413;18197.363092291707;40179.196416072096;40660.59339406686;40804.59195408008;41696.16607667891;41706.58293417027;60287.397126028176;61889.38110618836;61957.690211550456;62310;62520;8893.244074253502;9122.954385228031;9155.496447695441;9176.220021298264;9196.172344488761;13167;13728;13884.305784710927;13918.09532380392;14269.215193164475;12080.154389192672;12121.45453454579;12178.269303841798;12250.509979600716;12254.75490490203;11733.823992639946;11892.464839082435;11965.700857478632;12096.516139354328;12149;11625.651230462761;11996.340201289013;12128.636140915787;12217.328046957147;12238.388080595756;8667.869981950402;8744.475331480131;8799.824003520022;8860.778480538038;8877.866831997655;8647.221750042527;10766.838497422388;11213.775724485628;11223.326600404002;11284.492197851281 23:25:41 INFO - PROCESS | 27769 | |3;mootools.html;1476.217604669525;1533.762266848638;1582.3828706804347;1727.499025282668;1779.9555011124721;7513.248675132484;7934.166912474179;8152.755417337482;8343.54110523921;8346.123657016009;8346.332293416528;8359.91640083599;8397.286230670401;8413.537255450949;8419.747407577766;2332.1371092695686;2354.858708477488;2355.6702061711376;2365.656979737937;2365.8698771567556;2275.3287780104824;2287.370972982435;2315.9536809263805;2317.0268487235317;2332.428555004018;2302.26327575176;2343.238447504559;2345.319857241398;2354.3525530479083;2357.0571771291447;2331.265651319829;2332.591796435634;2351.706036745407;2357.552065107624;2361.728401233854;2279.7150356205475;2283.1438210671;2291;2299.310206937929;2303.9193628223097;8589.699360522352;8594.183552562497;8623.698170564001;8642.61108250124;8645.567721613894;5011.072951503984;5106.948930510722;5107.438181799999;5115.667481613683;5123.666961647481;3250.057483329855;3265.9952843384144;3352.8491217895253;3371.2246183377715;3386.271951530433;1086.9021788039036;1087.320424734541;1102.9117670586334;1136.0968030415838;1136.33524388233;12115.151939364248;12128.151029427943;12131.211471254428;12131.575394861138;12139.028877689852;4434.711743736647;4469.575390337913;4510.594046535762;4519.5480451954545;4563.771811409416;10306.175505959505;10313.84529232062;10333.225008124271;10333.534990925426;10339.483025848678;5243.213517972258;5281.788728450819;5282.841514754564;5284.7886084556185;5286.101362768339;4598.839040633562;4828.734419606955;4832.637552183601;4839.370881785346;4847;3871.399933010388;3898.2983063048923;3915.960840391617;3920.4511368408444;4014.197160567898;1125.471028616549;1149.8160294352863;1151.1251448898897;1162.5698491558178;1165.7377090154816;1067.0823092140752;1101.0860985382114;1105.082781291526;1113.704868209925;1127.2503784982894;5917.171595976567;6010.819675409744;6155.076738489173;6187.907181392283;6231.3145553989025;1019.8980101989741;1026.2713473433946;1043.3583346242006;1079.6653037558383;1105.5798796457295;4269.807858646368;4292.377605247221;4319.870403887889;4330.025744207528;4342.32693932441;10310.896891031143;10507.31702439339;10629.627963021258;10680.092192163598;10736.677899663022;10415.323004004715;10464.267501274837;10465.738356541147;10502;10586.682399528027;8014.719484818003;8053.879191812128;8178.550179740052;8203.179682031869;8224.876626850602;5956.851078723066;5999.340072591924;6044.335123136363;6059.909101363572;6092.664903430354;9326.253899687874;9375.578098985698;9501.192398646193;9524;9540.522973851419;9304.302177336862;9467.621295148117;9468.100530449596;9530.380525265835;9841.311108222355;6522.478201743944;7178.24628414009;7356.632168391452;7366.484346095936;7484.476086673881;8228.300594449538;8259.050209226016;8307.83384332322;8345.33237340999;8360.12218717026;7080.893786593102;7364.96317518409;7415.592142432218;7468.477206595703;7578.772636820904;7425.851482970203;7543.585102819397;7591.316781489692;7630.313271805564;7646.158922518407;7245.7826265212125;7263.891041634274;7315.414766818535;7320.96339518299;7329.193788683134;5124.692518448905;5226.372835259793;5248.895022099613;5378.542823860016;5454.836354909359;5386.326709161355;5419.05166595852;5454.318210223722;5478.753456094406;5503.20203570472 23:25:41 INFO - PROCESS | 27769 | |4;prototype.html;359.3244699964069;364.5188351376183;365.70926113739574;367.90986208378945;370.39810308249093;6334.081558174062;6344.873102537947;6368.10846481493;6381.712822922968;6479.838004049901;6447.742090316382;6463.321351258121;6473.190851143607;6478.708458119384;6501.252355979063;4922.581580565638;4925.138100832358;4929.285253638238;4934.358533390654;4998.750062496879;5000.774965126578;5001.649884508086;5005.874853128683;5006.54941055305;5011.974940125294;4944.134776414131;4969.378827646544;4973.129702302101;4974.353334066566;4984.651074424792;4753.405824271966;4888.877778055577;4959.156943319626;4964.60283177345;4977.651564390494;4207.873763787091;4231.42875711778;4237.110206856564;4238;4248.383984322256;6218.507558186003;6269.655168965705;6284.811455656338;6291.96854015727;6298.905516417258;5585.441455854382;5727.055035919068;5728.5417166626985;5740.225069615591;5756.798512052058;6836.008778727107;6842.521023528355;6843.281455447206;6847.554908930953;6849.315068493161;4742.715437073752;4744.478107408217;4744.572988431058;4746.501617330166;4762.2380419133115;7139.036230108921;7206;7211.242819503929;7223.349898509106;7223.602701851396;4735.431748190239;4739.4075740532435;4745.6440766942615;4755;4755.310479980383;4735.384400027974;4854.975725121351;4861.80552777892;4924.75376231187;4934.975325123423;5661.122526008476;5684.7777727788725;5693.601447898607;5704.572157088152;5706;6886.8622627547165;6895.413889819321;6906.930930690629;6909.861802763917;6928.4803639726215;1678.211240716861;1745.23209787693;1747.606788472609;1748.8688348373923;1751.2382113780545;1115.252780636959;1118.7930232906938;1140.321508702321;1141.8915203055697;1158.1603337580354;6553.508486863504;6629.171353580802;6636.270010298863;6674.499412543982;6687.6321802301345;7025.89461158083;7026.332498412643;7057.858842823115;7060.858782824314;7067.293270672892;6584.703688334036;6642.900356494656;6649.567778094505;6654.201495820533;6656.267810540837;3768.3593789055926;3812.370958791824;3814.6757525610633;3815.3323168445413;3815.599362066943;7152.964235178791;7305.45209109319;7309.597972111478;7345.118585769742;7413.36986356155;7138.535995160298;7145.249748776408;7154.892676609855;7181.389581885598;7182.066331376887;7238.601876896716;7253.165885923081;7269.927300726925;7270.745523906638;7280.417566594766;6881.380675739208;7024.8595028098125;7035.894461583182;7038.612876291649;7042.929570704227;6887.311268873073;6908.827279318058;6924.619145947021;6926.8614627708175;6927.930720692729;7285.963570182115;7367.300106489874;7384.963075184804;7393.778186654409;7395.519291246052;4811.855644330676;4821.2045012572535;4822.614190864792;4825.059113472839;4828.5412885775795;6935.861282774417;6962.443004559522;6970.616616086164;6974.267701891431;6998.965005174941;6665.366790154928;6802.387785099365;6809.38715515606;6817.625030623363;6823.624700641314;6751.93248067513;6754;6789.15135608049;6801.047853300641;6801.353871382211;6678.465722742266;6683.966580167068;6684.331566843277;6692.765753198614;6699.665016749241;6673.265940746417;6795.184577850492;6837.042814005944;6850.314968503109;6857.485688573277;6605.141331626858;6635.270120286668;6644.368784965421;6752.3922846944015;6812.93187068123 23:25:41 INFO - PROCESS | 27769 | |5;yui.html;909.2226146644618;925.1257561604286;926.703454894434;929.5677509957868;943.5989704375638;13858.792118118223;13875.514356997508;14017.929910350435;14075.014748967564;14076.296185190738;13576.45694172232;13741.244231567285;13764.724705505883;13797.310134493286;13799.655008624764;909.4088842252522;926.8424367857447;937.1003836317144;937.6577549194564;943.7027336389016;918.6417297254076;922.8338898998178;924.791921817589;928.4429342394543;929.9860502092474;960.6733710538416;967.7290358699576;970.4274478057945;970.7233438470038;973.265184785486;960.3949511807587;960.5389413081725;961.8845738511353;962.5283611030544;965.6475386483953;708.4403321376107;708.8653155900363;709.9396551293146;710.793869777769;713.3080911515873;14640.267986600627;14671.926640366837;14707.779383309258;14764.114153150738;14830.851691483054;14721.852781472155;14747.77878331826;14962.17708026058;14992.325345359484;14999.550013499613;11023.559057637685;11437.370944598044;11464.656060318204;11487.19589628718;11783.234089784222;3903;3916.804159791999;3971.62269584389;3984.2828290907623;3992.640662340374;59558.40441595615;59800;60079;60204.39795602075;60741.39258607401;11390.772184556428;11434.371109589052;11437.142214333959;11648.825267620992;11753.706157346134;20256.594868102555;20386.49033774138;20440.182392704424;20446.182152713725;20599.588008239753;8294.087650358455;8532.8720069199;8700.825983480296;8762.693305734396;8787.516686582172;4947.6289278304275;4989.251612258117;4995.225740010304;5006.699598024057;5045.268436076748;3494.825258737053;3605.6935160511125;3617.0234036809916;3618.800965946898;3627.510286111394;638.5370606310481;641.5412979719523;643.5462998585986;650.278191207759;654.8866926225436;690.526989012528;720.7477382916043;728.4609389052064;790.4822341366414;807.1041144329789;10011.149052330487;10325.84511232332;10404.323718958243;10463.162946964225;10516.26386152962;705.2806137739477;793.6944276453607;828.90467596226;836.1178956201145;854.6068808348106;5085.364329458817;5158.509941555546;5245.763940622681;5294.655847369909;5344.198370244494;63881.68059159767;65891.34108658948;66320.66839665771;66421.33578664152;66879.66560167167;53722.194167087524;55389.1691624626;56375.15437268444;57038.714806426535;57167;48579;48730;49535.25697114546;49539.752301238266;50215.74892125516;10081.747956301151;10105.9494702526;10142.49287535635;10158.593656253963;10218.897811021794;37372.439413408276;37442.62557374391;37568;39036.80481597574;39518;43107;49733.25400119073;50988.74505627448;51294.48705513046;51648;12263.141580089308;12526.373681315716;12526.561570344995;12594.622161335175;12720.363981800689;14251;14423.42306307736;14468.421263149356;14544.636384090483;14588.927055364655;13758.793618095537;13792.93103534476;13881.375338109607;13942.093763905314;14031.579052628438;12765.170263933187;12779.680507987374;13151.145175563557;13215.273159976294;13372.866271337161;12623.368831558202;13595.660108497366;13765.518206862711;13925.582232533041;14302.713945721236;11116.388598626829;11246.381449020382;11353.205275630626;11357.204995650225;11381.715457113638;11487.36819474937;11491.310521368745;11497.597584084851;11524.366159860952;11878.346690932081 23:25:41 INFO - PROCESS | 27769 | __end_tp_report 23:25:41 INFO - PROCESS | 27769 | __start_cc_report 23:25:41 INFO - PROCESS | 27769 | _x_x_mozilla_cycle_collect,310 23:25:41 INFO - PROCESS | 27769 | __end_cc_report 23:25:41 INFO - PROCESS | 27769 | __startTimestamp1467527141130__endTimestamp 23:25:41 INFO - PROCESS | 27769 | 23:25:41 INFO - PROCESS | 27769 | ------- Summary: start ------- 23:25:41 INFO - PROCESS | 27769 | Number of tests: 6 23:25:41 INFO - PROCESS | 27769 | 23:25:41 INFO - PROCESS | 27769 | [#0] dojo.html Cycles:165 Average:5608.85 Median:5851.68 stddev:624.89 (10.7%) stddev-sans-first:601.33 23:25:41 INFO - PROCESS | 27769 | Values: 3357.5 3430.5 3444.0 3449.7 3483.1 5602.5 5609.8 5623.4 5636.1 5640.3 5597.7 5609.6 5621.5 5625.2 5630.3 5039.8 5071.6 5125.1 5178.1 5182.9 5089.2 5128.6 5158.2 5267.9 5272.6 5116.7 5141.8 5154.1 5155.7 5206.9 5118.3 5122.7 5132.9 5147.5 5163.4 4945.0 4966.3 5012.9 5016.1 5082.7 5435.0 5453.7 5462.5 5465.2 5521.5 5900.5 5926.3 5930.1 5939.2 5966.8 5917.9 5920.9 5995.0 6000.7 6114.0 5660.1 5669.0 5670.0 5672.9 5699.1 6148.4 6158.0 6167.3 6167.5 6180.9 5770.5 5827.9 5917.1 5939.3 5945.3 6016.8 6044.3 6046.2 6047.9 6064.2 5970.4 6004.0 6008.4 6012.2 6025.2 5944.7 5947.4 6014.7 6024.1 6028.8 4545.0 4562.5 4565.4 4584.9 4612.1 4046.6 4109.3 4119.1 4123.6 4141.2 5686.3 5732.0 5813.9 5864.3 5896.2 6050.8 6114.0 6115.6 6118.8 6120.1 5729.2 5834.2 5840.2 5851.4 5851.7 5125.5 5174.6 5230.4 5247.1 5249.3 6255.1 6293.3 6296.9 6298.7 6324.4 6013.2 6032.8 6038.6 6042.8 6047.3 6239.5 6317.6 6342.7 6353.9 6362.9 5919.6 5925.1 5925.4 5933.9 5960.8 5904.9 5946.0 5996.9 6008.9 6038.0 5927.5 5965.9 5972.2 5973.1 6005.1 5869.8 5956.0 5966.9 5971.0 5975.3 5730.8 5776.4 5880.1 5891.1 5910.3 5826.5 5921.9 5930.8 5950.3 5971.2 5815.2 5821.7 5822.3 5824.9 5830.3 23:25:41 INFO - PROCESS | 27769 | 23:25:41 INFO - PROCESS | 27769 | [#1] ext.html Cycles:180 Average:56594.43 Median:40797.68 stddev:109047.93 (267.3%) stddev-sans-first:109272.94 23:25:41 INFO - PROCESS | 27769 | Values: 648.8 677.4 692.3 721.5 735.6 38415.8 38876.4 38901.0 38996.4 39184.0 40015.2 40794.2 40801.2 40861.6 40982.8 8698.1 8971.5 8996.5 9010.5 9031.2 8764.2 8833.6 8888.8 9155.6 9187.1 9124.6 9150.9 9173.1 9177.1 9222.2 9115.9 9181.5 9214.4 9222.6 9239.9 9023.5 9096.9 9149.7 9160.1 9167.9 42796.8 42993.4 43382.0 43382.3 43400.3 3846.7 3861.3 3916.9 4105.1 4249.4 33051.3 33393.0 33525.3 33627.7 34404.3 4366.4 4428.3 4443.7 4463.2 4475.4 310702.4 314378.0 316199.0 316669.0 317087.0 39923.8 60598.1 61243.4 61594.0 61780.4 38780.0 39002.0 39073.6 39136.2 39245.8 16826.2 16940.2 17028.6 17065.1 17123.2 14321.9 14467.6 14487.1 14501.1 14535.3 9414.5 9494.9 9528.0 9556.2 9583.6 3623.8 3674.9 3695.9 3723.2 3730.7 1103.6 1123.5 1142.9 1155.5 1181.7 34361.3 36170.3 37091.8 37237.8 37460.3 1233.6 1235.9 1245.9 1248.8 1268.2 16671.6 16691.3 16723.7 16762.5 17113.0 481217.0 521553.0 537835.0 540233.0 545955.0 58090.0 58508.1 58888.7 59070.0 59105.0 1497.9 1528.8 1536.8 1540.3 1567.2 31136.8 31835.4 31988.8 32056.2 32118.4 54460.0 55236.4 55357.4 55430.7 55567.2 360330.0 361097.0 366027.0 366718.0 366741.0 31541.5 31920.0 31986.4 31987.7 32002.8 49992.3 51026.7 51548.0 51564.7 52506.7 42272.0 42811.4 42907.1 42984.0 44041.3 41218.0 41287.4 41443.0 42525.8 42948.8 42917.1 43854.3 43870.0 43980.6 44552.6 35843.0 36329.6 36401.1 36553.5 36909.8 28737.0 29519.6 30174.0 30523.4 30757.2 23:25:41 INFO - PROCESS | 27769 | 23:25:41 INFO - PROCESS | 27769 | [#2] jquery.html Cycles:180 Average:29595.33 Median:21211.97 stddev:84058.18 (396.3%) stddev-sans-first:84265.45 23:25:41 INFO - PROCESS | 27769 | Values: 424.7 428.4 434.3 437.2 439.3 18389.0 19191.1 19240.7 21019.5 21756.0 20703.7 21082.6 21183.5 21209.7 21214.3 5490.8 5731.6 5740.0 5752.7 5763.3 5677.9 5754.9 5757.9 5990.9 6454.1 6491.4 6511.9 6521.8 6522.1 6538.9 5888.9 5942.1 5970.3 6401.3 6471.7 5761.5 5782.1 5792.2 5793.6 5814.9 13495.5 13690.2 13941.7 13948.4 13971.8 2513.2 2522.2 2526.1 2593.6 2881.6 9882.1 10925.5 11444.0 11572.7 15042.3 1983.2 2040.8 2050.2 2054.1 2094.1 78790.0 79384.0 81743.6 82661.0 82722.0 10744.6 11156.9 11274.8 11292.0 11381.4 15734.0 15791.3 15796.0 15808.0 15832.5 8528.3 8747.6 8876.1 8883.4 9069.9 8787.6 8854.7 8872.7 8879.2 8937.1 4826.4 4836.3 4850.5 4872.5 4983.5 1897.4 1964.6 1975.1 1982.6 1998.9 1009.7 1077.9 1090.5 1105.3 1129.2 18995.4 19412.9 19473.4 19930.9 20138.8 1067.5 1090.4 1100.3 1126.6 1132.4 10884.0 11111.1 11139.3 11147.8 11195.7 474600.0 511441.0 518423.9 521917.0 526825.0 78953.0 87197.6 89201.0 90419.5 91060.5 1111.1 1152.9 1166.0 1167.7 1174.2 17388.7 17643.5 17808.8 18031.7 18197.4 40179.2 40660.6 40804.6 41696.2 41706.6 60287.4 61889.4 61957.7 62310.0 62520.0 8893.2 9123.0 9155.5 9176.2 9196.2 13167.0 13728.0 13884.3 13918.1 14269.2 12080.2 12121.5 12178.3 12250.5 12254.8 11733.8 11892.5 11965.7 12096.5 12149.0 11625.7 11996.3 12128.6 12217.3 12238.4 8667.9 8744.5 8799.8 8860.8 8877.9 8647.2 10766.8 11213.8 11223.3 11284.5 23:25:41 INFO - PROCESS | 27769 | 23:25:41 INFO - PROCESS | 27769 | [#3] mootools.html Cycles:180 Average:5699.37 Median:4713.79 stddev:3151.44 (66.9%) stddev-sans-first:3144.30 23:25:41 INFO - PROCESS | 27769 | Values: 1476.2 1533.8 1582.4 1727.5 1780.0 7513.2 7934.2 8152.8 8343.5 8346.1 8346.3 8359.9 8397.3 8413.5 8419.7 2332.1 2354.9 2355.7 2365.7 2365.9 2275.3 2287.4 2316.0 2317.0 2332.4 2302.3 2343.2 2345.3 2354.4 2357.1 2331.3 2332.6 2351.7 2357.6 2361.7 2279.7 2283.1 2291.0 2299.3 2303.9 8589.7 8594.2 8623.7 8642.6 8645.6 5011.1 5106.9 5107.4 5115.7 5123.7 3250.1 3266.0 3352.8 3371.2 3386.3 1086.9 1087.3 1102.9 1136.1 1136.3 12115.2 12128.2 12131.2 12131.6 12139.0 4434.7 4469.6 4510.6 4519.5 4563.8 10306.2 10313.8 10333.2 10333.5 10339.5 5243.2 5281.8 5282.8 5284.8 5286.1 4598.8 4828.7 4832.6 4839.4 4847.0 3871.4 3898.3 3916.0 3920.5 4014.2 1125.5 1149.8 1151.1 1162.6 1165.7 1067.1 1101.1 1105.1 1113.7 1127.3 5917.2 6010.8 6155.1 6187.9 6231.3 1019.9 1026.3 1043.4 1079.7 1105.6 4269.8 4292.4 4319.9 4330.0 4342.3 10310.9 10507.3 10629.6 10680.1 10736.7 10415.3 10464.3 10465.7 10502.0 10586.7 8014.7 8053.9 8178.6 8203.2 8224.9 5956.9 5999.3 6044.3 6059.9 6092.7 9326.3 9375.6 9501.2 9524.0 9540.5 9304.3 9467.6 9468.1 9530.4 9841.3 6522.5 7178.2 7356.6 7366.5 7484.5 8228.3 8259.1 8307.8 8345.3 8360.1 7080.9 7365.0 7415.6 7468.5 7578.8 7425.9 7543.6 7591.3 7630.3 7646.2 7245.8 7263.9 7315.4 7321.0 7329.2 5124.7 5226.4 5248.9 5378.5 5454.8 5386.3 5419.1 5454.3 5478.8 5503.2 23:25:41 INFO - PROCESS | 27769 | 23:25:41 INFO - PROCESS | 27769 | [#4] prototype.html Cycles:180 Average:5716.62 Median:6569.11 stddev:1724.93 (26.3%) stddev-sans-first:1682.25 23:25:41 INFO - PROCESS | 27769 | Values: 359.3 364.5 365.7 367.9 370.4 6334.1 6344.9 6368.1 6381.7 6479.8 6447.7 6463.3 6473.2 6478.7 6501.3 4922.6 4925.1 4929.3 4934.4 4998.8 5000.8 5001.6 5005.9 5006.5 5012.0 4944.1 4969.4 4973.1 4974.4 4984.7 4753.4 4888.9 4959.2 4964.6 4977.7 4207.9 4231.4 4237.1 4238.0 4248.4 6218.5 6269.7 6284.8 6292.0 6298.9 5585.4 5727.1 5728.5 5740.2 5756.8 6836.0 6842.5 6843.3 6847.6 6849.3 4742.7 4744.5 4744.6 4746.5 4762.2 7139.0 7206.0 7211.2 7223.3 7223.6 4735.4 4739.4 4745.6 4755.0 4755.3 4735.4 4855.0 4861.8 4924.8 4935.0 5661.1 5684.8 5693.6 5704.6 5706.0 6886.9 6895.4 6906.9 6909.9 6928.5 1678.2 1745.2 1747.6 1748.9 1751.2 1115.3 1118.8 1140.3 1141.9 1158.2 6553.5 6629.2 6636.3 6674.5 6687.6 7025.9 7026.3 7057.9 7060.9 7067.3 6584.7 6642.9 6649.6 6654.2 6656.3 3768.4 3812.4 3814.7 3815.3 3815.6 7153.0 7305.5 7309.6 7345.1 7413.4 7138.5 7145.2 7154.9 7181.4 7182.1 7238.6 7253.2 7269.9 7270.7 7280.4 6881.4 7024.9 7035.9 7038.6 7042.9 6887.3 6908.8 6924.6 6926.9 6927.9 7286.0 7367.3 7385.0 7393.8 7395.5 4811.9 4821.2 4822.6 4825.1 4828.5 6935.9 6962.4 6970.6 6974.3 6999.0 6665.4 6802.4 6809.4 6817.6 6823.6 6751.9 6754.0 6789.2 6801.0 6801.4 6678.5 6684.0 6684.3 6692.8 6699.7 6673.3 6795.2 6837.0 6850.3 6857.5 6605.1 6635.3 6644.4 6752.4 6812.9 23:25:41 INFO - PROCESS | 27769 | 23:25:41 INFO - PROCESS | 27769 | [#5] yui.html Cycles:180 Average:15677.72 Median:21717.40 stddev:18018.46 (83.0%) stddev-sans-first:18034.87 23:25:41 INFO - PROCESS | 27769 | Values: 909.2 925.1 926.7 929.6 943.6 13858.8 13875.5 14017.9 14075.0 14076.3 13576.5 13741.2 13764.7 13797.3 13799.7 909.4 926.8 937.1 937.7 943.7 918.6 922.8 924.8 928.4 930.0 960.7 967.7 970.4 970.7 973.3 960.4 960.5 961.9 962.5 965.6 708.4 708.9 709.9 710.8 713.3 14640.3 14671.9 14707.8 14764.1 14830.9 14721.9 14747.8 14962.2 14992.3 14999.6 11023.6 11437.4 11464.7 11487.2 11783.2 3903.0 3916.8 3971.6 3984.3 3992.6 59558.4 59800.0 60079.0 60204.4 60741.4 11390.8 11434.4 11437.1 11648.8 11753.7 20256.6 20386.5 20440.2 20446.2 20599.6 8294.1 8532.9 8700.8 8762.7 8787.5 4947.6 4989.3 4995.2 5006.7 5045.3 3494.8 3605.7 3617.0 3618.8 3627.5 638.5 641.5 643.5 650.3 654.9 690.5 720.7 728.5 790.5 807.1 10011.1 10325.8 10404.3 10463.2 10516.3 705.3 793.7 828.9 836.1 854.6 5085.4 5158.5 5245.8 5294.7 5344.2 63881.7 65891.3 66320.7 66421.3 66879.7 53722.2 55389.2 56375.2 57038.7 57167.0 48579.0 48730.0 49535.3 49539.8 50215.7 10081.7 10105.9 10142.5 10158.6 10218.9 37372.4 37442.6 37568.0 39036.8 39518.0 43107.0 49733.3 50988.7 51294.5 51648.0 12263.1 12526.4 12526.6 12594.6 12720.4 14251.0 14423.4 14468.4 14544.6 14588.9 13758.8 13792.9 13881.4 13942.1 14031.6 12765.2 12779.7 13151.1 13215.3 13372.9 12623.4 13595.7 13765.5 13925.6 14302.7 11116.4 11246.4 11353.2 11357.2 11381.7 11487.4 11491.3 11497.6 11524.4 11878.3 23:25:41 INFO - PROCESS | 27769 | -------- Summary: end -------- 23:25:41 INFO - PROCESS | 27769 | 23:25:41 INFO - TEST-INFO | 27769: exit 0 23:25:41 INFO - TEST-OK | dromaeo_css | took 1108964ms 23:25:41 INFO - TEST-START | kraken 23:25:41 INFO - operating with platform_type : linux_ 23:25:41 INFO - Initialising browser for kraken test... 23:25:41 INFO - TEST-INFO | started process 28014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe1U_t1/profile http://localhost:35205/getInfo.html) 23:25:45 INFO - PROCESS | 28014 | 23:25:45 INFO - PROCESS | 28014 | (process:28089): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:25:46 INFO - PROCESS | 28014 | __metrics Screen width/height:1600/1200 23:25:46 INFO - PROCESS | 28014 | colorDepth:24 23:25:46 INFO - PROCESS | 28014 | Browser inner width/height: 1024/697 23:25:46 INFO - PROCESS | 28014 | __metrics 23:25:46 ERROR - PROCESS | 28014 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:25:47 INFO - TEST-INFO | 28014: exit 0 23:25:47 INFO - Browser initialized. 23:25:47 INFO - Running cycle 1/1 for kraken test... 23:25:47 INFO - TEST-INFO | started process 28139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe1U_t1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:49 INFO - PROCESS | 28139 | 23:25:49 INFO - PROCESS | 28139 | (process:28206): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:25:59 INFO - PROCESS | 28139 | RSS: Main: 151199744 23:25:59 INFO - PROCESS | 28139 | 23:26:02 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35205/tests/kraken/driver.html?testName=audio-beat-detection) 23:26:02 INFO - PROCESS | 28139 | RSS: Main: 156811264 23:26:02 INFO - PROCESS | 28139 | 23:26:05 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35205/tests/kraken/driver.html?testName=audio-dft) 23:26:06 INFO - PROCESS | 28139 | RSS: Main: 156348416 23:26:06 INFO - PROCESS | 28139 | 23:26:09 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35205/tests/kraken/driver.html?testName=audio-fft) 23:26:09 INFO - PROCESS | 28139 | RSS: Main: 156614656 23:26:09 INFO - PROCESS | 28139 | 23:26:11 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35205/tests/kraken/driver.html?testName=audio-oscillator) 23:26:12 INFO - PROCESS | 28139 | RSS: Main: 156483584 23:26:12 INFO - PROCESS | 28139 | 23:26:14 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35205/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:26:15 INFO - PROCESS | 28139 | RSS: Main: 156553216 23:26:15 INFO - PROCESS | 28139 | 23:26:18 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35205/tests/kraken/driver.html?testName=imaging-darkroom) 23:26:18 INFO - PROCESS | 28139 | RSS: Main: 156864512 23:26:18 INFO - PROCESS | 28139 | 23:26:22 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35205/tests/kraken/driver.html?testName=imaging-desaturate) 23:26:22 INFO - PROCESS | 28139 | RSS: Main: 156848128 23:26:22 INFO - PROCESS | 28139 | 23:26:25 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35205/tests/kraken/driver.html?testName=json-parse-financial) 23:26:26 INFO - PROCESS | 28139 | RSS: Main: 156676096 23:26:26 INFO - PROCESS | 28139 | 23:26:27 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35205/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:26:28 INFO - PROCESS | 28139 | RSS: Main: 156332032 23:26:28 INFO - PROCESS | 28139 | 23:26:29 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35205/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:26:30 INFO - PROCESS | 28139 | RSS: Main: 156352512 23:26:30 INFO - PROCESS | 28139 | 23:26:32 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35205/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:26:33 INFO - PROCESS | 28139 | RSS: Main: 156663808 23:26:33 INFO - PROCESS | 28139 | 23:26:35 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35205/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:26:36 INFO - PROCESS | 28139 | RSS: Main: 157016064 23:26:36 INFO - PROCESS | 28139 | 23:26:38 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35205/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:26:39 INFO - PROCESS | 28139 | RSS: Main: 157097984 23:26:39 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | Cycle 1(1): loaded http://localhost:35205/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35205/tests/kraken/driver.html?testName=ai-astar) 23:26:41 INFO - PROCESS | 28139 | RSS: Main: 158396416 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | __start_tp_report 23:26:41 INFO - PROCESS | 28139 | _x_x_mozilla_page_load 23:26:41 INFO - PROCESS | 28139 | _x_x_mozilla_page_load_details 23:26:41 INFO - PROCESS | 28139 | |i|pagename|runs| 23:26:41 INFO - PROCESS | 28139 | |0;ai-astar;107;110;103;110;110;111;100;109;111;112 23:26:41 INFO - PROCESS | 28139 | |1;audio-beat-detection;160;127;151;181;126;150;155;129;190;126 23:26:41 INFO - PROCESS | 28139 | |2;audio-dft;162;161;161;161;161;161;162;162;162;163 23:26:41 INFO - PROCESS | 28139 | |3;audio-fft;77;75;76;171;77;76;76;76;169;76 23:26:41 INFO - PROCESS | 28139 | |4;audio-oscillator;91;91;148;91;92;93;141;92;92;157 23:26:41 INFO - PROCESS | 28139 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 23:26:41 INFO - PROCESS | 28139 | |6;imaging-darkroom;146;147;147;147;146;146;147;146;147;147 23:26:41 INFO - PROCESS | 28139 | |7;imaging-desaturate;95;94;95;94;94;99;94;95;95;95 23:26:41 INFO - PROCESS | 28139 | |8;json-parse-financial;53;53;55;53;53;57;55;74;52;55 23:26:41 INFO - PROCESS | 28139 | |9;json-stringify-tinderbox;57;58;56;58;59;58;58;57;57;57 23:26:41 INFO - PROCESS | 28139 | |10;stanford-crypto-aes;73;71;74;75;74;73;74;77;75;83 23:26:41 INFO - PROCESS | 28139 | |11;stanford-crypto-ccm;124;116;122;119;112;113;112;119;132;134 23:26:41 INFO - PROCESS | 28139 | |12;stanford-crypto-pbkdf2;170;161;159;159;159;164;166;162;157;158 23:26:41 INFO - PROCESS | 28139 | |13;stanford-crypto-sha256-iterative;70;67;69;71;71;66;67;65;66;67 23:26:41 INFO - PROCESS | 28139 | __end_tp_report 23:26:41 INFO - PROCESS | 28139 | __start_cc_report 23:26:41 INFO - PROCESS | 28139 | _x_x_mozilla_cycle_collect,847 23:26:41 INFO - PROCESS | 28139 | __end_cc_report 23:26:41 INFO - PROCESS | 28139 | __startTimestamp1467527201543__endTimestamp 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | ------- Summary: start ------- 23:26:41 INFO - PROCESS | 28139 | Number of tests: 14 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.89 (3.5%) stddev-sans-first:4.10 23:26:41 INFO - PROCESS | 28139 | Values: 107.0 110.0 103.0 110.0 110.0 111.0 100.0 109.0 111.0 112.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:153.00 stddev:23.11 (15.1%) stddev-sans-first:24.20 23:26:41 INFO - PROCESS | 28139 | Values: 160.0 127.0 151.0 181.0 126.0 150.0 155.0 129.0 190.0 126.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 23:26:41 INFO - PROCESS | 28139 | Values: 162.0 161.0 161.0 161.0 161.0 161.0 162.0 162.0 162.0 163.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:39.59 (52.1%) stddev-sans-first:41.46 23:26:41 INFO - PROCESS | 28139 | Values: 77.0 75.0 76.0 171.0 77.0 76.0 76.0 76.0 169.0 76.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:91.50 stddev:27.78 (30.4%) stddev-sans-first:28.70 23:26:41 INFO - PROCESS | 28139 | Values: 91.0 91.0 148.0 91.0 92.0 93.0 141.0 92.0 92.0 157.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:26:41 INFO - PROCESS | 28139 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:26:41 INFO - PROCESS | 28139 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.49 (1.6%) stddev-sans-first:1.58 23:26:41 INFO - PROCESS | 28139 | Values: 95.0 94.0 95.0 94.0 94.0 99.0 94.0 95.0 95.0 95.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.00 stddev:6.50 (11.8%) stddev-sans-first:6.80 23:26:41 INFO - PROCESS | 28139 | Values: 53.0 53.0 55.0 53.0 53.0 57.0 55.0 74.0 52.0 55.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:58.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 23:26:41 INFO - PROCESS | 28139 | Values: 57.0 58.0 56.0 58.0 59.0 58.0 58.0 57.0 57.0 57.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.50 stddev:3.25 (4.4%) stddev-sans-first:3.37 23:26:41 INFO - PROCESS | 28139 | Values: 73.0 71.0 74.0 75.0 74.0 73.0 74.0 77.0 75.0 83.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:120.50 stddev:7.85 (6.5%) stddev-sans-first:8.21 23:26:41 INFO - PROCESS | 28139 | Values: 124.0 116.0 122.0 119.0 112.0 113.0 112.0 119.0 132.0 134.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:161.50 stddev:4.09 (2.5%) stddev-sans-first:2.96 23:26:41 INFO - PROCESS | 28139 | Values: 170.0 161.0 159.0 159.0 159.0 164.0 166.0 162.0 157.0 158.0 23:26:41 INFO - PROCESS | 28139 | 23:26:41 INFO - PROCESS | 28139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.18 (3.2%) stddev-sans-first:2.18 23:26:41 INFO - PROCESS | 28139 | Values: 70.0 67.0 69.0 71.0 71.0 66.0 67.0 65.0 66.0 67.0 23:26:41 INFO - PROCESS | 28139 | -------- Summary: end -------- 23:26:41 INFO - PROCESS | 28139 | 23:26:42 INFO - TEST-INFO | 28139: exit 0 23:26:42 INFO - TEST-OK | kraken | took 60644ms 23:26:42 INFO - SUITE-END | took 1169s 23:26:42 INFO - Completed test suite (00:19:29) 23:26:42 INFO - javascript benchmark 23:26:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.479590663447, 3430.536877521534, 3443.9655603443957, 3449.724022078234, 3483.0769845990817, 5602.46776556227, 5609.775608975641, 5623.381428042922, 5636.1264004079385, 5640.266765320513, 5597.6641401515935, 5609.607327487078, 5621.4659607337235, 5625.212470254168, 5630.268065151525, 5039.848804535861, 5071.568916642072, 5125.103106956286, 5178.093833579127, 5182.870428239286, 5089.185730283156, 5128.640995130342, 5158.2004789257535, 5267.86830329241, 5272.578193744491, 5116.667416617926, 5141.82003629873, 5154.098032844256, 5155.690658560479, 5206.947930520684, 5118.283440318359, 5122.718250496221, 5132.948670513321, 5147.48525147486, 5163.432022477525, 4944.975275123601, 4966.304717339575, 5012.924806127911, 5016.072026675077, 5082.720450375228, 5435.0, 5453.672779633195, 5462.535684466825, 5465.180222966586, 5521.5306698930235, 5900.468957793819, 5926.288845338544, 5930.110483427477, 5939.168516407706, 5966.820995370146, 5917.911231331534, 5920.851978700523, 5994.97002514989, 6000.669963152025, 6114.0, 5660.094384898438, 5668.97165514174, 5669.971650141723, 5672.858178545528, 5699.145128230757, 6148.385161483905, 6157.96921015392, 6167.259928808572, 6167.475764559973, 6180.8763824723255, 5770.480656740913, 5827.854303642443, 5917.082852157922, 5939.2575928009, 5945.256842894638, 6016.819495415057, 6044.335123136451, 6046.244219472566, 6047.909281360783, 6064.151018857364, 5970.402959703995, 6004.0, 6008.399160084044, 6012.188354572077, 6025.186599809057, 5944.7324870380935, 5947.434993675594, 6014.72933717975, 6024.126501657235, 6028.849278768066, 4544.977275113603, 4562.520935301812, 4565.406497155349, 4584.862454126382, 4612.0545288215835, 4046.635802777764, 4109.301418758818, 4119.052617897841, 4123.60825721556, 4141.213169497786, 5686.317641882918, 5732.0255556555485, 5813.854653633693, 5864.296284445893, 5896.233489646404, 6050.757969681252, 6114.021756518936, 6115.611137939864, 6118.832384214075, 6120.050983828535, 5729.197912292282, 5834.183214349994, 5840.153177789197, 5851.414858514115, 5851.6781577012825, 5125.487451254845, 5174.611904107207, 5230.424653288135, 5247.081760691864, 5249.291345668286, 6255.12428260044, 6293.3391993840905, 6296.905546416808, 6298.685065746786, 6324.43080122782, 6013.248343957005, 6032.788852390233, 6038.5772995889865, 6042.758289668364, 6047.274327080779, 6239.469645080219, 6317.5893566918, 6342.682865856781, 6353.872922541431, 6362.936370636235, 5919.6152250103605, 5925.081612350093, 5925.4370834770625, 5933.917062626473, 5960.76156953717, 5904.940950590439, 5945.970270148621, 5996.940030599812, 6008.8798224036145, 6037.9735444973585, 5927.4665280125, 5965.9105113422465, 5972.163897054329, 5973.074173503114, 6005.129256257731, 5869.7945571904775, 5956.047032474957, 5966.910496342472, 5971.044632858895, 5975.312839023568, 5730.799422020376, 5776.42235776419, 5880.14737863016, 5891.05743081105, 5910.261217347832, 5826.504747096545, 5921.940780592139, 5930.7924222652, 5950.285965684146, 5971.193888824953, 5815.244018277766, 5821.738021789114, 5822.272215973004, 5824.912626310694, 5830.300363956352], "value": 5568.3142839048505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.7923864363405, 677.3937326093146, 692.3042342445841, 721.5237942957646, 735.5586648011194, 38415.80792096039, 38876.416853747214, 38901.0, 38996.41505377422, 39184.0, 40015.199696006064, 40794.18411631773, 40801.183976320455, 40861.59138408615, 40982.795086024526, 8698.086700896394, 8971.461712297283, 8996.460212387277, 9010.504422256774, 9031.23234525066, 8764.21122099011, 8833.646654133827, 8888.822223555526, 9155.587998540082, 9187.081291870827, 9124.589393477276, 9150.86273705895, 9173.08269173084, 9177.128172823604, 9222.21611163052, 9115.908840911572, 9181.540922953825, 9214.44713317203, 9222.631094756201, 9239.907600924005, 9023.458592484472, 9096.8635470468, 9149.679761208392, 9160.129787670161, 9167.862482062774, 42796.78601607003, 42993.35509967353, 43382.0, 43382.349264761055, 43400.3489947651, 3846.653801157909, 3861.2856621525107, 3916.902077448058, 4105.117399759066, 4249.383839343278, 33051.3389732204, 33393.0, 33525.32949341024, 33627.663723362944, 34404.31191376159, 4366.366876802846, 4428.269335559628, 4443.666724995638, 4463.196624607569, 4475.373447717322, 310702.4464877684, 314378.0, 316199.0, 316669.0, 317087.0, 39923.80038099791, 60598.091028634604, 61243.38756612377, 61594.0, 61780.38219617836, 38780.0, 39002.0, 39073.609263907565, 39136.21727565433, 39245.80377098153, 16826.158692065346, 16940.152992350333, 17028.57428564271, 17065.06142162168, 17123.22945467457, 14321.856781432261, 14467.565973020826, 14487.058341207789, 14501.129932204101, 14535.27323633814, 9414.482203478738, 9494.905050949541, 9528.0, 9556.187724043533, 9583.616655333848, 3623.7644553103964, 3674.8713795017047, 3695.926081478355, 3723.2367364690717, 3730.6642402183934, 1103.6137351926761, 1123.455124264731, 1142.8514293142005, 1155.5031336525208, 1181.704573856536, 34361.31277374489, 36170.27659446796, 37091.814540927124, 37237.81381093077, 37460.25079498395, 1233.6422437493027, 1235.882591153839, 1245.9377031148406, 1248.831407759959, 1268.245393990574, 16671.583210419594, 16691.332346705996, 16723.665526689398, 16762.497125086265, 17113.0, 481217.0, 521553.0, 537835.0, 540233.0, 545955.0, 58090.0, 58508.122378164364, 58888.70555647194, 59070.0, 59105.0, 1497.8876584256225, 1528.8165420149653, 1536.8155821301516, 1540.283768047863, 1567.2163918040978, 31136.844315778275, 31835.36329273448, 31988.840055799574, 32056.198595035312, 32118.35763284768, 54460.0, 55236.44763552313, 55357.44642553684, 55430.72284638551, 55567.166492501834, 360330.0, 361097.0, 366027.0, 366718.0, 366741.0, 31541.52687709732, 31920.0, 31986.360272793947, 31987.680123198472, 32002.839985800852, 49992.25011624756, 51026.74486627692, 51548.0, 51564.74217628888, 52506.73746631242, 42272.0, 42811.35782963196, 42907.141857163304, 42984.0, 44041.339379909965, 41218.0, 41287.380689289086, 41443.0, 42525.78737106295, 42948.78525607352, 42917.14165716606, 43854.34218486789, 43870.0, 43980.56019439764, 44552.55447445484, 35843.0, 36329.63670363263, 36401.11387487749, 36553.45169822402, 36909.81545092365, 28737.0, 29519.55720664149, 30174.0, 30523.38953220879, 30757.23106922345], "value": 19693.249282029527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.687854426996, 428.38312829525483, 434.27042568484933, 437.24793355428653, 439.2532694419487, 18389.0, 19191.103225774466, 19240.71138932917, 21019.47451313718, 21756.0, 20703.689444658343, 21082.57834843302, 21183.470413239676, 21209.681854772152, 21214.257500987467, 5490.835274941758, 5731.598788084836, 5740.024195886709, 5752.712364381775, 5763.337216220126, 5677.886442271152, 5754.913676294859, 5757.942420575782, 5990.9400905990815, 6454.0641606966965, 6491.383318584751, 6511.902321465182, 6521.771737989171, 6522.1195138656385, 6538.901916471256, 5888.882222355572, 5942.138389933435, 5970.253718285215, 6401.263854656704, 6471.708773105198, 5761.452661997104, 5782.132680098019, 5792.218050563162, 5793.594448388614, 5814.854628634275, 13495.460181592725, 13690.178589284575, 13941.721165576733, 13948.442062317496, 13971.79042314366, 2513.195777351248, 2522.205505265835, 2526.141112021903, 2593.572060609997, 2881.639795025622, 9882.061204185591, 10925.453727313603, 11444.0, 11572.6528204154, 15042.32309546073, 1983.1868933737098, 2040.7755146933825, 2050.2106688924873, 2054.096197673019, 2094.1100032486283, 78790.0, 79384.0, 81743.59128204381, 82661.0, 82722.0, 10744.623938162127, 11156.944215278872, 11274.774504509864, 11292.0, 11381.430928453545, 15734.0, 15791.289391977389, 15796.0, 15808.0, 15832.525024249291, 8528.317734581342, 8747.606357713918, 8876.112388761201, 8883.42257753244, 9069.863952040725, 8787.604557794915, 8854.656456644689, 8872.689455869142, 8879.200871921428, 8937.106289371011, 4826.396700412449, 4836.347093142451, 4850.466448690641, 4872.512748725099, 4983.50164983506, 1897.4212865076283, 1964.6365422396902, 1975.140813746025, 1982.603479304145, 1998.920043198285, 1009.7273736091214, 1077.9083777878811, 1090.4711215060688, 1105.2705214558353, 1129.1869853705318, 18995.43013709591, 19412.902935485232, 19473.415797526097, 19930.90034549818, 20138.798612013987, 1067.524951396621, 1090.4166271045112, 1100.2793170473353, 1126.5831642292405, 1132.4111462039693, 10884.0, 11111.111111111091, 11139.275947063577, 11147.777044459066, 11195.720106997227, 474600.0, 511441.0, 518423.94521011336, 521917.0, 526825.0, 78953.0, 87197.56401217953, 89201.0, 90419.54790226139, 91060.54469727608, 1111.0889070961734, 1152.9192956493132, 1165.9941700291613, 1167.7430965187816, 1174.2484809721784, 17388.74064302068, 17643.470695879143, 17808.821911781233, 18031.729524057413, 18197.363092291707, 40179.196416072096, 40660.59339406686, 40804.59195408008, 41696.16607667891, 41706.58293417027, 60287.397126028176, 61889.38110618836, 61957.690211550456, 62310.0, 62520.0, 8893.244074253502, 9122.954385228031, 9155.496447695441, 9176.220021298264, 9196.172344488761, 13167.0, 13728.0, 13884.305784710927, 13918.09532380392, 14269.215193164475, 12080.154389192672, 12121.45453454579, 12178.269303841798, 12250.509979600716, 12254.75490490203, 11733.823992639946, 11892.464839082435, 11965.700857478632, 12096.516139354328, 12149.0, 11625.651230462761, 11996.340201289013, 12128.636140915787, 12217.328046957147, 12238.388080595756, 8667.869981950402, 8744.475331480131, 8799.824003520022, 8860.778480538038, 8877.866831997655, 8647.221750042527, 10766.838497422388, 11213.775724485628, 11223.326600404002, 11284.492197851281], "value": 9511.149775484979, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.217604669525, 1533.762266848638, 1582.3828706804347, 1727.499025282668, 1779.9555011124721, 7513.248675132484, 7934.166912474179, 8152.755417337482, 8343.54110523921, 8346.123657016009, 8346.332293416528, 8359.91640083599, 8397.286230670401, 8413.537255450949, 8419.747407577766, 2332.1371092695686, 2354.858708477488, 2355.6702061711376, 2365.656979737937, 2365.8698771567556, 2275.3287780104824, 2287.370972982435, 2315.9536809263805, 2317.0268487235317, 2332.428555004018, 2302.26327575176, 2343.238447504559, 2345.319857241398, 2354.3525530479083, 2357.0571771291447, 2331.265651319829, 2332.591796435634, 2351.706036745407, 2357.552065107624, 2361.728401233854, 2279.7150356205475, 2283.1438210671, 2291.0, 2299.310206937929, 2303.9193628223097, 8589.699360522352, 8594.183552562497, 8623.698170564001, 8642.61108250124, 8645.567721613894, 5011.072951503984, 5106.948930510722, 5107.438181799999, 5115.667481613683, 5123.666961647481, 3250.057483329855, 3265.9952843384144, 3352.8491217895253, 3371.2246183377715, 3386.271951530433, 1086.9021788039036, 1087.320424734541, 1102.9117670586334, 1136.0968030415838, 1136.33524388233, 12115.151939364248, 12128.151029427943, 12131.211471254428, 12131.575394861138, 12139.028877689852, 4434.711743736647, 4469.575390337913, 4510.594046535762, 4519.5480451954545, 4563.771811409416, 10306.175505959505, 10313.84529232062, 10333.225008124271, 10333.534990925426, 10339.483025848678, 5243.213517972258, 5281.788728450819, 5282.841514754564, 5284.7886084556185, 5286.101362768339, 4598.839040633562, 4828.734419606955, 4832.637552183601, 4839.370881785346, 4847.0, 3871.399933010388, 3898.2983063048923, 3915.960840391617, 3920.4511368408444, 4014.197160567898, 1125.471028616549, 1149.8160294352863, 1151.1251448898897, 1162.5698491558178, 1165.7377090154816, 1067.0823092140752, 1101.0860985382114, 1105.082781291526, 1113.704868209925, 1127.2503784982894, 5917.171595976567, 6010.819675409744, 6155.076738489173, 6187.907181392283, 6231.3145553989025, 1019.8980101989741, 1026.2713473433946, 1043.3583346242006, 1079.6653037558383, 1105.5798796457295, 4269.807858646368, 4292.377605247221, 4319.870403887889, 4330.025744207528, 4342.32693932441, 10310.896891031143, 10507.31702439339, 10629.627963021258, 10680.092192163598, 10736.677899663022, 10415.323004004715, 10464.267501274837, 10465.738356541147, 10502.0, 10586.682399528027, 8014.719484818003, 8053.879191812128, 8178.550179740052, 8203.179682031869, 8224.876626850602, 5956.851078723066, 5999.340072591924, 6044.335123136363, 6059.909101363572, 6092.664903430354, 9326.253899687874, 9375.578098985698, 9501.192398646193, 9524.0, 9540.522973851419, 9304.302177336862, 9467.621295148117, 9468.100530449596, 9530.380525265835, 9841.311108222355, 6522.478201743944, 7178.24628414009, 7356.632168391452, 7366.484346095936, 7484.476086673881, 8228.300594449538, 8259.050209226016, 8307.83384332322, 8345.33237340999, 8360.12218717026, 7080.893786593102, 7364.96317518409, 7415.592142432218, 7468.477206595703, 7578.772636820904, 7425.851482970203, 7543.585102819397, 7591.316781489692, 7630.313271805564, 7646.158922518407, 7245.7826265212125, 7263.891041634274, 7315.414766818535, 7320.96339518299, 7329.193788683134, 5124.692518448905, 5226.372835259793, 5248.895022099613, 5378.542823860016, 5454.836354909359, 5386.326709161355, 5419.05166595852, 5454.318210223722, 5478.753456094406, 5503.20203570472], "value": 4615.956649011325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.3244699964069, 364.5188351376183, 365.70926113739574, 367.90986208378945, 370.39810308249093, 6334.081558174062, 6344.873102537947, 6368.10846481493, 6381.712822922968, 6479.838004049901, 6447.742090316382, 6463.321351258121, 6473.190851143607, 6478.708458119384, 6501.252355979063, 4922.581580565638, 4925.138100832358, 4929.285253638238, 4934.358533390654, 4998.750062496879, 5000.774965126578, 5001.649884508086, 5005.874853128683, 5006.54941055305, 5011.974940125294, 4944.134776414131, 4969.378827646544, 4973.129702302101, 4974.353334066566, 4984.651074424792, 4753.405824271966, 4888.877778055577, 4959.156943319626, 4964.60283177345, 4977.651564390494, 4207.873763787091, 4231.42875711778, 4237.110206856564, 4238.0, 4248.383984322256, 6218.507558186003, 6269.655168965705, 6284.811455656338, 6291.96854015727, 6298.905516417258, 5585.441455854382, 5727.055035919068, 5728.5417166626985, 5740.225069615591, 5756.798512052058, 6836.008778727107, 6842.521023528355, 6843.281455447206, 6847.554908930953, 6849.315068493161, 4742.715437073752, 4744.478107408217, 4744.572988431058, 4746.501617330166, 4762.2380419133115, 7139.036230108921, 7206.0, 7211.242819503929, 7223.349898509106, 7223.602701851396, 4735.431748190239, 4739.4075740532435, 4745.6440766942615, 4755.0, 4755.310479980383, 4735.384400027974, 4854.975725121351, 4861.80552777892, 4924.75376231187, 4934.975325123423, 5661.122526008476, 5684.7777727788725, 5693.601447898607, 5704.572157088152, 5706.0, 6886.8622627547165, 6895.413889819321, 6906.930930690629, 6909.861802763917, 6928.4803639726215, 1678.211240716861, 1745.23209787693, 1747.606788472609, 1748.8688348373923, 1751.2382113780545, 1115.252780636959, 1118.7930232906938, 1140.321508702321, 1141.8915203055697, 1158.1603337580354, 6553.508486863504, 6629.171353580802, 6636.270010298863, 6674.499412543982, 6687.6321802301345, 7025.89461158083, 7026.332498412643, 7057.858842823115, 7060.858782824314, 7067.293270672892, 6584.703688334036, 6642.900356494656, 6649.567778094505, 6654.201495820533, 6656.267810540837, 3768.3593789055926, 3812.370958791824, 3814.6757525610633, 3815.3323168445413, 3815.599362066943, 7152.964235178791, 7305.45209109319, 7309.597972111478, 7345.118585769742, 7413.36986356155, 7138.535995160298, 7145.249748776408, 7154.892676609855, 7181.389581885598, 7182.066331376887, 7238.601876896716, 7253.165885923081, 7269.927300726925, 7270.745523906638, 7280.417566594766, 6881.380675739208, 7024.8595028098125, 7035.894461583182, 7038.612876291649, 7042.929570704227, 6887.311268873073, 6908.827279318058, 6924.619145947021, 6926.8614627708175, 6927.930720692729, 7285.963570182115, 7367.300106489874, 7384.963075184804, 7393.778186654409, 7395.519291246052, 4811.855644330676, 4821.2045012572535, 4822.614190864792, 4825.059113472839, 4828.5412885775795, 6935.861282774417, 6962.443004559522, 6970.616616086164, 6974.267701891431, 6998.965005174941, 6665.366790154928, 6802.387785099365, 6809.38715515606, 6817.625030623363, 6823.624700641314, 6751.93248067513, 6754.0, 6789.15135608049, 6801.047853300641, 6801.353871382211, 6678.465722742266, 6683.966580167068, 6684.331566843277, 6692.765753198614, 6699.665016749241, 6673.265940746417, 6795.184577850492, 6837.042814005944, 6850.314968503109, 6857.485688573277, 6605.141331626858, 6635.270120286668, 6644.368784965421, 6752.3922846944015, 6812.93187068123], "value": 5154.553353240343, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.2226146644618, 925.1257561604286, 926.703454894434, 929.5677509957868, 943.5989704375638, 13858.792118118223, 13875.514356997508, 14017.929910350435, 14075.014748967564, 14076.296185190738, 13576.45694172232, 13741.244231567285, 13764.724705505883, 13797.310134493286, 13799.655008624764, 909.4088842252522, 926.8424367857447, 937.1003836317144, 937.6577549194564, 943.7027336389016, 918.6417297254076, 922.8338898998178, 924.791921817589, 928.4429342394543, 929.9860502092474, 960.6733710538416, 967.7290358699576, 970.4274478057945, 970.7233438470038, 973.265184785486, 960.3949511807587, 960.5389413081725, 961.8845738511353, 962.5283611030544, 965.6475386483953, 708.4403321376107, 708.8653155900363, 709.9396551293146, 710.793869777769, 713.3080911515873, 14640.267986600627, 14671.926640366837, 14707.779383309258, 14764.114153150738, 14830.851691483054, 14721.852781472155, 14747.77878331826, 14962.17708026058, 14992.325345359484, 14999.550013499613, 11023.559057637685, 11437.370944598044, 11464.656060318204, 11487.19589628718, 11783.234089784222, 3903.0, 3916.804159791999, 3971.62269584389, 3984.2828290907623, 3992.640662340374, 59558.40441595615, 59800.0, 60079.0, 60204.39795602075, 60741.39258607401, 11390.772184556428, 11434.371109589052, 11437.142214333959, 11648.825267620992, 11753.706157346134, 20256.594868102555, 20386.49033774138, 20440.182392704424, 20446.182152713725, 20599.588008239753, 8294.087650358455, 8532.8720069199, 8700.825983480296, 8762.693305734396, 8787.516686582172, 4947.6289278304275, 4989.251612258117, 4995.225740010304, 5006.699598024057, 5045.268436076748, 3494.825258737053, 3605.6935160511125, 3617.0234036809916, 3618.800965946898, 3627.510286111394, 638.5370606310481, 641.5412979719523, 643.5462998585986, 650.278191207759, 654.8866926225436, 690.526989012528, 720.7477382916043, 728.4609389052064, 790.4822341366414, 807.1041144329789, 10011.149052330487, 10325.84511232332, 10404.323718958243, 10463.162946964225, 10516.26386152962, 705.2806137739477, 793.6944276453607, 828.90467596226, 836.1178956201145, 854.6068808348106, 5085.364329458817, 5158.509941555546, 5245.763940622681, 5294.655847369909, 5344.198370244494, 63881.68059159767, 65891.34108658948, 66320.66839665771, 66421.33578664152, 66879.66560167167, 53722.194167087524, 55389.1691624626, 56375.15437268444, 57038.714806426535, 57167.0, 48579.0, 48730.0, 49535.25697114546, 49539.752301238266, 50215.74892125516, 10081.747956301151, 10105.9494702526, 10142.49287535635, 10158.593656253963, 10218.897811021794, 37372.439413408276, 37442.62557374391, 37568.0, 39036.80481597574, 39518.0, 43107.0, 49733.25400119073, 50988.74505627448, 51294.48705513046, 51648.0, 12263.141580089308, 12526.373681315716, 12526.561570344995, 12594.622161335175, 12720.363981800689, 14251.0, 14423.42306307736, 14468.421263149356, 14544.636384090483, 14588.927055364655, 13758.793618095537, 13792.93103534476, 13881.375338109607, 13942.093763905314, 14031.579052628438, 12765.170263933187, 12779.680507987374, 13151.145175563557, 13215.273159976294, 13372.866271337161, 12623.368831558202, 13595.660108497366, 13765.518206862711, 13925.582232533041, 14302.713945721236, 11116.388598626829, 11246.381449020382, 11353.205275630626, 11357.204995650225, 11381.715457113638, 11487.36819474937, 11491.310521368745, 11497.597584084851, 11524.366159860952, 11878.346690932081], "value": 7251.746477467063, "unit": "score"}], "name": "dromaeo_css", "value": 7513.9408977978665, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 103.0, 110.0, 110.0, 111.0, 100.0, 109.0, 111.0, 112.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 127.0, 151.0, 181.0, 126.0, 150.0, 155.0, 129.0, 190.0, 126.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 171.0, 77.0, 76.0, 76.0, 76.0, 169.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 148.0, 91.0, 92.0, 93.0, 141.0, 92.0, 92.0, 157.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 99.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 53.0, 53.0, 57.0, 55.0, 74.0, 52.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 58.0, 59.0, 58.0, 58.0, 57.0, 57.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 74.0, 75.0, 74.0, 73.0, 74.0, 77.0, 75.0, 83.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 116.0, 122.0, 119.0, 112.0, 113.0, 112.0, 119.0, 132.0, 134.0], "value": 120.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 161.0, 159.0, 159.0, 159.0, 164.0, 166.0, 162.0, 157.0, 158.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 69.0, 71.0, 71.0, 66.0, 67.0, 65.0, 66.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1519.8, "alertThreshold": 2.0}]} 23:26:42 INFO - Return code: 0 23:26:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:26:42 ERROR - # TBPL SUCCESS # 23:26:42 INFO - Running post-action listener: _resource_record_post_action 23:26:42 INFO - Running post-run listener: _resource_record_post_run 23:26:43 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 28672; Write bytes: 462794752; Read time: 20; Write time: 345768 23:26:43 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242405376; Read time: 0; Write time: 229252 23:26:43 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219791360; Read time: 12; Write time: 116516 23:26:43 INFO - Running post-run listener: _upload_blobber_files 23:26:43 INFO - Blob upload gear active. 23:26:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:26:43 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 23:26:43 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'] 23:26:43 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 23:26:44 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:26:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:26:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:44 INFO - (blobuploader) - INFO - Done attempting. 23:26:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:26:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:26:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:45 INFO - (blobuploader) - INFO - Done attempting. 23:26:45 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:45 INFO - Return code: 0 23:26:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:26:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47a825fffef3c04cd68d553704a0015ffe961680421b5a7b7c2db1e27c986ea230da763eac58309ba37c32c1ba627718639148cce9d3fb0c5d81d36c46586437", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a7b1c0732845541c67109e377d9444f2a87080db5d07baeff6d9189c471324fd0fe6a58df69b5704d32cd04c03396ce1200931ed125d5478d74dd543884d9e"} 23:26:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:26:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:26:45 INFO - Contents: 23:26:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47a825fffef3c04cd68d553704a0015ffe961680421b5a7b7c2db1e27c986ea230da763eac58309ba37c32c1ba627718639148cce9d3fb0c5d81d36c46586437", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a7b1c0732845541c67109e377d9444f2a87080db5d07baeff6d9189c471324fd0fe6a58df69b5704d32cd04c03396ce1200931ed125d5478d74dd543884d9e"} 23:26:45 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:45 INFO - Copying logs to upload dir... 23:26:45 INFO - mkdir: /builds/slave/test/build/upload/logs 23:26:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.092293 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-02 23:26:45.558190) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:45.568901) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885 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/47a825fffef3c04cd68d553704a0015ffe961680421b5a7b7c2db1e27c986ea230da763eac58309ba37c32c1ba627718639148cce9d3fb0c5d81d36c46586437", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a7b1c0732845541c67109e377d9444f2a87080db5d07baeff6d9189c471324fd0fe6a58df69b5704d32cd04c03396ce1200931ed125d5478d74dd543884d9e"} build_url:https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.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/47a825fffef3c04cd68d553704a0015ffe961680421b5a7b7c2db1e27c986ea230da763eac58309ba37c32c1ba627718639148cce9d3fb0c5d81d36c46586437", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a7b1c0732845541c67109e377d9444f2a87080db5d07baeff6d9189c471324fd0fe6a58df69b5704d32cd04c03396ce1200931ed125d5478d74dd543884d9e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:45.598142) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-07-02 23:26:45.598446) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467524049.233886-1497689885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 2.31 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-07-02 23:26:47.916486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:26:47.916836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:26:47.917479) ========= ========= Total master_lag: 2.46 =========