builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1463761281.27 results: success (0) buildid: 20160520063516 builduid: c6abe845d2f04de6be1ed04f3c667eaf revision: 44e878aba14a9fc466e4e86e739ff513bae375b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.266165) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.266656) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.266981) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.282479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.283122) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 09:21:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-05-20 09:21:22 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084061 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.384748) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.385334) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015227 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.440929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.441731) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 44e878aba14a9fc466e4e86e739ff513bae375b5 --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 44e878aba14a9fc466e4e86e739ff513bae375b5 --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=a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 09:21:22,396 truncating revision to first 12 chars 2016-05-20 09:21:22,396 Setting DEBUG logging. 2016-05-20 09:21:22,396 attempt 1/10 2016-05-20 09:21:22,396 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/44e878aba14a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 09:21:22,669 unpacking tar archive at: mozilla-beta-44e878aba14a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:22.062336) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:22.062850) ========= script_repo_revision: 44e878aba14a9fc466e4e86e739ff513bae375b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:22.063938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:22.064676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:22.075867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-20 09:21:22.076184) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:21:23 INFO - MultiFileLogger online at 20160520 09:21:23 in /builds/slave/test 09:21:23 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 09:21:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:21:23 INFO - {'append_to_log': False, 09:21:23 INFO - 'base_work_dir': '/builds/slave/test', 09:21:23 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:21:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:21:23 INFO - 'branch': 'Mozilla-Beta', 09:21:23 INFO - 'buildbot_json_path': 'buildprops.json', 09:21:23 INFO - 'config_files': ('talos/linux_config.py',), 09:21:23 INFO - 'default_actions': ('clobber', 09:21:23 INFO - 'read-buildbot-config', 09:21:23 INFO - 'download-and-extract', 09:21:23 INFO - 'populate-webroot', 09:21:23 INFO - 'create-virtualenv', 09:21:23 INFO - 'install', 09:21:23 INFO - 'run-tests'), 09:21:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:21:23 INFO - 'download_minidump_stackwalk': True, 09:21:23 INFO - 'download_symbols': 'ondemand', 09:21:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:21:23 INFO - 'tooltool.py': '/tools/tooltool.py', 09:21:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:21:23 INFO - '/tools/misc-python/virtualenv.py')}, 09:21:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:21:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:21:23 INFO - 'installer_path': 'installer.exe', 09:21:23 INFO - 'log_level': 'info', 09:21:23 INFO - 'log_name': 'talos', 09:21:23 INFO - 'log_to_console': True, 09:21:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:21:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:21:23 INFO - 'opt_config_files': (), 09:21:23 INFO - 'pip_index': False, 09:21:23 INFO - 'sps_profile': False, 09:21:23 INFO - 'sps_profile_interval': 0, 09:21:23 INFO - 'suite': 'dromaeojs-e10s', 09:21:23 INFO - 'system_bits': '32', 09:21:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:21:23 INFO - 'title': 'talos-linux64-ix-064', 09:21:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:21:23 INFO - 'use_talos_json': True, 09:21:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:21:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:21:23 INFO - 'work_dir': 'build'} 09:21:23 INFO - ##### 09:21:23 INFO - ##### Running clobber step. 09:21:23 INFO - ##### 09:21:23 INFO - Running pre-action listener: _resource_record_pre_action 09:21:23 INFO - Running main action method: clobber 09:21:23 INFO - rmtree: /builds/slave/test/build 09:21:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:21:23 INFO - Running post-action listener: _resource_record_post_action 09:21:23 INFO - ##### 09:21:23 INFO - ##### Running read-buildbot-config step. 09:21:23 INFO - ##### 09:21:23 INFO - Running pre-action listener: _resource_record_pre_action 09:21:23 INFO - Running main action method: read_buildbot_config 09:21:23 INFO - Using buildbot properties: 09:21:23 INFO - { 09:21:23 INFO - "project": "", 09:21:23 INFO - "product": "firefox", 09:21:23 INFO - "script_repo_revision": "production", 09:21:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:21:23 INFO - "repository": "", 09:21:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 09:21:23 INFO - "buildid": "20160520063516", 09:21:23 INFO - "pgo_build": "True", 09:21:23 INFO - "basedir": "/builds/slave/test", 09:21:23 INFO - "buildnumber": 15, 09:21:23 INFO - "slavename": "talos-linux64-ix-064", 09:21:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:21:23 INFO - "platform": "ubuntu64_hw", 09:21:23 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:21:23 INFO - "branch": "mozilla-beta", 09:21:23 INFO - "repo_path": "releases/mozilla-beta", 09:21:23 INFO - "revision": "44e878aba14a9fc466e4e86e739ff513bae375b5", 09:21:23 INFO - "stage_platform": "linux64-pgo", 09:21:23 INFO - "builduid": "c6abe845d2f04de6be1ed04f3c667eaf", 09:21:23 INFO - "slavebuilddir": "test" 09:21:23 INFO - } 09:21:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 09:21:23 INFO - Running post-action listener: _resource_record_post_action 09:21:23 INFO - ##### 09:21:23 INFO - ##### Running download-and-extract step. 09:21:23 INFO - ##### 09:21:23 INFO - Running pre-action listener: _resource_record_pre_action 09:21:23 INFO - Running main action method: download_and_extract 09:21:23 INFO - mkdir: /builds/slave/test/build/tests 09:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:23 INFO - https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:21:25 INFO - Downloaded 1412 bytes. 09:21:25 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:21:25 INFO - Using the following test package requirements: 09:21:25 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:21:25 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:25 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:21:25 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:25 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 09:21:25 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:25 INFO - u'jsshell-linux-x86_64.zip'], 09:21:25 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:25 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:21:25 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:21:25 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:25 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 09:21:25 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:25 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 09:21:25 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:25 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:21:25 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:21:25 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:25 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:21:25 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:21:25 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')]} 09:21:25 INFO - https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:28 INFO - Downloaded 23364975 bytes. 09:21:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:21:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:21:29 INFO - Return code: 0 09:21:29 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:21: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')]} 09:21:29 INFO - https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:21:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:34 INFO - Downloaded 23364975 bytes. 09:21:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:21:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:21:35 INFO - Return code: 0 09:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:35 INFO - https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:21:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:21:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:21:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:21:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:21:37 INFO - Downloaded 10845194 bytes. 09:21:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:21:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:21:37 INFO - Return code: 0 09:21:37 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')]} 09:21:37 INFO - https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:21:38 INFO - Downloaded 53798215 bytes. 09:21:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:21:38 INFO - mkdir: /builds/slave/test/properties 09:21:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:21:38 INFO - Writing to file /builds/slave/test/properties/build_url 09:21:38 INFO - Contents: 09:21:38 INFO - build_url:https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:21:39 INFO - Running post-action listener: _resource_record_post_action 09:21:39 INFO - Running post-action listener: set_extra_try_arguments 09:21:39 INFO - ##### 09:21:39 INFO - ##### Running populate-webroot step. 09:21:39 INFO - ##### 09:21:39 INFO - Running pre-action listener: _resource_record_pre_action 09:21:39 INFO - Running main action method: populate_webroot 09:21:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:21:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:21:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:21:39 INFO - '--tppagecycles', 09:21:39 INFO - '7'], 09:21:39 INFO - 'tests': ['tsvgm']}}, 09:21:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:21:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:21:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:21:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:21:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:21:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:21:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:39 INFO - 'talos_options': ['--e10s'], 09:21:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:39 INFO - 'tests': ['damp', 'tps']}, 09:21:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:39 INFO - 'talos_options': ['--e10s'], 09:21:39 INFO - 'tests': ['damp', 'tps']}, 09:21:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:21:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:21:39 INFO - 'other': {'tests': ['a11yr', 09:21:39 INFO - 'ts_paint', 09:21:39 INFO - 'tpaint', 09:21:39 INFO - 'sessionrestore', 09:21:39 INFO - 'sessionrestore_no_auto_restore', 09:21:39 INFO - 'tabpaint']}, 09:21:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:21:39 INFO - 'tests': ['a11yr', 09:21:39 INFO - 'ts_paint', 09:21:39 INFO - 'tpaint', 09:21:39 INFO - 'sessionrestore', 09:21:39 INFO - 'sessionrestore_no_auto_restore', 09:21:39 INFO - 'tabpaint']}, 09:21:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:21:39 INFO - 'tests': ['a11yr', 09:21:39 INFO - 'ts_paint', 09:21:39 INFO - 'tpaint', 09:21:39 INFO - 'sessionrestore', 09:21:39 INFO - 'sessionrestore_no_auto_restore', 09:21:39 INFO - 'tabpaint']}, 09:21:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:21:39 INFO - 'tests': ['a11yr', 09:21:39 INFO - 'ts_paint', 09:21:39 INFO - 'tpaint', 09:21:39 INFO - 'sessionrestore', 09:21:39 INFO - 'sessionrestore_no_auto_restore', 09:21:39 INFO - 'tabpaint']}, 09:21:39 INFO - 'other_l64': {'tests': ['a11yr', 09:21:39 INFO - 'ts_paint', 09:21:39 INFO - 'tpaint', 09:21:39 INFO - 'sessionrestore', 09:21:39 INFO - 'sessionrestore_no_auto_restore', 09:21:39 INFO - 'tabpaint']}, 09:21:39 INFO - 'other_nol64': {'tests': ['a11yr', 09:21:39 INFO - 'ts_paint', 09:21:39 INFO - 'tpaint', 09:21:39 INFO - 'sessionrestore', 09:21:39 INFO - 'sessionrestore_no_auto_restore', 09:21:39 INFO - 'tabpaint']}, 09:21:39 INFO - 'svgr': {'tests': ['tsvgx', 09:21:39 INFO - 'tsvgr_opacity', 09:21:39 INFO - 'tart', 09:21:39 INFO - 'tscrollx', 09:21:39 INFO - 'cart']}, 09:21:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:21:39 INFO - 'tests': ['tsvgx', 09:21:39 INFO - 'tsvgr_opacity', 09:21:39 INFO - 'tart', 09:21:39 INFO - 'tscrollx', 09:21:39 INFO - 'cart']}, 09:21:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:39 INFO - 'tests': ['tp5o']}, 09:21:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:39 INFO - 'talos_options': ['--e10s'], 09:21:39 INFO - 'tests': ['tp5o']}, 09:21:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:39 INFO - 'talos_options': ['--xperf_path', 09:21:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:39 INFO - 'tests': ['tp5n']}, 09:21:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:39 INFO - 'talos_options': ['--e10s', 09:21:39 INFO - '--xperf_path', 09:21:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:39 INFO - 'tests': ['tp5n']}}, 09:21:39 INFO - 'talos.zip': {'path': '', 09:21:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:21:39 INFO - Running post-action listener: _resource_record_post_action 09:21:39 INFO - ##### 09:21:39 INFO - ##### Running create-virtualenv step. 09:21:39 INFO - ##### 09:21:39 INFO - Running pre-action listener: _resource_record_pre_action 09:21:39 INFO - Running main action method: create_virtualenv 09:21:39 INFO - Creating virtualenv /builds/slave/test/build/venv 09:21:39 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 09:21:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:21:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:21:39 INFO - Using real prefix '/usr' 09:21:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:21:40 INFO - Installing distribute.............................................................................................................................................................................................done. 09:21:42 INFO - Installing pip.................done. 09:21:42 INFO - Return code: 0 09:21:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:21:42 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')]} 09:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:42 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')]} 09:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:42 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 0x7f229b488f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f160>, '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 0x2570060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25704f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', '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 09:21:42 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 09:21:42 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 09:21:42 INFO - Using env: {'DISPLAY': ':0', 09:21:42 INFO - 'HOME': '/home/cltbld', 09:21:42 INFO - 'LANG': 'en_US.UTF-8', 09:21:42 INFO - 'LANGUAGE': 'en_US:en', 09:21:42 INFO - 'LOGNAME': 'cltbld', 09:21:42 INFO - 'MAIL': '/var/mail/cltbld', 09:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:42 INFO - 'MOZ_NO_REMOTE': '1', 09:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:42 INFO - 'NO_EM_RESTART': '1', 09:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:42 INFO - 'PWD': '/builds/slave/test', 09:21:42 INFO - 'SHELL': '/bin/bash', 09:21:42 INFO - 'SHLVL': '1', 09:21:42 INFO - 'TERM': 'linux', 09:21:42 INFO - 'TMOUT': '86400', 09:21:42 INFO - 'USER': 'cltbld', 09:21:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', 09:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:42 INFO - '_': '/tools/buildbot/bin/python'} 09:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:42 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 09:21:42 INFO - Cleaning up... 09:21:42 INFO - Return code: 0 09:21:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:21:42 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')]} 09:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:42 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')]} 09:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:42 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 0x7f229b488f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f160>, '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 0x2570060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25704f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', '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 09:21:42 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 09:21:42 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 09:21:42 INFO - Using env: {'DISPLAY': ':0', 09:21:42 INFO - 'HOME': '/home/cltbld', 09:21:42 INFO - 'LANG': 'en_US.UTF-8', 09:21:42 INFO - 'LANGUAGE': 'en_US:en', 09:21:42 INFO - 'LOGNAME': 'cltbld', 09:21:42 INFO - 'MAIL': '/var/mail/cltbld', 09:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:42 INFO - 'MOZ_NO_REMOTE': '1', 09:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:42 INFO - 'NO_EM_RESTART': '1', 09:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:42 INFO - 'PWD': '/builds/slave/test', 09:21:42 INFO - 'SHELL': '/bin/bash', 09:21:42 INFO - 'SHLVL': '1', 09:21:42 INFO - 'TERM': 'linux', 09:21:42 INFO - 'TMOUT': '86400', 09:21:42 INFO - 'USER': 'cltbld', 09:21:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', 09:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:42 INFO - '_': '/tools/buildbot/bin/python'} 09:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:42 INFO - Downloading/unpacking psutil>=0.7.1 09:21:42 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 09:21:42 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 09:21:42 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 09:21:42 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 09:21:42 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 09:21:42 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 09:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:21:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:44 INFO - Installing collected packages: psutil 09:21:44 INFO - Running setup.py install for psutil 09:21:44 INFO - building 'psutil._psutil_linux' extension 09:21:44 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 09:21:44 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 09:21:44 INFO - building 'psutil._psutil_posix' extension 09:21:44 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 09:21:45 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 09:21:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:45 INFO - Successfully installed psutil 09:21:45 INFO - Cleaning up... 09:21:45 INFO - Return code: 0 09:21:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f229b488f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f160>, '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 0x2570060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25704f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', '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 09:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:21:45 INFO - Using env: {'DISPLAY': ':0', 09:21:45 INFO - 'HOME': '/home/cltbld', 09:21:45 INFO - 'LANG': 'en_US.UTF-8', 09:21:45 INFO - 'LANGUAGE': 'en_US:en', 09:21:45 INFO - 'LOGNAME': 'cltbld', 09:21:45 INFO - 'MAIL': '/var/mail/cltbld', 09:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:45 INFO - 'MOZ_NO_REMOTE': '1', 09:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:45 INFO - 'NO_EM_RESTART': '1', 09:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:45 INFO - 'PWD': '/builds/slave/test', 09:21:45 INFO - 'SHELL': '/bin/bash', 09:21:45 INFO - 'SHLVL': '1', 09:21:45 INFO - 'TERM': 'linux', 09:21:45 INFO - 'TMOUT': '86400', 09:21:45 INFO - 'USER': 'cltbld', 09:21:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', 09:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:45 INFO - '_': '/tools/buildbot/bin/python'} 09:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:21:47 INFO - Installing collected packages: mozsystemmonitor 09:21:47 INFO - Running setup.py install for mozsystemmonitor 09:21:47 INFO - Successfully installed mozsystemmonitor 09:21:47 INFO - Cleaning up... 09:21:47 INFO - Return code: 0 09:21:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:47 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 0x7f229b488f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f160>, '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 0x2570060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25704f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', '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 09:21:47 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 09:21:47 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 09:21:47 INFO - Using env: {'DISPLAY': ':0', 09:21:47 INFO - 'HOME': '/home/cltbld', 09:21:47 INFO - 'LANG': 'en_US.UTF-8', 09:21:47 INFO - 'LANGUAGE': 'en_US:en', 09:21:47 INFO - 'LOGNAME': 'cltbld', 09:21:47 INFO - 'MAIL': '/var/mail/cltbld', 09:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:47 INFO - 'MOZ_NO_REMOTE': '1', 09:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:47 INFO - 'NO_EM_RESTART': '1', 09:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:47 INFO - 'PWD': '/builds/slave/test', 09:21:47 INFO - 'SHELL': '/bin/bash', 09:21:47 INFO - 'SHLVL': '1', 09:21:47 INFO - 'TERM': 'linux', 09:21:47 INFO - 'TMOUT': '86400', 09:21:47 INFO - 'USER': 'cltbld', 09:21:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', 09:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:47 INFO - '_': '/tools/buildbot/bin/python'} 09:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:49 INFO - Downloading blobuploader-1.2.4.tar.gz 09:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:21:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:21:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:50 INFO - Downloading docopt-0.6.1.tar.gz 09:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:21:50 INFO - Installing collected packages: blobuploader, requests, docopt 09:21:50 INFO - Running setup.py install for blobuploader 09:21:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:21:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:21:50 INFO - Running setup.py install for requests 09:21:50 INFO - Running setup.py install for docopt 09:21:51 INFO - Successfully installed blobuploader requests docopt 09:21:51 INFO - Cleaning up... 09:21:51 INFO - Return code: 0 09:21:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f229b488f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f160>, '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 0x2570060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25704f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', '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 09:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:51 INFO - Using env: {'DISPLAY': ':0', 09:21:51 INFO - 'HOME': '/home/cltbld', 09:21:51 INFO - 'LANG': 'en_US.UTF-8', 09:21:51 INFO - 'LANGUAGE': 'en_US:en', 09:21:51 INFO - 'LOGNAME': 'cltbld', 09:21:51 INFO - 'MAIL': '/var/mail/cltbld', 09:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:51 INFO - 'MOZ_NO_REMOTE': '1', 09:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:51 INFO - 'NO_EM_RESTART': '1', 09:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:51 INFO - 'PWD': '/builds/slave/test', 09:21:51 INFO - 'SHELL': '/bin/bash', 09:21:51 INFO - 'SHLVL': '1', 09:21:51 INFO - 'TERM': 'linux', 09:21:51 INFO - 'TMOUT': '86400', 09:21:51 INFO - 'USER': 'cltbld', 09:21:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', 09:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:51 INFO - '_': '/tools/buildbot/bin/python'} 09:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:51 INFO - Running setup.py (path:/tmp/pip-5yoVZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:51 INFO - Running setup.py (path:/tmp/pip-n0C31u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:51 INFO - Running setup.py (path:/tmp/pip-J4VmfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:51 INFO - Running setup.py (path:/tmp/pip-iMEKmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:51 INFO - Running setup.py (path:/tmp/pip-zdJrZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:51 INFO - Running setup.py (path:/tmp/pip-uvaO3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:51 INFO - Running setup.py (path:/tmp/pip-69S3DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:51 INFO - Running setup.py (path:/tmp/pip-am2ZPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:51 INFO - Running setup.py (path:/tmp/pip-J0aTuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:51 INFO - Running setup.py (path:/tmp/pip-zh7wXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:52 INFO - Running setup.py (path:/tmp/pip-LOJO9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:52 INFO - Running setup.py (path:/tmp/pip-vB8Dh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:52 INFO - Running setup.py (path:/tmp/pip-xgEvkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:52 INFO - Running setup.py (path:/tmp/pip-aYo0Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:52 INFO - Running setup.py (path:/tmp/pip-4QETsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:52 INFO - Running setup.py (path:/tmp/pip-2c0rNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:52 INFO - Running setup.py (path:/tmp/pip-yox3sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:52 INFO - Running setup.py install for manifestparser 09:21:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:52 INFO - Running setup.py install for mozcrash 09:21:52 INFO - Running setup.py install for mozdebug 09:21:52 INFO - Running setup.py install for mozdevice 09:21:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:21:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:52 INFO - Running setup.py install for mozfile 09:21:53 INFO - Running setup.py install for mozhttpd 09:21:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:53 INFO - Running setup.py install for mozinfo 09:21:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:53 INFO - Running setup.py install for mozInstall 09:21:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:53 INFO - Running setup.py install for mozleak 09:21:53 INFO - Running setup.py install for mozlog 09:21:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:53 INFO - Running setup.py install for moznetwork 09:21:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:53 INFO - Running setup.py install for mozprocess 09:21:53 INFO - Running setup.py install for mozprofile 09:21:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:53 INFO - Running setup.py install for mozrunner 09:21:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:54 INFO - Running setup.py install for mozscreenshot 09:21:54 INFO - Running setup.py install for moztest 09:21:54 INFO - Running setup.py install for mozversion 09:21:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:54 INFO - Cleaning up... 09:21:54 INFO - Return code: 0 09:21:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f229b488f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f160>, '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 0x2570060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25704f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', '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 09:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:54 INFO - Using env: {'DISPLAY': ':0', 09:21:54 INFO - 'HOME': '/home/cltbld', 09:21:54 INFO - 'LANG': 'en_US.UTF-8', 09:21:54 INFO - 'LANGUAGE': 'en_US:en', 09:21:54 INFO - 'LOGNAME': 'cltbld', 09:21:54 INFO - 'MAIL': '/var/mail/cltbld', 09:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:54 INFO - 'MOZ_NO_REMOTE': '1', 09:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:54 INFO - 'NO_EM_RESTART': '1', 09:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:54 INFO - 'PWD': '/builds/slave/test', 09:21:54 INFO - 'SHELL': '/bin/bash', 09:21:54 INFO - 'SHLVL': '1', 09:21:54 INFO - 'TERM': 'linux', 09:21:54 INFO - 'TMOUT': '86400', 09:21:54 INFO - 'USER': 'cltbld', 09:21:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', 09:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:54 INFO - '_': '/tools/buildbot/bin/python'} 09:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:54 INFO - Running setup.py (path:/tmp/pip-z6mDE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:54 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)) 09:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:54 INFO - Running setup.py (path:/tmp/pip-zfgXU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:54 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)) 09:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:54 INFO - Running setup.py (path:/tmp/pip-0SIQCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:54 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)) 09:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:54 INFO - Running setup.py (path:/tmp/pip-tXkqw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:54 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)) 09:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:54 INFO - Running setup.py (path:/tmp/pip-UG6bdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:54 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)) 09:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:54 INFO - Running setup.py (path:/tmp/pip-__VToR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:54 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)) 09:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:55 INFO - Running setup.py (path:/tmp/pip-K6CJvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:55 INFO - Running setup.py (path:/tmp/pip-qQ4w_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:55 INFO - Running setup.py (path:/tmp/pip-AOoDni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:55 INFO - Running setup.py (path:/tmp/pip-yCZ4sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:55 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)) 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:55 INFO - Running setup.py (path:/tmp/pip-troAgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:55 INFO - Running setup.py (path:/tmp/pip-RqX2sM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:55 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)) 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:55 INFO - Running setup.py (path:/tmp/pip-8TNRaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:55 INFO - Running setup.py (path:/tmp/pip-cMdF5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:55 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)) 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:55 INFO - Running setup.py (path:/tmp/pip-Lr2esk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:55 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)) 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:55 INFO - Running setup.py (path:/tmp/pip-BZ7BDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:55 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)) 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:55 INFO - Running setup.py (path:/tmp/pip-jAVLfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:57 INFO - Downloading blessings-1.6.tar.gz 09:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:57 INFO - Installing collected packages: blessings 09:21:57 INFO - Running setup.py install for blessings 09:21:57 INFO - Successfully installed blessings 09:21:57 INFO - Cleaning up... 09:21:57 INFO - Return code: 0 09:21:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:58 INFO - Reading from file tmpfile_stdout 09:21:58 INFO - Current package versions: 09:21:58 INFO - argparse == 1.2.1 09:21:58 INFO - blessings == 1.6 09:21:58 INFO - blobuploader == 1.2.4 09:21:58 INFO - docopt == 0.6.1 09:21:58 INFO - manifestparser == 1.1 09:21:58 INFO - mozInstall == 1.12 09:21:58 INFO - mozcrash == 0.17 09:21:58 INFO - mozdebug == 0.1 09:21:58 INFO - mozdevice == 0.48 09:21:58 INFO - mozfile == 1.2 09:21:58 INFO - mozhttpd == 0.7 09:21:58 INFO - mozinfo == 0.9 09:21:58 INFO - mozleak == 0.1 09:21:58 INFO - mozlog == 3.1 09:21:58 INFO - moznetwork == 0.27 09:21:58 INFO - mozprocess == 0.22 09:21:58 INFO - mozprofile == 0.28 09:21:58 INFO - mozrunner == 6.11 09:21:58 INFO - mozscreenshot == 0.1 09:21:58 INFO - mozsystemmonitor == 0.0 09:21:58 INFO - moztest == 0.7 09:21:58 INFO - mozversion == 1.4 09:21:58 INFO - psutil == 3.1.1 09:21:58 INFO - requests == 1.2.3 09:21:58 INFO - wsgiref == 0.1.2 09:21:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f229b488f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f160>, '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 0x2570060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25704f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', '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 09:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:58 INFO - Using env: {'DISPLAY': ':0', 09:21:58 INFO - 'HOME': '/home/cltbld', 09:21:58 INFO - 'LANG': 'en_US.UTF-8', 09:21:58 INFO - 'LANGUAGE': 'en_US:en', 09:21:58 INFO - 'LOGNAME': 'cltbld', 09:21:58 INFO - 'MAIL': '/var/mail/cltbld', 09:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:58 INFO - 'MOZ_NO_REMOTE': '1', 09:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:58 INFO - 'NO_EM_RESTART': '1', 09:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:58 INFO - 'PWD': '/builds/slave/test', 09:21:58 INFO - 'SHELL': '/bin/bash', 09:21:58 INFO - 'SHLVL': '1', 09:21:58 INFO - 'TERM': 'linux', 09:21:58 INFO - 'TMOUT': '86400', 09:21:58 INFO - 'USER': 'cltbld', 09:21:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', 09:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:58 INFO - '_': '/tools/buildbot/bin/python'} 09:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:21:58 INFO - Cleaning up... 09:21:58 INFO - Return code: 0 09:21:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f229b488f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f160>, '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 0x2570060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25704f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', '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 09:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:21:58 INFO - Using env: {'DISPLAY': ':0', 09:21:58 INFO - 'HOME': '/home/cltbld', 09:21:58 INFO - 'LANG': 'en_US.UTF-8', 09:21:58 INFO - 'LANGUAGE': 'en_US:en', 09:21:58 INFO - 'LOGNAME': 'cltbld', 09:21:58 INFO - 'MAIL': '/var/mail/cltbld', 09:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:58 INFO - 'MOZ_NO_REMOTE': '1', 09:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:58 INFO - 'NO_EM_RESTART': '1', 09:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:58 INFO - 'PWD': '/builds/slave/test', 09:21:58 INFO - 'SHELL': '/bin/bash', 09:21:58 INFO - 'SHLVL': '1', 09:21:58 INFO - 'TERM': 'linux', 09:21:58 INFO - 'TMOUT': '86400', 09:21:58 INFO - 'USER': 'cltbld', 09:21:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', 09:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:58 INFO - '_': '/tools/buildbot/bin/python'} 09:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:58 INFO - Downloading/unpacking jsonschema 09:21:58 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 09:21:58 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 09:21:58 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 09:21:58 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 09:21:58 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 09:21:58 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 09:22:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:22:00 INFO - Downloading/unpacking functools32 (from jsonschema) 09:22:00 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 09:22:00 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 09:22:00 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 09:22:00 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 09:22:00 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 09:22:00 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 09:22:00 INFO - Downloading functools32-3.2.3-2.tar.gz 09:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:22:00 INFO - warning: no files found matching '*.txt' 09:22:00 INFO - no previously-included directories found matching 'build' 09:22:00 INFO - no previously-included directories found matching 'dist' 09:22:00 INFO - no previously-included directories found matching '.git*' 09:22:00 INFO - Installing collected packages: jsonschema, functools32 09:22:00 INFO - Running setup.py install for functools32 09:22:01 INFO - warning: no files found matching '*.txt' 09:22:01 INFO - no previously-included directories found matching 'build' 09:22:01 INFO - no previously-included directories found matching 'dist' 09:22:01 INFO - no previously-included directories found matching '.git*' 09:22:01 INFO - Successfully installed jsonschema functools32 09:22:01 INFO - Cleaning up... 09:22:01 INFO - Return code: 0 09:22:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f229b488f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f160>, '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 0x2570060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25704f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', '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 09:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:22:01 INFO - Using env: {'DISPLAY': ':0', 09:22:01 INFO - 'HOME': '/home/cltbld', 09:22:01 INFO - 'LANG': 'en_US.UTF-8', 09:22:01 INFO - 'LANGUAGE': 'en_US:en', 09:22:01 INFO - 'LOGNAME': 'cltbld', 09:22:01 INFO - 'MAIL': '/var/mail/cltbld', 09:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:01 INFO - 'MOZ_NO_REMOTE': '1', 09:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:01 INFO - 'NO_EM_RESTART': '1', 09:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:01 INFO - 'PWD': '/builds/slave/test', 09:22:01 INFO - 'SHELL': '/bin/bash', 09:22:01 INFO - 'SHLVL': '1', 09:22:01 INFO - 'TERM': 'linux', 09:22:01 INFO - 'TMOUT': '86400', 09:22:01 INFO - 'USER': 'cltbld', 09:22:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', 09:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:01 INFO - '_': '/tools/buildbot/bin/python'} 09:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:01 INFO - Downloading/unpacking flake8 09:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:22:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:22:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 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 09:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:22:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:03 INFO - no previously-included directories found matching 'docs/_build' 09:22:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:22:04 INFO - Running setup.py install for pep8 09:22:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:04 INFO - no previously-included directories found matching 'docs/_build' 09:22:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:22:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:22:04 INFO - Cleaning up... 09:22:04 INFO - Return code: 0 09:22:04 INFO - Running post-action listener: _resource_record_post_action 09:22:04 INFO - Running post-action listener: _start_resource_monitoring 09:22:04 INFO - Starting resource monitoring. 09:22:04 INFO - ##### 09:22:04 INFO - ##### Running install step. 09:22:04 INFO - ##### 09:22:04 INFO - Running pre-action listener: _resource_record_pre_action 09:22:04 INFO - Running main action method: install 09:22:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:04 INFO - Reading from file tmpfile_stdout 09:22:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:22:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:22:04 INFO - Reading from file tmpfile_stdout 09:22:04 INFO - Output received: 09:22:04 INFO - Usage: mozinstall [options] installer 09:22:04 INFO - Options: 09:22:04 INFO - -h, --help show this help message and exit 09:22:04 INFO - -d DEST, --destination=DEST 09:22:04 INFO - Directory to install application into. [default: 09:22:04 INFO - "/builds/slave/test"] 09:22:04 INFO - --app=APP Application being installed. [default: firefox] 09:22:04 INFO - mkdir: /builds/slave/test/build/application 09:22:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:22:17 INFO - Reading from file tmpfile_stdout 09:22:17 INFO - Output received: 09:22:17 INFO - /builds/slave/test/build/application/firefox/firefox 09:22:17 INFO - Running post-action listener: _resource_record_post_action 09:22:17 INFO - ##### 09:22:17 INFO - ##### Running run-tests step. 09:22:17 INFO - ##### 09:22:17 INFO - Running pre-action listener: _resource_record_pre_action 09:22:17 INFO - Running main action method: run_tests 09:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:17 INFO - Python 2.7.3 09:22:17 INFO - Return code: 0 09:22:17 INFO - grabbing minidump binary from tooltool 09:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:17 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 0x256f160>, '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 0x2570060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25704f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:17 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 09:22:17 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 09:22:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:17 INFO - Return code: 0 09:22:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:22:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:22:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:22:18 INFO - Return code: 0 09:22:18 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/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 09:22:18 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/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 09:22:18 INFO - Using env: {'DISPLAY': ':0', 09:22:18 INFO - 'HOME': '/home/cltbld', 09:22:18 INFO - 'LANG': 'en_US.UTF-8', 09:22:18 INFO - 'LANGUAGE': 'en_US:en', 09:22:18 INFO - 'LOGNAME': 'cltbld', 09:22:18 INFO - 'MAIL': '/var/mail/cltbld', 09:22:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:18 INFO - 'MOZ_NO_REMOTE': '1', 09:22:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:18 INFO - 'NO_EM_RESTART': '1', 09:22:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:18 INFO - 'PWD': '/builds/slave/test', 09:22:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:18 INFO - 'SHELL': '/bin/bash', 09:22:18 INFO - 'SHLVL': '1', 09:22:18 INFO - 'TERM': 'linux', 09:22:18 INFO - 'TMOUT': '86400', 09:22:18 INFO - 'USER': 'cltbld', 09:22:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588', 09:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:18 INFO - '_': '/tools/buildbot/bin/python'} 09:22:18 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/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 09:22:18 INFO - mozversion application_buildid: 20160520063516 09:22:18 INFO - mozversion application_changeset: 44e878aba14a9fc466e4e86e739ff513bae375b5 09:22:18 INFO - mozversion application_display_name: Firefox 09:22:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:18 INFO - mozversion application_name: Firefox 09:22:18 INFO - mozversion application_remotingname: firefox 09:22:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:22:18 INFO - mozversion application_vendor: Mozilla 09:22:18 INFO - mozversion application_version: 47.0 09:22:18 INFO - mozversion platform_buildid: 20160520063516 09:22:18 INFO - mozversion platform_changeset: 44e878aba14a9fc466e4e86e739ff513bae375b5 09:22:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:22:18 INFO - mozversion platform_version: 47.0 09:22:18 INFO - using testdate: 1463761338 09:22:18 INFO - actual date: 1463761338 09:22:18 INFO - starting webserver on 'localhost:37208' 09:22:18 INFO - SUITE-START | Running 2 tests 09:22:18 INFO - TEST-START | dromaeo_css 09:22:18 INFO - operating with platform_type : linux_ 09:22:18 INFO - Initialising browser for dromaeo_css test... 09:22:18 INFO - TEST-INFO | started process 10785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiHxlRK/profile http://localhost:37208/getInfo.html) 09:22:22 INFO - PROCESS | 10785 | 09:22:22 INFO - PROCESS | 10785 | (process:10862): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:22:23 INFO - PROCESS | 10785 | __metrics Screen width/height:1600/1200 09:22:23 INFO - PROCESS | 10785 | colorDepth:24 09:22:23 INFO - PROCESS | 10785 | Browser inner width/height: 1024/697 09:22:23 INFO - PROCESS | 10785 | __metrics 09:22:24 ERROR - PROCESS | 10785 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 09:22:25 INFO - TEST-INFO | 10785: exit 0 09:22:25 INFO - Browser initialized. 09:22:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:22:25 INFO - TEST-INFO | started process 10912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiHxlRK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:26 INFO - PROCESS | 10912 | 09:22:26 INFO - PROCESS | 10912 | (process:10978): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:22:36 INFO - PROCESS | 10912 | RSS: Main: 149991424 09:22:36 INFO - PROCESS | 10912 | 09:23:26 INFO - PROCESS | 10912 | 1463761406449 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] 09:25:34 INFO - PROCESS | 10912 | Cycle 1(1): loaded http://localhost:37208/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37208/tests/dromaeo/cssquery-ext.html) 09:25:35 INFO - PROCESS | 10912 | RSS: Main: 153546752 09:25:35 INFO - PROCESS | 10912 | 09:28:37 INFO - PROCESS | 10912 | Cycle 1(1): loaded http://localhost:37208/tests/dromaeo/cssquery-ext.html (next: http://localhost:37208/tests/dromaeo/cssquery-jquery.html) 09:28:37 INFO - PROCESS | 10912 | RSS: Main: 152137728 09:28:37 INFO - PROCESS | 10912 | 09:31:39 INFO - PROCESS | 10912 | Cycle 1(1): loaded http://localhost:37208/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37208/tests/dromaeo/cssquery-mootools.html) 09:31:39 INFO - PROCESS | 10912 | RSS: Main: 151650304 09:31:39 INFO - PROCESS | 10912 | 09:34:41 INFO - PROCESS | 10912 | Cycle 1(1): loaded http://localhost:37208/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37208/tests/dromaeo/cssquery-prototype.html) 09:34:42 INFO - PROCESS | 10912 | RSS: Main: 151912448 09:34:42 INFO - PROCESS | 10912 | 09:37:44 INFO - PROCESS | 10912 | Cycle 1(1): loaded http://localhost:37208/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37208/tests/dromaeo/cssquery-yui.html) 09:37:45 INFO - PROCESS | 10912 | RSS: Main: 151121920 09:37:45 INFO - PROCESS | 10912 | 09:40:46 INFO - PROCESS | 10912 | Cycle 1(1): loaded http://localhost:37208/tests/dromaeo/cssquery-yui.html (next: http://localhost:37208/tests/dromaeo/cssquery-dojo.html) 09:40:47 INFO - PROCESS | 10912 | RSS: Main: 155312128 09:40:47 INFO - PROCESS | 10912 | 09:40:47 INFO - PROCESS | 10912 | __start_tp_report 09:40:47 INFO - PROCESS | 10912 | _x_x_mozilla_page_load 09:40:47 INFO - PROCESS | 10912 | _x_x_mozilla_page_load_details 09:40:47 INFO - PROCESS | 10912 | |i|pagename|runs| 09:40:47 INFO - PROCESS | 10912 | |0;dojo.html;3283.22844131629;3344.38128946145;3348.5479460272873;3364.9158771030707;3380.6450322716114;5441.483059109383;5466.671999680022;5472.315960504942;5476.315460567429;5502.2296878437055;5480.588955828319;5505.752241149148;5517.5585953123755;5518.117101263799;5518.2826232589805;5007.048660754454;5017.949820501784;5085.313482679846;5102.413222479407;5143;4987.725675087869;5106;5110;5183.429822719498;5203.089459344618;5077.162268225738;5109.310243117169;5113.028524580336;5124.974375128119;5134.25553294772;5059.949400505985;5092.236164575306;5098.872528186788;5107.233914912774;5116.539511443969;4936.679115857493;4984.0281145176705;5020.1214787412055;5023.824166154203;5078.238264260353;5355.357357117132;5364.544013758835;5367.43641917597;5380.192971054334;5385.461453854622;5959.553033522503;5966.045432730785;5968.940310596882;5976.731047102848;5982.4316689914385;5920.023196172627;5963.105534169866;6001.309849367335;6011.368806275365;6014.939850601481;5521.337439507245;5527.309086364205;5532.529734972532;5538.280023596947;5539.086050801613;5918.852028699317;6036.3360030396625;6058.757649693963;6064.605800622945;6070.180525628984;5850.034744267234;5863;5869.589128761031;5873.383294754075;5876.9118463223085;5926.851828704231;5955;5960.403959604092;5960.910586341209;5963.642181469039;5870.5890587659305;5878.970605147032;5914.9112763308585;5929.73316200772;5931.7627294907725;5893.292804863444;5936.050231962951;5940.227770389822;5946.762129514771;5953.226080609493;4471.910561788746;4501.144782491317;4515.9548404515535;4532.1842068427995;4532.98007948209;4038.1116154445976;4047.453593764863;4068.7355321903983;4089.6319331259733;4127.09203975125;5652.406497317805;5731.197632331477;5742.454466825645;5767.423257674283;5813.3895940925595;5955.940440595538;5958.404159584007;5996.910046349309;6019.969900150559;6026.728797204137;5596.4403559644525;5618.971905140448;5724.370319264877;5727.885442291131;5747.051736463437;5118.10433174193;5129.512696293846;5131.204663277198;5157.8452646420665;5177.352830896138;5982.880342393128;6180.690965451709;6202.503799696014;6207.255129384503;6228.283747369111;5979.252593425822;6044.516438684983;6047.848803779941;6061.818145455643;6079.726412311545;6148.877022459436;6155;6155.630662160284;6176.104464852661;6177.2587289525545;5763.740631671669;5872.677002764889;5888.676122813286;5895.292564892069;5912.379200184091;5994.6403215807195;6046.365131661112;6058.818235452944;6073.5748497604745;6086.847828804138;5794.971025144847;5820.010598198402;5850.180974663465;5861.736221869941;5866.823995280149;5729.885402291848;5747.712614369181;5795.565332599987;5860.941390586039;5874.765009399576;5682.77268909239;5710.457506536873;5717.256756621779;5726.427357264407;5740.856478588069;5824.388439213822;5832.650040997553;5846.970765146147;5861.736221869941;5874.970625146847;5657.575681823797;5724;5754.19441278213;5764.337101233412;5850.824475265749 09:40:47 INFO - PROCESS | 10912 | |1;ext.html;537.666646679059;566.1451208674899;577.0219477984815;579.5392662833048;596.7642781101465;42532.57467425325;43839.90400239992;43850.780746096265;43866;43884.561154388444;45024.77487612557;46089.30866037012;46147.53852461474;46169.30746038804;46487.30269045958;8752.168543988328;8962;8971.147740964598;8971.775705607379;8978.50618215998;8843.77890552735;8962.507062111581;9045.502497362642;9047.276217902552;9051.049639787827;8976.59605317759;9046.728598142066;9058.184763371295;9069.95465022674;9092.909070909305;8908.8663670045;9012.369134160612;9014.999999999967;9015.549222538879;9017;8755.824883502359;8886.244669203126;8901.243394311492;8902.33232507558;8903.599338029804;40778;41284.935753212216;41317.1736565267;41449.585504144874;41572.79213603913;3623.691986181178;3740.887773366776;3761.4733937248807;3787.261484010619;4364.476262848447;32913.83543082269;33137.3372532548;33274;33676.15809604755;34514;4236.258654735439;4296.140771845643;4332.761698106603;4344.543822898613;4414.646828253732;237428;237694;238800;239627;321149.9999999977;65292.67353663201;67642.3235767636;68171.65914170397;68507.65746171237;68644;72058;77607.61196194096;78450.60774696204;78634.60682696664;78648.60675696585;18867;19005.14476848545;19078.236870525023;19080.236790528503;19085.522861928563;14682.412703491955;14714.779278310834;14734.526547345395;14767.852321476863;14779.408823646934;22932.738699371363;24109.276721698378;24168;24178.87910560436;24197.7580224199;8019.639116239783;8191.713290034821;8219.136990616018;8268.462549934355;8272.958635206905;1051.4269723000982;1077.8544896439037;1093.3603841752663;1123.9880613701546;1143.6283207957447;30769.38461230763;31621.051368458982;34471.82764086164;36425;36485.08787280339;1068.455087905174;1111.5831563163813;1133.8129208680475;1181.5155786127646;1182.148852825964;16032.19839008045;16236.269367878474;16370.263338149813;16738.414155504743;16977;427879;546672;552565;691258;695920;65812;67033;67424.6628766853;67505;67575.32424675788;1461.7222727681706;1495.4915328788047;1508.5474357692867;1510.9244537773068;1518.780186005653;32260.516092258167;32566.674333256364;32867.671323286464;32929;33650.49524257089;53089;53150;53697;53748.46251537435;53773.19340209978;276362;278180;280163;280594;280930;36797.26405471929;37129.81435092807;37146.44280335851;37468.43797343096;37481.81259093687;48625.75687121542;48684.269735954695;48927.26609100795;50051.74974125252;50842.23736643879;43863.34204986991;43915.78042109769;44438.3334249993;45136;45416.77291613521;40310.39534406928;40896.79551602223;41358.35869128186;41485.1702965945;41976.16047678968;40738.59261407348;40849;41385;41798;41898.79050604728;35419.82290088533;35867;35992.28015439729;36282.637173627925;36297.27405451823;27544.449111017268;28315.575266371434;28401.147965561067;28629.28426789347;28719.42561148807 09:40:47 INFO - PROCESS | 10912 | |2;jquery.html;383.08282429300874;384.728766219815;387.33378588827225;391.19609203087646;394.7591968898973;12507.687307817308;13000;15816.841831581682;18446.815531844677;19110.808891911078;19479.70780438291;19724.802751972475;20129.295474658353;20129.899350503227;20246.797532024677;6141.263048434183;6169.568130230886;6343.175387199658;6405.359464053604;6430.839229019289;6395.072714456401;6401.967990160043;6411.326810684857;6431.935680643204;6437.613743175401;6156.107364432155;6368.554201205918;6401.1678481797535;6415.711292991803;6428.132202152719;6359.841003974914;6391.233052033739;6405.071264666621;6405.135306733578;6428.228612566475;6048.7882924097885;6139.87720245597;6144.293406258248;6215.2541694996435;6221.844453888643;24483.877580611985;24757.133500327403;24873.5025299493;25067.37331566707;25446.618300725502;2272.6591011348264;2608.6347911292432;3166.5883435153282;3173.8889138880027;3383.069655844638;14972.951893367359;15117.54647360581;15299.15854627995;15462.072275663384;15886.443974460954;2111.19774485696;2117.396541985542;2124.946876328089;2154.084514081525;2223.58863610231;69775;71043.28956710418;72265.27734722638;72401.63799181023;72744;15841.287142078634;15945.760813587573;15963.441279555393;16174.514764557081;16257.430989915296;13646.795298070538;14196.64508387278;27334.45331093367;27405.451890962468;27420.588691169647;7908.4464087513325;7965.6017199139815;8042.396820238506;8055.476394034369;8168.754937351889;7877.369810415153;7949.364050876032;7995;8093.635786389626;8136.1863813618165;4381.7370957742;4419.11617676466;4438.733675979452;4571.1543364477675;4687.273472611751;1870.5417172792752;1874.334611213027;1885.679434496139;1948.3278268997174;1961.2351183038627;970.8398463835648;1014.6803756816579;1061.230607809332;1106.8007758603528;1116.7208197950513;17332.740008899877;17374.783765136573;17517.824821751874;17551.473455796346;18131;999.9100080992746;1013.083159740436;1033.5917312661607;1056.772793849326;1069.5347523827004;10085.596576136872;10094.545745441474;10152.796944061078;10185.33795303303;10219.48902554884;429109;435666;438668;440495;445263;76204.23795761971;77498;78371.60814195893;78892.60553697195;80018;1039.776448063655;1060.41677077607;1061.5647584490475;1062.9415382153902;1093.5516438260274;15722;15935.36258549645;15944.760828587812;16038.679226415174;16042.117683527518;29187.70812291935;34317.31365372628;34630.82684586561;37256.62743372531;37996.43005354867;43809;46628.7668561655;46920;47173.76413117912;47276.763616183074;8190.549519776469;8555.401121921655;8583.227509524173;8840.29277657773;8893.64425422976;13187.010974177167;13575;13639.454421823017;13769.931150344184;13845.51540696111;11387.601433950103;11667.824982625438;11914.76170476603;11914.821277680669;11930;11336.489857956247;11877.346745929057;11991.400429978641;12026.27842329463;12031.4585843639;6452.9677351612945;11816.881831181921;11984.161108722306;12174.391280435766;12176.269423834598;8061.919380806117;8650.56747162652;8806.075362086889;8897.510636915033;8939.73180804577;10780.676579702622;11456.312621242752;11534.711632209262;11640.243384180001;11697.415129243334 09:40:47 INFO - PROCESS | 10912 | |3;mootools.html;1551.8758499320054;1601.1593913195575;1848.500904755716;1887.1319193171141;1953.6483432982066;8131.756047318575;8163.91836081639;8307;8322.04296505902;8356.122607126248;8218.794530136749;8298.70954516592;8316.667333306661;8319.209675080872;8343.290820280283;2330.93007209784;2351.2240960483086;2356.222446592629;2362.2086600988605;2363.7163540375095;2405.783479486846;2414.7343792182846;2450.8284420090513;2458.2502336787275;2458.50829834033;2315.2128276386024;2321.7097862767155;2328.057136859566;2338.485533182697;2354.72920614129;2402.8318017738766;2420.2860156253946;2430.5746494363502;2435.3789783605243;2442.7557244275517;2387.212219967407;2393.4734358441115;2397.2328854766483;2399.3881560202212;2404.483036147237;8265.46274492156;8314;8320.459170153921;8332.04181519127;8347.958260208721;5141.74291285438;5218.217267409881;5234.084035293847;5240.266362709223;5264.078786212397;3165.509346051366;3203.5515027896113;3247.0745837436216;3259.771815972883;3333.666633336671;964.864918911353;982.5038355630433;991.7173605522464;1006.3458751811309;1008.339537602864;11243.66269011931;11390.71523211918;11402.885971140266;11412.20114591979;11449.656510304621;4394.604485596312;4439.334099884978;4498.572635599613;4499.4150760400935;4504.301833215857;9236.907630923739;9258.953705231566;9269.90730092704;9288.256939444827;9321.860172097424;5235.214717792362;5269.420363759983;5274.208868669731;5279.076161671692;5279.656822306538;4594.954050459452;4675.696079754805;4694.859154225379;4715.669903106749;4805.399325084364;3488.110531814371;3563.732720045955;3568.3041806847937;3604.116991337139;3620.5836328821997;1059.523214553454;1063.1494804156644;1067.6263307842348;1070.314998401024;1085.3487907255742;1448.7754398068316;1457.358762144653;1468.5227301126963;1480.9111453312835;1500.9624759380883;8009.759707208793;8062.032556093306;8067.83864322722;8075.071366792894;8084.231997960184;521.56188801407;526.7497938479191;534.7219445888117;534.9037173308842;536.6216817143904;6090.908636370458;6154.661493617894;6162.5378096642935;6170.413810687977;6190.040543715641;10017.248706347053;10383.740406489898;10406.5837366506;10424.68725938223;10491;9331.113544213289;10035;10093.142082922886;10132.54403551842;10266.435346055889;7768.456208065381;7899.960500197577;7922.168172341936;7942.801429964297;7962.601869906482;7632.69469221225;7685.116211635734;7779.105402878741;7787.415943804351;7797.961010194913;8761.912380876365;8763.430377025474;8802.559872006503;9041.728748137566;9054.773630659287;8781.604827782638;8986.640534378552;9101.044390339184;9162.725118246462;9299.674511392339;7298.744543940937;7401;7505.587192704235;7511.586862722603;7517.436192285491;7816.06207255133;7874.212578742309;7917.683292668459;7931.444798864024;7955.085165205844;7063.82340441493;7109.28907109285;7189.712411503481;7194.892076618959;7243.311885370881;7148.499605027599;7150.998860159478;7175.103112110986;7214.71141154348;7263.636818159177;7170.641467926687;7363.595002274712;7366.189719130784;7391;7392.630368481447;6753.189617245962;6760.966195168992;6793.626350550569;6802.6258555779905;6826.453883689193;6734.595924244365;6809.557378770364;6812.14848143982;6813.216480104653;6837.282085381163 09:40:47 INFO - PROCESS | 10912 | |4;prototype.html;354.1005845153311;362.61924978772294;363.7671889990407;367.17752234993605;369.58790948092883;6321.3994670506345;6354.523410744189;6368.586041907279;6375.521835862306;6426.132472116263;6256.374362563742;6272.68636568172;6273.686315684209;6284.12022316876;6292.842678933029;4709.387779588648;4806.086843499741;4828.444728856182;4835.975820120894;4851.22380419133;4824.927626085611;4838.564529192372;4841.661083724141;4844.370231869852;4846.151923413407;4783;4792.305115758213;4795.688280261789;4802.59177969873;4810.567048965592;4786.760661966905;4788.61691064714;4798.448178459469;4809.855704328876;4811.182099043171;4178.78815143608;4182.811773470201;4186.769727664977;4187.874363769061;4189.895252618709;5888;5961;5986.521078313768;6000.819975400745;6010.609310394854;5525.668459892419;5571.637843540157;5574.163875418679;5597.272354593917;5603.971980140073;6630.933690663128;6672.666366681647;6706.362895524917;6714.697838597226;6716.2276338221245;4593;4594.65540084495;4595.540445955411;4595.724256544618;4614.492405835355;6978.441724662015;7029.929700702979;7040.225575186725;7041.3310735480045;7047.577145371243;4667.8599642010795;4826;4832.371791667061;4833.830815921426;4836.443808962014;4884.633652476078;4911.919377736892;4914.33656456381;4915.3855768029;4921.114199444134;5627.71861406928;5668.461496157858;5670.829875103754;5672.234248376499;5684.976704193202;6819.795406137824;6824.931750682529;6830.146231721035;6830.7609233676585;6842.897356539655;1692.339987404913;1697.2616911643229;1702.7956645202407;1703.34421247818;1708.2825213410397;1111.6720567432626;1130.4008875296106;1136.4999400263857;1144.9885501144881;1148.5979907032638;6449;6490.286068532458;6511.316311787289;6527.34726527353;6620.668966551653;6970.477214208955;6977.82555436108;7008;7025.92974070263;7029.718811247493;6518.804435866931;6625.4037136657935;6688.7324507019175;6698.531102822853;6727.226368967534;3789.374753165752;3803.2773772983046;3833.3291673956946;3834.0989867381145;3835.137094153793;7323.12122545298;7343.559386436831;7406.592637404994;7412.4440666950195;7424;7302.415806735448;7326.67029983652;7363.889541656772;7418.888716669254;7422.183559808417;7131.358177764027;7321.963390183015;7354.77935661931;7393.223711510429;7399.630018499053;7022.824429389306;7091.680874360769;7106.253843346374;7116.715331386894;7142.607156606437;6938.23679395256;6978.371946524634;7008.088948436671;7023.051887995055;7037.049998250171;7362.852742945004;7386.446016548673;7405.7778266652085;7410.036695229801;7412.4070074394995;4896.338994235733;4953.578945789648;5025.145725226794;5026.47222041695;5049.57078648319;6989.685464154227;7012.509124361246;7024.227334993249;7050.788476345718;7059.858802823812;6780.491463140185;6798.048273241849;6807.625580593115;6822.044913711985;6830.248672646105;6808.38724514796;6819.863602728017;6872.175338959357;6878.8624227516175;6886.345797149263;6501.122348483083;6639.867202656016;6676.732930682912;6720.630365329954;6746.730130794714;6882.69027893736;6888.242293347627;6889.242183359726;6893.103896493424;6901.930980690129;6731.966340168267;6733.42765864907;6743.089682892747;6751.493637977073;6754.493412993947 09:40:47 INFO - PROCESS | 10912 | |5;yui.html;782.2021538031208;894.2488309819751;895.3687650206605;907.7367563406613;922.741632342944;14278.000539962193;14576.198309093008;14616.4884229052;14628.707425851477;14645.853541464583;13929.930350348259;14017.579472615813;14055.016148869583;14061.437542498314;14075.085119467227;922.7739203895055;958.3818437108062;958.7267628725815;961.024560071528;961.1637875048717;950.339514037744;952.49041762657;953.3279038278032;956.6269155029544;959.8752162218901;1002.2633364477103;1008.9798204035915;1009.0817356205854;1009.5002973528077;1010.0909181736423;996.9501524923725;999.5302207962246;1002.5839276700161;1003.1373019203479;1011.0748664971542;738.7894450081701;742.8402893377896;743.8698227810112;743.9590822504761;744.3858816476428;14496.34766435513;14511.346989385504;14522.056066355653;14547.418103275857;14565.6358591035;14178.787318190132;14357.210353430557;14398.78401823963;14409.639759006004;14413.927930360282;11791.941040294743;11814.822777658343;11814.881851181464;11915.106367022508;11946.940265298705;3901.7854018028997;3915.843366265346;3945.447637330776;3962.187751510933;4002.5597184309704;54813;54877.45122548763;54901.72549137269;54957.90084198333;55403.72298138524;10917.617883374203;11184.720381990353;11245.100391968623;11310.151738619472;11320.490577924013;20146.496337591678;20203.79796202019;20234.595308093754;20275.79724202739;20327.288544900857;8000.719974800854;8079.757607271791;8309.37679674027;8585.65657373698;8625.266852317623;4642.53574642533;4736.526347365236;4761.95238047622;4823.686460380064;4830.178869592178;3513.5432393789156;3528.417811061146;3532.752707310515;3546.1666508370513;3554.3779838528153;606.8331208917583;611.376396076;628.4061561824124;649.1496140056447;660.4848218389664;631.8325643704422;717.160921721587;752.9924700753032;789.7393860026177;804.9356051515865;9467.952660236655;9791.216702663769;9930.453825039693;9962.651307204213;10001.849972250422;651.5081113759081;766.861964846333;783.8784988326819;793.6547601793238;795.9960200198962;4433.800478978454;4470.195364834296;4486.551344865487;4555.498895121534;4645.465771436328;63866.36133638697;64121.35878641247;64435.67782161059;64568.354316457175;64931;55367;55558.444415556136;55753;55858.72070639702;57079.14381284284;49781;50410.24384634233;50464.747676262115;50799.49200508022;51105.48894511082;9004.189622933967;9211.170994610517;9213.262938964732;9254.213391861767;9374.531273436165;36977.815110924275;37441.625583743815;38057.80971095127;39037.41443878287;39769.40345894872;48911.755441222565;49565.50434495753;49989.750051250965;50730.239046415074;51663.74168129286;12367.505299788269;12481;12510.624681259576;12653.74692506163;12938.417771200131;13155.934220328838;13949.511767088103;13978.30108494551;13990.370433330321;14179.503717369842;12631.684207894876;12708.682282943;12842.614721558368;12976;13010.674733131747;13285;13292.534761283308;13383.799243011168;13448;13527.323633818467;11737;11983.64049078529;12221.266723996589;12393.876061239273;12941;10644.627438039632;10735.677929662123;10977.560897564008;11045.447727613426;11172.832407514057;10826.51280692355;10989.969472306882;11010.217362035834;11043;11088.833667494833 09:40:47 INFO - PROCESS | 10912 | __end_tp_report 09:40:47 INFO - PROCESS | 10912 | __start_cc_report 09:40:47 INFO - PROCESS | 10912 | _x_x_mozilla_cycle_collect,323 09:40:47 INFO - PROCESS | 10912 | __end_cc_report 09:40:47 INFO - PROCESS | 10912 | __startTimestamp1463762447155__endTimestamp 09:40:47 INFO - PROCESS | 10912 | 09:40:47 INFO - PROCESS | 10912 | ------- Summary: start ------- 09:40:47 INFO - PROCESS | 10912 | Number of tests: 6 09:40:47 INFO - PROCESS | 10912 | 09:40:47 INFO - PROCESS | 10912 | [#0] dojo.html Cycles:165 Average:5535.00 Median:5754.19 stddev:617.48 (10.7%) stddev-sans-first:593.56 09:40:47 INFO - PROCESS | 10912 | Values: 3283.2 3344.4 3348.5 3364.9 3380.6 5441.5 5466.7 5472.3 5476.3 5502.2 5480.6 5505.8 5517.6 5518.1 5518.3 5007.0 5017.9 5085.3 5102.4 5143.0 4987.7 5106.0 5110.0 5183.4 5203.1 5077.2 5109.3 5113.0 5125.0 5134.3 5059.9 5092.2 5098.9 5107.2 5116.5 4936.7 4984.0 5020.1 5023.8 5078.2 5355.4 5364.5 5367.4 5380.2 5385.5 5959.6 5966.0 5968.9 5976.7 5982.4 5920.0 5963.1 6001.3 6011.4 6014.9 5521.3 5527.3 5532.5 5538.3 5539.1 5918.9 6036.3 6058.8 6064.6 6070.2 5850.0 5863.0 5869.6 5873.4 5876.9 5926.9 5955.0 5960.4 5960.9 5963.6 5870.6 5879.0 5914.9 5929.7 5931.8 5893.3 5936.1 5940.2 5946.8 5953.2 4471.9 4501.1 4516.0 4532.2 4533.0 4038.1 4047.5 4068.7 4089.6 4127.1 5652.4 5731.2 5742.5 5767.4 5813.4 5955.9 5958.4 5996.9 6020.0 6026.7 5596.4 5619.0 5724.4 5727.9 5747.1 5118.1 5129.5 5131.2 5157.8 5177.4 5982.9 6180.7 6202.5 6207.3 6228.3 5979.3 6044.5 6047.8 6061.8 6079.7 6148.9 6155.0 6155.6 6176.1 6177.3 5763.7 5872.7 5888.7 5895.3 5912.4 5994.6 6046.4 6058.8 6073.6 6086.8 5795.0 5820.0 5850.2 5861.7 5866.8 5729.9 5747.7 5795.6 5860.9 5874.8 5682.8 5710.5 5717.3 5726.4 5740.9 5824.4 5832.7 5847.0 5861.7 5875.0 5657.6 5724.0 5754.2 5764.3 5850.8 09:40:47 INFO - PROCESS | 10912 | 09:40:47 INFO - PROCESS | 10912 | [#1] ext.html Cycles:180 Average:56421.74 Median:41685.40 stddev:108257.36 (259.7%) stddev-sans-first:108479.74 09:40:47 INFO - PROCESS | 10912 | Values: 537.7 566.1 577.0 579.5 596.8 42532.6 43839.9 43850.8 43866.0 43884.6 45024.8 46089.3 46147.5 46169.3 46487.3 8752.2 8962.0 8971.1 8971.8 8978.5 8843.8 8962.5 9045.5 9047.3 9051.0 8976.6 9046.7 9058.2 9070.0 9092.9 8908.9 9012.4 9015.0 9015.5 9017.0 8755.8 8886.2 8901.2 8902.3 8903.6 40778.0 41284.9 41317.2 41449.6 41572.8 3623.7 3740.9 3761.5 3787.3 4364.5 32913.8 33137.3 33274.0 33676.2 34514.0 4236.3 4296.1 4332.8 4344.5 4414.6 237428.0 237694.0 238800.0 239627.0 321150.0 65292.7 67642.3 68171.7 68507.7 68644.0 72058.0 77607.6 78450.6 78634.6 78648.6 18867.0 19005.1 19078.2 19080.2 19085.5 14682.4 14714.8 14734.5 14767.9 14779.4 22932.7 24109.3 24168.0 24178.9 24197.8 8019.6 8191.7 8219.1 8268.5 8273.0 1051.4 1077.9 1093.4 1124.0 1143.6 30769.4 31621.1 34471.8 36425.0 36485.1 1068.5 1111.6 1133.8 1181.5 1182.1 16032.2 16236.3 16370.3 16738.4 16977.0 427879.0 546672.0 552565.0 691258.0 695920.0 65812.0 67033.0 67424.7 67505.0 67575.3 1461.7 1495.5 1508.5 1510.9 1518.8 32260.5 32566.7 32867.7 32929.0 33650.5 53089.0 53150.0 53697.0 53748.5 53773.2 276362.0 278180.0 280163.0 280594.0 280930.0 36797.3 37129.8 37146.4 37468.4 37481.8 48625.8 48684.3 48927.3 50051.7 50842.2 43863.3 43915.8 44438.3 45136.0 45416.8 40310.4 40896.8 41358.4 41485.2 41976.2 40738.6 40849.0 41385.0 41798.0 41898.8 35419.8 35867.0 35992.3 36282.6 36297.3 27544.4 28315.6 28401.1 28629.3 28719.4 09:40:47 INFO - PROCESS | 10912 | 09:40:47 INFO - PROCESS | 10912 | [#2] jquery.html Cycles:180 Average:26831.56 Median:14971.54 stddev:71813.88 (479.7%) stddev-sans-first:71987.88 09:40:47 INFO - PROCESS | 10912 | Values: 383.1 384.7 387.3 391.2 394.8 12507.7 13000.0 15816.8 18446.8 19110.8 19479.7 19724.8 20129.3 20129.9 20246.8 6141.3 6169.6 6343.2 6405.4 6430.8 6395.1 6402.0 6411.3 6431.9 6437.6 6156.1 6368.6 6401.2 6415.7 6428.1 6359.8 6391.2 6405.1 6405.1 6428.2 6048.8 6139.9 6144.3 6215.3 6221.8 24483.9 24757.1 24873.5 25067.4 25446.6 2272.7 2608.6 3166.6 3173.9 3383.1 14973.0 15117.5 15299.2 15462.1 15886.4 2111.2 2117.4 2124.9 2154.1 2223.6 69775.0 71043.3 72265.3 72401.6 72744.0 15841.3 15945.8 15963.4 16174.5 16257.4 13646.8 14196.6 27334.5 27405.5 27420.6 7908.4 7965.6 8042.4 8055.5 8168.8 7877.4 7949.4 7995.0 8093.6 8136.2 4381.7 4419.1 4438.7 4571.2 4687.3 1870.5 1874.3 1885.7 1948.3 1961.2 970.8 1014.7 1061.2 1106.8 1116.7 17332.7 17374.8 17517.8 17551.5 18131.0 999.9 1013.1 1033.6 1056.8 1069.5 10085.6 10094.5 10152.8 10185.3 10219.5 429109.0 435666.0 438668.0 440495.0 445263.0 76204.2 77498.0 78371.6 78892.6 80018.0 1039.8 1060.4 1061.6 1062.9 1093.6 15722.0 15935.4 15944.8 16038.7 16042.1 29187.7 34317.3 34630.8 37256.6 37996.4 43809.0 46628.8 46920.0 47173.8 47276.8 8190.5 8555.4 8583.2 8840.3 8893.6 13187.0 13575.0 13639.5 13769.9 13845.5 11387.6 11667.8 11914.8 11914.8 11930.0 11336.5 11877.3 11991.4 12026.3 12031.5 6453.0 11816.9 11984.2 12174.4 12176.3 8061.9 8650.6 8806.1 8897.5 8939.7 10780.7 11456.3 11534.7 11640.2 11697.4 09:40:47 INFO - PROCESS | 10912 | 09:40:47 INFO - PROCESS | 10912 | [#3] mootools.html Cycles:180 Average:5791.76 Median:3313.77 stddev:3038.62 (91.7%) stddev-sans-first:3030.44 09:40:47 INFO - PROCESS | 10912 | Values: 1551.9 1601.2 1848.5 1887.1 1953.6 8131.8 8163.9 8307.0 8322.0 8356.1 8218.8 8298.7 8316.7 8319.2 8343.3 2330.9 2351.2 2356.2 2362.2 2363.7 2405.8 2414.7 2450.8 2458.3 2458.5 2315.2 2321.7 2328.1 2338.5 2354.7 2402.8 2420.3 2430.6 2435.4 2442.8 2387.2 2393.5 2397.2 2399.4 2404.5 8265.5 8314.0 8320.5 8332.0 8348.0 5141.7 5218.2 5234.1 5240.3 5264.1 3165.5 3203.6 3247.1 3259.8 3333.7 964.9 982.5 991.7 1006.3 1008.3 11243.7 11390.7 11402.9 11412.2 11449.7 4394.6 4439.3 4498.6 4499.4 4504.3 9236.9 9259.0 9269.9 9288.3 9321.9 5235.2 5269.4 5274.2 5279.1 5279.7 4595.0 4675.7 4694.9 4715.7 4805.4 3488.1 3563.7 3568.3 3604.1 3620.6 1059.5 1063.1 1067.6 1070.3 1085.3 1448.8 1457.4 1468.5 1480.9 1501.0 8009.8 8062.0 8067.8 8075.1 8084.2 521.6 526.7 534.7 534.9 536.6 6090.9 6154.7 6162.5 6170.4 6190.0 10017.2 10383.7 10406.6 10424.7 10491.0 9331.1 10035.0 10093.1 10132.5 10266.4 7768.5 7900.0 7922.2 7942.8 7962.6 7632.7 7685.1 7779.1 7787.4 7798.0 8761.9 8763.4 8802.6 9041.7 9054.8 8781.6 8986.6 9101.0 9162.7 9299.7 7298.7 7401.0 7505.6 7511.6 7517.4 7816.1 7874.2 7917.7 7931.4 7955.1 7063.8 7109.3 7189.7 7194.9 7243.3 7148.5 7151.0 7175.1 7214.7 7263.6 7170.6 7363.6 7366.2 7391.0 7392.6 6753.2 6761.0 6793.6 6802.6 6826.5 6734.6 6809.6 6812.1 6813.2 6837.3 09:40:47 INFO - PROCESS | 10912 | 09:40:47 INFO - PROCESS | 10912 | [#4] prototype.html Cycles:180 Average:5690.32 Median:6469.64 stddev:1738.14 (26.9%) stddev-sans-first:1696.24 09:40:47 INFO - PROCESS | 10912 | Values: 354.1 362.6 363.8 367.2 369.6 6321.4 6354.5 6368.6 6375.5 6426.1 6256.4 6272.7 6273.7 6284.1 6292.8 4709.4 4806.1 4828.4 4836.0 4851.2 4824.9 4838.6 4841.7 4844.4 4846.2 4783.0 4792.3 4795.7 4802.6 4810.6 4786.8 4788.6 4798.4 4809.9 4811.2 4178.8 4182.8 4186.8 4187.9 4189.9 5888.0 5961.0 5986.5 6000.8 6010.6 5525.7 5571.6 5574.2 5597.3 5604.0 6630.9 6672.7 6706.4 6714.7 6716.2 4593.0 4594.7 4595.5 4595.7 4614.5 6978.4 7029.9 7040.2 7041.3 7047.6 4667.9 4826.0 4832.4 4833.8 4836.4 4884.6 4911.9 4914.3 4915.4 4921.1 5627.7 5668.5 5670.8 5672.2 5685.0 6819.8 6824.9 6830.1 6830.8 6842.9 1692.3 1697.3 1702.8 1703.3 1708.3 1111.7 1130.4 1136.5 1145.0 1148.6 6449.0 6490.3 6511.3 6527.3 6620.7 6970.5 6977.8 7008.0 7025.9 7029.7 6518.8 6625.4 6688.7 6698.5 6727.2 3789.4 3803.3 3833.3 3834.1 3835.1 7323.1 7343.6 7406.6 7412.4 7424.0 7302.4 7326.7 7363.9 7418.9 7422.2 7131.4 7322.0 7354.8 7393.2 7399.6 7022.8 7091.7 7106.3 7116.7 7142.6 6938.2 6978.4 7008.1 7023.1 7037.0 7362.9 7386.4 7405.8 7410.0 7412.4 4896.3 4953.6 5025.1 5026.5 5049.6 6989.7 7012.5 7024.2 7050.8 7059.9 6780.5 6798.0 6807.6 6822.0 6830.2 6808.4 6819.9 6872.2 6878.9 6886.3 6501.1 6639.9 6676.7 6720.6 6746.7 6882.7 6888.2 6889.2 6893.1 6901.9 6732.0 6733.4 6743.1 6751.5 6754.5 09:40:47 INFO - PROCESS | 10912 | 09:40:47 INFO - PROCESS | 10912 | [#5] yui.html Cycles:180 Average:15377.82 Median:3953.82 stddev:17713.71 (448.0%) stddev-sans-first:17729.49 09:40:47 INFO - PROCESS | 10912 | Values: 782.2 894.2 895.4 907.7 922.7 14278.0 14576.2 14616.5 14628.7 14645.9 13929.9 14017.6 14055.0 14061.4 14075.1 922.8 958.4 958.7 961.0 961.2 950.3 952.5 953.3 956.6 959.9 1002.3 1009.0 1009.1 1009.5 1010.1 997.0 999.5 1002.6 1003.1 1011.1 738.8 742.8 743.9 744.0 744.4 14496.3 14511.3 14522.1 14547.4 14565.6 14178.8 14357.2 14398.8 14409.6 14413.9 11791.9 11814.8 11814.9 11915.1 11946.9 3901.8 3915.8 3945.4 3962.2 4002.6 54813.0 54877.5 54901.7 54957.9 55403.7 10917.6 11184.7 11245.1 11310.2 11320.5 20146.5 20203.8 20234.6 20275.8 20327.3 8000.7 8079.8 8309.4 8585.7 8625.3 4642.5 4736.5 4762.0 4823.7 4830.2 3513.5 3528.4 3532.8 3546.2 3554.4 606.8 611.4 628.4 649.1 660.5 631.8 717.2 753.0 789.7 804.9 9468.0 9791.2 9930.5 9962.7 10001.8 651.5 766.9 783.9 793.7 796.0 4433.8 4470.2 4486.6 4555.5 4645.5 63866.4 64121.4 64435.7 64568.4 64931.0 55367.0 55558.4 55753.0 55858.7 57079.1 49781.0 50410.2 50464.7 50799.5 51105.5 9004.2 9211.2 9213.3 9254.2 9374.5 36977.8 37441.6 38057.8 39037.4 39769.4 48911.8 49565.5 49989.8 50730.2 51663.7 12367.5 12481.0 12510.6 12653.7 12938.4 13155.9 13949.5 13978.3 13990.4 14179.5 12631.7 12708.7 12842.6 12976.0 13010.7 13285.0 13292.5 13383.8 13448.0 13527.3 11737.0 11983.6 12221.3 12393.9 12941.0 10644.6 10735.7 10977.6 11045.4 11172.8 10826.5 10990.0 11010.2 11043.0 11088.8 09:40:47 INFO - PROCESS | 10912 | -------- Summary: end -------- 09:40:47 INFO - PROCESS | 10912 | 09:40:47 INFO - TEST-INFO | 10912: exit 0 09:40:47 INFO - TEST-OK | dromaeo_css | took 1109327ms 09:40:47 INFO - TEST-START | kraken 09:40:47 INFO - operating with platform_type : linux_ 09:40:47 INFO - Initialising browser for kraken test... 09:40:47 INFO - TEST-INFO | started process 11153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPeNw4m/profile http://localhost:37208/getInfo.html) 09:40:51 INFO - PROCESS | 11153 | 09:40:51 INFO - PROCESS | 11153 | (process:11228): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:40:52 INFO - PROCESS | 11153 | __metrics Screen width/height:1600/1200 09:40:52 INFO - PROCESS | 11153 | colorDepth:24 09:40:52 INFO - PROCESS | 11153 | Browser inner width/height: 1024/697 09:40:52 INFO - PROCESS | 11153 | __metrics 09:40:53 ERROR - PROCESS | 11153 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 09:40:54 INFO - TEST-INFO | 11153: exit 0 09:40:54 INFO - Browser initialized. 09:40:54 INFO - Running cycle 1/1 for kraken test... 09:40:54 INFO - TEST-INFO | started process 11278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPeNw4m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:56 INFO - PROCESS | 11278 | 09:40:56 INFO - PROCESS | 11278 | (process:11345): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:41:06 INFO - PROCESS | 11278 | RSS: Main: 149938176 09:41:06 INFO - PROCESS | 11278 | 09:41:08 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37208/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:09 INFO - PROCESS | 11278 | RSS: Main: 153788416 09:41:09 INFO - PROCESS | 11278 | 09:41:12 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37208/tests/kraken/driver.html?testName=audio-dft) 09:41:12 INFO - PROCESS | 11278 | RSS: Main: 154415104 09:41:12 INFO - PROCESS | 11278 | 09:41:15 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37208/tests/kraken/driver.html?testName=audio-fft) 09:41:16 INFO - PROCESS | 11278 | RSS: Main: 154697728 09:41:16 INFO - PROCESS | 11278 | 09:41:18 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37208/tests/kraken/driver.html?testName=audio-oscillator) 09:41:18 INFO - PROCESS | 11278 | RSS: Main: 154918912 09:41:18 INFO - PROCESS | 11278 | 09:41:20 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37208/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:41:21 INFO - PROCESS | 11278 | RSS: Main: 154943488 09:41:21 INFO - PROCESS | 11278 | 09:41:24 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37208/tests/kraken/driver.html?testName=imaging-darkroom) 09:41:25 INFO - PROCESS | 11278 | RSS: Main: 154873856 09:41:25 INFO - PROCESS | 11278 | 09:41:28 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37208/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:29 INFO - PROCESS | 11278 | RSS: Main: 155000832 09:41:29 INFO - PROCESS | 11278 | 09:41:31 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37208/tests/kraken/driver.html?testName=json-parse-financial) 09:41:32 INFO - PROCESS | 11278 | RSS: Main: 154738688 09:41:32 INFO - PROCESS | 11278 | 09:41:34 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37208/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:41:34 INFO - PROCESS | 11278 | RSS: Main: 154636288 09:41:34 INFO - PROCESS | 11278 | 09:41:36 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37208/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:41:37 INFO - PROCESS | 11278 | RSS: Main: 154669056 09:41:37 INFO - PROCESS | 11278 | 09:41:39 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37208/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:39 INFO - PROCESS | 11278 | RSS: Main: 155361280 09:41:39 INFO - PROCESS | 11278 | 09:41:42 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:42 INFO - PROCESS | 11278 | RSS: Main: 155422720 09:41:42 INFO - PROCESS | 11278 | 09:41:45 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:45 INFO - PROCESS | 11278 | RSS: Main: 155414528 09:41:45 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | Cycle 1(1): loaded http://localhost:37208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37208/tests/kraken/driver.html?testName=ai-astar) 09:41:47 INFO - PROCESS | 11278 | RSS: Main: 156962816 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | __start_tp_report 09:41:47 INFO - PROCESS | 11278 | _x_x_mozilla_page_load 09:41:47 INFO - PROCESS | 11278 | _x_x_mozilla_page_load_details 09:41:47 INFO - PROCESS | 11278 | |i|pagename|runs| 09:41:47 INFO - PROCESS | 11278 | |0;ai-astar;112;106;113;111;114;124;112;111;114;114 09:41:47 INFO - PROCESS | 11278 | |1;audio-beat-detection;156;131;151;168;129;154;157;126;177;129 09:41:47 INFO - PROCESS | 11278 | |2;audio-dft;167;163;162;162;163;162;161;164;166;165 09:41:47 INFO - PROCESS | 11278 | |3;audio-fft;75;77;73;169;76;72;76;73;167;76 09:41:47 INFO - PROCESS | 11278 | |4;audio-oscillator;95;95;143;94;93;94;144;93;93;142 09:41:47 INFO - PROCESS | 11278 | |5;imaging-gaussian-blur;118;118;117;117;118;117;117;117;119;118 09:41:47 INFO - PROCESS | 11278 | |6;imaging-darkroom;146;146;147;148;147;147;147;147;147;147 09:41:47 INFO - PROCESS | 11278 | |7;imaging-desaturate;96;96;96;96;97;98;97;97;96;96 09:41:47 INFO - PROCESS | 11278 | |8;json-parse-financial;53;54;58;54;53;57;54;61;59;58 09:41:47 INFO - PROCESS | 11278 | |9;json-stringify-tinderbox;67;65;65;65;65;68;70;65;66;66 09:41:47 INFO - PROCESS | 11278 | |10;stanford-crypto-aes;85;80;79;79;80;79;79;79;80;80 09:41:47 INFO - PROCESS | 11278 | |11;stanford-crypto-ccm;123;112;112;122;117;115;114;112;113;121 09:41:47 INFO - PROCESS | 11278 | |12;stanford-crypto-pbkdf2;140;143;144;142;144;146;142;144;136;136 09:41:47 INFO - PROCESS | 11278 | |13;stanford-crypto-sha256-iterative;73;66;67;69;69;65;66;67;66;67 09:41:47 INFO - PROCESS | 11278 | __end_tp_report 09:41:47 INFO - PROCESS | 11278 | __start_cc_report 09:41:47 INFO - PROCESS | 11278 | _x_x_mozilla_cycle_collect,820 09:41:47 INFO - PROCESS | 11278 | __end_cc_report 09:41:47 INFO - PROCESS | 11278 | __startTimestamp1463762507679__endTimestamp 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | ------- Summary: start ------- 09:41:47 INFO - PROCESS | 11278 | Number of tests: 14 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.50 stddev:4.51 (4.0%) stddev-sans-first:4.76 09:41:47 INFO - PROCESS | 11278 | Values: 112.0 106.0 113.0 111.0 114.0 124.0 112.0 111.0 114.0 114.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:155.00 stddev:18.03 (11.6%) stddev-sans-first:18.88 09:41:47 INFO - PROCESS | 11278 | Values: 156.0 131.0 151.0 168.0 129.0 154.0 157.0 126.0 177.0 129.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:1.96 (1.2%) stddev-sans-first:1.62 09:41:47 INFO - PROCESS | 11278 | Values: 167.0 163.0 162.0 162.0 163.0 162.0 161.0 164.0 166.0 165.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.50 stddev:39.35 (52.1%) stddev-sans-first:41.17 09:41:47 INFO - PROCESS | 11278 | Values: 75.0 77.0 73.0 169.0 76.0 72.0 76.0 73.0 167.0 76.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.50 stddev:23.75 (25.4%) stddev-sans-first:24.68 09:41:47 INFO - PROCESS | 11278 | Values: 95.0 95.0 143.0 94.0 93.0 94.0 144.0 93.0 93.0 142.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 09:41:47 INFO - PROCESS | 11278 | Values: 118.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 119.0 118.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 09:41:47 INFO - PROCESS | 11278 | Values: 146.0 146.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 09:41:47 INFO - PROCESS | 11278 | Values: 96.0 96.0 96.0 96.0 97.0 98.0 97.0 97.0 96.0 96.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.50 stddev:2.85 (4.9%) stddev-sans-first:2.79 09:41:47 INFO - PROCESS | 11278 | Values: 53.0 54.0 58.0 54.0 53.0 57.0 54.0 61.0 59.0 58.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:1.69 (2.6%) stddev-sans-first:1.76 09:41:47 INFO - PROCESS | 11278 | Values: 67.0 65.0 65.0 65.0 65.0 68.0 70.0 65.0 66.0 66.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:1.83 (2.3%) stddev-sans-first:0.53 09:41:47 INFO - PROCESS | 11278 | Values: 85.0 80.0 79.0 79.0 80.0 79.0 79.0 79.0 80.0 80.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#11] stanford-crypto-ccm Cycles:10 Average:116.10 Median:116.00 stddev:4.38 (3.8%) stddev-sans-first:3.87 09:41:47 INFO - PROCESS | 11278 | Values: 123.0 112.0 112.0 122.0 117.0 115.0 114.0 112.0 113.0 121.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:143.50 stddev:3.40 (2.4%) stddev-sans-first:3.55 09:41:47 INFO - PROCESS | 11278 | Values: 140.0 143.0 144.0 142.0 144.0 146.0 142.0 144.0 136.0 136.0 09:41:47 INFO - PROCESS | 11278 | 09:41:47 INFO - PROCESS | 11278 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:2.32 (3.5%) stddev-sans-first:1.36 09:41:47 INFO - PROCESS | 11278 | Values: 73.0 66.0 67.0 69.0 69.0 65.0 66.0 67.0 66.0 67.0 09:41:47 INFO - PROCESS | 11278 | -------- Summary: end -------- 09:41:47 INFO - PROCESS | 11278 | 09:41:48 INFO - TEST-INFO | 11278: exit 0 09:41:48 INFO - TEST-OK | kraken | took 60803ms 09:41:48 INFO - SUITE-END | took 1170s 09:41:48 INFO - Completed test suite (00:19:30) 09:41:48 INFO - javascript benchmark 09:41:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3283.22844131629, 3344.38128946145, 3348.5479460272873, 3364.9158771030707, 3380.6450322716114, 5441.483059109383, 5466.671999680022, 5472.315960504942, 5476.315460567429, 5502.2296878437055, 5480.588955828319, 5505.752241149148, 5517.5585953123755, 5518.117101263799, 5518.2826232589805, 5007.048660754454, 5017.949820501784, 5085.313482679846, 5102.413222479407, 5143.0, 4987.725675087869, 5106.0, 5110.0, 5183.429822719498, 5203.089459344618, 5077.162268225738, 5109.310243117169, 5113.028524580336, 5124.974375128119, 5134.25553294772, 5059.949400505985, 5092.236164575306, 5098.872528186788, 5107.233914912774, 5116.539511443969, 4936.679115857493, 4984.0281145176705, 5020.1214787412055, 5023.824166154203, 5078.238264260353, 5355.357357117132, 5364.544013758835, 5367.43641917597, 5380.192971054334, 5385.461453854622, 5959.553033522503, 5966.045432730785, 5968.940310596882, 5976.731047102848, 5982.4316689914385, 5920.023196172627, 5963.105534169866, 6001.309849367335, 6011.368806275365, 6014.939850601481, 5521.337439507245, 5527.309086364205, 5532.529734972532, 5538.280023596947, 5539.086050801613, 5918.852028699317, 6036.3360030396625, 6058.757649693963, 6064.605800622945, 6070.180525628984, 5850.034744267234, 5863.0, 5869.589128761031, 5873.383294754075, 5876.9118463223085, 5926.851828704231, 5955.0, 5960.403959604092, 5960.910586341209, 5963.642181469039, 5870.5890587659305, 5878.970605147032, 5914.9112763308585, 5929.73316200772, 5931.7627294907725, 5893.292804863444, 5936.050231962951, 5940.227770389822, 5946.762129514771, 5953.226080609493, 4471.910561788746, 4501.144782491317, 4515.9548404515535, 4532.1842068427995, 4532.98007948209, 4038.1116154445976, 4047.453593764863, 4068.7355321903983, 4089.6319331259733, 4127.09203975125, 5652.406497317805, 5731.197632331477, 5742.454466825645, 5767.423257674283, 5813.3895940925595, 5955.940440595538, 5958.404159584007, 5996.910046349309, 6019.969900150559, 6026.728797204137, 5596.4403559644525, 5618.971905140448, 5724.370319264877, 5727.885442291131, 5747.051736463437, 5118.10433174193, 5129.512696293846, 5131.204663277198, 5157.8452646420665, 5177.352830896138, 5982.880342393128, 6180.690965451709, 6202.503799696014, 6207.255129384503, 6228.283747369111, 5979.252593425822, 6044.516438684983, 6047.848803779941, 6061.818145455643, 6079.726412311545, 6148.877022459436, 6155.0, 6155.630662160284, 6176.104464852661, 6177.2587289525545, 5763.740631671669, 5872.677002764889, 5888.676122813286, 5895.292564892069, 5912.379200184091, 5994.6403215807195, 6046.365131661112, 6058.818235452944, 6073.5748497604745, 6086.847828804138, 5794.971025144847, 5820.010598198402, 5850.180974663465, 5861.736221869941, 5866.823995280149, 5729.885402291848, 5747.712614369181, 5795.565332599987, 5860.941390586039, 5874.765009399576, 5682.77268909239, 5710.457506536873, 5717.256756621779, 5726.427357264407, 5740.856478588069, 5824.388439213822, 5832.650040997553, 5846.970765146147, 5861.736221869941, 5874.970625146847, 5657.575681823797, 5724.0, 5754.19441278213, 5764.337101233412, 5850.824475265749], "unit": "score", "name": "dojo.html", "value": 5494.655268484651}, {"lowerIsBetter": false, "replicates": [537.666646679059, 566.1451208674899, 577.0219477984815, 579.5392662833048, 596.7642781101465, 42532.57467425325, 43839.90400239992, 43850.780746096265, 43866.0, 43884.561154388444, 45024.77487612557, 46089.30866037012, 46147.53852461474, 46169.30746038804, 46487.30269045958, 8752.168543988328, 8962.0, 8971.147740964598, 8971.775705607379, 8978.50618215998, 8843.77890552735, 8962.507062111581, 9045.502497362642, 9047.276217902552, 9051.049639787827, 8976.59605317759, 9046.728598142066, 9058.184763371295, 9069.95465022674, 9092.909070909305, 8908.8663670045, 9012.369134160612, 9014.999999999967, 9015.549222538879, 9017.0, 8755.824883502359, 8886.244669203126, 8901.243394311492, 8902.33232507558, 8903.599338029804, 40778.0, 41284.935753212216, 41317.1736565267, 41449.585504144874, 41572.79213603913, 3623.691986181178, 3740.887773366776, 3761.4733937248807, 3787.261484010619, 4364.476262848447, 32913.83543082269, 33137.3372532548, 33274.0, 33676.15809604755, 34514.0, 4236.258654735439, 4296.140771845643, 4332.761698106603, 4344.543822898613, 4414.646828253732, 237428.0, 237694.0, 238800.0, 239627.0, 321149.9999999977, 65292.67353663201, 67642.3235767636, 68171.65914170397, 68507.65746171237, 68644.0, 72058.0, 77607.61196194096, 78450.60774696204, 78634.60682696664, 78648.60675696585, 18867.0, 19005.14476848545, 19078.236870525023, 19080.236790528503, 19085.522861928563, 14682.412703491955, 14714.779278310834, 14734.526547345395, 14767.852321476863, 14779.408823646934, 22932.738699371363, 24109.276721698378, 24168.0, 24178.87910560436, 24197.7580224199, 8019.639116239783, 8191.713290034821, 8219.136990616018, 8268.462549934355, 8272.958635206905, 1051.4269723000982, 1077.8544896439037, 1093.3603841752663, 1123.9880613701546, 1143.6283207957447, 30769.38461230763, 31621.051368458982, 34471.82764086164, 36425.0, 36485.08787280339, 1068.455087905174, 1111.5831563163813, 1133.8129208680475, 1181.5155786127646, 1182.148852825964, 16032.19839008045, 16236.269367878474, 16370.263338149813, 16738.414155504743, 16977.0, 427879.0, 546672.0, 552565.0, 691258.0, 695920.0, 65812.0, 67033.0, 67424.6628766853, 67505.0, 67575.32424675788, 1461.7222727681706, 1495.4915328788047, 1508.5474357692867, 1510.9244537773068, 1518.780186005653, 32260.516092258167, 32566.674333256364, 32867.671323286464, 32929.0, 33650.49524257089, 53089.0, 53150.0, 53697.0, 53748.46251537435, 53773.19340209978, 276362.0, 278180.0, 280163.0, 280594.0, 280930.0, 36797.26405471929, 37129.81435092807, 37146.44280335851, 37468.43797343096, 37481.81259093687, 48625.75687121542, 48684.269735954695, 48927.26609100795, 50051.74974125252, 50842.23736643879, 43863.34204986991, 43915.78042109769, 44438.3334249993, 45136.0, 45416.77291613521, 40310.39534406928, 40896.79551602223, 41358.35869128186, 41485.1702965945, 41976.16047678968, 40738.59261407348, 40849.0, 41385.0, 41798.0, 41898.79050604728, 35419.82290088533, 35867.0, 35992.28015439729, 36282.637173627925, 36297.27405451823, 27544.449111017268, 28315.575266371434, 28401.147965561067, 28629.28426789347, 28719.42561148807], "unit": "score", "name": "ext.html", "value": 20873.222175852563}, {"lowerIsBetter": false, "replicates": [383.08282429300874, 384.728766219815, 387.33378588827225, 391.19609203087646, 394.7591968898973, 12507.687307817308, 13000.0, 15816.841831581682, 18446.815531844677, 19110.808891911078, 19479.70780438291, 19724.802751972475, 20129.295474658353, 20129.899350503227, 20246.797532024677, 6141.263048434183, 6169.568130230886, 6343.175387199658, 6405.359464053604, 6430.839229019289, 6395.072714456401, 6401.967990160043, 6411.326810684857, 6431.935680643204, 6437.613743175401, 6156.107364432155, 6368.554201205918, 6401.1678481797535, 6415.711292991803, 6428.132202152719, 6359.841003974914, 6391.233052033739, 6405.071264666621, 6405.135306733578, 6428.228612566475, 6048.7882924097885, 6139.87720245597, 6144.293406258248, 6215.2541694996435, 6221.844453888643, 24483.877580611985, 24757.133500327403, 24873.5025299493, 25067.37331566707, 25446.618300725502, 2272.6591011348264, 2608.6347911292432, 3166.5883435153282, 3173.8889138880027, 3383.069655844638, 14972.951893367359, 15117.54647360581, 15299.15854627995, 15462.072275663384, 15886.443974460954, 2111.19774485696, 2117.396541985542, 2124.946876328089, 2154.084514081525, 2223.58863610231, 69775.0, 71043.28956710418, 72265.27734722638, 72401.63799181023, 72744.0, 15841.287142078634, 15945.760813587573, 15963.441279555393, 16174.514764557081, 16257.430989915296, 13646.795298070538, 14196.64508387278, 27334.45331093367, 27405.451890962468, 27420.588691169647, 7908.4464087513325, 7965.6017199139815, 8042.396820238506, 8055.476394034369, 8168.754937351889, 7877.369810415153, 7949.364050876032, 7995.0, 8093.635786389626, 8136.1863813618165, 4381.7370957742, 4419.11617676466, 4438.733675979452, 4571.1543364477675, 4687.273472611751, 1870.5417172792752, 1874.334611213027, 1885.679434496139, 1948.3278268997174, 1961.2351183038627, 970.8398463835648, 1014.6803756816579, 1061.230607809332, 1106.8007758603528, 1116.7208197950513, 17332.740008899877, 17374.783765136573, 17517.824821751874, 17551.473455796346, 18131.0, 999.9100080992746, 1013.083159740436, 1033.5917312661607, 1056.772793849326, 1069.5347523827004, 10085.596576136872, 10094.545745441474, 10152.796944061078, 10185.33795303303, 10219.48902554884, 429109.0, 435666.0, 438668.0, 440495.0, 445263.0, 76204.23795761971, 77498.0, 78371.60814195893, 78892.60553697195, 80018.0, 1039.776448063655, 1060.41677077607, 1061.5647584490475, 1062.9415382153902, 1093.5516438260274, 15722.0, 15935.36258549645, 15944.760828587812, 16038.679226415174, 16042.117683527518, 29187.70812291935, 34317.31365372628, 34630.82684586561, 37256.62743372531, 37996.43005354867, 43809.0, 46628.7668561655, 46920.0, 47173.76413117912, 47276.763616183074, 8190.549519776469, 8555.401121921655, 8583.227509524173, 8840.29277657773, 8893.64425422976, 13187.010974177167, 13575.0, 13639.454421823017, 13769.931150344184, 13845.51540696111, 11387.601433950103, 11667.824982625438, 11914.76170476603, 11914.821277680669, 11930.0, 11336.489857956247, 11877.346745929057, 11991.400429978641, 12026.27842329463, 12031.4585843639, 6452.9677351612945, 11816.881831181921, 11984.161108722306, 12174.391280435766, 12176.269423834598, 8061.919380806117, 8650.56747162652, 8806.075362086889, 8897.510636915033, 8939.73180804577, 10780.676579702622, 11456.312621242752, 11534.711632209262, 11640.243384180001, 11697.415129243334], "unit": "score", "name": "jquery.html", "value": 9455.547824945765}, {"lowerIsBetter": false, "replicates": [1551.8758499320054, 1601.1593913195575, 1848.500904755716, 1887.1319193171141, 1953.6483432982066, 8131.756047318575, 8163.91836081639, 8307.0, 8322.04296505902, 8356.122607126248, 8218.794530136749, 8298.70954516592, 8316.667333306661, 8319.209675080872, 8343.290820280283, 2330.93007209784, 2351.2240960483086, 2356.222446592629, 2362.2086600988605, 2363.7163540375095, 2405.783479486846, 2414.7343792182846, 2450.8284420090513, 2458.2502336787275, 2458.50829834033, 2315.2128276386024, 2321.7097862767155, 2328.057136859566, 2338.485533182697, 2354.72920614129, 2402.8318017738766, 2420.2860156253946, 2430.5746494363502, 2435.3789783605243, 2442.7557244275517, 2387.212219967407, 2393.4734358441115, 2397.2328854766483, 2399.3881560202212, 2404.483036147237, 8265.46274492156, 8314.0, 8320.459170153921, 8332.04181519127, 8347.958260208721, 5141.74291285438, 5218.217267409881, 5234.084035293847, 5240.266362709223, 5264.078786212397, 3165.509346051366, 3203.5515027896113, 3247.0745837436216, 3259.771815972883, 3333.666633336671, 964.864918911353, 982.5038355630433, 991.7173605522464, 1006.3458751811309, 1008.339537602864, 11243.66269011931, 11390.71523211918, 11402.885971140266, 11412.20114591979, 11449.656510304621, 4394.604485596312, 4439.334099884978, 4498.572635599613, 4499.4150760400935, 4504.301833215857, 9236.907630923739, 9258.953705231566, 9269.90730092704, 9288.256939444827, 9321.860172097424, 5235.214717792362, 5269.420363759983, 5274.208868669731, 5279.076161671692, 5279.656822306538, 4594.954050459452, 4675.696079754805, 4694.859154225379, 4715.669903106749, 4805.399325084364, 3488.110531814371, 3563.732720045955, 3568.3041806847937, 3604.116991337139, 3620.5836328821997, 1059.523214553454, 1063.1494804156644, 1067.6263307842348, 1070.314998401024, 1085.3487907255742, 1448.7754398068316, 1457.358762144653, 1468.5227301126963, 1480.9111453312835, 1500.9624759380883, 8009.759707208793, 8062.032556093306, 8067.83864322722, 8075.071366792894, 8084.231997960184, 521.56188801407, 526.7497938479191, 534.7219445888117, 534.9037173308842, 536.6216817143904, 6090.908636370458, 6154.661493617894, 6162.5378096642935, 6170.413810687977, 6190.040543715641, 10017.248706347053, 10383.740406489898, 10406.5837366506, 10424.68725938223, 10491.0, 9331.113544213289, 10035.0, 10093.142082922886, 10132.54403551842, 10266.435346055889, 7768.456208065381, 7899.960500197577, 7922.168172341936, 7942.801429964297, 7962.601869906482, 7632.69469221225, 7685.116211635734, 7779.105402878741, 7787.415943804351, 7797.961010194913, 8761.912380876365, 8763.430377025474, 8802.559872006503, 9041.728748137566, 9054.773630659287, 8781.604827782638, 8986.640534378552, 9101.044390339184, 9162.725118246462, 9299.674511392339, 7298.744543940937, 7401.0, 7505.587192704235, 7511.586862722603, 7517.436192285491, 7816.06207255133, 7874.212578742309, 7917.683292668459, 7931.444798864024, 7955.085165205844, 7063.82340441493, 7109.28907109285, 7189.712411503481, 7194.892076618959, 7243.311885370881, 7148.499605027599, 7150.998860159478, 7175.103112110986, 7214.71141154348, 7263.636818159177, 7170.641467926687, 7363.595002274712, 7366.189719130784, 7391.0, 7392.630368481447, 6753.189617245962, 6760.966195168992, 6793.626350550569, 6802.6258555779905, 6826.453883689193, 6734.595924244365, 6809.557378770364, 6812.14848143982, 6813.216480104653, 6837.282085381163], "unit": "score", "name": "mootools.html", "value": 4663.42802568531}, {"lowerIsBetter": false, "replicates": [354.1005845153311, 362.61924978772294, 363.7671889990407, 367.17752234993605, 369.58790948092883, 6321.3994670506345, 6354.523410744189, 6368.586041907279, 6375.521835862306, 6426.132472116263, 6256.374362563742, 6272.68636568172, 6273.686315684209, 6284.12022316876, 6292.842678933029, 4709.387779588648, 4806.086843499741, 4828.444728856182, 4835.975820120894, 4851.22380419133, 4824.927626085611, 4838.564529192372, 4841.661083724141, 4844.370231869852, 4846.151923413407, 4783.0, 4792.305115758213, 4795.688280261789, 4802.59177969873, 4810.567048965592, 4786.760661966905, 4788.61691064714, 4798.448178459469, 4809.855704328876, 4811.182099043171, 4178.78815143608, 4182.811773470201, 4186.769727664977, 4187.874363769061, 4189.895252618709, 5888.0, 5961.0, 5986.521078313768, 6000.819975400745, 6010.609310394854, 5525.668459892419, 5571.637843540157, 5574.163875418679, 5597.272354593917, 5603.971980140073, 6630.933690663128, 6672.666366681647, 6706.362895524917, 6714.697838597226, 6716.2276338221245, 4593.0, 4594.65540084495, 4595.540445955411, 4595.724256544618, 4614.492405835355, 6978.441724662015, 7029.929700702979, 7040.225575186725, 7041.3310735480045, 7047.577145371243, 4667.8599642010795, 4826.0, 4832.371791667061, 4833.830815921426, 4836.443808962014, 4884.633652476078, 4911.919377736892, 4914.33656456381, 4915.3855768029, 4921.114199444134, 5627.71861406928, 5668.461496157858, 5670.829875103754, 5672.234248376499, 5684.976704193202, 6819.795406137824, 6824.931750682529, 6830.146231721035, 6830.7609233676585, 6842.897356539655, 1692.339987404913, 1697.2616911643229, 1702.7956645202407, 1703.34421247818, 1708.2825213410397, 1111.6720567432626, 1130.4008875296106, 1136.4999400263857, 1144.9885501144881, 1148.5979907032638, 6449.0, 6490.286068532458, 6511.316311787289, 6527.34726527353, 6620.668966551653, 6970.477214208955, 6977.82555436108, 7008.0, 7025.92974070263, 7029.718811247493, 6518.804435866931, 6625.4037136657935, 6688.7324507019175, 6698.531102822853, 6727.226368967534, 3789.374753165752, 3803.2773772983046, 3833.3291673956946, 3834.0989867381145, 3835.137094153793, 7323.12122545298, 7343.559386436831, 7406.592637404994, 7412.4440666950195, 7424.0, 7302.415806735448, 7326.67029983652, 7363.889541656772, 7418.888716669254, 7422.183559808417, 7131.358177764027, 7321.963390183015, 7354.77935661931, 7393.223711510429, 7399.630018499053, 7022.824429389306, 7091.680874360769, 7106.253843346374, 7116.715331386894, 7142.607156606437, 6938.23679395256, 6978.371946524634, 7008.088948436671, 7023.051887995055, 7037.049998250171, 7362.852742945004, 7386.446016548673, 7405.7778266652085, 7410.036695229801, 7412.4070074394995, 4896.338994235733, 4953.578945789648, 5025.145725226794, 5026.47222041695, 5049.57078648319, 6989.685464154227, 7012.509124361246, 7024.227334993249, 7050.788476345718, 7059.858802823812, 6780.491463140185, 6798.048273241849, 6807.625580593115, 6822.044913711985, 6830.248672646105, 6808.38724514796, 6819.863602728017, 6872.175338959357, 6878.8624227516175, 6886.345797149263, 6501.122348483083, 6639.867202656016, 6676.732930682912, 6720.630365329954, 6746.730130794714, 6882.69027893736, 6888.242293347627, 6889.242183359726, 6893.103896493424, 6901.930980690129, 6731.966340168267, 6733.42765864907, 6743.089682892747, 6751.493637977073, 6754.493412993947], "unit": "score", "name": "prototype.html", "value": 5125.130166848151}, {"lowerIsBetter": false, "replicates": [782.2021538031208, 894.2488309819751, 895.3687650206605, 907.7367563406613, 922.741632342944, 14278.000539962193, 14576.198309093008, 14616.4884229052, 14628.707425851477, 14645.853541464583, 13929.930350348259, 14017.579472615813, 14055.016148869583, 14061.437542498314, 14075.085119467227, 922.7739203895055, 958.3818437108062, 958.7267628725815, 961.024560071528, 961.1637875048717, 950.339514037744, 952.49041762657, 953.3279038278032, 956.6269155029544, 959.8752162218901, 1002.2633364477103, 1008.9798204035915, 1009.0817356205854, 1009.5002973528077, 1010.0909181736423, 996.9501524923725, 999.5302207962246, 1002.5839276700161, 1003.1373019203479, 1011.0748664971542, 738.7894450081701, 742.8402893377896, 743.8698227810112, 743.9590822504761, 744.3858816476428, 14496.34766435513, 14511.346989385504, 14522.056066355653, 14547.418103275857, 14565.6358591035, 14178.787318190132, 14357.210353430557, 14398.78401823963, 14409.639759006004, 14413.927930360282, 11791.941040294743, 11814.822777658343, 11814.881851181464, 11915.106367022508, 11946.940265298705, 3901.7854018028997, 3915.843366265346, 3945.447637330776, 3962.187751510933, 4002.5597184309704, 54813.0, 54877.45122548763, 54901.72549137269, 54957.90084198333, 55403.72298138524, 10917.617883374203, 11184.720381990353, 11245.100391968623, 11310.151738619472, 11320.490577924013, 20146.496337591678, 20203.79796202019, 20234.595308093754, 20275.79724202739, 20327.288544900857, 8000.719974800854, 8079.757607271791, 8309.37679674027, 8585.65657373698, 8625.266852317623, 4642.53574642533, 4736.526347365236, 4761.95238047622, 4823.686460380064, 4830.178869592178, 3513.5432393789156, 3528.417811061146, 3532.752707310515, 3546.1666508370513, 3554.3779838528153, 606.8331208917583, 611.376396076, 628.4061561824124, 649.1496140056447, 660.4848218389664, 631.8325643704422, 717.160921721587, 752.9924700753032, 789.7393860026177, 804.9356051515865, 9467.952660236655, 9791.216702663769, 9930.453825039693, 9962.651307204213, 10001.849972250422, 651.5081113759081, 766.861964846333, 783.8784988326819, 793.6547601793238, 795.9960200198962, 4433.800478978454, 4470.195364834296, 4486.551344865487, 4555.498895121534, 4645.465771436328, 63866.36133638697, 64121.35878641247, 64435.67782161059, 64568.354316457175, 64931.0, 55367.0, 55558.444415556136, 55753.0, 55858.72070639702, 57079.14381284284, 49781.0, 50410.24384634233, 50464.747676262115, 50799.49200508022, 51105.48894511082, 9004.189622933967, 9211.170994610517, 9213.262938964732, 9254.213391861767, 9374.531273436165, 36977.815110924275, 37441.625583743815, 38057.80971095127, 39037.41443878287, 39769.40345894872, 48911.755441222565, 49565.50434495753, 49989.750051250965, 50730.239046415074, 51663.74168129286, 12367.505299788269, 12481.0, 12510.624681259576, 12653.74692506163, 12938.417771200131, 13155.934220328838, 13949.511767088103, 13978.30108494551, 13990.370433330321, 14179.503717369842, 12631.684207894876, 12708.682282943, 12842.614721558368, 12976.0, 13010.674733131747, 13285.0, 13292.534761283308, 13383.799243011168, 13448.0, 13527.323633818467, 11737.0, 11983.64049078529, 12221.266723996589, 12393.876061239273, 12941.0, 10644.627438039632, 10735.677929662123, 10977.560897564008, 11045.447727613426, 11172.832407514057, 10826.51280692355, 10989.969472306882, 11010.217362035834, 11043.0, 11088.833667494833], "unit": "score", "name": "yui.html", "value": 7111.532110401838}], "name": "dromaeo_css", "value": 7544.055619290121}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 113.0, 111.0, 114.0, 124.0, 112.0, 111.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 151.0, 168.0, 129.0, 154.0, 157.0, 126.0, 177.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [167.0, 163.0, 162.0, 162.0, 163.0, 162.0, 161.0, 164.0, 166.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 73.0, 169.0, 76.0, 72.0, 76.0, 73.0, 167.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 143.0, 94.0, 93.0, 94.0, 144.0, 93.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 119.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 98.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 58.0, 54.0, 53.0, 57.0, 54.0, 61.0, 59.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 65.0, 65.0, 65.0, 68.0, 70.0, 65.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.2}, {"lowerIsBetter": true, "replicates": [85.0, 80.0, 79.0, 79.0, 80.0, 79.0, 79.0, 79.0, 80.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [123.0, 112.0, 112.0, 122.0, 117.0, 115.0, 114.0, 112.0, 113.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.1}, {"lowerIsBetter": true, "replicates": [140.0, 143.0, 144.0, 142.0, 144.0, 146.0, 142.0, 144.0, 136.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [73.0, 66.0, 67.0, 69.0, 69.0, 65.0, 66.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1515.0}]} 09:41:48 INFO - Return code: 0 09:41:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:41:48 ERROR - # TBPL SUCCESS # 09:41:48 INFO - Running post-action listener: _resource_record_post_action 09:41:48 INFO - Running post-run listener: _resource_record_post_run 09:41:50 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 20480; Write bytes: 456777728; Read time: 536; Write time: 505632 09:41:50 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 4096; Write bytes: 237342720; Read time: 172; Write time: 325648 09:41:50 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 219123712; Read time: 364; Write time: 179960 09:41:50 INFO - Running post-run listener: _upload_blobber_files 09:41:50 INFO - Blob upload gear active. 09:41:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:50 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 09:41:50 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'] 09:41:50 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 09:41:50 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:41:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:41:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:51 INFO - (blobuploader) - INFO - Done attempting. 09:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:41:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:41:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:53 INFO - (blobuploader) - INFO - Done attempting. 09:41:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:53 INFO - Return code: 0 09:41:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d05d2883e2f078bc9a01ed42b0588577718616708d2f79f37e00872b442682d1a8594129f668981685d2d7710c2ad7aa4c6ac495d8366a036dc3e9f7b4d777f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab11a177454b7392d6167878f90659f8e492e1e7e44e3554addd3b5e32d1ff63bd3e498d96cce1b3900bde977c28f0c733f99b0f6a305306e559015f35208c38"} 09:41:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:53 INFO - Contents: 09:41:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d05d2883e2f078bc9a01ed42b0588577718616708d2f79f37e00872b442682d1a8594129f668981685d2d7710c2ad7aa4c6ac495d8366a036dc3e9f7b4d777f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab11a177454b7392d6167878f90659f8e492e1e7e44e3554addd3b5e32d1ff63bd3e498d96cce1b3900bde977c28f0c733f99b0f6a305306e559015f35208c38"} 09:41:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:53 INFO - Copying logs to upload dir... 09:41:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.404380 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-20 09:41:52.479374) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 09:41:52.482967) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588 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/d05d2883e2f078bc9a01ed42b0588577718616708d2f79f37e00872b442682d1a8594129f668981685d2d7710c2ad7aa4c6ac495d8366a036dc3e9f7b4d777f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab11a177454b7392d6167878f90659f8e492e1e7e44e3554addd3b5e32d1ff63bd3e498d96cce1b3900bde977c28f0c733f99b0f6a305306e559015f35208c38"} build_url:https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.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/d05d2883e2f078bc9a01ed42b0588577718616708d2f79f37e00872b442682d1a8594129f668981685d2d7710c2ad7aa4c6ac495d8366a036dc3e9f7b4d777f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab11a177454b7392d6167878f90659f8e492e1e7e44e3554addd3b5e32d1ff63bd3e498d96cce1b3900bde977c28f0c733f99b0f6a305306e559015f35208c38"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 09:41:52.507901) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:41:52.508258) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463758620.211260-1940181588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:41:52.594595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 09:41:52.594947) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 09:41:52.595270) ========= ========= Total master_lag: 0.17 =========